builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-013 starttime: 1487609496.69 results: success (0) buildid: 20170220070057 builduid: 59d38ecc375c4f3d8a75893d12924e50 revision: 3b31bcb88fe341172e93cc8b1143e617c0988694 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-20 08:51:36.688577) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-20 08:51:36.689021) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-20 08:51:36.689284) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-20 08:51:36.705585) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-20 08:51:36.705858) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1487608364.973979-562395971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-20 08:51:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2017-02-20 08:51:38 (219 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.089471 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-20 08:51:36.808471) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-20 08:51:36.808743) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1487608364.973979-562395971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016639 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-20 08:51:36.858133) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-20 08:51:36.858481) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 3b31bcb88fe341172e93cc8b1143e617c0988694 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 3b31bcb88fe341172e93cc8b1143e617c0988694 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1487608364.973979-562395971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-20 08:51:38,122 truncating revision to first 12 chars 2017-02-20 08:51:38,122 Setting DEBUG logging. 2017-02-20 08:51:38,122 attempt 1/10 2017-02-20 08:51:38,122 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/3b31bcb88fe3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-20 08:51:38,512 unpacking tar archive at: mozilla-beta-3b31bcb88fe3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.713060 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-20 08:51:37.583956) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-20 08:51:37.584275) ========= script_repo_revision: 3b31bcb88fe341172e93cc8b1143e617c0988694 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-20 08:51:37.584643) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-20 08:51:37.584908) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-20 08:51:37.592876) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-02-20 08:51:37.593131) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1487608364.973979-562395971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:51:38 INFO - MultiFileLogger online at 20170220 08:51:38 in /builds/slave/test 08:51:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 08:51:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:51:38 INFO - {'append_to_log': False, 08:51:38 INFO - 'base_work_dir': '/builds/slave/test', 08:51:38 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:51:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:51:38 INFO - 'branch': 'Mozilla-Beta', 08:51:38 INFO - 'buildbot_json_path': 'buildprops.json', 08:51:38 INFO - 'config_files': ('talos/linux_config.py',), 08:51:38 INFO - 'default_actions': ('clobber', 08:51:38 INFO - 'read-buildbot-config', 08:51:38 INFO - 'download-and-extract', 08:51:38 INFO - 'populate-webroot', 08:51:38 INFO - 'create-virtualenv', 08:51:38 INFO - 'install', 08:51:38 INFO - 'run-tests'), 08:51:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:51:38 INFO - 'download_minidump_stackwalk': True, 08:51:38 INFO - 'download_symbols': 'ondemand', 08:51:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:51:38 INFO - 'tooltool.py': '/tools/tooltool.py', 08:51:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:51:38 INFO - '/tools/misc-python/virtualenv.py')}, 08:51:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:51:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:51:38 INFO - 'installer_path': 'installer.exe', 08:51:38 INFO - 'log_level': 'info', 08:51:38 INFO - 'log_name': 'talos', 08:51:38 INFO - 'log_to_console': True, 08:51:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:51:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:51:38 INFO - 'opt_config_files': (), 08:51:38 INFO - 'pip_index': False, 08:51:38 INFO - 'sps_profile': False, 08:51:38 INFO - 'sps_profile_interval': 0, 08:51:38 INFO - 'suite': 'dromaeojs', 08:51:38 INFO - 'system_bits': '32', 08:51:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:51:38 INFO - 'title': 'talos-linux64-ix-013', 08:51:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:51:38 INFO - 'use_talos_json': True, 08:51:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:51:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:51:38 INFO - 'work_dir': 'build'} 08:51:38 INFO - [mozharness: 2017-02-20 16:51:38.961047Z] Running clobber step. 08:51:38 INFO - Running pre-action listener: _resource_record_pre_action 08:51:38 INFO - Running main action method: clobber 08:51:38 INFO - rmtree: /builds/slave/test/build 08:51:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:51:39 INFO - Running post-action listener: _resource_record_post_action 08:51:39 INFO - [mozharness: 2017-02-20 16:51:39.413114Z] Finished clobber step (success) 08:51:39 INFO - [mozharness: 2017-02-20 16:51:39.413215Z] Running read-buildbot-config step. 08:51:39 INFO - Running pre-action listener: _resource_record_pre_action 08:51:39 INFO - Running main action method: read_buildbot_config 08:51:39 INFO - Using buildbot properties: 08:51:39 INFO - { 08:51:39 INFO - "project": "", 08:51:39 INFO - "product": "firefox", 08:51:39 INFO - "script_repo_revision": "production", 08:51:39 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 08:51:39 INFO - "repository": "", 08:51:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 08:51:39 INFO - "buildid": "20170220070057", 08:51:39 INFO - "pgo_build": "True", 08:51:39 INFO - "basedir": "/builds/slave/test", 08:51:39 INFO - "buildnumber": 147, 08:51:39 INFO - "slavename": "talos-linux64-ix-013", 08:51:39 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:51:39 INFO - "platform": "ubuntu64_hw", 08:51:39 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 08:51:39 INFO - "branch": "mozilla-beta", 08:51:39 INFO - "repo_path": "releases/mozilla-beta", 08:51:39 INFO - "revision": "3b31bcb88fe341172e93cc8b1143e617c0988694", 08:51:39 INFO - "stage_platform": "linux64-pgo", 08:51:39 INFO - "builduid": "59d38ecc375c4f3d8a75893d12924e50", 08:51:39 INFO - "slavebuilddir": "test" 08:51:39 INFO - } 08:51:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/D4GqBfJeShGxw6opEygDhg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 08:51:39 INFO - Running post-action listener: _resource_record_post_action 08:51:39 INFO - [mozharness: 2017-02-20 16:51:39.415670Z] Finished read-buildbot-config step (success) 08:51:39 INFO - [mozharness: 2017-02-20 16:51:39.415759Z] Running download-and-extract step. 08:51:39 INFO - Running pre-action listener: _resource_record_pre_action 08:51:39 INFO - Running main action method: download_and_extract 08:51:39 INFO - mkdir: /builds/slave/test/build/tests 08:51:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:39 INFO - trying https://queue.taskcluster.net/v1/task/D4GqBfJeShGxw6opEygDhg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 08:51:39 INFO - Downloading https://queue.taskcluster.net/v1/task/D4GqBfJeShGxw6opEygDhg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 08:51:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D4GqBfJeShGxw6opEygDhg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:51:39 INFO - Downloaded 1327 bytes. 08:51:39 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 08:51:39 INFO - Using the following test package requirements: 08:51:39 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 08:51:39 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 08:51:39 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 08:51:39 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 08:51:39 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 08:51:39 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 08:51:39 INFO - u'jsshell-linux-x86_64.zip'], 08:51:39 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 08:51:39 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 08:51:39 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 08:51:39 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 08:51:39 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 08:51:39 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 08:51:39 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 08:51:39 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 08:51:39 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 08:51:39 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 08:51:39 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 08:51:39 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:51:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D4GqBfJeShGxw6opEygDhg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 08:51:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D4GqBfJeShGxw6opEygDhg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:51:39 INFO - Fetch https://queue.taskcluster.net/v1/task/D4GqBfJeShGxw6opEygDhg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 08:51:40 INFO - Http code: 200 08:51:40 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 08:51:40 INFO - x-amz-cf-id: rwHQsBaboiLDGpzeo3B6yX-qUbsLjMCIoyj6ZhoHb4z20IWz48aI8Q== 08:51:40 INFO - x-amz-version-id: DQ1gDFDhepCnUYpfkE.JT24JlaMZwc_9 08:51:40 INFO - Expected file size: 21963902 08:51:40 INFO - Obtained file size: 21963902 08:51:44 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:51:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D4GqBfJeShGxw6opEygDhg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 08:51:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D4GqBfJeShGxw6opEygDhg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:51:44 INFO - Fetch https://queue.taskcluster.net/v1/task/D4GqBfJeShGxw6opEygDhg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 08:51:45 INFO - Http code: 200 08:51:45 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 08:51:45 INFO - x-amz-cf-id: pLxNtwNOqbvcEtZIzdNEkfk8AsmJ_L-vrOZxMhq2AbZSCinIMgY4Hw== 08:51:45 INFO - x-amz-version-id: DQ1gDFDhepCnUYpfkE.JT24JlaMZwc_9 08:51:45 INFO - Expected file size: 21963902 08:51:45 INFO - Obtained file size: 21963902 08:51:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D4GqBfJeShGxw6opEygDhg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 08:51:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D4GqBfJeShGxw6opEygDhg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:51:50 INFO - Fetch https://queue.taskcluster.net/v1/task/D4GqBfJeShGxw6opEygDhg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 08:51:50 INFO - Http code: 200 08:51:50 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 08:51:50 INFO - x-amz-cf-id: PwVOH31uW_ChdgN2EPJJ6UL3Ch0a_gRXcJTd6h-fsbs3k-1f87FjFA== 08:51:50 INFO - x-amz-version-id: xz2RQxXtOoUX1teBfKAFcH5kWHsjEWda 08:51:50 INFO - Expected file size: 14403005 08:51:50 INFO - Obtained file size: 14403005 08:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:51 INFO - trying https://queue.taskcluster.net/v1/task/D4GqBfJeShGxw6opEygDhg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 08:51:51 INFO - Downloading https://queue.taskcluster.net/v1/task/D4GqBfJeShGxw6opEygDhg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 08:51:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D4GqBfJeShGxw6opEygDhg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:51:52 INFO - Downloaded 57736271 bytes. 08:51:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D4GqBfJeShGxw6opEygDhg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 08:51:52 INFO - mkdir: /builds/slave/test/properties 08:51:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:51:52 INFO - Writing to file /builds/slave/test/properties/build_url 08:51:52 INFO - Contents: 08:51:52 INFO - build_url:https://queue.taskcluster.net/v1/task/D4GqBfJeShGxw6opEygDhg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 08:51:52 INFO - Running post-action listener: _resource_record_post_action 08:51:52 INFO - Running post-action listener: set_extra_try_arguments 08:51:52 INFO - [mozharness: 2017-02-20 16:51:52.874312Z] Finished download-and-extract step (success) 08:51:52 INFO - [mozharness: 2017-02-20 16:51:52.874538Z] Running populate-webroot step. 08:51:52 INFO - Running pre-action listener: _resource_record_pre_action 08:51:52 INFO - Running main action method: populate_webroot 08:51:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:51:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:51:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:51:52 INFO - '--tppagecycles', 08:51:52 INFO - '7'], 08:51:52 INFO - 'tests': ['tsvgm']}}, 08:51:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:51:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:51:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:51:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:51:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:51:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:51:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:52 INFO - 'talos_options': ['--disable-e10s'], 08:51:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:51:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:51:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:52 INFO - 'talos_options': ['--disable-e10s'], 08:51:52 INFO - 'tests': ['damp', 'tps']}, 08:51:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:52 INFO - 'tests': ['damp', 'tps']}, 08:51:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:51:52 INFO - 'tests': ['dromaeo_dom']}, 08:51:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:51:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:51:52 INFO - 'tests': ['basic_compositor_video']}, 08:51:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:51:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:51:52 INFO - 'tests': ['a11yr', 08:51:52 INFO - 'ts_paint', 08:51:52 INFO - 'tpaint', 08:51:52 INFO - 'sessionrestore', 08:51:52 INFO - 'sessionrestore_no_auto_restore', 08:51:52 INFO - 'tabpaint']}, 08:51:52 INFO - 'other-e10s': {'tests': ['a11yr', 08:51:52 INFO - 'ts_paint', 08:51:52 INFO - 'tpaint', 08:51:52 INFO - 'sessionrestore', 08:51:52 INFO - 'sessionrestore_no_auto_restore', 08:51:52 INFO - 'tabpaint']}, 08:51:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:51:52 INFO - 'ts_paint', 08:51:52 INFO - 'tpaint', 08:51:52 INFO - 'sessionrestore', 08:51:52 INFO - 'sessionrestore_no_auto_restore', 08:51:52 INFO - 'tabpaint']}, 08:51:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:51:52 INFO - 'ts_paint', 08:51:52 INFO - 'tpaint', 08:51:52 INFO - 'sessionrestore', 08:51:52 INFO - 'sessionrestore_no_auto_restore', 08:51:52 INFO - 'tabpaint']}, 08:51:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:51:52 INFO - 'tests': ['a11yr', 08:51:52 INFO - 'ts_paint', 08:51:52 INFO - 'tpaint', 08:51:52 INFO - 'sessionrestore', 08:51:52 INFO - 'sessionrestore_no_auto_restore', 08:51:52 INFO - 'tabpaint']}, 08:51:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:51:52 INFO - 'tests': ['a11yr', 08:51:52 INFO - 'ts_paint', 08:51:52 INFO - 'tpaint', 08:51:52 INFO - 'sessionrestore', 08:51:52 INFO - 'sessionrestore_no_auto_restore', 08:51:52 INFO - 'tabpaint']}, 08:51:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:51:52 INFO - 'tests': ['tsvgx', 08:51:52 INFO - 'tsvgr_opacity', 08:51:52 INFO - 'tart', 08:51:52 INFO - 'tscrollx', 08:51:52 INFO - 'cart']}, 08:51:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:51:52 INFO - 'tsvgr_opacity', 08:51:52 INFO - 'tart', 08:51:52 INFO - 'tscrollx', 08:51:52 INFO - 'cart']}, 08:51:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:52 INFO - 'talos_options': ['--disable-e10s'], 08:51:52 INFO - 'tests': ['tp5o']}, 08:51:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:52 INFO - 'tests': ['tp5o']}, 08:51:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:52 INFO - 'talos_options': ['--disable-e10s', 08:51:52 INFO - '--xperf_path', 08:51:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:51:52 INFO - 'tests': ['tp5n']}, 08:51:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:52 INFO - 'talos_options': ['--xperf_path', 08:51:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:51:52 INFO - 'tests': ['tp5n']}}, 08:51:52 INFO - 'talos.zip': {'path': '', 08:51:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:51:52 INFO - Running post-action listener: _resource_record_post_action 08:51:52 INFO - [mozharness: 2017-02-20 16:51:52.892140Z] Finished populate-webroot step (success) 08:51:52 INFO - [mozharness: 2017-02-20 16:51:52.892228Z] Running create-virtualenv step. 08:51:52 INFO - Running pre-action listener: _resource_record_pre_action 08:51:52 INFO - Running main action method: create_virtualenv 08:51:52 INFO - Creating virtualenv /builds/slave/test/build/venv 08:51:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:51:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:51:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:51:53 INFO - Using real prefix '/usr' 08:51:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:51:53 INFO - Installing distribute.............................................................................................................................................................................................done. 08:51:55 INFO - Installing pip.................done. 08:51:55 INFO - Return code: 0 08:51:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:51:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:51:55 INFO - Reading from file tmpfile_stdout 08:51:55 INFO - Output received: 08:51:55 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:51:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:51:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe092d46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12bbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b8f60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ba1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1487608364.973979-562395971', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:51:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:51:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:51:55 INFO - Using env: {'DISPLAY': ':0', 08:51:55 INFO - 'HOME': '/home/cltbld', 08:51:55 INFO - 'LANG': 'en_US.UTF-8', 08:51:55 INFO - 'LANGUAGE': 'en_US:en', 08:51:55 INFO - 'LOGNAME': 'cltbld', 08:51:55 INFO - 'MAIL': '/var/mail/cltbld', 08:51:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:55 INFO - 'MOZ_NO_REMOTE': '1', 08:51:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:55 INFO - 'NO_EM_RESTART': '1', 08:51:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:55 INFO - 'PWD': '/builds/slave/test', 08:51:55 INFO - 'SHELL': '/bin/bash', 08:51:55 INFO - 'SHLVL': '1', 08:51:55 INFO - 'TERM': 'linux', 08:51:55 INFO - 'TMOUT': '86400', 08:51:55 INFO - 'USER': 'cltbld', 08:51:55 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1487608364.973979-562395971', 08:51:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:55 INFO - '_': '/tools/buildbot/bin/python'} 08:51:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:51:55 INFO - Cleaning up... 08:51:55 INFO - Return code: 0 08:51:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:51:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe092d46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12bbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b8f60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ba1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1487608364.973979-562395971', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:51:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:51:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:51:56 INFO - Using env: {'DISPLAY': ':0', 08:51:56 INFO - 'HOME': '/home/cltbld', 08:51:56 INFO - 'LANG': 'en_US.UTF-8', 08:51:56 INFO - 'LANGUAGE': 'en_US:en', 08:51:56 INFO - 'LOGNAME': 'cltbld', 08:51:56 INFO - 'MAIL': '/var/mail/cltbld', 08:51:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:56 INFO - 'MOZ_NO_REMOTE': '1', 08:51:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:56 INFO - 'NO_EM_RESTART': '1', 08:51:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:56 INFO - 'PWD': '/builds/slave/test', 08:51:56 INFO - 'SHELL': '/bin/bash', 08:51:56 INFO - 'SHLVL': '1', 08:51:56 INFO - 'TERM': 'linux', 08:51:56 INFO - 'TMOUT': '86400', 08:51:56 INFO - 'USER': 'cltbld', 08:51:56 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1487608364.973979-562395971', 08:51:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:56 INFO - '_': '/tools/buildbot/bin/python'} 08:51:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:56 INFO - Downloading/unpacking psutil>=3.1.1 08:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:51:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:51:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:51:58 INFO - Installing collected packages: psutil 08:51:58 INFO - Running setup.py install for psutil 08:51:58 INFO - building 'psutil._psutil_linux' extension 08:51:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:51:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:51:58 INFO - building 'psutil._psutil_posix' extension 08:51:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:51:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:51:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:51:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:51:58 INFO - Successfully installed psutil 08:51:58 INFO - Cleaning up... 08:51:59 INFO - Return code: 0 08:51:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:51:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe092d46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12bbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b8f60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ba1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1487608364.973979-562395971', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:51:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:51:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:51:59 INFO - Using env: {'DISPLAY': ':0', 08:51:59 INFO - 'HOME': '/home/cltbld', 08:51:59 INFO - 'LANG': 'en_US.UTF-8', 08:51:59 INFO - 'LANGUAGE': 'en_US:en', 08:51:59 INFO - 'LOGNAME': 'cltbld', 08:51:59 INFO - 'MAIL': '/var/mail/cltbld', 08:51:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:59 INFO - 'MOZ_NO_REMOTE': '1', 08:51:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:59 INFO - 'NO_EM_RESTART': '1', 08:51:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:59 INFO - 'PWD': '/builds/slave/test', 08:51:59 INFO - 'SHELL': '/bin/bash', 08:51:59 INFO - 'SHLVL': '1', 08:51:59 INFO - 'TERM': 'linux', 08:51:59 INFO - 'TMOUT': '86400', 08:51:59 INFO - 'USER': 'cltbld', 08:51:59 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1487608364.973979-562395971', 08:51:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:59 INFO - '_': '/tools/buildbot/bin/python'} 08:51:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:52:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:52:01 INFO - Installing collected packages: mozsystemmonitor 08:52:01 INFO - Running setup.py install for mozsystemmonitor 08:52:01 INFO - Successfully installed mozsystemmonitor 08:52:01 INFO - Cleaning up... 08:52:01 INFO - Return code: 0 08:52:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:52:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe092d46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12bbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b8f60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ba1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1487608364.973979-562395971', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:52:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:52:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:52:01 INFO - Using env: {'DISPLAY': ':0', 08:52:01 INFO - 'HOME': '/home/cltbld', 08:52:01 INFO - 'LANG': 'en_US.UTF-8', 08:52:01 INFO - 'LANGUAGE': 'en_US:en', 08:52:01 INFO - 'LOGNAME': 'cltbld', 08:52:01 INFO - 'MAIL': '/var/mail/cltbld', 08:52:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:01 INFO - 'MOZ_NO_REMOTE': '1', 08:52:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:01 INFO - 'NO_EM_RESTART': '1', 08:52:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:01 INFO - 'PWD': '/builds/slave/test', 08:52:01 INFO - 'SHELL': '/bin/bash', 08:52:01 INFO - 'SHLVL': '1', 08:52:01 INFO - 'TERM': 'linux', 08:52:01 INFO - 'TMOUT': '86400', 08:52:01 INFO - 'USER': 'cltbld', 08:52:01 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1487608364.973979-562395971', 08:52:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:01 INFO - '_': '/tools/buildbot/bin/python'} 08:52:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:01 INFO - Downloading/unpacking jsonschema==2.5.1 08:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:52:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:04 INFO - Downloading functools32-3.2.3-2.tar.gz 08:52:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:52:04 INFO - warning: no files found matching '*.txt' 08:52:04 INFO - no previously-included directories found matching 'build' 08:52:04 INFO - no previously-included directories found matching 'dist' 08:52:04 INFO - no previously-included directories found matching '.git*' 08:52:04 INFO - Installing collected packages: jsonschema, functools32 08:52:04 INFO - Running setup.py install for functools32 08:52:04 INFO - warning: no files found matching '*.txt' 08:52:04 INFO - no previously-included directories found matching 'build' 08:52:04 INFO - no previously-included directories found matching 'dist' 08:52:04 INFO - no previously-included directories found matching '.git*' 08:52:04 INFO - Successfully installed jsonschema functools32 08:52:04 INFO - Cleaning up... 08:52:04 INFO - Return code: 0 08:52:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:52:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe092d46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12bbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b8f60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ba1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1487608364.973979-562395971', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:52:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:52:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:52:04 INFO - Using env: {'DISPLAY': ':0', 08:52:04 INFO - 'HOME': '/home/cltbld', 08:52:04 INFO - 'LANG': 'en_US.UTF-8', 08:52:04 INFO - 'LANGUAGE': 'en_US:en', 08:52:04 INFO - 'LOGNAME': 'cltbld', 08:52:04 INFO - 'MAIL': '/var/mail/cltbld', 08:52:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:04 INFO - 'MOZ_NO_REMOTE': '1', 08:52:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:04 INFO - 'NO_EM_RESTART': '1', 08:52:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:04 INFO - 'PWD': '/builds/slave/test', 08:52:04 INFO - 'SHELL': '/bin/bash', 08:52:04 INFO - 'SHLVL': '1', 08:52:04 INFO - 'TERM': 'linux', 08:52:04 INFO - 'TMOUT': '86400', 08:52:04 INFO - 'USER': 'cltbld', 08:52:04 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1487608364.973979-562395971', 08:52:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:04 INFO - '_': '/tools/buildbot/bin/python'} 08:52:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:52:04 INFO - Cleaning up... 08:52:04 INFO - Return code: 0 08:52:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:52:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe092d46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12bbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b8f60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ba1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1487608364.973979-562395971', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:52:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:52:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:52:04 INFO - Using env: {'DISPLAY': ':0', 08:52:04 INFO - 'HOME': '/home/cltbld', 08:52:04 INFO - 'LANG': 'en_US.UTF-8', 08:52:04 INFO - 'LANGUAGE': 'en_US:en', 08:52:04 INFO - 'LOGNAME': 'cltbld', 08:52:04 INFO - 'MAIL': '/var/mail/cltbld', 08:52:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:04 INFO - 'MOZ_NO_REMOTE': '1', 08:52:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:04 INFO - 'NO_EM_RESTART': '1', 08:52:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:04 INFO - 'PWD': '/builds/slave/test', 08:52:04 INFO - 'SHELL': '/bin/bash', 08:52:04 INFO - 'SHLVL': '1', 08:52:04 INFO - 'TERM': 'linux', 08:52:04 INFO - 'TMOUT': '86400', 08:52:04 INFO - 'USER': 'cltbld', 08:52:04 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1487608364.973979-562395971', 08:52:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:04 INFO - '_': '/tools/buildbot/bin/python'} 08:52:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:04 INFO - Downloading/unpacking blobuploader==1.2.4 08:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:06 INFO - Downloading blobuploader-1.2.4.tar.gz 08:52:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:52:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:52:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:52:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:07 INFO - Downloading docopt-0.6.1.tar.gz 08:52:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:52:07 INFO - Installing collected packages: blobuploader, requests, docopt 08:52:07 INFO - Running setup.py install for blobuploader 08:52:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:52:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:52:07 INFO - Running setup.py install for requests 08:52:08 INFO - Running setup.py install for docopt 08:52:08 INFO - Successfully installed blobuploader requests docopt 08:52:08 INFO - Cleaning up... 08:52:08 INFO - Return code: 0 08:52:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe092d46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12bbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b8f60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ba1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1487608364.973979-562395971', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:52:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:52:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:52:08 INFO - Using env: {'DISPLAY': ':0', 08:52:08 INFO - 'HOME': '/home/cltbld', 08:52:08 INFO - 'LANG': 'en_US.UTF-8', 08:52:08 INFO - 'LANGUAGE': 'en_US:en', 08:52:08 INFO - 'LOGNAME': 'cltbld', 08:52:08 INFO - 'MAIL': '/var/mail/cltbld', 08:52:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:08 INFO - 'MOZ_NO_REMOTE': '1', 08:52:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:08 INFO - 'NO_EM_RESTART': '1', 08:52:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:08 INFO - 'PWD': '/builds/slave/test', 08:52:08 INFO - 'SHELL': '/bin/bash', 08:52:08 INFO - 'SHLVL': '1', 08:52:08 INFO - 'TERM': 'linux', 08:52:08 INFO - 'TMOUT': '86400', 08:52:08 INFO - 'USER': 'cltbld', 08:52:08 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1487608364.973979-562395971', 08:52:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:08 INFO - '_': '/tools/buildbot/bin/python'} 08:52:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:52:08 INFO - Running setup.py (path:/tmp/pip-T1k8wy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:52:08 INFO - Running setup.py (path:/tmp/pip-cu0LDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:52:08 INFO - Running setup.py (path:/tmp/pip-bDLURU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:52:08 INFO - Running setup.py (path:/tmp/pip-2vLdms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:52:08 INFO - Running setup.py (path:/tmp/pip-lAmE4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:52:08 INFO - Running setup.py (path:/tmp/pip-w3RR6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:52:08 INFO - Running setup.py (path:/tmp/pip-7c_uIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:52:08 INFO - Running setup.py (path:/tmp/pip-cxjDut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:52:09 INFO - Running setup.py (path:/tmp/pip-3_j_Ie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:52:09 INFO - Running setup.py (path:/tmp/pip-ayd3Xm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:52:09 INFO - Running setup.py (path:/tmp/pip-fpxzBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:52:09 INFO - Running setup.py (path:/tmp/pip-0CN1l3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:52:09 INFO - Running setup.py (path:/tmp/pip-UUParG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:52:09 INFO - Running setup.py (path:/tmp/pip-OSuofz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:52:09 INFO - Running setup.py (path:/tmp/pip-I8hfC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:52:09 INFO - Running setup.py (path:/tmp/pip-mzm__s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:52:09 INFO - Running setup.py (path:/tmp/pip-56EQ0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:52:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:52:09 INFO - Running setup.py install for manifestparser 08:52:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:52:09 INFO - Running setup.py install for mozcrash 08:52:09 INFO - Running setup.py install for mozdebug 08:52:09 INFO - Running setup.py install for mozdevice 08:52:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:52:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:52:10 INFO - Running setup.py install for mozfile 08:52:10 INFO - Running setup.py install for mozhttpd 08:52:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:52:10 INFO - Running setup.py install for mozinfo 08:52:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:52:10 INFO - Running setup.py install for mozInstall 08:52:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:52:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:52:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:52:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:52:10 INFO - Running setup.py install for mozleak 08:52:10 INFO - Running setup.py install for mozlog 08:52:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:52:10 INFO - Running setup.py install for moznetwork 08:52:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:52:10 INFO - Running setup.py install for mozprocess 08:52:10 INFO - Running setup.py install for mozprofile 08:52:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:52:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:52:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:52:11 INFO - Running setup.py install for mozrunner 08:52:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:52:11 INFO - Running setup.py install for mozscreenshot 08:52:11 INFO - Running setup.py install for moztest 08:52:11 INFO - Running setup.py install for mozversion 08:52:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:52:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:52:11 INFO - Cleaning up... 08:52:11 INFO - Return code: 0 08:52:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:52:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe092d46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12bbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b8f60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ba1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1487608364.973979-562395971', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:52:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:52:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:52:11 INFO - Using env: {'DISPLAY': ':0', 08:52:11 INFO - 'HOME': '/home/cltbld', 08:52:11 INFO - 'LANG': 'en_US.UTF-8', 08:52:11 INFO - 'LANGUAGE': 'en_US:en', 08:52:11 INFO - 'LOGNAME': 'cltbld', 08:52:11 INFO - 'MAIL': '/var/mail/cltbld', 08:52:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:11 INFO - 'MOZ_NO_REMOTE': '1', 08:52:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:11 INFO - 'NO_EM_RESTART': '1', 08:52:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:11 INFO - 'PWD': '/builds/slave/test', 08:52:11 INFO - 'SHELL': '/bin/bash', 08:52:11 INFO - 'SHLVL': '1', 08:52:11 INFO - 'TERM': 'linux', 08:52:11 INFO - 'TMOUT': '86400', 08:52:11 INFO - 'USER': 'cltbld', 08:52:11 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1487608364.973979-562395971', 08:52:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:11 INFO - '_': '/tools/buildbot/bin/python'} 08:52:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:52:11 INFO - Running setup.py (path:/tmp/pip-p2uj3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:52:11 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:52:11 INFO - Running setup.py (path:/tmp/pip-qRJNeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:52:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:52:11 INFO - Running setup.py (path:/tmp/pip-EJ7JuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:52:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:52:11 INFO - Running setup.py (path:/tmp/pip-2RZ17l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:52:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:52:11 INFO - Running setup.py (path:/tmp/pip-iHbI88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:52:12 INFO - Running setup.py (path:/tmp/pip-3oq71B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:52:12 INFO - Running setup.py (path:/tmp/pip-MPPvdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:52:12 INFO - Running setup.py (path:/tmp/pip-ctVSq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:52:12 INFO - Running setup.py (path:/tmp/pip-yXydUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:52:12 INFO - Running setup.py (path:/tmp/pip-tpNltf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:52:12 INFO - Running setup.py (path:/tmp/pip-EPElph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:52:12 INFO - Running setup.py (path:/tmp/pip-P7QOhf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:52:12 INFO - Running setup.py (path:/tmp/pip-i5I84M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:52:12 INFO - Running setup.py (path:/tmp/pip-LSbhFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:52:12 INFO - Running setup.py (path:/tmp/pip-g30F6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:52:12 INFO - Running setup.py (path:/tmp/pip-yHNh9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:52:12 INFO - Running setup.py (path:/tmp/pip-XNLYC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:52:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:14 INFO - Downloading blessings-1.6.tar.gz 08:52:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:52:15 INFO - Installing collected packages: blessings 08:52:15 INFO - Running setup.py install for blessings 08:52:15 INFO - Successfully installed blessings 08:52:15 INFO - Cleaning up... 08:52:15 INFO - Return code: 0 08:52:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:52:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:52:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:52:15 INFO - Reading from file tmpfile_stdout 08:52:15 INFO - Current package versions: 08:52:15 INFO - argparse == 1.2.1 08:52:15 INFO - blessings == 1.6 08:52:15 INFO - blobuploader == 1.2.4 08:52:15 INFO - docopt == 0.6.1 08:52:15 INFO - functools32 == 3.2.3-2 08:52:15 INFO - jsonschema == 2.5.1 08:52:15 INFO - manifestparser == 1.1 08:52:15 INFO - mozInstall == 1.12 08:52:15 INFO - mozcrash == 1.0 08:52:15 INFO - mozdebug == 0.1 08:52:15 INFO - mozdevice == 0.48 08:52:15 INFO - mozfile == 1.2 08:52:15 INFO - mozhttpd == 0.7 08:52:15 INFO - mozinfo == 0.9 08:52:15 INFO - mozleak == 0.1 08:52:15 INFO - mozlog == 3.4 08:52:15 INFO - moznetwork == 0.27 08:52:15 INFO - mozprocess == 0.23 08:52:15 INFO - mozprofile == 0.28 08:52:15 INFO - mozrunner == 6.13 08:52:15 INFO - mozscreenshot == 0.1 08:52:15 INFO - mozsystemmonitor == 0.3 08:52:15 INFO - moztest == 0.8 08:52:15 INFO - mozversion == 1.4 08:52:15 INFO - psutil == 3.1.1 08:52:15 INFO - requests == 1.2.3 08:52:15 INFO - wsgiref == 0.1.2 08:52:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:52:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe092d46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12bbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b8f60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ba1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1487608364.973979-562395971', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:52:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:52:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:52:15 INFO - Using env: {'DISPLAY': ':0', 08:52:15 INFO - 'HOME': '/home/cltbld', 08:52:15 INFO - 'LANG': 'en_US.UTF-8', 08:52:15 INFO - 'LANGUAGE': 'en_US:en', 08:52:15 INFO - 'LOGNAME': 'cltbld', 08:52:15 INFO - 'MAIL': '/var/mail/cltbld', 08:52:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:15 INFO - 'MOZ_NO_REMOTE': '1', 08:52:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:15 INFO - 'NO_EM_RESTART': '1', 08:52:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:15 INFO - 'PWD': '/builds/slave/test', 08:52:15 INFO - 'SHELL': '/bin/bash', 08:52:15 INFO - 'SHLVL': '1', 08:52:15 INFO - 'TERM': 'linux', 08:52:15 INFO - 'TMOUT': '86400', 08:52:15 INFO - 'USER': 'cltbld', 08:52:15 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1487608364.973979-562395971', 08:52:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:15 INFO - '_': '/tools/buildbot/bin/python'} 08:52:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:52:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:52:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:52:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:52:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:52:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:52:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:52:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:52:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:52:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:52:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:52:15 INFO - Cleaning up... 08:52:15 INFO - Return code: 0 08:52:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:52:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe092d46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12bbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b8f60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ba1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1487608364.973979-562395971', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:52:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:52:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:52:15 INFO - Using env: {'DISPLAY': ':0', 08:52:15 INFO - 'HOME': '/home/cltbld', 08:52:15 INFO - 'LANG': 'en_US.UTF-8', 08:52:15 INFO - 'LANGUAGE': 'en_US:en', 08:52:15 INFO - 'LOGNAME': 'cltbld', 08:52:15 INFO - 'MAIL': '/var/mail/cltbld', 08:52:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:15 INFO - 'MOZ_NO_REMOTE': '1', 08:52:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:15 INFO - 'NO_EM_RESTART': '1', 08:52:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:15 INFO - 'PWD': '/builds/slave/test', 08:52:15 INFO - 'SHELL': '/bin/bash', 08:52:15 INFO - 'SHLVL': '1', 08:52:15 INFO - 'TERM': 'linux', 08:52:15 INFO - 'TMOUT': '86400', 08:52:15 INFO - 'USER': 'cltbld', 08:52:15 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1487608364.973979-562395971', 08:52:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:15 INFO - '_': '/tools/buildbot/bin/python'} 08:52:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:52:15 INFO - Cleaning up... 08:52:15 INFO - Return code: 0 08:52:15 INFO - Running post-action listener: _resource_record_post_action 08:52:15 INFO - Running post-action listener: _start_resource_monitoring 08:52:15 INFO - Starting resource monitoring. 08:52:15 INFO - [mozharness: 2017-02-20 16:52:15.927289Z] Finished create-virtualenv step (success) 08:52:15 INFO - [mozharness: 2017-02-20 16:52:15.927835Z] Running install step. 08:52:15 INFO - Running pre-action listener: _resource_record_pre_action 08:52:15 INFO - Running main action method: install 08:52:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:52:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:52:16 INFO - Reading from file tmpfile_stdout 08:52:16 INFO - Detecting whether we're running mozinstall >=1.0... 08:52:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:52:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:52:16 INFO - Reading from file tmpfile_stdout 08:52:16 INFO - Output received: 08:52:16 INFO - Usage: mozinstall [options] installer 08:52:16 INFO - Options: 08:52:16 INFO - -h, --help show this help message and exit 08:52:16 INFO - -d DEST, --destination=DEST 08:52:16 INFO - Directory to install application into. [default: 08:52:16 INFO - "/builds/slave/test"] 08:52:16 INFO - --app=APP Application being installed. [default: firefox] 08:52:16 INFO - mkdir: /builds/slave/test/build/application 08:52:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:52:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:52:29 INFO - Reading from file tmpfile_stdout 08:52:29 INFO - Output received: 08:52:29 INFO - /builds/slave/test/build/application/firefox/firefox 08:52:29 INFO - Running post-action listener: _resource_record_post_action 08:52:29 INFO - [mozharness: 2017-02-20 16:52:29.859717Z] Finished install step (success) 08:52:29 INFO - [mozharness: 2017-02-20 16:52:29.859963Z] Running run-tests step. 08:52:29 INFO - Running pre-action listener: _resource_record_pre_action 08:52:29 INFO - Running main action method: run_tests 08:52:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:52:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:52:29 INFO - Python 2.7.3 08:52:29 INFO - Return code: 0 08:52:29 INFO - grabbing minidump binary from tooltool 08:52:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:29 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b8f60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ba1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:52:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:52:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:52:29 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:52:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:52:29 INFO - Return code: 0 08:52:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:52:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:52:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:52:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:52:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:52:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D4GqBfJeShGxw6opEygDhg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:52:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/D4GqBfJeShGxw6opEygDhg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:52:29 INFO - Using env: {'DISPLAY': ':0', 08:52:29 INFO - 'HOME': '/home/cltbld', 08:52:29 INFO - 'LANG': 'en_US.UTF-8', 08:52:29 INFO - 'LANGUAGE': 'en_US:en', 08:52:29 INFO - 'LOGNAME': 'cltbld', 08:52:29 INFO - 'MAIL': '/var/mail/cltbld', 08:52:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:52:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:52:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:29 INFO - 'MOZ_NO_REMOTE': '1', 08:52:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:52:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:29 INFO - 'NO_EM_RESTART': '1', 08:52:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:29 INFO - 'PWD': '/builds/slave/test', 08:52:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:52:29 INFO - 'SHELL': '/bin/bash', 08:52:29 INFO - 'SHLVL': '1', 08:52:29 INFO - 'TERM': 'linux', 08:52:29 INFO - 'TMOUT': '86400', 08:52:29 INFO - 'USER': 'cltbld', 08:52:29 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1487608364.973979-562395971', 08:52:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:29 INFO - '_': '/tools/buildbot/bin/python'} 08:52:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D4GqBfJeShGxw6opEygDhg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:52:30 INFO - mozversion application_buildid: 20170220070057 08:52:30 INFO - mozversion application_changeset: 3b31bcb88fe341172e93cc8b1143e617c0988694 08:52:30 INFO - mozversion application_display_name: Firefox 08:52:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:52:30 INFO - mozversion application_name: Firefox 08:52:30 INFO - mozversion application_remotingname: firefox 08:52:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:52:30 INFO - mozversion application_vendor: Mozilla 08:52:30 INFO - mozversion application_version: 52.0 08:52:30 INFO - mozversion platform_buildid: 20170220070057 08:52:30 INFO - mozversion platform_changeset: 3b31bcb88fe341172e93cc8b1143e617c0988694 08:52:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:52:30 INFO - mozversion platform_version: 52.0 08:52:30 INFO - using testdate: 1487609550 08:52:30 INFO - actual date: 1487609550 08:52:30 INFO - starting webserver on 'localhost:57875' 08:52:30 INFO - SUITE-START | Running 2 tests 08:52:30 INFO - TEST-START | dromaeo_css 08:52:30 INFO - operating with platform_type : linux_ 08:52:30 INFO - Initialising browser for dromaeo_css test... 08:52:30 INFO - TEST-INFO | started process 27459 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwX_kTL/profile http://localhost:57875/getInfo.html) 08:52:33 INFO - PROCESS | 27459 | __metrics Screen width/height:1600/1200 08:52:33 INFO - PROCESS | 27459 | colorDepth:24 08:52:33 INFO - PROCESS | 27459 | Browser inner width/height: 1024/697 08:52:33 INFO - PROCESS | 27459 | __metrics 08:52:34 INFO - PROCESS | 27459 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:52:34 INFO - PROCESS | 27459 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:52:35 INFO - TEST-INFO | 27459: exit 0 08:52:35 INFO - Browser initialized. 08:52:35 INFO - Running cycle 1/1 for dromaeo_css test... 08:52:35 INFO - TEST-INFO | started process 27550 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwX_kTL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:52:47 INFO - PROCESS | 27550 | RSS: Main: 141840384 08:52:47 INFO - PROCESS | 27550 | 08:55:48 INFO - PROCESS | 27550 | Cycle 1(1): loaded http://localhost:57875/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57875/tests/dromaeo/cssquery-ext.html) 08:55:50 INFO - PROCESS | 27550 | RSS: Main: 248786944 08:55:50 INFO - PROCESS | 27550 | 08:58:52 INFO - PROCESS | 27550 | Cycle 1(1): loaded http://localhost:57875/tests/dromaeo/cssquery-ext.html (next: http://localhost:57875/tests/dromaeo/cssquery-jquery.html) 08:58:53 INFO - PROCESS | 27550 | RSS: Main: 236793856 08:58:53 INFO - PROCESS | 27550 | 09:01:55 INFO - PROCESS | 27550 | Cycle 1(1): loaded http://localhost:57875/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57875/tests/dromaeo/cssquery-mootools.html) 09:01:55 INFO - PROCESS | 27550 | RSS: Main: 233185280 09:01:55 INFO - PROCESS | 27550 | 09:04:57 INFO - PROCESS | 27550 | Cycle 1(1): loaded http://localhost:57875/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57875/tests/dromaeo/cssquery-prototype.html) 09:04:58 INFO - PROCESS | 27550 | RSS: Main: 203739136 09:04:58 INFO - PROCESS | 27550 | 09:08:00 INFO - PROCESS | 27550 | Cycle 1(1): loaded http://localhost:57875/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57875/tests/dromaeo/cssquery-yui.html) 09:08:01 INFO - PROCESS | 27550 | RSS: Main: 174567424 09:08:01 INFO - PROCESS | 27550 | 09:11:03 INFO - PROCESS | 27550 | Cycle 1(1): loaded http://localhost:57875/tests/dromaeo/cssquery-yui.html (next: http://localhost:57875/tests/dromaeo/cssquery-dojo.html) 09:11:04 INFO - PROCESS | 27550 | RSS: Main: 266895360 09:11:04 INFO - PROCESS | 27550 | 09:11:04 INFO - PROCESS | 27550 | __start_tp_report 09:11:04 INFO - PROCESS | 27550 | _x_x_mozilla_page_load 09:11:04 INFO - PROCESS | 27550 | _x_x_mozilla_page_load_details 09:11:04 INFO - PROCESS | 27550 | |i|pagename|runs| 09:11:04 INFO - PROCESS | 27550 | |0;dojo.html;3191.4095892259934;3220.420324341619;3224.3551289742045;3233.482642777153;3273.1817045738567;5568.415316391776;5648.717564121798;5661.915071273929;5661.943380566193;5662.150677398392;5548.639338442998;5631.211630371751;5636.408177141392;5642.463965923241;5668.064769313069;5086.567641750456;5107.948920510803;5118.6416950813455;5145.716985565792;5178.559822415099;5013.022460620181;5031.371078615173;5187.144121219994;5202.271681964528;5214.348206474191;5015.799368025275;5031.22016087507;5073.4926507349155;5075.568576670969;5096.821611243608;5097.643164978453;5127.769250383742;5185.351831021122;5185.481451854822;5203.03743807393;4931.531504507102;4947.678400903929;5075.543201111881;5093.719845408501;5139.7687104080405;5451.155070964007;5478.506934375925;5495.175723641446;5498.230247765316;5517.917231241535;5899.970500147515;5945.375735547748;5994.940050599525;5995;5995.46040856325;5827.184194212814;5902.675352855591;6017.7592896284095;6018.638881667071;6038.818835434944;5534.1145416733125;5569.470900264469;5579.330480342385;5618.297712785902;5649.180868774005;6175.073738939195;6180.443760061616;6186;6188.44304012632;6188.9788184948975;5680.11958146488;5741.741621627037;5903.321118071391;5909.084091965752;5924.940750592526;5860.062390017577;5911.9113213301835;5917.46742793142;5982.970085149546;6016.42843929826;5958.702064896738;5967.850803729942;5973.283206015306;5973.342932277446;5974.551908606872;5724.856878577985;5897.911531327033;5965.28416590012;5968.970155149196;5989.880202395928;4517.593416592456;4546.977265113719;4566.018306064212;4570.063137056895;4630.745309008037;4080.6735461163034;4112.588741125864;4113;4114.6091121343425;4134.1731653669385;5664.20701101846;5679.77280908759;5682.573806964494;5684.005299072728;5715.628484148517;5828.184054232411;5892.882142357129;5901.793437229677;5905.498032667271;5953.374895635982;5706.857328566819;5715.5427565794635;5716.628419152825;5718.599698021098;5737.340205876294;5049.6212784041345;5061.746912654353;5066;5066.797328106834;5091.66904151229;6001;6065.332813390435;6095.9390406097145;6115.235595550556;6248.343923888017;5987.970060149845;5988.940110598838;5993.011153159854;6014.729337179925;6022.789202377896;6182.196314479269;6182.505399568114;6185.6907154641185;6197.845053873689;6203.689815509297;5651.971740141273;5669.177969194361;5806;5872.677002764889;5877.764889404376;5891.823245302648;6004.489618382487;6006.129111278928;6031.75872965094;6034.8793024138395;5791.218185545066;5837.474627283565;5843.2403787507355;5844.912326315024;5854.385289544707;5624.521915637217;5630.662160270397;5820.126980952891;5825.0679891217205;5827.125931110198;5672.517835983987;5705.971470142623;5721.370649228498;5783.566232532493;5811.912821307768;5909.556783241188;5910.970445147746;5913.46778789911;5913.58604897653;5925.614835035709;5597.692126933058;5621.409751975983;5654.519365853948;5669.886602267849;5738.9139162913425 09:11:04 INFO - PROCESS | 27550 | |1;ext.html;574.4743559642927;602.8071017274473;624.5940138909708;645.8546826963931;665.1087542692791;34421.655783442155;37518.81240593797;43689.12621747567;44650.33024504635;44922.77538612302;45589;45966;46018.53981460193;46062.53937460625;46084.76957615215;8903.198712115924;9035.367524273304;9050.773730656754;9052.230560402373;9054.094590540926;8381.706640267592;8550.486970781742;8572.057073721886;8844.248238899669;8978.820423591524;10548;10818;10829.945850270738;11107.777844443146;11131.554737810478;10878.075363594104;10939.398333091676;10952.34285942846;10960.890391096067;10963.068139208177;10795.352278863214;10847.891521084766;10861.1854110942;10863.945680271627;10874.18443616732;44952.3257151143;45101;45177.774111129234;45317.54682453166;45350.31974520385;3518.102883764649;3564.946525802115;3629.2560025195035;4065;4269.124829409963;32408.6759132408;32523.674763252537;33040.33919321624;33356.833215833765;33435.16412089693;3905.5899130591165;3913.726039177259;4074.490688663917;4114.485689288839;4123.402106694542;322578;324889;326963;327180;327615.36192319123;38813.61186388157;39801;64652.67673661601;64708;64935;41001.35994560184;41298;41302.58697413048;41305.173896521905;41370.586294137276;17478.65042699139;17642.47072587799;17644.206010729547;17644.382446614305;17653.293868245128;14940.402383904522;15044.097354158786;15055.171965541782;15056.774148387783;15061;9025.909740902507;9237.353385262966;9288.442693438416;9625.903740962642;9652.372595781251;3581.8925432237074;3592.5688917329567;3609.909752256162;3620.022593899685;3694.7413681042067;994.8706668133241;1050.3907733514543;1099.301943266032;1137.9829302560468;1147.2026941275733;29929.401411972074;32998.50502242468;33756.32487350288;33929;34346;1140.3898914080926;1155.2664058323026;1170.303669316755;1182.479708928069;1221.0109811053076;16091.372572358223;17097.914510427367;17190.570235743955;17209.827901721073;17410.82364704412;498981;507149;507228;507705;508642;61060.69469652623;61484.38515614876;61561;61587.38412615816;61650.38349616446;1410.1257220523137;1444.1335198880797;1469.544441223224;1470.808794856683;1475.1739026145392;30288.242793930327;32567.674323256466;33015.17462063468;33017.33965320632;33245.50131748074;54701.72649136729;55710;55719.442805573046;55760.72119639376;55972.440275596724;424600;425338;426047;427505;427573;30085.097447076623;31239.531407029368;31300.530492043094;31305.217369565944;31318.843405782824;48521.75739121423;48825.511744883515;49154.508454916424;50629.24056139087;50649;41203.321784083935;42134.578654213066;42569.78715106405;42723.35914961216;44517.33224001578;42162.78918605387;42185.36721949112;42421;43151;43818;41123;42006.15987680291;42236;42709.78645106754;42781.57218427776;34338.48492272568;37268.627313726516;37494.812525937195;37523.81238093792;37974.2405151901;28154.015972988702;28223.827256141427;28269.71730282671;28275.879309052314;28312.292192695346 09:11:04 INFO - PROCESS | 27550 | |2;jquery.html;398.31291022985334;402.4164960806829;422.11988005009556;429.8474041715191;442.7609091090811;13609.523666671668;15114.168720720356;19312;19943.5042371822;20322.89838550805;19642.70535941962;19747.308844190455;20044.69932951007;20219.98900054995;20428.28501002465;5692.174634677969;5740.483356497924;5811.4479124483105;5869.325027621835;5937.020391635397;4097.856575019875;5771.307443106812;5866.823995280127;5868.76524939002;5870.236869206997;4266.616004559589;6213.937860621404;6450.709718062699;6473.320301368359;6610.471162307004;6331.525135614847;6455.83860403489;6490.837729056811;6568.310327415625;6584.8024559263295;5787.392323806024;5791.015527360359;5791.797287094932;5793.652380857162;5797.594168408213;21794.673079903656;21930.232441864617;22217;23167.536649267087;23314.184003559792;2450.154696629678;2514.861682607456;2527.4439623282847;2566.268613445159;2844.9047116860156;9454.621815127386;9921;9926.751831204205;9927.40435573868;9964.451955142536;1886.2643569008098;1931.7005864090947;1953.7069439584034;1963.6170946665407;1987.5428651410111;77228.61385693091;79898.80151797786;80427.19572804256;81493.59253203755;81687.5915620424;9117.452952822852;9672.22622190223;9744.17174540172;9758.072983066597;11445.885541144482;14309.21299328547;14404.351804168837;14406.207658578878;14414.711705765825;14426.85573144255;8220.136885627042;8283.420160588701;8351.290140338018;8438.45150065256;8601.31189504838;8415.74752757406;8456.2812160967;8488.618012189343;8632.827343453097;8690.261327787082;4306.763128027988;4318.827246910151;4333.566643335641;4350.956490435118;4436.404703248571;2009.4976255936017;2048.2933387981125;2059.835213182942;2098.2236572467978;2112.9471763205734;891.5675897189858;950.8431108867098;991.8214721350226;997.4414327976211;1032.673015175496;18990.43028709141;19058.14238359277;19271.325503607306;19530.70703939442;19581.706274405897;975.658519518163;994.2543092680489;1021.7292417509366;1026.7279171019686;1050.558765318568;10123.898761012442;10601.469926503798;10705.1435885129;10759.784804304027;10771.299865508718;445106;445828;466483;467697;469363;91678;91942.54028729947;92906;93068.53465732628;93952;991.4447909170888;1051.668724351842;1052.7947050325267;1053.3837704942694;1083.7994970930404;17195;17421.564460888072;17441.651166976844;17489.56276093108;17845.821541784415;39684.40473392844;40829;41027.58972410238;42626.57373426226;44018.33972490351;53630.46369536411;54230.45769542254;56188.15717764319;56461.435385645615;56925.430745692014;7342.48602597813;7823;7843.7254696085365;8237.83524329522;8422.705205317785;11366.943165284121;13419.597412077654;13439.193648381128;13451.125676830974;13472.461101555828;11065.225434219848;11102;11512.94243528777;11693.532258709556;12166.817497737718;11295.209335346446;11682.532698691957;11728.648140555797;11742.119341049627;12000.099992500423;11679.474423651127;11705.473253703434;12002.459889305177;12331.815022774845;12412.441440135035;8162.632681529464;8206.753797386087;8230.588470576327;8273.46222495536;8375.748727538183;9821.754456138653;11702.239354441934;11781.293122412682;11997.291672889873;12065.457054432396 09:11:04 INFO - PROCESS | 27550 | |3;mootools.html;1372.2246930484268;1519.620094976256;1520.4982355822576;1664.8668106551477;1801.117452448299;7529.134149572801;8147.959260203698;8366.581670916461;8473.745787626382;8674.132586741323;8564.100769419214;8622.956885215564;8642.092580279059;8644.610992505337;8650.567471626426;2395.9041638334447;2422.9757702423017;2425.490646964131;2427.8421902576365;2433.3551608823677;2383.4875501767115;2383.535210633927;2439.0365805506813;2447.669564608782;2448.608222684371;2373.91691290804;2388.8208384371155;2402.25530085674;2412.7345991940874;2413.1433341163897;2291.919782807594;2316.143027079983;2331.9533609327805;2335.4511689752894;2339.754325795801;2312.9190478333176;2317.2121478697322;2347.8943447544902;2348.941276468085;2349.3774149850306;8371.748847534524;8478.66085356585;8481.533515656636;8484.618192181366;8632.697855575025;5228.843134705965;5410.756515956791;5420.620556561043;5495.917561236584;5499.340079190482;3353.111425472252;3377.037544299863;3406.131436483706;3432.9141771455666;3447.844846981892;1049.795289918466;1078.466159251168;1858.869879108463;1893.6496748101645;1958.7747409048;11612.767744645143;11631.592894248744;11669;11729.296242225493;11737.413129343498;4431.534688857688;4616.584507394351;4705.835295764632;4712.363830882856;4712.740799256006;9400.435973841591;9410.200132988773;9413.90586094144;9417.76455588602;9424.528773561295;5385;5395.136778115482;5396.109641909119;5401.972990135103;5404.486573775485;4225.72532785368;4378.10248898975;4501.7974191161475;4862.489438608895;5072.087024335581;3836.712246581518;3860.131470419133;3969.384745364473;3987.860424885115;3989.501312335958;1183.2308999150448;1253.260576260011;1255.2092181925511;1256.4597223193932;1264.8861602455822;932.8507438809758;979.9265055120894;984.7882705218412;996.6063404955003;1005.5424781724298;5800.50695690871;5907.940920590739;5939.643621382731;5995.550333724988;6032.125341825411;478.16798770139707;479.13516103433636;487.1572180128327;487.99024019519413;489.2978575743819;4042.777647229431;4066.1054567994993;4130.0294430808735;4150.813213405404;4187.309093999517;10058.698239052841;10310.123639490577;10389.740256493647;10401.479926003669;10403.947980260202;9781.168600669023;10256.58973641046;10331.793364132674;10339;10343.482825858828;7729.227077292226;7914.129445760962;7921.603919803987;7923.920760792318;7951.522908625501;5647.407022262603;5876.882462350643;5935.614185077956;5946.881062378815;6195.287541932736;9755.560999754885;9834.803303934024;9842.507874606097;9850.113489785954;9862.802743945225;8645.092265312052;9030.413023153475;9765.9023409765;9902.108810207115;10046.146077583195;7092.468064895257;7366.631668416665;7464.141623713343;7465.365443937326;7467.477276590586;7672.271134242238;7729.149793522821;7739.535627862121;7820.257075577811;7821.296083352526;6992.300769922967;7061.929380706332;7066.116735408074;7109.111361079865;7276.199618042117;7134.750283740044;7216.783496494903;7223.783286501413;7275.054242948383;7355.632218388952;6601.768938087336;6663.566868153554;6671.5997040177745;6675.132232809704;6699.062131301719;4918.213085906238;4976.2038073908;4979.925301120414;5018.623603229699;5183.377994640668;4959.70241785494;4964.7765850537535;5053.115704751727;5098.439171691037;5134.666246693953 09:11:04 INFO - PROCESS | 27550 | |4;prototype.html;350.5565459693488;358.60911606349083;363.781730961423;364.98905032849024;368.33331669677904;5250.133727934895;5332.426934054463;5347.545458636016;5412.539934105601;5424.728763561826;5096.337476128098;5272.894542109156;5304.416514183436;5308.01801666692;5327.893442131165;4231;4242.257604919142;4253.489581250239;4256.318988961767;4256.829726810932;4157.605027522381;4213.283741763892;4236.597523235303;4240.1307731914885;4275.102228532012;4191.287481128215;4196.601322874338;4200.516940551845;4201.642860356873;4219.493660760713;4207.410962465257;4208.548050922427;4211.694374743824;4221.303484924983;4258.126424373266;3605.6214097519646;3677.3748462761396;3688.7786732796117;3711.2577484502935;3837.2517359114986;5136.5890728741615;5137.152369858969;5141.940545375495;5151.742412879341;5161;4752;4753.500882407332;4766.713997160146;4782.3543821584335;4783.790264567194;5257.5005374489365;5398.379186393576;5510.972445137789;5533.557315414757;5534.778608855641;4012.277789997799;4014.9360419488858;4024.5774193709826;4033.3748269018056;4041.717079804415;5769.88460230793;5798.695293558958;5799.18811366409;5821.53427725781;5853.921857740484;4114.033202197481;4115.42384066231;4164.4586203793315;4200.1179752252365;4221.366794980778;4198.517170525429;4206.72656277341;4226.302660061117;4228.365745138254;4245.3844192591905;4754.835065408928;4764.38063051808;4781.474037855833;4824.734639594786;4825.276208568743;5438.108346288264;5568.9443105569235;5583.944160558342;5594.042344902666;5595;1331.7269959658247;1351.6080336702246;1351.8648135186402;1363.6795353092016;1374.5670113914084;969.7284760267137;991.3952488981715;995.994046013517;1000.8548760429696;1005.3766664667953;5284.841454756363;5288.497592728685;5310.548603368757;5378.596605254622;5385.676859388371;5497.257870187474;5517;5536.695481748462;5558.748706773763;5679.545636349082;5158.587313014949;5223.2948551945765;5240.222681978557;5275.155975043975;5276.81531146408;2904.8547572621283;2907.6770069618274;2911.7379435850876;2914.877772057773;2915.3731947631363;5612.859678507988;5902.557308201816;5904.350521442638;5980.51461403947;5990.161377407167;5846.736896839652;5861.681121747658;5904.5238690327415;5906.586538942319;5918.378570250062;5754.251947246915;5954.106883967353;6003.849903752353;6004.489618382487;6019.217501724747;5732.828015159552;5762.8847423050465;5771.653700777967;5802.535797136304;5819.5053420459735;5730.971345143247;5740.598158128891;5752.827415177551;5758.481736643722;5787.971060144672;5710.2862142232225;5921.763129474945;5950.583459157818;5959.761609535743;5965.313988891333;4172.395002724648;4198.307279299003;4198.328267477189;4227.577242275748;4251.893702657459;5752.712364381848;5812.7674893003805;5818.912716309174;5878.470937615635;5903.2325797646035;5598.776048957996;5615;5622.88754224905;5623.156526521055;5658.405867383865;5401.568584325236;5640.153976903333;5640.238567793295;5651.378348381757;5695.658260504383;5346.385165705838;5483.314585676791;5531.787285085998;5552.500274975271;5561.221429000024;5643.927653745775;5651.717414129359;5658.17956396312;5663.801766938137;5672.801451949162;5283.788648454019;5523.613347065667;5535.121736696976;5537.754005348765;5558.6648011192965 09:11:04 INFO - PROCESS | 27550 | |5;yui.html;737.3400806278378;741.4883730226144;744.7765670298911;772.0966469230999;834.2450082675181;14946;15874.523764287062;15892;15897;15906.68186636268;15314.617134571641;15432.074075555474;15462.768058479132;15476.226188690576;15485.303161357739;716.0476566167011;737.9852402951938;811.4401063266357;834.0950069174937;841.9368547358941;824.2252282854128;834.2991886815074;834.870595057767;835.6490274084899;835.908050114487;898.1018981018981;898.5282726568571;899.7885496908222;899.9910000900005;900.1718419054486;895.2614093372961;896.1307531694246;897.8428774964387;897.9236764874994;897.9820403591957;659.864727730814;661.8279247395664;661.9371159739817;662.370747789597;662.4667142949924;14653.70692586153;14693.77959330611;14702.191379474125;14717.55847324582;15509.922450387789;14379.209143497104;14985.625359365995;15015.399384024626;15112.01771884835;15207.923960380238;10594.31136976094;10619.734506637318;10716.78566428667;10720.785584288271;10807.297525660806;3718.0704823794053;3738.5700644425965;3772.320982223199;3788.0719223790347;3798.924021519582;62096;64469.67765161191;64569.677151614414;64839.67580162069;64989.3501064988;11338.716532086764;11360;11419.429028548539;11479.885201147881;11537.826932596017;21581.24465643695;21638.459038523848;21639.134434622752;21705.782942170692;21729.13083476643;7392.889106663404;7397.075365579302;7489.962550187323;7613.581253031137;7662.272084151997;4106.815193316308;4158.4888366393525;4294.484661840599;4370.366296886934;4436.733795972252;3212.6305474870223;3304.553885225464;3329.067860998924;3332.75004374668;3404.69357757803;585.1632166002572;594.5540844366725;599.8110595162597;609.7804790275497;615.3784677475782;668.8361351468824;695.7738734911175;705.3264132753209;715.7673756029311;724.731849215783;8175.468594541336;8547.27348175412;9002.414843035182;9010.954945225232;9212.585433655368;619.3620570812071;664.7440735316937;718.7520305494596;729.6278897762179;730.3353947907485;4214.536400995888;4221.5567365426805;4407.316865885793;4408.206522825923;4423.049044455457;58190.4180958185;88927.55536222277;89581.55209224042;92371;92564;49704.50295496999;62830.0575491368;80317.19682803215;82852.58573707093;83620.58189709134;44387.334189987174;66349.33650663529;69605.99999999898;71045.2895471049;71907;8669.306455483673;8685.652573896974;8740.300775938036;8770.956145219234;8808.383413161273;48617.270740938206;49657.50342496529;49845.252321215936;50068.749656251486;51394;40571.98570035655;64593.67703161454;67861.66069169622;69272;70532.64733676298;10956.726081847699;11193.552257909918;11213.71965700864;11403.543858245577;11458.598949036743;12708.237505749685;12981.091323607257;13314.667133321356;13348.132371395828;13561.593152205449;12282.324472154118;12338.938305308417;12688.23870567769;12936.676583085498;12995;12865.228086314852;13117.934410327887;13489.527866524624;13517.459301628218;13735.793963090762;12518.248905065726;13040.217586944813;13135.211887286794;13183.67040823987;13415;9802.166815820736;9872.703818885446;9896.901030989886;9943.552540135566;10369.481525923522;10324.174066074846;10964.506597203304;11011.341213051224;11049.558017679203;11135.33188008722 09:11:04 INFO - PROCESS | 27550 | __end_tp_report 09:11:04 INFO - PROCESS | 27550 | __start_cc_report 09:11:04 INFO - PROCESS | 27550 | _x_x_mozilla_cycle_collect,1001 09:11:04 INFO - PROCESS | 27550 | __end_cc_report 09:11:04 INFO - PROCESS | 27550 | __startTimestamp1487610664236__endTimestamp 09:11:04 INFO - PROCESS | 27550 | 09:11:04 INFO - PROCESS | 27550 | ------- Summary: start ------- 09:11:04 INFO - PROCESS | 27550 | Number of tests: 6 09:11:04 INFO - PROCESS | 27550 | 09:11:04 INFO - PROCESS | 27550 | [#0] dojo.html Cycles:165 Average:5540.81 Median:5715.63 stddev:622.15 (10.9%) stddev-sans-first:596.13 09:11:04 INFO - PROCESS | 27550 | Values: 3191.4 3220.4 3224.4 3233.5 3273.2 5568.4 5648.7 5661.9 5661.9 5662.2 5548.6 5631.2 5636.4 5642.5 5668.1 5086.6 5107.9 5118.6 5145.7 5178.6 5013.0 5031.4 5187.1 5202.3 5214.3 5015.8 5031.2 5073.5 5075.6 5096.8 5097.6 5127.8 5185.4 5185.5 5203.0 4931.5 4947.7 5075.5 5093.7 5139.8 5451.2 5478.5 5495.2 5498.2 5517.9 5900.0 5945.4 5994.9 5995.0 5995.5 5827.2 5902.7 6017.8 6018.6 6038.8 5534.1 5569.5 5579.3 5618.3 5649.2 6175.1 6180.4 6186.0 6188.4 6189.0 5680.1 5741.7 5903.3 5909.1 5924.9 5860.1 5911.9 5917.5 5983.0 6016.4 5958.7 5967.9 5973.3 5973.3 5974.6 5724.9 5897.9 5965.3 5969.0 5989.9 4517.6 4547.0 4566.0 4570.1 4630.7 4080.7 4112.6 4113.0 4114.6 4134.2 5664.2 5679.8 5682.6 5684.0 5715.6 5828.2 5892.9 5901.8 5905.5 5953.4 5706.9 5715.5 5716.6 5718.6 5737.3 5049.6 5061.7 5066.0 5066.8 5091.7 6001.0 6065.3 6095.9 6115.2 6248.3 5988.0 5988.9 5993.0 6014.7 6022.8 6182.2 6182.5 6185.7 6197.8 6203.7 5652.0 5669.2 5806.0 5872.7 5877.8 5891.8 6004.5 6006.1 6031.8 6034.9 5791.2 5837.5 5843.2 5844.9 5854.4 5624.5 5630.7 5820.1 5825.1 5827.1 5672.5 5706.0 5721.4 5783.6 5811.9 5909.6 5911.0 5913.5 5913.6 5925.6 5597.7 5621.4 5654.5 5669.9 5738.9 09:11:04 INFO - PROCESS | 27550 | 09:11:04 INFO - PROCESS | 27550 | [#1] ext.html Cycles:180 Average:58330.46 Median:3909.66 stddev:112688.02 (2882.3%) stddev-sans-first:112920.70 09:11:04 INFO - PROCESS | 27550 | Values: 574.5 602.8 624.6 645.9 665.1 34421.7 37518.8 43689.1 44650.3 44922.8 45589.0 45966.0 46018.5 46062.5 46084.8 8903.2 9035.4 9050.8 9052.2 9054.1 8381.7 8550.5 8572.1 8844.2 8978.8 10548.0 10818.0 10829.9 11107.8 11131.6 10878.1 10939.4 10952.3 10960.9 10963.1 10795.4 10847.9 10861.2 10863.9 10874.2 44952.3 45101.0 45177.8 45317.5 45350.3 3518.1 3564.9 3629.3 4065.0 4269.1 32408.7 32523.7 33040.3 33356.8 33435.2 3905.6 3913.7 4074.5 4114.5 4123.4 322578.0 324889.0 326963.0 327180.0 327615.4 38813.6 39801.0 64652.7 64708.0 64935.0 41001.4 41298.0 41302.6 41305.2 41370.6 17478.7 17642.5 17644.2 17644.4 17653.3 14940.4 15044.1 15055.2 15056.8 15061.0 9025.9 9237.4 9288.4 9625.9 9652.4 3581.9 3592.6 3609.9 3620.0 3694.7 994.9 1050.4 1099.3 1138.0 1147.2 29929.4 32998.5 33756.3 33929.0 34346.0 1140.4 1155.3 1170.3 1182.5 1221.0 16091.4 17097.9 17190.6 17209.8 17410.8 498981.0 507149.0 507228.0 507705.0 508642.0 61060.7 61484.4 61561.0 61587.4 61650.4 1410.1 1444.1 1469.5 1470.8 1475.2 30288.2 32567.7 33015.2 33017.3 33245.5 54701.7 55710.0 55719.4 55760.7 55972.4 424600.0 425338.0 426047.0 427505.0 427573.0 30085.1 31239.5 31300.5 31305.2 31318.8 48521.8 48825.5 49154.5 50629.2 50649.0 41203.3 42134.6 42569.8 42723.4 44517.3 42162.8 42185.4 42421.0 43151.0 43818.0 41123.0 42006.2 42236.0 42709.8 42781.6 34338.5 37268.6 37494.8 37523.8 37974.2 28154.0 28223.8 28269.7 28275.9 28312.3 09:11:04 INFO - PROCESS | 27550 | 09:11:04 INFO - PROCESS | 27550 | [#2] jquery.html Cycles:180 Average:27982.80 Median:23446.59 stddev:75852.61 (323.5%) stddev-sans-first:76037.12 09:11:04 INFO - PROCESS | 27550 | Values: 398.3 402.4 422.1 429.8 442.8 13609.5 15114.2 19312.0 19943.5 20322.9 19642.7 19747.3 20044.7 20220.0 20428.3 5692.2 5740.5 5811.4 5869.3 5937.0 4097.9 5771.3 5866.8 5868.8 5870.2 4266.6 6213.9 6450.7 6473.3 6610.5 6331.5 6455.8 6490.8 6568.3 6584.8 5787.4 5791.0 5791.8 5793.7 5797.6 21794.7 21930.2 22217.0 23167.5 23314.2 2450.2 2514.9 2527.4 2566.3 2844.9 9454.6 9921.0 9926.8 9927.4 9964.5 1886.3 1931.7 1953.7 1963.6 1987.5 77228.6 79898.8 80427.2 81493.6 81687.6 9117.5 9672.2 9744.2 9758.1 11445.9 14309.2 14404.4 14406.2 14414.7 14426.9 8220.1 8283.4 8351.3 8438.5 8601.3 8415.7 8456.3 8488.6 8632.8 8690.3 4306.8 4318.8 4333.6 4351.0 4436.4 2009.5 2048.3 2059.8 2098.2 2112.9 891.6 950.8 991.8 997.4 1032.7 18990.4 19058.1 19271.3 19530.7 19581.7 975.7 994.3 1021.7 1026.7 1050.6 10123.9 10601.5 10705.1 10759.8 10771.3 445106.0 445828.0 466483.0 467697.0 469363.0 91678.0 91942.5 92906.0 93068.5 93952.0 991.4 1051.7 1052.8 1053.4 1083.8 17195.0 17421.6 17441.7 17489.6 17845.8 39684.4 40829.0 41027.6 42626.6 44018.3 53630.5 54230.5 56188.2 56461.4 56925.4 7342.5 7823.0 7843.7 8237.8 8422.7 11366.9 13419.6 13439.2 13451.1 13472.5 11065.2 11102.0 11512.9 11693.5 12166.8 11295.2 11682.5 11728.6 11742.1 12000.1 11679.5 11705.5 12002.5 12331.8 12412.4 8162.6 8206.8 8230.6 8273.5 8375.7 9821.8 11702.2 11781.3 11997.3 12065.5 09:11:04 INFO - PROCESS | 27550 | 09:11:04 INFO - PROCESS | 27550 | [#3] mootools.html Cycles:180 Average:5595.93 Median:5035.87 stddev:3062.91 (60.8%) stddev-sans-first:3055.05 09:11:04 INFO - PROCESS | 27550 | Values: 1372.2 1519.6 1520.5 1664.9 1801.1 7529.1 8148.0 8366.6 8473.7 8674.1 8564.1 8623.0 8642.1 8644.6 8650.6 2395.9 2423.0 2425.5 2427.8 2433.4 2383.5 2383.5 2439.0 2447.7 2448.6 2373.9 2388.8 2402.3 2412.7 2413.1 2291.9 2316.1 2332.0 2335.5 2339.8 2312.9 2317.2 2347.9 2348.9 2349.4 8371.7 8478.7 8481.5 8484.6 8632.7 5228.8 5410.8 5420.6 5495.9 5499.3 3353.1 3377.0 3406.1 3432.9 3447.8 1049.8 1078.5 1858.9 1893.6 1958.8 11612.8 11631.6 11669.0 11729.3 11737.4 4431.5 4616.6 4705.8 4712.4 4712.7 9400.4 9410.2 9413.9 9417.8 9424.5 5385.0 5395.1 5396.1 5402.0 5404.5 4225.7 4378.1 4501.8 4862.5 5072.1 3836.7 3860.1 3969.4 3987.9 3989.5 1183.2 1253.3 1255.2 1256.5 1264.9 932.9 979.9 984.8 996.6 1005.5 5800.5 5907.9 5939.6 5995.6 6032.1 478.2 479.1 487.2 488.0 489.3 4042.8 4066.1 4130.0 4150.8 4187.3 10058.7 10310.1 10389.7 10401.5 10403.9 9781.2 10256.6 10331.8 10339.0 10343.5 7729.2 7914.1 7921.6 7923.9 7951.5 5647.4 5876.9 5935.6 5946.9 6195.3 9755.6 9834.8 9842.5 9850.1 9862.8 8645.1 9030.4 9765.9 9902.1 10046.1 7092.5 7366.6 7464.1 7465.4 7467.5 7672.3 7729.1 7739.5 7820.3 7821.3 6992.3 7061.9 7066.1 7109.1 7276.2 7134.8 7216.8 7223.8 7275.1 7355.6 6601.8 6663.6 6671.6 6675.1 6699.1 4918.2 4976.2 4979.9 5018.6 5183.4 4959.7 4964.8 5053.1 5098.4 5134.7 09:11:04 INFO - PROCESS | 27550 | 09:11:04 INFO - PROCESS | 27550 | [#4] prototype.html Cycles:180 Average:4720.60 Median:5309.28 stddev:1380.92 (26.0%) stddev-sans-first:1345.27 09:11:04 INFO - PROCESS | 27550 | Values: 350.6 358.6 363.8 365.0 368.3 5250.1 5332.4 5347.5 5412.5 5424.7 5096.3 5272.9 5304.4 5308.0 5327.9 4231.0 4242.3 4253.5 4256.3 4256.8 4157.6 4213.3 4236.6 4240.1 4275.1 4191.3 4196.6 4200.5 4201.6 4219.5 4207.4 4208.5 4211.7 4221.3 4258.1 3605.6 3677.4 3688.8 3711.3 3837.3 5136.6 5137.2 5141.9 5151.7 5161.0 4752.0 4753.5 4766.7 4782.4 4783.8 5257.5 5398.4 5511.0 5533.6 5534.8 4012.3 4014.9 4024.6 4033.4 4041.7 5769.9 5798.7 5799.2 5821.5 5853.9 4114.0 4115.4 4164.5 4200.1 4221.4 4198.5 4206.7 4226.3 4228.4 4245.4 4754.8 4764.4 4781.5 4824.7 4825.3 5438.1 5568.9 5583.9 5594.0 5595.0 1331.7 1351.6 1351.9 1363.7 1374.6 969.7 991.4 996.0 1000.9 1005.4 5284.8 5288.5 5310.5 5378.6 5385.7 5497.3 5517.0 5536.7 5558.7 5679.5 5158.6 5223.3 5240.2 5275.2 5276.8 2904.9 2907.7 2911.7 2914.9 2915.4 5612.9 5902.6 5904.4 5980.5 5990.2 5846.7 5861.7 5904.5 5906.6 5918.4 5754.3 5954.1 6003.8 6004.5 6019.2 5732.8 5762.9 5771.7 5802.5 5819.5 5731.0 5740.6 5752.8 5758.5 5788.0 5710.3 5921.8 5950.6 5959.8 5965.3 4172.4 4198.3 4198.3 4227.6 4251.9 5752.7 5812.8 5818.9 5878.5 5903.2 5598.8 5615.0 5622.9 5623.2 5658.4 5401.6 5640.2 5640.2 5651.4 5695.7 5346.4 5483.3 5531.8 5552.5 5561.2 5643.9 5651.7 5658.2 5663.8 5672.8 5283.8 5523.6 5535.1 5537.8 5558.7 09:11:04 INFO - PROCESS | 27550 | 09:11:04 INFO - PROCESS | 27550 | [#5] yui.html Cycles:180 Average:17615.45 Median:49774.88 stddev:23247.13 (46.7%) stddev-sans-first:23277.80 09:11:04 INFO - PROCESS | 27550 | Values: 737.3 741.5 744.8 772.1 834.2 14946.0 15874.5 15892.0 15897.0 15906.7 15314.6 15432.1 15462.8 15476.2 15485.3 716.0 738.0 811.4 834.1 841.9 824.2 834.3 834.9 835.6 835.9 898.1 898.5 899.8 900.0 900.2 895.3 896.1 897.8 897.9 898.0 659.9 661.8 661.9 662.4 662.5 14653.7 14693.8 14702.2 14717.6 15509.9 14379.2 14985.6 15015.4 15112.0 15207.9 10594.3 10619.7 10716.8 10720.8 10807.3 3718.1 3738.6 3772.3 3788.1 3798.9 62096.0 64469.7 64569.7 64839.7 64989.4 11338.7 11360.0 11419.4 11479.9 11537.8 21581.2 21638.5 21639.1 21705.8 21729.1 7392.9 7397.1 7490.0 7613.6 7662.3 4106.8 4158.5 4294.5 4370.4 4436.7 3212.6 3304.6 3329.1 3332.8 3404.7 585.2 594.6 599.8 609.8 615.4 668.8 695.8 705.3 715.8 724.7 8175.5 8547.3 9002.4 9011.0 9212.6 619.4 664.7 718.8 729.6 730.3 4214.5 4221.6 4407.3 4408.2 4423.0 58190.4 88927.6 89581.6 92371.0 92564.0 49704.5 62830.1 80317.2 82852.6 83620.6 44387.3 66349.3 69606.0 71045.3 71907.0 8669.3 8685.7 8740.3 8771.0 8808.4 48617.3 49657.5 49845.3 50068.7 51394.0 40572.0 64593.7 67861.7 69272.0 70532.6 10956.7 11193.6 11213.7 11403.5 11458.6 12708.2 12981.1 13314.7 13348.1 13561.6 12282.3 12338.9 12688.2 12936.7 12995.0 12865.2 13117.9 13489.5 13517.5 13735.8 12518.2 13040.2 13135.2 13183.7 13415.0 9802.2 9872.7 9896.9 9943.6 10369.5 10324.2 10964.5 11011.3 11049.6 11135.3 09:11:04 INFO - PROCESS | 27550 | -------- Summary: end -------- 09:11:04 INFO - PROCESS | 27550 | 09:11:05 INFO - TEST-INFO | 27550: exit 0 09:11:05 INFO - TEST-OK | dromaeo_css | took 1114906ms 09:11:05 INFO - TEST-START | kraken 09:11:05 INFO - operating with platform_type : linux_ 09:11:05 INFO - Initialising browser for kraken test... 09:11:05 INFO - TEST-INFO | started process 27857 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXmedzS/profile http://localhost:57875/getInfo.html) 09:11:09 INFO - PROCESS | 27857 | __metrics Screen width/height:1600/1200 09:11:09 INFO - PROCESS | 27857 | colorDepth:24 09:11:09 INFO - PROCESS | 27857 | Browser inner width/height: 1024/697 09:11:09 INFO - PROCESS | 27857 | __metrics 09:11:10 INFO - PROCESS | 27857 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:11:10 INFO - PROCESS | 27857 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:11:10 INFO - TEST-INFO | 27857: exit 0 09:11:10 INFO - Browser initialized. 09:11:10 INFO - Running cycle 1/1 for kraken test... 09:11:10 INFO - TEST-INFO | started process 27946 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXmedzS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:11:22 INFO - PROCESS | 27946 | RSS: Main: 142049280 09:11:22 INFO - PROCESS | 27946 | 09:11:25 INFO - PROCESS | 27946 | Cycle 1(1): loaded http://localhost:57875/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57875/tests/kraken/driver.html?testName=audio-beat-detection) 09:11:26 INFO - PROCESS | 27946 | RSS: Main: 183996416 09:11:26 INFO - PROCESS | 27946 | 09:11:28 INFO - PROCESS | 27946 | Cycle 1(1): loaded http://localhost:57875/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57875/tests/kraken/driver.html?testName=audio-dft) 09:11:29 INFO - PROCESS | 27946 | RSS: Main: 173895680 09:11:29 INFO - PROCESS | 27946 | 09:11:31 INFO - PROCESS | 27946 | Cycle 1(1): loaded http://localhost:57875/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57875/tests/kraken/driver.html?testName=audio-fft) 09:11:32 INFO - PROCESS | 27946 | RSS: Main: 265465856 09:11:32 INFO - PROCESS | 27946 | 09:11:34 INFO - PROCESS | 27946 | Cycle 1(1): loaded http://localhost:57875/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57875/tests/kraken/driver.html?testName=audio-oscillator) 09:11:35 INFO - PROCESS | 27946 | RSS: Main: 171761664 09:11:35 INFO - PROCESS | 27946 | 09:11:37 INFO - PROCESS | 27946 | Cycle 1(1): loaded http://localhost:57875/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57875/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:11:37 INFO - PROCESS | 27946 | RSS: Main: 174260224 09:11:37 INFO - PROCESS | 27946 | 09:11:40 INFO - PROCESS | 27946 | Cycle 1(1): loaded http://localhost:57875/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57875/tests/kraken/driver.html?testName=imaging-darkroom) 09:11:41 INFO - PROCESS | 27946 | RSS: Main: 212975616 09:11:41 INFO - PROCESS | 27946 | 09:11:44 INFO - PROCESS | 27946 | Cycle 1(1): loaded http://localhost:57875/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57875/tests/kraken/driver.html?testName=imaging-desaturate) 09:11:45 INFO - PROCESS | 27946 | RSS: Main: 211046400 09:11:45 INFO - PROCESS | 27946 | 09:11:48 INFO - PROCESS | 27946 | Cycle 1(1): loaded http://localhost:57875/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57875/tests/kraken/driver.html?testName=json-parse-financial) 09:11:48 INFO - PROCESS | 27946 | RSS: Main: 209596416 09:11:48 INFO - PROCESS | 27946 | 09:11:50 INFO - PROCESS | 27946 | Cycle 1(1): loaded http://localhost:57875/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57875/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:11:50 INFO - PROCESS | 27946 | RSS: Main: 172298240 09:11:50 INFO - PROCESS | 27946 | 09:11:52 INFO - PROCESS | 27946 | Cycle 1(1): loaded http://localhost:57875/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57875/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:11:53 INFO - PROCESS | 27946 | RSS: Main: 179302400 09:11:53 INFO - PROCESS | 27946 | 09:11:55 INFO - PROCESS | 27946 | Cycle 1(1): loaded http://localhost:57875/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57875/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:11:55 INFO - PROCESS | 27946 | RSS: Main: 189087744 09:11:55 INFO - PROCESS | 27946 | 09:11:58 INFO - PROCESS | 27946 | Cycle 1(1): loaded http://localhost:57875/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57875/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:11:58 INFO - PROCESS | 27946 | RSS: Main: 197353472 09:11:58 INFO - PROCESS | 27946 | 09:12:01 INFO - PROCESS | 27946 | Cycle 1(1): loaded http://localhost:57875/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57875/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:12:02 INFO - PROCESS | 27946 | RSS: Main: 193839104 09:12:02 INFO - PROCESS | 27946 | 09:12:03 INFO - PROCESS | 27946 | Cycle 1(1): loaded http://localhost:57875/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57875/tests/kraken/driver.html?testName=ai-astar) 09:12:04 INFO - PROCESS | 27946 | RSS: Main: 245452800 09:12:04 INFO - PROCESS | 27946 | 09:12:04 INFO - PROCESS | 27946 | __start_tp_report 09:12:04 INFO - PROCESS | 27946 | _x_x_mozilla_page_load 09:12:04 INFO - PROCESS | 27946 | _x_x_mozilla_page_load_details 09:12:04 INFO - PROCESS | 27946 | |i|pagename|runs| 09:12:04 INFO - PROCESS | 27946 | |0;ai-astar;104;110;110;112;111;112;110;114;111;111 09:12:04 INFO - PROCESS | 27946 | |1;audio-beat-detection;147;119;121;156;119;117;117;122;144;118 09:12:04 INFO - PROCESS | 27946 | |2;audio-dft;161;160;161;159;160;161;161;160;160;160 09:12:04 INFO - PROCESS | 27946 | |3;audio-fft;75;76;76;108;75;75;75;77;105;76 09:12:04 INFO - PROCESS | 27946 | |4;audio-oscillator;81;82;124;82;83;81;98;81;81;113 09:12:04 INFO - PROCESS | 27946 | |5;imaging-gaussian-blur;116;116;117;117;116;117;117;117;117;117 09:12:04 INFO - PROCESS | 27946 | |6;imaging-darkroom;146;146;147;145;146;146;145;146;146;145 09:12:04 INFO - PROCESS | 27946 | |7;imaging-desaturate;86;85;85;84;85;84;84;85;85;85 09:12:04 INFO - PROCESS | 27946 | |8;json-parse-financial;53;50;52;52;52;51;53;52;52;51 09:12:04 INFO - PROCESS | 27946 | |9;json-stringify-tinderbox;60;61;60;62;61;60;60;59;59;60 09:12:04 INFO - PROCESS | 27946 | |10;stanford-crypto-aes;83;79;80;74;79;74;74;74;73;74 09:12:04 INFO - PROCESS | 27946 | |11;stanford-crypto-ccm;133;122;123;134;121;119;119;124;165;121 09:12:04 INFO - PROCESS | 27946 | |12;stanford-crypto-pbkdf2;158;157;153;155;155;154;158;158;163;157 09:12:04 INFO - PROCESS | 27946 | |13;stanford-crypto-sha256-iterative;63;64;63;63;63;63;64;63;63;62 09:12:04 INFO - PROCESS | 27946 | __end_tp_report 09:12:04 INFO - PROCESS | 27946 | __start_cc_report 09:12:04 INFO - PROCESS | 27946 | _x_x_mozilla_cycle_collect,1630 09:12:04 INFO - PROCESS | 27946 | __end_cc_report 09:12:04 INFO - PROCESS | 27946 | __startTimestamp1487610724033__endTimestamp 09:12:04 INFO - PROCESS | 27946 | 09:12:04 INFO - PROCESS | 27946 | ------- Summary: start ------- 09:12:04 INFO - PROCESS | 27946 | Number of tests: 14 09:12:04 INFO - PROCESS | 27946 | 09:12:04 INFO - PROCESS | 27946 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:2.59 (2.3%) stddev-sans-first:1.30 09:12:04 INFO - PROCESS | 27946 | Values: 104.0 110.0 110.0 112.0 111.0 112.0 110.0 114.0 111.0 111.0 09:12:04 INFO - PROCESS | 27946 | 09:12:04 INFO - PROCESS | 27946 | [#1] audio-beat-detection Cycles:10 Average:128.00 Median:121.50 stddev:14.87 (12.2%) stddev-sans-first:14.09 09:12:04 INFO - PROCESS | 27946 | Values: 147.0 119.0 121.0 156.0 119.0 117.0 117.0 122.0 144.0 118.0 09:12:04 INFO - PROCESS | 27946 | 09:12:04 INFO - PROCESS | 27946 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.50 stddev:0.67 (0.4%) stddev-sans-first:0.67 09:12:04 INFO - PROCESS | 27946 | Values: 161.0 160.0 161.0 159.0 160.0 161.0 161.0 160.0 160.0 160.0 09:12:04 INFO - PROCESS | 27946 | 09:12:04 INFO - PROCESS | 27946 | [#3] audio-fft Cycles:10 Average:81.80 Median:75.50 stddev:13.05 (17.3%) stddev-sans-first:13.61 09:12:04 INFO - PROCESS | 27946 | Values: 75.0 76.0 76.0 108.0 75.0 75.0 75.0 77.0 105.0 76.0 09:12:04 INFO - PROCESS | 27946 | 09:12:04 INFO - PROCESS | 27946 | [#4] audio-oscillator Cycles:10 Average:90.60 Median:81.50 stddev:15.80 (19.4%) stddev-sans-first:16.37 09:12:04 INFO - PROCESS | 27946 | Values: 81.0 82.0 124.0 82.0 83.0 81.0 98.0 81.0 81.0 113.0 09:12:04 INFO - PROCESS | 27946 | 09:12:04 INFO - PROCESS | 27946 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 09:12:04 INFO - PROCESS | 27946 | Values: 116.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 09:12:04 INFO - PROCESS | 27946 | 09:12:04 INFO - PROCESS | 27946 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 09:12:04 INFO - PROCESS | 27946 | Values: 146.0 146.0 147.0 145.0 146.0 146.0 145.0 146.0 146.0 145.0 09:12:04 INFO - PROCESS | 27946 | 09:12:04 INFO - PROCESS | 27946 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 09:12:04 INFO - PROCESS | 27946 | Values: 86.0 85.0 85.0 84.0 85.0 84.0 84.0 85.0 85.0 85.0 09:12:04 INFO - PROCESS | 27946 | 09:12:04 INFO - PROCESS | 27946 | [#8] json-parse-financial Cycles:10 Average:51.80 Median:52.00 stddev:0.92 (1.8%) stddev-sans-first:0.87 09:12:04 INFO - PROCESS | 27946 | Values: 53.0 50.0 52.0 52.0 52.0 51.0 53.0 52.0 52.0 51.0 09:12:04 INFO - PROCESS | 27946 | 09:12:04 INFO - PROCESS | 27946 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:0.92 (1.5%) stddev-sans-first:0.97 09:12:04 INFO - PROCESS | 27946 | Values: 60.0 61.0 60.0 62.0 61.0 60.0 60.0 59.0 59.0 60.0 09:12:04 INFO - PROCESS | 27946 | 09:12:04 INFO - PROCESS | 27946 | [#10] stanford-crypto-aes Cycles:10 Average:76.40 Median:76.50 stddev:3.50 (4.6%) stddev-sans-first:2.78 09:12:04 INFO - PROCESS | 27946 | Values: 83.0 79.0 80.0 74.0 79.0 74.0 74.0 74.0 73.0 74.0 09:12:04 INFO - PROCESS | 27946 | 09:12:04 INFO - PROCESS | 27946 | [#11] stanford-crypto-ccm Cycles:10 Average:128.10 Median:123.50 stddev:14.01 (11.3%) stddev-sans-first:14.75 09:12:04 INFO - PROCESS | 27946 | Values: 133.0 122.0 123.0 134.0 121.0 119.0 119.0 124.0 165.0 121.0 09:12:04 INFO - PROCESS | 27946 | 09:12:04 INFO - PROCESS | 27946 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.80 Median:157.50 stddev:2.82 (1.8%) stddev-sans-first:2.96 09:12:04 INFO - PROCESS | 27946 | Values: 158.0 157.0 153.0 155.0 155.0 154.0 158.0 158.0 163.0 157.0 09:12:04 INFO - PROCESS | 27946 | 09:12:04 INFO - PROCESS | 27946 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 09:12:04 INFO - PROCESS | 27946 | Values: 63.0 64.0 63.0 63.0 63.0 63.0 64.0 63.0 63.0 62.0 09:12:04 INFO - PROCESS | 27946 | -------- Summary: end -------- 09:12:04 INFO - PROCESS | 27946 | 09:12:05 INFO - TEST-INFO | 27946: exit 0 09:12:05 INFO - TEST-OK | kraken | took 60057ms 09:12:05 INFO - SUITE-END | took 1174s 09:12:05 INFO - Completed test suite (00:19:35) 09:12:05 INFO - javascript benchmark 09:12:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3191.4095892259934, 3220.420324341619, 3224.3551289742045, 3233.482642777153, 3273.1817045738567, 5568.415316391776, 5648.717564121798, 5661.915071273929, 5661.943380566193, 5662.150677398392, 5548.639338442998, 5631.211630371751, 5636.408177141392, 5642.463965923241, 5668.064769313069, 5086.567641750456, 5107.948920510803, 5118.6416950813455, 5145.716985565792, 5178.559822415099, 5013.022460620181, 5031.371078615173, 5187.144121219994, 5202.271681964528, 5214.348206474191, 5015.799368025275, 5031.22016087507, 5073.4926507349155, 5075.568576670969, 5096.821611243608, 5097.643164978453, 5127.769250383742, 5185.351831021122, 5185.481451854822, 5203.03743807393, 4931.531504507102, 4947.678400903929, 5075.543201111881, 5093.719845408501, 5139.7687104080405, 5451.155070964007, 5478.506934375925, 5495.175723641446, 5498.230247765316, 5517.917231241535, 5899.970500147515, 5945.375735547748, 5994.940050599525, 5995.0, 5995.46040856325, 5827.184194212814, 5902.675352855591, 6017.7592896284095, 6018.638881667071, 6038.818835434944, 5534.1145416733125, 5569.470900264469, 5579.330480342385, 5618.297712785902, 5649.180868774005, 6175.073738939195, 6180.443760061616, 6186.0, 6188.44304012632, 6188.9788184948975, 5680.11958146488, 5741.741621627037, 5903.321118071391, 5909.084091965752, 5924.940750592526, 5860.062390017577, 5911.9113213301835, 5917.46742793142, 5982.970085149546, 6016.42843929826, 5958.702064896738, 5967.850803729942, 5973.283206015306, 5973.342932277446, 5974.551908606872, 5724.856878577985, 5897.911531327033, 5965.28416590012, 5968.970155149196, 5989.880202395928, 4517.593416592456, 4546.977265113719, 4566.018306064212, 4570.063137056895, 4630.745309008037, 4080.6735461163034, 4112.588741125864, 4113.0, 4114.6091121343425, 4134.1731653669385, 5664.20701101846, 5679.77280908759, 5682.573806964494, 5684.005299072728, 5715.628484148517, 5828.184054232411, 5892.882142357129, 5901.793437229677, 5905.498032667271, 5953.374895635982, 5706.857328566819, 5715.5427565794635, 5716.628419152825, 5718.599698021098, 5737.340205876294, 5049.6212784041345, 5061.746912654353, 5066.0, 5066.797328106834, 5091.66904151229, 6001.0, 6065.332813390435, 6095.9390406097145, 6115.235595550556, 6248.343923888017, 5987.970060149845, 5988.940110598838, 5993.011153159854, 6014.729337179925, 6022.789202377896, 6182.196314479269, 6182.505399568114, 6185.6907154641185, 6197.845053873689, 6203.689815509297, 5651.971740141273, 5669.177969194361, 5806.0, 5872.677002764889, 5877.764889404376, 5891.823245302648, 6004.489618382487, 6006.129111278928, 6031.75872965094, 6034.8793024138395, 5791.218185545066, 5837.474627283565, 5843.2403787507355, 5844.912326315024, 5854.385289544707, 5624.521915637217, 5630.662160270397, 5820.126980952891, 5825.0679891217205, 5827.125931110198, 5672.517835983987, 5705.971470142623, 5721.370649228498, 5783.566232532493, 5811.912821307768, 5909.556783241188, 5910.970445147746, 5913.46778789911, 5913.58604897653, 5925.614835035709, 5597.692126933058, 5621.409751975983, 5654.519365853948, 5669.886602267849, 5738.9139162913425], "value": 5499.225650239513, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.4743559642927, 602.8071017274473, 624.5940138909708, 645.8546826963931, 665.1087542692791, 34421.655783442155, 37518.81240593797, 43689.12621747567, 44650.33024504635, 44922.77538612302, 45589.0, 45966.0, 46018.53981460193, 46062.53937460625, 46084.76957615215, 8903.198712115924, 9035.367524273304, 9050.773730656754, 9052.230560402373, 9054.094590540926, 8381.706640267592, 8550.486970781742, 8572.057073721886, 8844.248238899669, 8978.820423591524, 10548.0, 10818.0, 10829.945850270738, 11107.777844443146, 11131.554737810478, 10878.075363594104, 10939.398333091676, 10952.34285942846, 10960.890391096067, 10963.068139208177, 10795.352278863214, 10847.891521084766, 10861.1854110942, 10863.945680271627, 10874.18443616732, 44952.3257151143, 45101.0, 45177.774111129234, 45317.54682453166, 45350.31974520385, 3518.102883764649, 3564.946525802115, 3629.2560025195035, 4065.0, 4269.124829409963, 32408.6759132408, 32523.674763252537, 33040.33919321624, 33356.833215833765, 33435.16412089693, 3905.5899130591165, 3913.726039177259, 4074.490688663917, 4114.485689288839, 4123.402106694542, 322578.0, 324889.0, 326963.0, 327180.0, 327615.36192319123, 38813.61186388157, 39801.0, 64652.67673661601, 64708.0, 64935.0, 41001.35994560184, 41298.0, 41302.58697413048, 41305.173896521905, 41370.586294137276, 17478.65042699139, 17642.47072587799, 17644.206010729547, 17644.382446614305, 17653.293868245128, 14940.402383904522, 15044.097354158786, 15055.171965541782, 15056.774148387783, 15061.0, 9025.909740902507, 9237.353385262966, 9288.442693438416, 9625.903740962642, 9652.372595781251, 3581.8925432237074, 3592.5688917329567, 3609.909752256162, 3620.022593899685, 3694.7413681042067, 994.8706668133241, 1050.3907733514543, 1099.301943266032, 1137.9829302560468, 1147.2026941275733, 29929.401411972074, 32998.50502242468, 33756.32487350288, 33929.0, 34346.0, 1140.3898914080926, 1155.2664058323026, 1170.303669316755, 1182.479708928069, 1221.0109811053076, 16091.372572358223, 17097.914510427367, 17190.570235743955, 17209.827901721073, 17410.82364704412, 498981.0, 507149.0, 507228.0, 507705.0, 508642.0, 61060.69469652623, 61484.38515614876, 61561.0, 61587.38412615816, 61650.38349616446, 1410.1257220523137, 1444.1335198880797, 1469.544441223224, 1470.808794856683, 1475.1739026145392, 30288.242793930327, 32567.674323256466, 33015.17462063468, 33017.33965320632, 33245.50131748074, 54701.72649136729, 55710.0, 55719.442805573046, 55760.72119639376, 55972.440275596724, 424600.0, 425338.0, 426047.0, 427505.0, 427573.0, 30085.097447076623, 31239.531407029368, 31300.530492043094, 31305.217369565944, 31318.843405782824, 48521.75739121423, 48825.511744883515, 49154.508454916424, 50629.24056139087, 50649.0, 41203.321784083935, 42134.578654213066, 42569.78715106405, 42723.35914961216, 44517.33224001578, 42162.78918605387, 42185.36721949112, 42421.0, 43151.0, 43818.0, 41123.0, 42006.15987680291, 42236.0, 42709.78645106754, 42781.57218427776, 34338.48492272568, 37268.627313726516, 37494.812525937195, 37523.81238093792, 37974.2405151901, 28154.015972988702, 28223.827256141427, 28269.71730282671, 28275.879309052314, 28312.292192695346], "value": 19874.8205151887, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.31291022985334, 402.4164960806829, 422.11988005009556, 429.8474041715191, 442.7609091090811, 13609.523666671668, 15114.168720720356, 19312.0, 19943.5042371822, 20322.89838550805, 19642.70535941962, 19747.308844190455, 20044.69932951007, 20219.98900054995, 20428.28501002465, 5692.174634677969, 5740.483356497924, 5811.4479124483105, 5869.325027621835, 5937.020391635397, 4097.856575019875, 5771.307443106812, 5866.823995280127, 5868.76524939002, 5870.236869206997, 4266.616004559589, 6213.937860621404, 6450.709718062699, 6473.320301368359, 6610.471162307004, 6331.525135614847, 6455.83860403489, 6490.837729056811, 6568.310327415625, 6584.8024559263295, 5787.392323806024, 5791.015527360359, 5791.797287094932, 5793.652380857162, 5797.594168408213, 21794.673079903656, 21930.232441864617, 22217.0, 23167.536649267087, 23314.184003559792, 2450.154696629678, 2514.861682607456, 2527.4439623282847, 2566.268613445159, 2844.9047116860156, 9454.621815127386, 9921.0, 9926.751831204205, 9927.40435573868, 9964.451955142536, 1886.2643569008098, 1931.7005864090947, 1953.7069439584034, 1963.6170946665407, 1987.5428651410111, 77228.61385693091, 79898.80151797786, 80427.19572804256, 81493.59253203755, 81687.5915620424, 9117.452952822852, 9672.22622190223, 9744.17174540172, 9758.072983066597, 11445.885541144482, 14309.21299328547, 14404.351804168837, 14406.207658578878, 14414.711705765825, 14426.85573144255, 8220.136885627042, 8283.420160588701, 8351.290140338018, 8438.45150065256, 8601.31189504838, 8415.74752757406, 8456.2812160967, 8488.618012189343, 8632.827343453097, 8690.261327787082, 4306.763128027988, 4318.827246910151, 4333.566643335641, 4350.956490435118, 4436.404703248571, 2009.4976255936017, 2048.2933387981125, 2059.835213182942, 2098.2236572467978, 2112.9471763205734, 891.5675897189858, 950.8431108867098, 991.8214721350226, 997.4414327976211, 1032.673015175496, 18990.43028709141, 19058.14238359277, 19271.325503607306, 19530.70703939442, 19581.706274405897, 975.658519518163, 994.2543092680489, 1021.7292417509366, 1026.7279171019686, 1050.558765318568, 10123.898761012442, 10601.469926503798, 10705.1435885129, 10759.784804304027, 10771.299865508718, 445106.0, 445828.0, 466483.0, 467697.0, 469363.0, 91678.0, 91942.54028729947, 92906.0, 93068.53465732628, 93952.0, 991.4447909170888, 1051.668724351842, 1052.7947050325267, 1053.3837704942694, 1083.7994970930404, 17195.0, 17421.564460888072, 17441.651166976844, 17489.56276093108, 17845.821541784415, 39684.40473392844, 40829.0, 41027.58972410238, 42626.57373426226, 44018.33972490351, 53630.46369536411, 54230.45769542254, 56188.15717764319, 56461.435385645615, 56925.430745692014, 7342.48602597813, 7823.0, 7843.7254696085365, 8237.83524329522, 8422.705205317785, 11366.943165284121, 13419.597412077654, 13439.193648381128, 13451.125676830974, 13472.461101555828, 11065.225434219848, 11102.0, 11512.94243528777, 11693.532258709556, 12166.817497737718, 11295.209335346446, 11682.532698691957, 11728.648140555797, 11742.119341049627, 12000.099992500423, 11679.474423651127, 11705.473253703434, 12002.459889305177, 12331.815022774845, 12412.441440135035, 8162.632681529464, 8206.753797386087, 8230.588470576327, 8273.46222495536, 8375.748727538183, 9821.754456138653, 11702.239354441934, 11781.293122412682, 11997.291672889873, 12065.457054432396], "value": 9203.396891093022, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1372.2246930484268, 1519.620094976256, 1520.4982355822576, 1664.8668106551477, 1801.117452448299, 7529.134149572801, 8147.959260203698, 8366.581670916461, 8473.745787626382, 8674.132586741323, 8564.100769419214, 8622.956885215564, 8642.092580279059, 8644.610992505337, 8650.567471626426, 2395.9041638334447, 2422.9757702423017, 2425.490646964131, 2427.8421902576365, 2433.3551608823677, 2383.4875501767115, 2383.535210633927, 2439.0365805506813, 2447.669564608782, 2448.608222684371, 2373.91691290804, 2388.8208384371155, 2402.25530085674, 2412.7345991940874, 2413.1433341163897, 2291.919782807594, 2316.143027079983, 2331.9533609327805, 2335.4511689752894, 2339.754325795801, 2312.9190478333176, 2317.2121478697322, 2347.8943447544902, 2348.941276468085, 2349.3774149850306, 8371.748847534524, 8478.66085356585, 8481.533515656636, 8484.618192181366, 8632.697855575025, 5228.843134705965, 5410.756515956791, 5420.620556561043, 5495.917561236584, 5499.340079190482, 3353.111425472252, 3377.037544299863, 3406.131436483706, 3432.9141771455666, 3447.844846981892, 1049.795289918466, 1078.466159251168, 1858.869879108463, 1893.6496748101645, 1958.7747409048, 11612.767744645143, 11631.592894248744, 11669.0, 11729.296242225493, 11737.413129343498, 4431.534688857688, 4616.584507394351, 4705.835295764632, 4712.363830882856, 4712.740799256006, 9400.435973841591, 9410.200132988773, 9413.90586094144, 9417.76455588602, 9424.528773561295, 5385.0, 5395.136778115482, 5396.109641909119, 5401.972990135103, 5404.486573775485, 4225.72532785368, 4378.10248898975, 4501.7974191161475, 4862.489438608895, 5072.087024335581, 3836.712246581518, 3860.131470419133, 3969.384745364473, 3987.860424885115, 3989.501312335958, 1183.2308999150448, 1253.260576260011, 1255.2092181925511, 1256.4597223193932, 1264.8861602455822, 932.8507438809758, 979.9265055120894, 984.7882705218412, 996.6063404955003, 1005.5424781724298, 5800.50695690871, 5907.940920590739, 5939.643621382731, 5995.550333724988, 6032.125341825411, 478.16798770139707, 479.13516103433636, 487.1572180128327, 487.99024019519413, 489.2978575743819, 4042.777647229431, 4066.1054567994993, 4130.0294430808735, 4150.813213405404, 4187.309093999517, 10058.698239052841, 10310.123639490577, 10389.740256493647, 10401.479926003669, 10403.947980260202, 9781.168600669023, 10256.58973641046, 10331.793364132674, 10339.0, 10343.482825858828, 7729.227077292226, 7914.129445760962, 7921.603919803987, 7923.920760792318, 7951.522908625501, 5647.407022262603, 5876.882462350643, 5935.614185077956, 5946.881062378815, 6195.287541932736, 9755.560999754885, 9834.803303934024, 9842.507874606097, 9850.113489785954, 9862.802743945225, 8645.092265312052, 9030.413023153475, 9765.9023409765, 9902.108810207115, 10046.146077583195, 7092.468064895257, 7366.631668416665, 7464.141623713343, 7465.365443937326, 7467.477276590586, 7672.271134242238, 7729.149793522821, 7739.535627862121, 7820.257075577811, 7821.296083352526, 6992.300769922967, 7061.929380706332, 7066.116735408074, 7109.111361079865, 7276.199618042117, 7134.750283740044, 7216.783496494903, 7223.783286501413, 7275.054242948383, 7355.632218388952, 6601.768938087336, 6663.566868153554, 6671.5997040177745, 6675.132232809704, 6699.062131301719, 4918.213085906238, 4976.2038073908, 4979.925301120414, 5018.623603229699, 5183.377994640668, 4959.70241785494, 4964.7765850537535, 5053.115704751727, 5098.439171691037, 5134.666246693953], "value": 4505.157629613407, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.5565459693488, 358.60911606349083, 363.781730961423, 364.98905032849024, 368.33331669677904, 5250.133727934895, 5332.426934054463, 5347.545458636016, 5412.539934105601, 5424.728763561826, 5096.337476128098, 5272.894542109156, 5304.416514183436, 5308.01801666692, 5327.893442131165, 4231.0, 4242.257604919142, 4253.489581250239, 4256.318988961767, 4256.829726810932, 4157.605027522381, 4213.283741763892, 4236.597523235303, 4240.1307731914885, 4275.102228532012, 4191.287481128215, 4196.601322874338, 4200.516940551845, 4201.642860356873, 4219.493660760713, 4207.410962465257, 4208.548050922427, 4211.694374743824, 4221.303484924983, 4258.126424373266, 3605.6214097519646, 3677.3748462761396, 3688.7786732796117, 3711.2577484502935, 3837.2517359114986, 5136.5890728741615, 5137.152369858969, 5141.940545375495, 5151.742412879341, 5161.0, 4752.0, 4753.500882407332, 4766.713997160146, 4782.3543821584335, 4783.790264567194, 5257.5005374489365, 5398.379186393576, 5510.972445137789, 5533.557315414757, 5534.778608855641, 4012.277789997799, 4014.9360419488858, 4024.5774193709826, 4033.3748269018056, 4041.717079804415, 5769.88460230793, 5798.695293558958, 5799.18811366409, 5821.53427725781, 5853.921857740484, 4114.033202197481, 4115.42384066231, 4164.4586203793315, 4200.1179752252365, 4221.366794980778, 4198.517170525429, 4206.72656277341, 4226.302660061117, 4228.365745138254, 4245.3844192591905, 4754.835065408928, 4764.38063051808, 4781.474037855833, 4824.734639594786, 4825.276208568743, 5438.108346288264, 5568.9443105569235, 5583.944160558342, 5594.042344902666, 5595.0, 1331.7269959658247, 1351.6080336702246, 1351.8648135186402, 1363.6795353092016, 1374.5670113914084, 969.7284760267137, 991.3952488981715, 995.994046013517, 1000.8548760429696, 1005.3766664667953, 5284.841454756363, 5288.497592728685, 5310.548603368757, 5378.596605254622, 5385.676859388371, 5497.257870187474, 5517.0, 5536.695481748462, 5558.748706773763, 5679.545636349082, 5158.587313014949, 5223.2948551945765, 5240.222681978557, 5275.155975043975, 5276.81531146408, 2904.8547572621283, 2907.6770069618274, 2911.7379435850876, 2914.877772057773, 2915.3731947631363, 5612.859678507988, 5902.557308201816, 5904.350521442638, 5980.51461403947, 5990.161377407167, 5846.736896839652, 5861.681121747658, 5904.5238690327415, 5906.586538942319, 5918.378570250062, 5754.251947246915, 5954.106883967353, 6003.849903752353, 6004.489618382487, 6019.217501724747, 5732.828015159552, 5762.8847423050465, 5771.653700777967, 5802.535797136304, 5819.5053420459735, 5730.971345143247, 5740.598158128891, 5752.827415177551, 5758.481736643722, 5787.971060144672, 5710.2862142232225, 5921.763129474945, 5950.583459157818, 5959.761609535743, 5965.313988891333, 4172.395002724648, 4198.307279299003, 4198.328267477189, 4227.577242275748, 4251.893702657459, 5752.712364381848, 5812.7674893003805, 5818.912716309174, 5878.470937615635, 5903.2325797646035, 5598.776048957996, 5615.0, 5622.88754224905, 5623.156526521055, 5658.405867383865, 5401.568584325236, 5640.153976903333, 5640.238567793295, 5651.378348381757, 5695.658260504383, 5346.385165705838, 5483.314585676791, 5531.787285085998, 5552.500274975271, 5561.221429000024, 5643.927653745775, 5651.717414129359, 5658.17956396312, 5663.801766938137, 5672.801451949162, 5283.788648454019, 5523.613347065667, 5535.121736696976, 5537.754005348765, 5558.6648011192965], "value": 4286.397492181219, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [737.3400806278378, 741.4883730226144, 744.7765670298911, 772.0966469230999, 834.2450082675181, 14946.0, 15874.523764287062, 15892.0, 15897.0, 15906.68186636268, 15314.617134571641, 15432.074075555474, 15462.768058479132, 15476.226188690576, 15485.303161357739, 716.0476566167011, 737.9852402951938, 811.4401063266357, 834.0950069174937, 841.9368547358941, 824.2252282854128, 834.2991886815074, 834.870595057767, 835.6490274084899, 835.908050114487, 898.1018981018981, 898.5282726568571, 899.7885496908222, 899.9910000900005, 900.1718419054486, 895.2614093372961, 896.1307531694246, 897.8428774964387, 897.9236764874994, 897.9820403591957, 659.864727730814, 661.8279247395664, 661.9371159739817, 662.370747789597, 662.4667142949924, 14653.70692586153, 14693.77959330611, 14702.191379474125, 14717.55847324582, 15509.922450387789, 14379.209143497104, 14985.625359365995, 15015.399384024626, 15112.01771884835, 15207.923960380238, 10594.31136976094, 10619.734506637318, 10716.78566428667, 10720.785584288271, 10807.297525660806, 3718.0704823794053, 3738.5700644425965, 3772.320982223199, 3788.0719223790347, 3798.924021519582, 62096.0, 64469.67765161191, 64569.677151614414, 64839.67580162069, 64989.3501064988, 11338.716532086764, 11360.0, 11419.429028548539, 11479.885201147881, 11537.826932596017, 21581.24465643695, 21638.459038523848, 21639.134434622752, 21705.782942170692, 21729.13083476643, 7392.889106663404, 7397.075365579302, 7489.962550187323, 7613.581253031137, 7662.272084151997, 4106.815193316308, 4158.4888366393525, 4294.484661840599, 4370.366296886934, 4436.733795972252, 3212.6305474870223, 3304.553885225464, 3329.067860998924, 3332.75004374668, 3404.69357757803, 585.1632166002572, 594.5540844366725, 599.8110595162597, 609.7804790275497, 615.3784677475782, 668.8361351468824, 695.7738734911175, 705.3264132753209, 715.7673756029311, 724.731849215783, 8175.468594541336, 8547.27348175412, 9002.414843035182, 9010.954945225232, 9212.585433655368, 619.3620570812071, 664.7440735316937, 718.7520305494596, 729.6278897762179, 730.3353947907485, 4214.536400995888, 4221.5567365426805, 4407.316865885793, 4408.206522825923, 4423.049044455457, 58190.4180958185, 88927.55536222277, 89581.55209224042, 92371.0, 92564.0, 49704.50295496999, 62830.0575491368, 80317.19682803215, 82852.58573707093, 83620.58189709134, 44387.334189987174, 66349.33650663529, 69605.99999999898, 71045.2895471049, 71907.0, 8669.306455483673, 8685.652573896974, 8740.300775938036, 8770.956145219234, 8808.383413161273, 48617.270740938206, 49657.50342496529, 49845.252321215936, 50068.749656251486, 51394.0, 40571.98570035655, 64593.67703161454, 67861.66069169622, 69272.0, 70532.64733676298, 10956.726081847699, 11193.552257909918, 11213.71965700864, 11403.543858245577, 11458.598949036743, 12708.237505749685, 12981.091323607257, 13314.667133321356, 13348.132371395828, 13561.593152205449, 12282.324472154118, 12338.938305308417, 12688.23870567769, 12936.676583085498, 12995.0, 12865.228086314852, 13117.934410327887, 13489.527866524624, 13517.459301628218, 13735.793963090762, 12518.248905065726, 13040.217586944813, 13135.211887286794, 13183.67040823987, 13415.0, 9802.166815820736, 9872.703818885446, 9896.901030989886, 9943.552540135566, 10369.481525923522, 10324.174066074846, 10964.506597203304, 11011.341213051224, 11049.558017679203, 11135.33188008722], "value": 7089.767739856257, "unit": "score"}], "name": "dromaeo_css", "value": 7186.299070352073, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 110.0, 110.0, 112.0, 111.0, 112.0, 110.0, 114.0, 111.0, 111.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 119.0, 121.0, 156.0, 119.0, 117.0, 117.0, 122.0, 144.0, 118.0], "value": 128.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 159.0, 160.0, 161.0, 161.0, 160.0, 160.0, 160.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 108.0, 75.0, 75.0, 75.0, 77.0, 105.0, 76.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 124.0, 82.0, 83.0, 81.0, 98.0, 81.0, 81.0, 113.0], "value": 90.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 84.0, 85.0, 84.0, 84.0, 85.0, 85.0, 85.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 50.0, 52.0, 52.0, 52.0, 51.0, 53.0, 52.0, 52.0, 51.0], "value": 51.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 62.0, 61.0, 60.0, 60.0, 59.0, 59.0, 60.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 79.0, 80.0, 74.0, 79.0, 74.0, 74.0, 74.0, 73.0, 74.0], "value": 76.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 122.0, 123.0, 134.0, 121.0, 119.0, 119.0, 124.0, 165.0, 121.0], "value": 128.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 157.0, 153.0, 155.0, 155.0, 154.0, 158.0, 158.0, 163.0, 157.0], "value": 156.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 63.0, 63.0, 63.0, 64.0, 63.0, 63.0, 62.0], "value": 63.1, "unit": "score"}], "name": "kraken", "value": 1454.8999999999999, "alertThreshold": 2.0}]} 09:12:05 INFO - Return code: 0 09:12:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:12:05 INFO - # TBPL SUCCESS # 09:12:05 INFO - Running post-action listener: _resource_record_post_action 09:12:05 INFO - [mozharness: 2017-02-20 17:12:05.345748Z] Finished run-tests step (success) 09:12:05 INFO - Running post-run listener: _resource_record_post_run 09:12:05 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 331939840; Read time: 8; Write time: 194112 09:12:05 INFO - TinderboxPrint: CPU usage
12.9% 09:12:05 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 09:12:05 INFO - TinderboxPrint: I/O write bytes / time
331,939,840 / 194,112 09:12:05 INFO - TinderboxPrint: CPU idle
8,264.0 (87.1%) 09:12:05 INFO - TinderboxPrint: CPU user
1,186.4 (12.5%) 09:12:05 INFO - TinderboxPrint: Swap in / out
0 / 0 09:12:05 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 112300032; Read time: 0; Write time: 67200 09:12:05 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 219639808; Read time: 8; Write time: 126912 09:12:05 INFO - Running post-run listener: _upload_blobber_files 09:12:05 INFO - Blob upload gear active. 09:12:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:12:05 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:12:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:12:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:12:06 INFO - (blobuploader) - INFO - Open directory for files ... 09:12:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:12:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:12:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:12:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:12:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:12:07 INFO - (blobuploader) - INFO - Done attempting. 09:12:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:12:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:12:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:12:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:12:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:12:10 INFO - (blobuploader) - INFO - Done attempting. 09:12:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:12:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:12:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:12:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:12:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:12:11 INFO - (blobuploader) - INFO - Done attempting. 09:12:11 INFO - (blobuploader) - INFO - Iteration through files over. 09:12:11 INFO - Return code: 0 09:12:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:12:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:12:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ff9d0ade8dc8c316cf8655efe2d034ac643090946a7017a50ecd6bdb6168d7da37f9d8e4024fb1adc619ee48db92bb30ad787ae5e74b911576c51e6af6012461", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d79857a8ba1c333bdc6a638748fa9e3ae861c21ea0f96325a4fed820966059cb16102e2250f95643073c0fbea3fe10c9fc608bde46d760a19d59eab06c1f89b7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/31718fbe8409865adf038067047f4985da0e9168f41fff6893b2b7b2212cfec6e9d9a572a118e07687119a52e7b402dd102417739560fce026a41fd64e8fac2c"} 09:12:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:12:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:12:11 INFO - Contents: 09:12:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ff9d0ade8dc8c316cf8655efe2d034ac643090946a7017a50ecd6bdb6168d7da37f9d8e4024fb1adc619ee48db92bb30ad787ae5e74b911576c51e6af6012461", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d79857a8ba1c333bdc6a638748fa9e3ae861c21ea0f96325a4fed820966059cb16102e2250f95643073c0fbea3fe10c9fc608bde46d760a19d59eab06c1f89b7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/31718fbe8409865adf038067047f4985da0e9168f41fff6893b2b7b2212cfec6e9d9a572a118e07687119a52e7b402dd102417739560fce026a41fd64e8fac2c"} 09:12:11 INFO - Running post-run listener: copy_logs_to_upload_dir 09:12:11 INFO - Copying logs to upload dir... 09:12:11 INFO - mkdir: /builds/slave/test/build/upload/logs 09:12:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.074667 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-02-20 09:12:10.682139) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-20 09:12:10.685152) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1487608364.973979-562395971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ff9d0ade8dc8c316cf8655efe2d034ac643090946a7017a50ecd6bdb6168d7da37f9d8e4024fb1adc619ee48db92bb30ad787ae5e74b911576c51e6af6012461", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d79857a8ba1c333bdc6a638748fa9e3ae861c21ea0f96325a4fed820966059cb16102e2250f95643073c0fbea3fe10c9fc608bde46d760a19d59eab06c1f89b7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/31718fbe8409865adf038067047f4985da0e9168f41fff6893b2b7b2212cfec6e9d9a572a118e07687119a52e7b402dd102417739560fce026a41fd64e8fac2c"} build_url:https://queue.taskcluster.net/v1/task/D4GqBfJeShGxw6opEygDhg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011426 build_url: 'https://queue.taskcluster.net/v1/task/D4GqBfJeShGxw6opEygDhg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ff9d0ade8dc8c316cf8655efe2d034ac643090946a7017a50ecd6bdb6168d7da37f9d8e4024fb1adc619ee48db92bb30ad787ae5e74b911576c51e6af6012461", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d79857a8ba1c333bdc6a638748fa9e3ae861c21ea0f96325a4fed820966059cb16102e2250f95643073c0fbea3fe10c9fc608bde46d760a19d59eab06c1f89b7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/31718fbe8409865adf038067047f4985da0e9168f41fff6893b2b7b2212cfec6e9d9a572a118e07687119a52e7b402dd102417739560fce026a41fd64e8fac2c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-20 09:12:10.709260) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-20 09:12:10.709562) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1487608364.973979-562395971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-20 09:12:10.794537) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-20 09:12:10.794845) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-20 09:12:10.795125) ========= ========= Total master_lag: 0.17 =========