builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-027 starttime: 1475604428.06 results: success (0) buildid: 20161004095100 builduid: dd0d322500d44e469cf86829747df4ed revision: d8a271c72525309029b952075dcbdb9b2f1a284a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 11:07:08.056158) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 11:07:08.056731) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 11:07:08.057079) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 11:07:08.072199) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 11:07:08.072513) ========= 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=1f5564757af27664ca02d71f000001b0-1475603429.973071-1518134071 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-04 11:07:08-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 136M=0s 2016-10-04 11:07:08 (136 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.144234 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 11:07:08.234510) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 11:07:08.234943) ========= 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=1f5564757af27664ca02d71f000001b0-1475603429.973071-1518134071 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022436 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 11:07:08.286906) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-04 11:07:08.287275) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev d8a271c72525309029b952075dcbdb9b2f1a284a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev d8a271c72525309029b952075dcbdb9b2f1a284a --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=1f5564757af27664ca02d71f000001b0-1475603429.973071-1518134071 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-04 11:07:08,552 truncating revision to first 12 chars 2016-10-04 11:07:08,552 Setting DEBUG logging. 2016-10-04 11:07:08,552 attempt 1/10 2016-10-04 11:07:08,552 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/d8a271c72525?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-04 11:07:09,336 unpacking tar archive at: autoland-d8a271c72525/testing/mozharness/ program finished with exit code 0 elapsedTime=1.366607 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-04 11:07:09.667579) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 11:07:09.667934) ========= script_repo_revision: d8a271c72525309029b952075dcbdb9b2f1a284a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 11:07:09.668371) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 11:07:09.668707) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 11:07:09.677792) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-10-04 11:07:09.678138) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 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', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] 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=1f5564757af27664ca02d71f000001b0-1475603429.973071-1518134071 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:07:10 INFO - MultiFileLogger online at 20161004 11:07:10 in /builds/slave/test 11:07:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 11:07:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:07:10 INFO - {'append_to_log': False, 11:07:10 INFO - 'base_work_dir': '/builds/slave/test', 11:07:10 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 11:07:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:07:10 INFO - 'branch': 'Autoland-Non-PGO', 11:07:10 INFO - 'buildbot_json_path': 'buildprops.json', 11:07:10 INFO - 'config_files': ('talos/linux_config.py',), 11:07:10 INFO - 'default_actions': ('clobber', 11:07:10 INFO - 'read-buildbot-config', 11:07:10 INFO - 'download-and-extract', 11:07:10 INFO - 'populate-webroot', 11:07:10 INFO - 'create-virtualenv', 11:07:10 INFO - 'install', 11:07:10 INFO - 'run-tests'), 11:07:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:07:10 INFO - 'download_minidump_stackwalk': True, 11:07:10 INFO - 'download_symbols': 'ondemand', 11:07:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:07:10 INFO - 'tooltool.py': '/tools/tooltool.py', 11:07:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:07:10 INFO - '/tools/misc-python/virtualenv.py')}, 11:07:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:07:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:07:10 INFO - 'installer_path': 'installer.exe', 11:07:10 INFO - 'log_level': 'info', 11:07:10 INFO - 'log_name': 'talos', 11:07:10 INFO - 'log_to_console': True, 11:07:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:07:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:07:10 INFO - 'opt_config_files': (), 11:07:10 INFO - 'pip_index': False, 11:07:10 INFO - 'sps_profile': False, 11:07:10 INFO - 'sps_profile_interval': 0, 11:07:10 INFO - 'suite': 'dromaeojs', 11:07:10 INFO - 'system_bits': '32', 11:07:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:07:10 INFO - 'title': 'talos-linux64-ix-027', 11:07:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:07:10 INFO - 'use_talos_json': True, 11:07:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:07:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:07:10 INFO - 'work_dir': 'build'} 11:07:10 INFO - [mozharness: 2016-10-04 18:07:10.049391Z] Running clobber step. 11:07:10 INFO - Running pre-action listener: _resource_record_pre_action 11:07:10 INFO - Running main action method: clobber 11:07:10 INFO - rmtree: /builds/slave/test/build 11:07:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:07:10 INFO - Running post-action listener: _resource_record_post_action 11:07:10 INFO - [mozharness: 2016-10-04 18:07:10.509762Z] Finished clobber step (success) 11:07:10 INFO - [mozharness: 2016-10-04 18:07:10.509870Z] Running read-buildbot-config step. 11:07:10 INFO - Running pre-action listener: _resource_record_pre_action 11:07:10 INFO - Running main action method: read_buildbot_config 11:07:10 INFO - Using buildbot properties: 11:07:10 INFO - { 11:07:10 INFO - "project": "", 11:07:10 INFO - "product": "firefox", 11:07:10 INFO - "script_repo_revision": "production", 11:07:10 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 11:07:10 INFO - "repository": "", 11:07:10 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 11:07:10 INFO - "buildid": "20161004095100", 11:07:10 INFO - "pgo_build": "False", 11:07:10 INFO - "basedir": "/builds/slave/test", 11:07:10 INFO - "buildnumber": 771, 11:07:10 INFO - "slavename": "talos-linux64-ix-027", 11:07:10 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:07:10 INFO - "platform": "ubuntu64_hw", 11:07:10 INFO - "scheduler": "tests-autoland-linux64-talos", 11:07:10 INFO - "branch": "autoland", 11:07:10 INFO - "repo_path": "integration/autoland", 11:07:10 INFO - "revision": "d8a271c72525309029b952075dcbdb9b2f1a284a", 11:07:10 INFO - "stage_platform": "linux64", 11:07:10 INFO - "builduid": "dd0d322500d44e469cf86829747df4ed", 11:07:10 INFO - "slavebuilddir": "test" 11:07:10 INFO - } 11:07:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/eWQrRHLxTiqHAP79VaSgVw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 11:07:10 INFO - Running post-action listener: _resource_record_post_action 11:07:10 INFO - [mozharness: 2016-10-04 18:07:10.512317Z] Finished read-buildbot-config step (success) 11:07:10 INFO - [mozharness: 2016-10-04 18:07:10.512405Z] Running download-and-extract step. 11:07:10 INFO - Running pre-action listener: _resource_record_pre_action 11:07:10 INFO - Running main action method: download_and_extract 11:07:10 INFO - mkdir: /builds/slave/test/build/tests 11:07:10 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')]} 11:07:10 INFO - trying https://queue.taskcluster.net/v1/task/eWQrRHLxTiqHAP79VaSgVw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 11:07:10 INFO - Downloading https://queue.taskcluster.net/v1/task/eWQrRHLxTiqHAP79VaSgVw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 11:07:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eWQrRHLxTiqHAP79VaSgVw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:07:11 INFO - Downloaded 1201 bytes. 11:07:11 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 11:07:11 INFO - Using the following test package requirements: 11:07:11 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 11:07:11 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:07:11 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:07:11 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:11 INFO - u'jsshell-linux-x86_64.zip'], 11:07:11 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:07:11 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 11:07:11 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:07:11 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:07:11 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:07:11 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:07:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eWQrRHLxTiqHAP79VaSgVw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 11:07:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eWQrRHLxTiqHAP79VaSgVw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:07:11 INFO - Fetch https://queue.taskcluster.net/v1/task/eWQrRHLxTiqHAP79VaSgVw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 11:07:11 INFO - Http code: 200 11:07:11 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 11:07:11 INFO - x-amz-cf-id: A0UsyDk-c5HYJzO97DWZRfmM1_A1qFTrM32DQAQDBSgeYW40n3TRiQ== 11:07:11 INFO - x-amz-version-id: KJWUDpl4hiMQaUj7baO32HZZLLd.Hhq0 11:07:11 INFO - Expected file size: 20421424 11:07:11 INFO - Obtained file size: 20421424 11:07:15 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:07:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eWQrRHLxTiqHAP79VaSgVw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 11:07:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eWQrRHLxTiqHAP79VaSgVw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:07:15 INFO - Fetch https://queue.taskcluster.net/v1/task/eWQrRHLxTiqHAP79VaSgVw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 11:07:16 INFO - Http code: 200 11:07:16 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 11:07:16 INFO - x-amz-cf-id: mCUb7-dyW2XZFhgm77o3htyoxR2Yu_5gC73s7YkWRErx6SFhJZBlgQ== 11:07:16 INFO - x-amz-version-id: KJWUDpl4hiMQaUj7baO32HZZLLd.Hhq0 11:07:16 INFO - Expected file size: 20421424 11:07:16 INFO - Obtained file size: 20421424 11:07:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eWQrRHLxTiqHAP79VaSgVw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 11:07:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eWQrRHLxTiqHAP79VaSgVw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:07:21 INFO - Fetch https://queue.taskcluster.net/v1/task/eWQrRHLxTiqHAP79VaSgVw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 11:07:21 INFO - Http code: 200 11:07:21 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 11:07:21 INFO - x-amz-cf-id: MI9GPXGBpRiDhMx_5F2zWVCFafe8rfy-Eb18lwVWgQVDsCQw-fA3oA== 11:07:21 INFO - x-amz-version-id: IVACfnA.Uh5Xn2tRqCN8BZf67PcnmUWN 11:07:22 INFO - Expected file size: 14409006 11:07:22 INFO - Obtained file size: 14409006 11:07:22 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')]} 11:07:22 INFO - trying https://queue.taskcluster.net/v1/task/eWQrRHLxTiqHAP79VaSgVw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:07:22 INFO - Downloading https://queue.taskcluster.net/v1/task/eWQrRHLxTiqHAP79VaSgVw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:07:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eWQrRHLxTiqHAP79VaSgVw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:07:23 INFO - Downloaded 55791620 bytes. 11:07:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eWQrRHLxTiqHAP79VaSgVw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:07:23 INFO - mkdir: /builds/slave/test/properties 11:07:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:07:23 INFO - Writing to file /builds/slave/test/properties/build_url 11:07:23 INFO - Contents: 11:07:23 INFO - build_url:https://queue.taskcluster.net/v1/task/eWQrRHLxTiqHAP79VaSgVw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:07:24 INFO - Running post-action listener: _resource_record_post_action 11:07:24 INFO - Running post-action listener: set_extra_try_arguments 11:07:24 INFO - [mozharness: 2016-10-04 18:07:24.059049Z] Finished download-and-extract step (success) 11:07:24 INFO - [mozharness: 2016-10-04 18:07:24.059277Z] Running populate-webroot step. 11:07:24 INFO - Running pre-action listener: _resource_record_pre_action 11:07:24 INFO - Running main action method: populate_webroot 11:07:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:07:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:07:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:07:24 INFO - '--tppagecycles', 11:07:24 INFO - '7'], 11:07:24 INFO - 'tests': ['tsvgm']}}, 11:07:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:07:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:07:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:07:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:07:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:07:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:07:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:24 INFO - 'talos_options': ['--disable-e10s'], 11:07:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:07:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:07:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:24 INFO - 'talos_options': ['--disable-e10s'], 11:07:24 INFO - 'tests': ['damp', 'tps']}, 11:07:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:24 INFO - 'tests': ['damp', 'tps']}, 11:07:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:07:24 INFO - 'tests': ['dromaeo_dom']}, 11:07:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:07:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:07:24 INFO - 'tests': ['basic_compositor_video']}, 11:07:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:07:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:07:24 INFO - 'tests': ['a11yr', 11:07:24 INFO - 'ts_paint', 11:07:24 INFO - 'tpaint', 11:07:24 INFO - 'sessionrestore', 11:07:24 INFO - 'sessionrestore_no_auto_restore', 11:07:24 INFO - 'tabpaint']}, 11:07:24 INFO - 'other-e10s': {'tests': ['a11yr', 11:07:24 INFO - 'ts_paint', 11:07:24 INFO - 'tpaint', 11:07:24 INFO - 'sessionrestore', 11:07:24 INFO - 'sessionrestore_no_auto_restore', 11:07:24 INFO - 'tabpaint']}, 11:07:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:07:24 INFO - 'ts_paint', 11:07:24 INFO - 'tpaint', 11:07:24 INFO - 'sessionrestore', 11:07:24 INFO - 'sessionrestore_no_auto_restore', 11:07:24 INFO - 'tabpaint']}, 11:07:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:07:24 INFO - 'ts_paint', 11:07:24 INFO - 'tpaint', 11:07:24 INFO - 'sessionrestore', 11:07:24 INFO - 'sessionrestore_no_auto_restore', 11:07:24 INFO - 'tabpaint']}, 11:07:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:07:24 INFO - 'tests': ['a11yr', 11:07:24 INFO - 'ts_paint', 11:07:24 INFO - 'tpaint', 11:07:24 INFO - 'sessionrestore', 11:07:24 INFO - 'sessionrestore_no_auto_restore', 11:07:24 INFO - 'tabpaint']}, 11:07:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:07:24 INFO - 'tests': ['a11yr', 11:07:24 INFO - 'ts_paint', 11:07:24 INFO - 'tpaint', 11:07:24 INFO - 'sessionrestore', 11:07:24 INFO - 'sessionrestore_no_auto_restore', 11:07:24 INFO - 'tabpaint']}, 11:07:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:07:24 INFO - 'tests': ['tsvgx', 11:07:24 INFO - 'tsvgr_opacity', 11:07:24 INFO - 'tart', 11:07:24 INFO - 'tscrollx', 11:07:24 INFO - 'cart']}, 11:07:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:07:24 INFO - 'tsvgr_opacity', 11:07:24 INFO - 'tart', 11:07:24 INFO - 'tscrollx', 11:07:24 INFO - 'cart']}, 11:07:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:24 INFO - 'talos_options': ['--disable-e10s'], 11:07:24 INFO - 'tests': ['tp5o']}, 11:07:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:24 INFO - 'tests': ['tp5o']}, 11:07:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:24 INFO - 'talos_options': ['--disable-e10s', 11:07:24 INFO - '--xperf_path', 11:07:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:07:24 INFO - 'tests': ['tp5n']}, 11:07:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:24 INFO - 'talos_options': ['--xperf_path', 11:07:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:07:24 INFO - 'tests': ['tp5n']}}, 11:07:24 INFO - 'talos.zip': {'path': '', 11:07:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:07:24 INFO - Running post-action listener: _resource_record_post_action 11:07:24 INFO - [mozharness: 2016-10-04 18:07:24.079058Z] Finished populate-webroot step (success) 11:07:24 INFO - [mozharness: 2016-10-04 18:07:24.079146Z] Running create-virtualenv step. 11:07:24 INFO - Running pre-action listener: _resource_record_pre_action 11:07:24 INFO - Running main action method: create_virtualenv 11:07:24 INFO - Creating virtualenv /builds/slave/test/build/venv 11:07:24 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 11:07:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:07:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:07:24 INFO - Using real prefix '/usr' 11:07:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:07:24 INFO - Installing distribute.............................................................................................................................................................................................done. 11:07:26 INFO - Installing pip.................done. 11:07:26 INFO - Return code: 0 11:07:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:07:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:07:26 INFO - Reading from file tmpfile_stdout 11:07:26 INFO - Output received: 11:07:26 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) 11:07:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:07:26 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')]} 11:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:26 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')]} 11:07:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:26 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 0x7fa3c7e86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27fdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27faf60>, '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 0x27fbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27fc1d0>, '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': '1f5564757af27664ca02d71f000001b0-1475603429.973071-1518134071', '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 11:07:26 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 11:07:26 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 11:07:26 INFO - Using env: {'DISPLAY': ':0', 11:07:26 INFO - 'HOME': '/home/cltbld', 11:07:26 INFO - 'LANG': 'en_US.UTF-8', 11:07:26 INFO - 'LANGUAGE': 'en_US:en', 11:07:26 INFO - 'LOGNAME': 'cltbld', 11:07:26 INFO - 'MAIL': '/var/mail/cltbld', 11:07:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:26 INFO - 'MOZ_NO_REMOTE': '1', 11:07:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:26 INFO - 'NO_EM_RESTART': '1', 11:07:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:26 INFO - 'PWD': '/builds/slave/test', 11:07:26 INFO - 'SHELL': '/bin/bash', 11:07:26 INFO - 'SHLVL': '1', 11:07:26 INFO - 'TERM': 'linux', 11:07:26 INFO - 'TMOUT': '86400', 11:07:26 INFO - 'USER': 'cltbld', 11:07:26 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475603429.973071-1518134071', 11:07:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:26 INFO - '_': '/tools/buildbot/bin/python'} 11:07:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:27 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 11:07:27 INFO - Cleaning up... 11:07:27 INFO - Return code: 0 11:07:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:07:27 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')]} 11:07:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:27 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')]} 11:07:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:27 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 0x7fa3c7e86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27fdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27faf60>, '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 0x27fbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27fc1d0>, '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': '1f5564757af27664ca02d71f000001b0-1475603429.973071-1518134071', '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 11:07:27 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 11:07:27 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 11:07:27 INFO - Using env: {'DISPLAY': ':0', 11:07:27 INFO - 'HOME': '/home/cltbld', 11:07:27 INFO - 'LANG': 'en_US.UTF-8', 11:07:27 INFO - 'LANGUAGE': 'en_US:en', 11:07:27 INFO - 'LOGNAME': 'cltbld', 11:07:27 INFO - 'MAIL': '/var/mail/cltbld', 11:07:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:27 INFO - 'MOZ_NO_REMOTE': '1', 11:07:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:27 INFO - 'NO_EM_RESTART': '1', 11:07:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:27 INFO - 'PWD': '/builds/slave/test', 11:07:27 INFO - 'SHELL': '/bin/bash', 11:07:27 INFO - 'SHLVL': '1', 11:07:27 INFO - 'TERM': 'linux', 11:07:27 INFO - 'TMOUT': '86400', 11:07:27 INFO - 'USER': 'cltbld', 11:07:27 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475603429.973071-1518134071', 11:07:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:27 INFO - '_': '/tools/buildbot/bin/python'} 11:07:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:27 INFO - Downloading/unpacking psutil>=3.1.1 11:07:27 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 11:07:27 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 11:07:27 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 11:07:27 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 11:07:27 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 11:07:27 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 11:07:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:07:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:07:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:07:29 INFO - Installing collected packages: psutil 11:07:29 INFO - Running setup.py install for psutil 11:07:29 INFO - building 'psutil._psutil_linux' extension 11:07:29 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 11:07:29 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 11:07:29 INFO - building 'psutil._psutil_posix' extension 11:07:29 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 11:07:29 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 11:07:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:07:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:07:29 INFO - Successfully installed psutil 11:07:29 INFO - Cleaning up... 11:07:29 INFO - Return code: 0 11:07:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:07: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')]} 11:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07: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')]} 11:07:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:29 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 0x7fa3c7e86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27fdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27faf60>, '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 0x27fbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27fc1d0>, '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': '1f5564757af27664ca02d71f000001b0-1475603429.973071-1518134071', '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 11:07:29 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 11:07:29 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 11:07:29 INFO - Using env: {'DISPLAY': ':0', 11:07:29 INFO - 'HOME': '/home/cltbld', 11:07:29 INFO - 'LANG': 'en_US.UTF-8', 11:07:29 INFO - 'LANGUAGE': 'en_US:en', 11:07:29 INFO - 'LOGNAME': 'cltbld', 11:07:29 INFO - 'MAIL': '/var/mail/cltbld', 11:07:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:29 INFO - 'MOZ_NO_REMOTE': '1', 11:07:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:29 INFO - 'NO_EM_RESTART': '1', 11:07:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:29 INFO - 'PWD': '/builds/slave/test', 11:07:29 INFO - 'SHELL': '/bin/bash', 11:07:29 INFO - 'SHLVL': '1', 11:07:29 INFO - 'TERM': 'linux', 11:07:29 INFO - 'TMOUT': '86400', 11:07:29 INFO - 'USER': 'cltbld', 11:07:29 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475603429.973071-1518134071', 11:07:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:29 INFO - '_': '/tools/buildbot/bin/python'} 11:07:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:07:30 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 11:07:30 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 11:07:30 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 11:07:30 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 11:07:30 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 11:07:30 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 11:07:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:07:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:07:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:07:32 INFO - Installing collected packages: mozsystemmonitor 11:07:32 INFO - Running setup.py install for mozsystemmonitor 11:07:32 INFO - Successfully installed mozsystemmonitor 11:07:32 INFO - Cleaning up... 11:07:32 INFO - Return code: 0 11:07:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:07:32 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')]} 11:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:32 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')]} 11:07:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:32 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 0x7fa3c7e86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27fdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27faf60>, '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 0x27fbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27fc1d0>, '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': '1f5564757af27664ca02d71f000001b0-1475603429.973071-1518134071', '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 11:07:32 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 11:07:32 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 11:07:32 INFO - Using env: {'DISPLAY': ':0', 11:07:32 INFO - 'HOME': '/home/cltbld', 11:07:32 INFO - 'LANG': 'en_US.UTF-8', 11:07:32 INFO - 'LANGUAGE': 'en_US:en', 11:07:32 INFO - 'LOGNAME': 'cltbld', 11:07:32 INFO - 'MAIL': '/var/mail/cltbld', 11:07:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:32 INFO - 'MOZ_NO_REMOTE': '1', 11:07:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:32 INFO - 'NO_EM_RESTART': '1', 11:07:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:32 INFO - 'PWD': '/builds/slave/test', 11:07:32 INFO - 'SHELL': '/bin/bash', 11:07:32 INFO - 'SHLVL': '1', 11:07:32 INFO - 'TERM': 'linux', 11:07:32 INFO - 'TMOUT': '86400', 11:07:32 INFO - 'USER': 'cltbld', 11:07:32 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475603429.973071-1518134071', 11:07:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:32 INFO - '_': '/tools/buildbot/bin/python'} 11:07:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:32 INFO - Downloading/unpacking jsonschema==2.5.1 11:07:32 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 11:07:32 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 11:07:32 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 11:07:32 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 11:07:32 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 11:07:32 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 11:07:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:07:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:07:34 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 11:07:34 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 11:07:34 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 11:07:34 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 11:07:34 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 11:07:34 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 11:07:34 INFO - Downloading functools32-3.2.3-2.tar.gz 11:07:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:07:34 INFO - warning: no files found matching '*.txt' 11:07:34 INFO - no previously-included directories found matching 'build' 11:07:34 INFO - no previously-included directories found matching 'dist' 11:07:34 INFO - no previously-included directories found matching '.git*' 11:07:34 INFO - Installing collected packages: jsonschema, functools32 11:07:34 INFO - Running setup.py install for functools32 11:07:34 INFO - warning: no files found matching '*.txt' 11:07:34 INFO - no previously-included directories found matching 'build' 11:07:34 INFO - no previously-included directories found matching 'dist' 11:07:34 INFO - no previously-included directories found matching '.git*' 11:07:34 INFO - Successfully installed jsonschema functools32 11:07:34 INFO - Cleaning up... 11:07:34 INFO - Return code: 0 11:07:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:07:34 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')]} 11:07:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:34 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')]} 11:07:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:34 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 0x7fa3c7e86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27fdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27faf60>, '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 0x27fbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27fc1d0>, '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': '1f5564757af27664ca02d71f000001b0-1475603429.973071-1518134071', '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 11:07:34 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 11:07:34 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 11:07:34 INFO - Using env: {'DISPLAY': ':0', 11:07:34 INFO - 'HOME': '/home/cltbld', 11:07:34 INFO - 'LANG': 'en_US.UTF-8', 11:07:34 INFO - 'LANGUAGE': 'en_US:en', 11:07:34 INFO - 'LOGNAME': 'cltbld', 11:07:34 INFO - 'MAIL': '/var/mail/cltbld', 11:07:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:34 INFO - 'MOZ_NO_REMOTE': '1', 11:07:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:34 INFO - 'NO_EM_RESTART': '1', 11:07:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:34 INFO - 'PWD': '/builds/slave/test', 11:07:34 INFO - 'SHELL': '/bin/bash', 11:07:34 INFO - 'SHLVL': '1', 11:07:34 INFO - 'TERM': 'linux', 11:07:34 INFO - 'TMOUT': '86400', 11:07:34 INFO - 'USER': 'cltbld', 11:07:34 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475603429.973071-1518134071', 11:07:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:34 INFO - '_': '/tools/buildbot/bin/python'} 11:07:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:07:35 INFO - Cleaning up... 11:07:35 INFO - Return code: 0 11:07:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:07:35 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')]} 11:07:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:35 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')]} 11:07:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:35 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 0x7fa3c7e86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27fdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27faf60>, '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 0x27fbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27fc1d0>, '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': '1f5564757af27664ca02d71f000001b0-1475603429.973071-1518134071', '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 11:07:35 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 11:07:35 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 11:07:35 INFO - Using env: {'DISPLAY': ':0', 11:07:35 INFO - 'HOME': '/home/cltbld', 11:07:35 INFO - 'LANG': 'en_US.UTF-8', 11:07:35 INFO - 'LANGUAGE': 'en_US:en', 11:07:35 INFO - 'LOGNAME': 'cltbld', 11:07:35 INFO - 'MAIL': '/var/mail/cltbld', 11:07:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:35 INFO - 'MOZ_NO_REMOTE': '1', 11:07:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:35 INFO - 'NO_EM_RESTART': '1', 11:07:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:35 INFO - 'PWD': '/builds/slave/test', 11:07:35 INFO - 'SHELL': '/bin/bash', 11:07:35 INFO - 'SHLVL': '1', 11:07:35 INFO - 'TERM': 'linux', 11:07:35 INFO - 'TMOUT': '86400', 11:07:35 INFO - 'USER': 'cltbld', 11:07:35 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475603429.973071-1518134071', 11:07:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:35 INFO - '_': '/tools/buildbot/bin/python'} 11:07:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:35 INFO - Downloading/unpacking blobuploader==1.2.4 11:07:35 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 11:07:35 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 11:07:35 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 11:07:35 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 11:07:35 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 11:07:35 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 11:07:37 INFO - Downloading blobuploader-1.2.4.tar.gz 11:07:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:07:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:07:37 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 11:07:37 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 11:07:37 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 11:07:37 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 11:07:37 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 11:07:37 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 11:07:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:07:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:07:37 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 11:07:37 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 11:07:37 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 11:07:37 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 11:07:37 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 11:07:37 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 11:07:37 INFO - Downloading docopt-0.6.1.tar.gz 11:07:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:07:37 INFO - Installing collected packages: blobuploader, requests, docopt 11:07:37 INFO - Running setup.py install for blobuploader 11:07:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:07:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:07:38 INFO - Running setup.py install for requests 11:07:38 INFO - Running setup.py install for docopt 11:07:38 INFO - Successfully installed blobuploader requests docopt 11:07:38 INFO - Cleaning up... 11:07:38 INFO - Return code: 0 11:07:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:07:38 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')]} 11:07:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:38 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')]} 11:07:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:38 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 0x7fa3c7e86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27fdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27faf60>, '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 0x27fbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27fc1d0>, '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': '1f5564757af27664ca02d71f000001b0-1475603429.973071-1518134071', '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 11:07:38 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 11:07:38 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 11:07:38 INFO - Using env: {'DISPLAY': ':0', 11:07:38 INFO - 'HOME': '/home/cltbld', 11:07:38 INFO - 'LANG': 'en_US.UTF-8', 11:07:38 INFO - 'LANGUAGE': 'en_US:en', 11:07:38 INFO - 'LOGNAME': 'cltbld', 11:07:38 INFO - 'MAIL': '/var/mail/cltbld', 11:07:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:38 INFO - 'MOZ_NO_REMOTE': '1', 11:07:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:38 INFO - 'NO_EM_RESTART': '1', 11:07:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:38 INFO - 'PWD': '/builds/slave/test', 11:07:38 INFO - 'SHELL': '/bin/bash', 11:07:38 INFO - 'SHLVL': '1', 11:07:38 INFO - 'TERM': 'linux', 11:07:38 INFO - 'TMOUT': '86400', 11:07:38 INFO - 'USER': 'cltbld', 11:07:38 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475603429.973071-1518134071', 11:07:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:38 INFO - '_': '/tools/buildbot/bin/python'} 11:07:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:07:38 INFO - Running setup.py (path:/tmp/pip-yRzbeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:07:38 INFO - Running setup.py (path:/tmp/pip-My9F0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:07:39 INFO - Running setup.py (path:/tmp/pip-TPlkep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:07:39 INFO - Running setup.py (path:/tmp/pip-UExBxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:07:39 INFO - Running setup.py (path:/tmp/pip-c6WDOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:07:39 INFO - Running setup.py (path:/tmp/pip-T5MBsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:07:39 INFO - Running setup.py (path:/tmp/pip-RqbodB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:07:39 INFO - Running setup.py (path:/tmp/pip-WcGeF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:07:39 INFO - Running setup.py (path:/tmp/pip-DntnFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:07:39 INFO - Running setup.py (path:/tmp/pip-gQ2SHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:07:39 INFO - Running setup.py (path:/tmp/pip-ZydH_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:07:39 INFO - Running setup.py (path:/tmp/pip-2VYrRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:07:39 INFO - Running setup.py (path:/tmp/pip-08URpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:07:39 INFO - Running setup.py (path:/tmp/pip-XosSxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:39 INFO - Running setup.py (path:/tmp/pip-iMX3sV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:07:39 INFO - Running setup.py (path:/tmp/pip-OHPVT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:07:40 INFO - Running setup.py (path:/tmp/pip-IzUUQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:07:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:07:40 INFO - Running setup.py install for manifestparser 11:07:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:07:40 INFO - Running setup.py install for mozcrash 11:07:40 INFO - Running setup.py install for mozdebug 11:07:40 INFO - Running setup.py install for mozdevice 11:07:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:07:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:07:40 INFO - Running setup.py install for mozfile 11:07:40 INFO - Running setup.py install for mozhttpd 11:07:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:07:40 INFO - Running setup.py install for mozinfo 11:07:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:07:40 INFO - Running setup.py install for mozInstall 11:07:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:07:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:07:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:07:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:07:40 INFO - Running setup.py install for mozleak 11:07:41 INFO - Running setup.py install for mozlog 11:07:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:07:41 INFO - Running setup.py install for moznetwork 11:07:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:07:41 INFO - Running setup.py install for mozprocess 11:07:41 INFO - Running setup.py install for mozprofile 11:07:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:07:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:07:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:07:41 INFO - Running setup.py install for mozrunner 11:07:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:07:41 INFO - Running setup.py install for mozscreenshot 11:07:41 INFO - Running setup.py install for moztest 11:07:41 INFO - Running setup.py install for mozversion 11:07:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:07:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:07:41 INFO - Cleaning up... 11:07:41 INFO - Return code: 0 11:07:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:07:41 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')]} 11:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:41 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')]} 11:07:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:42 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 0x7fa3c7e86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27fdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27faf60>, '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 0x27fbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27fc1d0>, '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': '1f5564757af27664ca02d71f000001b0-1475603429.973071-1518134071', '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 11:07:42 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 11:07:42 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 11:07:42 INFO - Using env: {'DISPLAY': ':0', 11:07:42 INFO - 'HOME': '/home/cltbld', 11:07:42 INFO - 'LANG': 'en_US.UTF-8', 11:07:42 INFO - 'LANGUAGE': 'en_US:en', 11:07:42 INFO - 'LOGNAME': 'cltbld', 11:07:42 INFO - 'MAIL': '/var/mail/cltbld', 11:07:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:42 INFO - 'MOZ_NO_REMOTE': '1', 11:07:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:42 INFO - 'NO_EM_RESTART': '1', 11:07:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:42 INFO - 'PWD': '/builds/slave/test', 11:07:42 INFO - 'SHELL': '/bin/bash', 11:07:42 INFO - 'SHLVL': '1', 11:07:42 INFO - 'TERM': 'linux', 11:07:42 INFO - 'TMOUT': '86400', 11:07:42 INFO - 'USER': 'cltbld', 11:07:42 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475603429.973071-1518134071', 11:07:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:42 INFO - '_': '/tools/buildbot/bin/python'} 11:07:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:07:42 INFO - Running setup.py (path:/tmp/pip-DNqSQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:07:42 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)) 11:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:07:42 INFO - Running setup.py (path:/tmp/pip-IJ6Og9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:07:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 11:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:07:42 INFO - Running setup.py (path:/tmp/pip-3ninpJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:07:42 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)) 11:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:07:42 INFO - Running setup.py (path:/tmp/pip-NSNNg8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:07:42 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)) 11:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:07:42 INFO - Running setup.py (path:/tmp/pip-BhO5Vo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:07:42 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)) 11:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:07:42 INFO - Running setup.py (path:/tmp/pip-50IhwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:07:42 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)) 11:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:07:42 INFO - Running setup.py (path:/tmp/pip-qkYZZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:07:42 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)) 11:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:07:42 INFO - Running setup.py (path:/tmp/pip-yYWgTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:07:42 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)) 11:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:07:42 INFO - Running setup.py (path:/tmp/pip-4pyP06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:07:42 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)) 11:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:07:42 INFO - Running setup.py (path:/tmp/pip-av7I72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:07:42 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)) 11:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:07:42 INFO - Running setup.py (path:/tmp/pip-0qG5Cs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:07:43 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)) 11:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:07:43 INFO - Running setup.py (path:/tmp/pip-rAVZV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:07:43 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)) 11:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:07:43 INFO - Running setup.py (path:/tmp/pip-V7QHWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:07:43 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)) 11:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:07:43 INFO - Running setup.py (path:/tmp/pip-q2VALx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:07:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 11:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:43 INFO - Running setup.py (path:/tmp/pip-nKY5S7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:43 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)) 11:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:07:43 INFO - Running setup.py (path:/tmp/pip-YIBfNq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:07:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 11:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:07:43 INFO - Running setup.py (path:/tmp/pip-Z0o94R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:07:43 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)) 11:07:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:07:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:07:43 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)) 11:07:43 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)) 11:07:43 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)) 11:07:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:07:43 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 11:07:43 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 11:07:43 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 11:07:43 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 11:07:43 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 11:07:43 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 11:07:45 INFO - Downloading blessings-1.6.tar.gz 11:07:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:07:45 INFO - Installing collected packages: blessings 11:07:45 INFO - Running setup.py install for blessings 11:07:45 INFO - Successfully installed blessings 11:07:45 INFO - Cleaning up... 11:07:45 INFO - Return code: 0 11:07:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:07:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:07:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:07:46 INFO - Reading from file tmpfile_stdout 11:07:46 INFO - Current package versions: 11:07:46 INFO - argparse == 1.2.1 11:07:46 INFO - blessings == 1.6 11:07:46 INFO - blobuploader == 1.2.4 11:07:46 INFO - docopt == 0.6.1 11:07:46 INFO - functools32 == 3.2.3-2 11:07:46 INFO - jsonschema == 2.5.1 11:07:46 INFO - manifestparser == 1.1 11:07:46 INFO - mozInstall == 1.12 11:07:46 INFO - mozcrash == 0.17 11:07:46 INFO - mozdebug == 0.1 11:07:46 INFO - mozdevice == 0.48 11:07:46 INFO - mozfile == 1.2 11:07:46 INFO - mozhttpd == 0.7 11:07:46 INFO - mozinfo == 0.9 11:07:46 INFO - mozleak == 0.1 11:07:46 INFO - mozlog == 3.4 11:07:46 INFO - moznetwork == 0.27 11:07:46 INFO - mozprocess == 0.23 11:07:46 INFO - mozprofile == 0.28 11:07:46 INFO - mozrunner == 6.12 11:07:46 INFO - mozscreenshot == 0.1 11:07:46 INFO - mozsystemmonitor == 0.3 11:07:46 INFO - moztest == 0.7 11:07:46 INFO - mozversion == 1.4 11:07:46 INFO - psutil == 3.1.1 11:07:46 INFO - requests == 1.2.3 11:07:46 INFO - wsgiref == 0.1.2 11:07:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:07:46 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')]} 11:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:46 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')]} 11:07:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:46 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 0x7fa3c7e86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27fdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27faf60>, '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 0x27fbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27fc1d0>, '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': '1f5564757af27664ca02d71f000001b0-1475603429.973071-1518134071', '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 11:07:46 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 11:07:46 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 11:07:46 INFO - Using env: {'DISPLAY': ':0', 11:07:46 INFO - 'HOME': '/home/cltbld', 11:07:46 INFO - 'LANG': 'en_US.UTF-8', 11:07:46 INFO - 'LANGUAGE': 'en_US:en', 11:07:46 INFO - 'LOGNAME': 'cltbld', 11:07:46 INFO - 'MAIL': '/var/mail/cltbld', 11:07:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:46 INFO - 'MOZ_NO_REMOTE': '1', 11:07:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:46 INFO - 'NO_EM_RESTART': '1', 11:07:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:46 INFO - 'PWD': '/builds/slave/test', 11:07:46 INFO - 'SHELL': '/bin/bash', 11:07:46 INFO - 'SHLVL': '1', 11:07:46 INFO - 'TERM': 'linux', 11:07:46 INFO - 'TMOUT': '86400', 11:07:46 INFO - 'USER': 'cltbld', 11:07:46 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475603429.973071-1518134071', 11:07:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:46 INFO - '_': '/tools/buildbot/bin/python'} 11:07:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:46 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)) 11:07:46 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)) 11:07:46 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)) 11:07:46 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)) 11:07:46 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)) 11:07:46 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)) 11:07:46 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)) 11:07:46 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)) 11:07:46 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)) 11:07:46 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)) 11:07:46 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)) 11:07:46 INFO - Cleaning up... 11:07:46 INFO - Return code: 0 11:07:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:07:46 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')]} 11:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:46 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')]} 11:07:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:46 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 0x7fa3c7e86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27fdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27faf60>, '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 0x27fbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27fc1d0>, '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': '1f5564757af27664ca02d71f000001b0-1475603429.973071-1518134071', '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 11:07:46 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 11:07:46 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 11:07:46 INFO - Using env: {'DISPLAY': ':0', 11:07:46 INFO - 'HOME': '/home/cltbld', 11:07:46 INFO - 'LANG': 'en_US.UTF-8', 11:07:46 INFO - 'LANGUAGE': 'en_US:en', 11:07:46 INFO - 'LOGNAME': 'cltbld', 11:07:46 INFO - 'MAIL': '/var/mail/cltbld', 11:07:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:46 INFO - 'MOZ_NO_REMOTE': '1', 11:07:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:46 INFO - 'NO_EM_RESTART': '1', 11:07:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:46 INFO - 'PWD': '/builds/slave/test', 11:07:46 INFO - 'SHELL': '/bin/bash', 11:07:46 INFO - 'SHLVL': '1', 11:07:46 INFO - 'TERM': 'linux', 11:07:46 INFO - 'TMOUT': '86400', 11:07:46 INFO - 'USER': 'cltbld', 11:07:46 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475603429.973071-1518134071', 11:07:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:46 INFO - '_': '/tools/buildbot/bin/python'} 11:07:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:07:46 INFO - Cleaning up... 11:07:46 INFO - Return code: 0 11:07:46 INFO - Running post-action listener: _resource_record_post_action 11:07:46 INFO - Running post-action listener: _start_resource_monitoring 11:07:46 INFO - Starting resource monitoring. 11:07:46 INFO - [mozharness: 2016-10-04 18:07:46.678526Z] Finished create-virtualenv step (success) 11:07:46 INFO - [mozharness: 2016-10-04 18:07:46.679028Z] Running install step. 11:07:46 INFO - Running pre-action listener: _resource_record_pre_action 11:07:46 INFO - Running main action method: install 11:07:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:07:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:07:46 INFO - Reading from file tmpfile_stdout 11:07:46 INFO - Detecting whether we're running mozinstall >=1.0... 11:07:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:07:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:07:46 INFO - Reading from file tmpfile_stdout 11:07:46 INFO - Output received: 11:07:46 INFO - Usage: mozinstall [options] installer 11:07:46 INFO - Options: 11:07:46 INFO - -h, --help show this help message and exit 11:07:46 INFO - -d DEST, --destination=DEST 11:07:46 INFO - Directory to install application into. [default: 11:07:46 INFO - "/builds/slave/test"] 11:07:46 INFO - --app=APP Application being installed. [default: firefox] 11:07:46 INFO - mkdir: /builds/slave/test/build/application 11:07:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:07:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:08:03 INFO - Reading from file tmpfile_stdout 11:08:03 INFO - Output received: 11:08:03 INFO - /builds/slave/test/build/application/firefox/firefox 11:08:03 INFO - Running post-action listener: _resource_record_post_action 11:08:03 INFO - [mozharness: 2016-10-04 18:08:03.118407Z] Finished install step (success) 11:08:03 INFO - [mozharness: 2016-10-04 18:08:03.118654Z] Running run-tests step. 11:08:03 INFO - Running pre-action listener: _resource_record_pre_action 11:08:03 INFO - Running main action method: run_tests 11:08:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:08:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:08:03 INFO - Python 2.7.3 11:08:03 INFO - Return code: 0 11:08:03 INFO - grabbing minidump binary from tooltool 11:08:03 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')]} 11:08:03 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 0x27faf60>, '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 0x27fbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27fc1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:08:03 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 11:08:03 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 11:08:03 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 11:08:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:08:03 INFO - Return code: 0 11:08:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:08:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:08:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:08:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:08:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:08:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eWQrRHLxTiqHAP79VaSgVw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 11:08:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eWQrRHLxTiqHAP79VaSgVw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 11:08:03 INFO - Using env: {'DISPLAY': ':0', 11:08:03 INFO - 'HOME': '/home/cltbld', 11:08:03 INFO - 'LANG': 'en_US.UTF-8', 11:08:03 INFO - 'LANGUAGE': 'en_US:en', 11:08:03 INFO - 'LOGNAME': 'cltbld', 11:08:03 INFO - 'MAIL': '/var/mail/cltbld', 11:08:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:08:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:08:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:03 INFO - 'MOZ_NO_REMOTE': '1', 11:08:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:08:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:03 INFO - 'NO_EM_RESTART': '1', 11:08:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:03 INFO - 'PWD': '/builds/slave/test', 11:08:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:08:03 INFO - 'SHELL': '/bin/bash', 11:08:03 INFO - 'SHLVL': '1', 11:08:03 INFO - 'TERM': 'linux', 11:08:03 INFO - 'TMOUT': '86400', 11:08:03 INFO - 'USER': 'cltbld', 11:08:03 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475603429.973071-1518134071', 11:08:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:03 INFO - '_': '/tools/buildbot/bin/python'} 11:08:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eWQrRHLxTiqHAP79VaSgVw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 11:08:03 INFO - mozversion application_buildid: 20161004095100 11:08:03 INFO - mozversion application_changeset: d8a271c72525309029b952075dcbdb9b2f1a284a 11:08:03 INFO - mozversion application_display_name: Nightly 11:08:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:08:03 INFO - mozversion application_name: Firefox 11:08:03 INFO - mozversion application_remotingname: firefox 11:08:03 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 11:08:03 INFO - mozversion application_vendor: Mozilla 11:08:03 INFO - mozversion application_version: 52.0a1 11:08:03 INFO - mozversion platform_buildid: 20161004095100 11:08:03 INFO - mozversion platform_changeset: d8a271c72525309029b952075dcbdb9b2f1a284a 11:08:03 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 11:08:03 INFO - mozversion platform_version: 52.0a1 11:08:03 INFO - using testdate: 1475604483 11:08:03 INFO - actual date: 1475604483 11:08:03 INFO - starting webserver on 'localhost:33206' 11:08:03 INFO - SUITE-START | Running 2 tests 11:08:03 INFO - TEST-START | dromaeo_css 11:08:03 INFO - operating with platform_type : linux_ 11:08:03 INFO - Initialising browser for dromaeo_css test... 11:08:03 INFO - TEST-INFO | started process 21136 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcVvS6E/profile http://localhost:33206/getInfo.html) 11:08:07 INFO - PROCESS | 21136 | __metrics Screen width/height:1600/1200 11:08:07 INFO - PROCESS | 21136 | colorDepth:24 11:08:07 INFO - PROCESS | 21136 | Browser inner width/height: 1024/697 11:08:07 INFO - PROCESS | 21136 | __metrics 11:08:08 INFO - PROCESS | 21136 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:08:08 INFO - PROCESS | 21136 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:08:08 INFO - PROCESS | 21136 | console.error: PushService: 11:08:08 INFO - PROCESS | 21136 | stateChangeProcessEnqueue: Error transitioning state 11:08:08 INFO - PROCESS | 21136 | UnknownError 11:08:09 INFO - TEST-INFO | 21136: exit 0 11:08:09 INFO - Browser initialized. 11:08:09 INFO - Running cycle 1/1 for dromaeo_css test... 11:08:09 INFO - TEST-INFO | started process 21219 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcVvS6E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:08:21 INFO - PROCESS | 21219 | RSS: Main: 175173632 11:08:21 INFO - PROCESS | 21219 | 11:09:13 INFO - PROCESS | 21219 | 1475604553497 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:11:26 INFO - PROCESS | 21219 | Cycle 1(1): loaded http://localhost:33206/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33206/tests/dromaeo/cssquery-ext.html) 11:11:27 INFO - PROCESS | 21219 | RSS: Main: 285843456 11:11:27 INFO - PROCESS | 21219 | 11:14:30 INFO - PROCESS | 21219 | Cycle 1(1): loaded http://localhost:33206/tests/dromaeo/cssquery-ext.html (next: http://localhost:33206/tests/dromaeo/cssquery-jquery.html) 11:14:30 INFO - PROCESS | 21219 | RSS: Main: 273883136 11:14:30 INFO - PROCESS | 21219 | 11:17:33 INFO - PROCESS | 21219 | Cycle 1(1): loaded http://localhost:33206/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33206/tests/dromaeo/cssquery-mootools.html) 11:17:34 INFO - PROCESS | 21219 | RSS: Main: 249303040 11:17:34 INFO - PROCESS | 21219 | 11:20:36 INFO - PROCESS | 21219 | Cycle 1(1): loaded http://localhost:33206/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33206/tests/dromaeo/cssquery-prototype.html) 11:20:37 INFO - PROCESS | 21219 | RSS: Main: 219156480 11:20:37 INFO - PROCESS | 21219 | 11:23:40 INFO - PROCESS | 21219 | Cycle 1(1): loaded http://localhost:33206/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33206/tests/dromaeo/cssquery-yui.html) 11:23:40 INFO - PROCESS | 21219 | RSS: Main: 219746304 11:23:40 INFO - PROCESS | 21219 | 11:26:43 INFO - PROCESS | 21219 | Cycle 1(1): loaded http://localhost:33206/tests/dromaeo/cssquery-yui.html (next: http://localhost:33206/tests/dromaeo/cssquery-dojo.html) 11:26:43 INFO - PROCESS | 21219 | RSS: Main: 315174912 11:26:43 INFO - PROCESS | 21219 | 11:26:43 INFO - PROCESS | 21219 | __start_tp_report 11:26:43 INFO - PROCESS | 21219 | _x_x_mozilla_page_load 11:26:43 INFO - PROCESS | 21219 | _x_x_mozilla_page_load_details 11:26:43 INFO - PROCESS | 21219 | |i|pagename|runs| 11:26:43 INFO - PROCESS | 21219 | |0;dojo.html;2508.172303139964;2534.898604055838;2571.7299683533224;2575.098715449593;2585.831920925141;4426.800793964271;4494.595486406222;4587.266037434011;4594.7013444126105;4617.653675974303;4524.592786649201;4548.363229147922;4580.793864276107;4618.445786505624;4661.230896902007;4161.979190104061;4173.603507666767;4211.368294755781;4220.915581688364;4235.174141042498;4238.088810905655;4250.6386957108525;4289.914201715964;4299.763513006784;4336.891577710551;4097.282975479279;4205.831766729358;4233.153369326147;4274.145170965804;4332.97833510832;4100.405441211008;4124.175164967019;4158.542560318362;4160.667146628262;4195;4194.412782210493;4226.5773422657485;4261.957380426187;4268.530461649216;4281.7002809803325;4533.591976722111;4563.885902852422;4587.036722288323;4606.953930460686;4629.23617603095;4746.738929358884;4924.138275801721;4926.433460152092;4933.851984440436;4983.825566105169;4820.68665536739;4834.58905992991;4925.236588328779;4930.654854160211;4982.725950072744;4591.609713174417;4627.051454451829;4640.141573808856;4646.465656449518;4646.651501137429;5087.796488140433;5088.542031217208;5093.1341671915125;5103.260027296022;5163.251328557338;4694.131585656664;4747.430308362949;4748.430188377417;4775.976120119377;4816.627261230603;4932.8520144395725;4933.260010998307;4934.703917764946;4980.651354405157;4998.5751211146735;4843.660943733905;4874.488178741252;4882.6826256293225;4949.331840201598;4955.876103097451;4662.463816661059;4666.32338310943;4701.506341834127;4844.854654360375;4849.636277279218;4045.9190816183514;4049.8785036448953;4055.270051390719;4059.6752259819145;4059.8985025374013;3568.6074531801482;3589.5513060867393;3601.9639803602154;3619.3847046002243;3643.562772467321;4256.446661933991;4261.978690106592;4306.784660766949;4308.4399028126145;4318.611324980767;4811.9518804811505;4832.420109586872;4872.4153101628035;4880.560749532488;4890.339804126468;4183.644390226804;4196.790160492024;4208.263553878059;4211.915761684749;4231.449911511545;4289.785510724451;4318.676099292566;4356.803943822472;4410.933835992462;4416.558344165558;4602.05657840142;4608.700434471749;4611.976940115278;4654.581087701988;4656.557627025427;4730.053989202104;4771.23660214364;4829.66192366531;4832.323474713613;4839.927401089057;4562.749048802348;4592.288195329729;4604.677672562889;4613.492515823324;4618.56123668251;4744.074905393415;4745.9050818984115;4746.762661866962;4797.544233297831;4847.830325938575;4884.63365247615;4934.55588996992;4943.9505604944925;4945.406551213878;4947.703137811743;4748.145333839942;4749.786259618395;4750.192467280502;4766.95233047679;4817.0125124350125;4602.539746025371;4743.335932969456;4756.476787553435;4807.206810876166;4872.43966943806;4632.420947381577;4711.646626502958;4750.406199225097;4750.477447480844;4802.73584952831;4770.475247722818;4797.136515427117;4811.374521312207;4824.396950381202;4885.633577481774;4734.242521196592;4743.0988112258565;4746.7389293589185;4800.567948884617;4803.903921921612 11:26:43 INFO - PROCESS | 21219 | |1;ext.html;564.9322779945902;566.1027271774241;566.611870868455;571.5713215088683;578.5516224925685;27521.587176192374;28233.294167645818;37611.24777504452;38375.23249535008;38455;40196.39705404414;40534.189316213655;40595.79702101493;40630.39054414186;40639.796801016026;7544.321011108999;7683;7686.923130768677;7693.346065584432;7696.345810606077;7092.326229008236;7278.708851645928;7280.162781280141;7485.139208990954;7600.315971562558;9578.425294482318;9925.305228633999;9933.751656208617;10244.129249013842;10244.28290019699;9948.104670579647;9966.601335946554;10008.799824003552;10012.94993525035;10014.24893133018;7002.089728335335;7237.638118094127;9423.48170850603;9481.715548533555;9484.430934143973;35669.28661426757;36257.824530528254;36437.81781091104;39975;40198;2770.6259654946525;2772.237634650467;2811.550151975674;3143.8899638512544;3319.079210294949;27311.45377092467;27417.177484675292;27601.171964841087;27746.306342341402;28217.576736348972;3432.70821980132;3544.0962554548423;3549.716022718176;3572.7316802535247;3579.3736096183065;250906;255174.72412638002;255780;255798.44201558118;255826;47760.52239477561;47974.520254797004;47983.28025079626;53420.73289633527;53726;53926.460735392146;59047;59115.40884591185;59149.40850591439;59191;13754.793678094837;13861.237631930138;13870.583882483541;13875.236861972688;13877.514286999907;10504.264701470824;10560.577576896838;10569.312994655324;10669.466526673636;10672.146228301717;15961.920190399205;16373.672526549402;17913.641727165385;18296.17667204979;18331.63336733258;6831.950414875518;6925.896111558331;7027.578345299298;7204.855902882018;7310.417895231299;789.9802504937422;888.6045709659139;913.0686699566538;920.1626519866888;927.5037854747812;26458.6031209532;27215;28032.29919252035;28037.719622803917;28069.157925262276;912.6714382822179;944.1172503708917;958.2142643032646;967.1972263021676;1012.9949350253202;13807.930960345135;14511.419543218364;14601.561953141423;14798.778018329735;14815.92592037033;399114;400752;402857;403284;403686;42155;43683.34474982878;43747;47137;47648.523514764405;1161.5818305410046;1167.0896700573567;1192.8389667394965;1193.3973343461496;1197.203859433467;26553;27995.58006629943;28555.143345699664;28608.856955715088;28763.568546472237;41284.38073428841;41659.7917010413;41669.58330416657;41671.16657666769;41720;271768;399469;407670;411389;629901;36746;36864.25850571303;36874.44688329624;36994.44508332323;37529.81235093807;39994;40028.799856000536;40181.79909100436;40436;40831.38752918768;34662.82668586641;34858.65141348554;34935.65064349426;35210.8239458801;35339.646603533634;34449.65550344565;34773;34842.82578587091;34926.30147397089;35115.64884351124;34260;34887;35131.121721957155;35180.472292916136;35709.46435803413;29474.557881632223;31227.68772312248;31406.685933140376;31429;31990.84004579962;24294.76395621024;24656.383590410383;24692.259232223063;24780.752192477845;25103.246902592953 11:26:43 INFO - PROCESS | 21219 | |2;jquery.html;336.5675107486878;349.7114880223816;370.24100593782737;374.67403359077605;385.37761515153034;12404.255744655327;16552.58618534537;17236.22436990334;18459.35392261271;18613.441596752084;16666.66666666669;16812;17460.47618571442;17524.912375438136;17609.710737604124;4898.608111351093;5090.541851233388;5204.661696989702;5223.399309079447;5231.372235331765;3738.9252214955686;3924.725269231155;5134;5241.135212689921;5244.632875698702;5759.366469688331;6027.879442411171;6049.546284028694;6122.63264204147;6131.63210207389;6076.878462430771;6093.268807743055;6523.347665233438;6827.180738311435;6866.073080134168;6528.37980391862;6697.933020669829;6707.128073350482;6711.899321510181;6716.5634233774645;22005.889970550044;22229.77770222293;22525.648461092223;22882.542349152925;22910.885445572832;2091.6862470629376;2217.1796435318875;2260.8417410781253;2426.9514609707708;2502.0117053763843;13291.53479628218;14021.64945876351;14603.634909127251;14624.634384140376;15102.471413500474;1730.8788384813067;1831.157667472964;1836.8714190006706;1844.6495165918432;1847.7228415737613;78129;79772;79926.60036699838;80899.5955020227;82905;16168.434104806276;16171.259202983007;16227.513174604781;16525.58686032859;16645.3341866324;28820.567691484644;28952.710472895;29051.41897162045;29096.563551546744;29308.120756377342;8614.78463038429;8967.820643587222;8968.10318968098;8984.371094023356;9295;7282.708691652275;7498.4001279897475;7514.9624251878395;7568.810779730551;7618.923810761821;7968.099618734436;8336.499810011419;8438;8623;8639.827203455896;3115.750739940799;3143.355612099514;3310.0235430548046;3324.492660243466;3356.681115294043;768.4774353439715;806.2743530822307;824.6577670266772;826.7313123234852;859.3855393393753;16377.754333685005;16678.749818752727;17159.828401716073;17173;17464;769.4440593373134;775.6160700453312;790.020374735324;799.8280369720538;810.5217921426387;7133.785986420416;9063.68277110298;9122.817543649222;9460.479673618018;9848.2613803965;337709;346009;358795;361021;361102;61346;61547;68432.6578367115;69333.3066669337;79199.20800792033;859.6293999069532;869.3914260018013;896.2381975321056;900.5092224737534;901.0223907060912;15433.768493472831;15438.30527626282;16097.275622597246;16329.346826126823;16396.918015409847;34393.828030860685;34588.654113459546;35008.47487287642;35288.82355588206;35312;45784.54215457803;49305.75347123241;49334.50665493443;49350;49432.25851612157;7134.643267836691;7148.106486689164;7249.565026098451;7331.41348692114;7348.412127029718;11234.3259404436;11943.940280298542;11989.520419183134;12298.323592202514;12402.13185077036;9688.564014619218;9742.366746161477;10056.34633748804;10218.1825453965;10802.567897284021;7207.855842883008;7282.344588987016;7593.1647518774;9593.328467007243;10122.44326562046;7592.734254301073;7629;7780.766577002699;8028.87956680662;8057.758267251992;11336.716582085513;11424;11609.47757350938;11715.1799374043;11818.704532386759;10921.453927303763;11319;11408.258463199865;11427;11650.70873228176 11:26:43 INFO - PROCESS | 21219 | |3;mootools.html;1285.1967520299813;1355.0853174107474;1356.6201463590191;1599.1524492019234;1645.5227983884668;6684.4986626003;6924.619145946971;7112.288771122885;7680.193579674131;7683.11644160921;7047.85904281914;7344.596047217401;7347.191808901017;7504;7510.023696919407;1916.396335154429;1942.8445724342089;1951.8145776151243;1956.6967120096338;1956.7945365736607;1643.967120657586;1695.5252529291818;1805.9458216253468;1940.1754254441876;1960.9411717648422;1958.2558627721446;1972.6843705007202;1974.891380974053;1976.8023197680188;1977.3672424824063;1884.1521315407983;1897.857660675448;1904.1812020831037;1904.7714274287175;1906.780720217172;1912.129980858706;1916.8370688491495;1917.8561607879465;1919.280269898788;1923.4614307993784;7400.925990740131;7559.433042521833;7561.508501947411;7564.394848412114;7567.281108294703;4251;4375.496817865955;4376.868693939187;4380.0582874682095;4384.89037774055;2578.9871050644815;2615.3069436599317;2644.431447238853;2667.919962401131;2685.1810197889636;796.3151689546985;820.4912953968518;831.9209675080918;831.9584020798997;836.8326334733077;9757.90242097577;9844.803103937953;9945.75135621608;10005.899941000569;10017;3632.4914511968345;3769.754965927206;3802.9049273767823;3858.0354911272184;3879.650831425185;8629.482231066031;8640.30877529796;8643.740687779376;8645.3948223625;8650.697225597074;4320.330348795942;4320.481542214954;4323.156984388077;4325.351197320364;4334.544872788375;3979.7612143271494;3980.3233450313514;3982.4424580558743;3988.581198974066;3993.121513267077;3115.5326700995033;3159.4786860167815;3195.2650890295363;3212.759043071779;3228.0961330826935;984.5421878826237;987.7728122531857;1003.7490627343165;1005.1606908231562;1010.5654568535454;763.8128658478709;777.739457281817;792.1049214387705;792.8572856885701;805.2430715127762;4923.556879880828;4934.629902757308;4961.809165800254;5064.974675126601;5221.947780522146;833.3666413525764;865.1485820344468;877.7849426890452;887.5074333744705;890.6838072484175;3193.568868202763;3270.1661076425357;3280.967190328066;3284.802911825298;3406.7444941628983;8676.6529338827;8995.505247211466;9004.63981440735;9007.594658240396;9009.909900900908;8930.062343453974;8940.46357218556;8941.910580894239;8952;8957.686480973265;7046.154461464657;7166.784996450115;7175.461840361993;7183.102112235971;7186;4867.221244600847;4928.581070608895;4962.6774259673;5038.672486288379;5199.896002080013;8545.2309292164;8577.270931970852;8579.056303806452;8702.695405661025;8752.606132723915;8015.799605009922;8413.326933845156;8417.663293468193;8692.174243446863;8702.82594348122;6563.113979612691;6715.294894036056;6719.798406047827;6730.899036514358;6735.831604209934;6304.71628776697;6551.44312733423;7167.820804479929;7213.819654508679;7247.166575843846;5957.49361304294;5973.253343332083;6290.778653717312;6340.239171299474;6437.420632142942;6493.480521558358;6494.220693516808;6585.078089067631;6620.404163625297;6624.4700423965005;6039.335673076046;6133.803908237851;6133.877322453437;6139.048447490646;6143.262808463013;4260.531341552489;4352.347147927836;4398.428204333544;4495.730256184639;4580.473245576802;4386.978065109654;4449.822007119679;4487.955120448753;4490.797914093939;4498.70758400716 11:26:43 INFO - PROCESS | 21219 | |4;prototype.html;269.36564390859525;283.88218889161;285.2469480571292;286.2100602337549;295.4784804819493;4843.636727245457;4876.317315575822;4876.926846097307;4877.975610121949;4884.5848102911295;4765.332853400527;4780;4838.669365924373;4843.66094373394;4849.393825771778;3567.340042092215;3677.999999999987;3686.907827304312;3769.792661403622;3821.5987321331277;3814.389697648377;3816.3893776995687;3837.9424308635394;3859.20886218326;3863.3239183142978;3772.5284339457567;3796.6962642988633;3801.4107813288983;3814.923701525982;3814.980925095371;3593.730470214731;3660;3725.8137093145506;3771.434284857266;3802.707079592924;3327.584051993501;3337.398048936524;3340.716039136652;3341.1313058604937;3342.9607939157095;4686.109639168547;4695.906081878344;4716.38686970695;4723.5984941279685;4748.169070412699;4243.830246790125;4345.804438800262;4367.235733746582;4372.5627437256335;4375.562443755631;5059.494050594948;5069.467705890866;5081.771320290559;5088.542031217208;5090.9236361454605;3690.741648084635;3692.907677308062;3696.8890933272046;3699.9445008324897;3704.1850792825803;5166.689998600096;5299.470052994747;5304.708241046779;5307.2569840222395;5321.308229930084;3699.1122130688977;3703.518542589446;3722.925541489209;3731.253749250161;3742.045778326509;3770.8506151493384;3771.2834561433788;3771.5097037384962;3788.2384691118764;3803.174476251415;4317.395564620955;4332.783360832009;4334.4798624165305;4336.674749393808;4347.782610869507;4885.828995985124;5032.270320803463;5052.72210028452;5053.772580233898;5136.768845401966;1315.4475120449433;1331.3343328335832;1333.313343628013;1333.599920023989;1334.252818421687;832.3008672714949;842.8819965204876;858.3390789092364;870.303756994402;878.5124256037833;4364.4980827204645;4410;4562.612177964844;4575.656825738017;4586.656000799953;5102.617303702237;5232.3721153461065;5234.214867769789;5242.895142097137;5254.108520932461;4487.41663583732;4517.599544141327;4517.93828450314;4552.588697503785;4560.270356742905;2641.828281161718;2769.1138835572424;2776.6529183852017;2786.874590643426;2820.576913462956;4973.801047958041;4979.755061234691;4994.9500504994485;5019.196928491497;5021.648484606042;5246.501582349671;5379.5427388671615;5379.67721936685;5404;5412.377576578744;4953.6037117030555;5015.3229314042865;5020.221865610836;5029.748512574357;5032.446430892525;5269.657472264291;5269.868253293698;5272.815451459181;5340.412554618911;5341.439148889311;5000.87497812543;5132.538071573576;5162.483751624807;5178.71517066565;5192.740362981911;4980.626453015966;5001.24981252815;5015.194529969281;5026.673266237683;5030.496950305087;3289.950650740289;3321.534985102039;3325.0024992502636;3325.3681800457834;3337.349216902681;4417.00617361104;4517.887052823706;4639.35049093134;4660.229112937062;4660.347551342883;4487.304467807495;4520.259700015452;4522.525134860924;4532.546745325441;4543.4775000874;4487.439070116236;4503.797329120263;4515.322701594787;4581.496035436033;4607.170709272363;4492.213862574102;4494.213512635341;4520.638348932143;4524.88687782808;4527.4340707411575;4789.712617242976;4917.754112294299;4917.9016419672125;5032.6225533084435;5182.896342073062;4973.179425394769;4973.35346404965;4974.825881094144;4976.726280054631;4989.9251511228085 11:26:43 INFO - PROCESS | 21219 | |5;yui.html;621.7606221604682;691.1636919327616;710.2577806192528;719.9568025918442;747.8541684371546;13501.122427042248;14002.789958150635;14200.644983875409;14217.431302747891;14239.430422783102;13002;13346.532871349506;13421.127626704258;13450;13467.326633668326;732.3226015935238;733.4205977277944;733.4719002318323;740.459464590849;741.2550386861224;619.1239396254294;630.385374260095;715.3061530315586;737.9815504612374;739.9593022383793;797.9680812767482;798.5208874675207;798.9280964713174;799.6601444386142;800.0559339978822;791.639803889229;791.6516732637679;791.9089304729914;791.9089304729944;791.9406044546653;470.8822794301425;479.0753845078996;480.07824976045725;480.9470958194631;481.1555719711918;11832.349220792852;12213.755724885452;12263.0189584833;12657.873421265762;12692.492300307977;12659.936700316532;13191.736165276641;13602.795958060637;13765.655858603615;14121.364538595684;10197.082262596401;10421.739456513573;10463.267571270015;10643.893561064368;10859.619913302997;3185.761067919915;3203.9679603203904;3205.487122060459;3225.161458020908;3265.297960938386;60166.69916650389;60428.09357859636;60984;61626.38373616251;62584.68707656478;9900.55447504864;9993.550290236812;10027.29808913369;10154.796904061877;10233.48832558369;18060.638787224445;18086.90956545209;18096.45710628683;18204.180811863233;18221.18004689792;6548.345165483509;6560.311167327457;6581.76963806274;6641.966790166019;6700.932990670129;3620.2035552178477;3639.253952939641;3661;3739.6634302912867;3741.8877433677035;2762.4198918226994;2859.7998140130408;2896.3483216276168;2898.145047211078;2923.0646193217967;490.0835437731465;496.2481840012384;497.2417063977463;507.2948601443996;513.2455290722631;582.4379473807711;597.8909123575792;614.015572858732;618.4464903910974;623.9563230573816;7816.921830781619;8138.877916831252;8350.791230219293;8392;8522.957385213158;553.327706836196;616.3928530397554;616.4298024327479;620.3703241210176;628.1645411602558;3790.905227369338;3897.3569361055675;3959.604039596075;4117.732347397409;4122.464079669624;57376;57485.71257143771;57576.71211643915;74639.62680186673;102302.48848755709;52360;53146.73426632842;53221.2016819748;84867;87591;46274.768626156656;46674.29988550174;47723.761381192875;59407.702961484916;76193;8058.234467725557;8061.113277539584;8461.133253158101;8495.447795893248;8550.957245213984;39406.2118757629;40315.596844031184;41630.95922601959;41890;42613.14773704571;62184.68907655433;62644.686776565824;64043;64588.677056616296;65389.34610653832;10042.347247428894;10134.239932005277;10315.27793054509;10333.948330258301;10684.893151068702;11869.347185904859;12073.517059317528;12120.93939530332;12496.375181241083;12503;11452.885471145182;11661.183717139718;11969;12322.507099715911;12340.259584424963;10964.28732132409;11470.254433461798;11536.134789890959;11666.300021998708;12049.277043377426;11113.166512511432;11265.472085467556;11508.13688973347;11574.88425115738;11814.94092529532;9275.582598783207;9501.239900808057;9610.711678649652;9742.756431088996;9746.781652293463;9773.634887912875;10376.169906407318;10414.947925260325;10439.739006524898;10467.895321046692 11:26:43 INFO - PROCESS | 21219 | __end_tp_report 11:26:43 INFO - PROCESS | 21219 | __start_cc_report 11:26:43 INFO - PROCESS | 21219 | _x_x_mozilla_cycle_collect,1076 11:26:43 INFO - PROCESS | 21219 | __end_cc_report 11:26:43 INFO - PROCESS | 21219 | __startTimestamp1475605603897__endTimestamp 11:26:43 INFO - PROCESS | 21219 | 11:26:43 INFO - PROCESS | 21219 | ------- Summary: start ------- 11:26:43 INFO - PROCESS | 21219 | Number of tests: 6 11:26:43 INFO - PROCESS | 21219 | 11:26:43 INFO - PROCESS | 21219 | [#0] dojo.html Cycles:165 Average:4521.70 Median:4646.47 stddev:477.20 (10.3%) stddev-sans-first:451.76 11:26:43 INFO - PROCESS | 21219 | Values: 2508.2 2534.9 2571.7 2575.1 2585.8 4426.8 4494.6 4587.3 4594.7 4617.7 4524.6 4548.4 4580.8 4618.4 4661.2 4162.0 4173.6 4211.4 4220.9 4235.2 4238.1 4250.6 4289.9 4299.8 4336.9 4097.3 4205.8 4233.2 4274.1 4333.0 4100.4 4124.2 4158.5 4160.7 4195.0 4194.4 4226.6 4262.0 4268.5 4281.7 4533.6 4563.9 4587.0 4607.0 4629.2 4746.7 4924.1 4926.4 4933.9 4983.8 4820.7 4834.6 4925.2 4930.7 4982.7 4591.6 4627.1 4640.1 4646.5 4646.7 5087.8 5088.5 5093.1 5103.3 5163.3 4694.1 4747.4 4748.4 4776.0 4816.6 4932.9 4933.3 4934.7 4980.7 4998.6 4843.7 4874.5 4882.7 4949.3 4955.9 4662.5 4666.3 4701.5 4844.9 4849.6 4045.9 4049.9 4055.3 4059.7 4059.9 3568.6 3589.6 3602.0 3619.4 3643.6 4256.4 4262.0 4306.8 4308.4 4318.6 4812.0 4832.4 4872.4 4880.6 4890.3 4183.6 4196.8 4208.3 4211.9 4231.4 4289.8 4318.7 4356.8 4410.9 4416.6 4602.1 4608.7 4612.0 4654.6 4656.6 4730.1 4771.2 4829.7 4832.3 4839.9 4562.7 4592.3 4604.7 4613.5 4618.6 4744.1 4745.9 4746.8 4797.5 4847.8 4884.6 4934.6 4944.0 4945.4 4947.7 4748.1 4749.8 4750.2 4767.0 4817.0 4602.5 4743.3 4756.5 4807.2 4872.4 4632.4 4711.6 4750.4 4750.5 4802.7 4770.5 4797.1 4811.4 4824.4 4885.6 4734.2 4743.1 4746.7 4800.6 4803.9 11:26:43 INFO - PROCESS | 21219 | 11:26:43 INFO - PROCESS | 21219 | [#1] ext.html Cycles:180 Average:50720.80 Median:36347.82 stddev:99254.46 (273.1%) stddev-sans-first:99461.45 11:26:43 INFO - PROCESS | 21219 | Values: 564.9 566.1 566.6 571.6 578.6 27521.6 28233.3 37611.2 38375.2 38455.0 40196.4 40534.2 40595.8 40630.4 40639.8 7544.3 7683.0 7686.9 7693.3 7696.3 7092.3 7278.7 7280.2 7485.1 7600.3 9578.4 9925.3 9933.8 10244.1 10244.3 9948.1 9966.6 10008.8 10012.9 10014.2 7002.1 7237.6 9423.5 9481.7 9484.4 35669.3 36257.8 36437.8 39975.0 40198.0 2770.6 2772.2 2811.6 3143.9 3319.1 27311.5 27417.2 27601.2 27746.3 28217.6 3432.7 3544.1 3549.7 3572.7 3579.4 250906.0 255174.7 255780.0 255798.4 255826.0 47760.5 47974.5 47983.3 53420.7 53726.0 53926.5 59047.0 59115.4 59149.4 59191.0 13754.8 13861.2 13870.6 13875.2 13877.5 10504.3 10560.6 10569.3 10669.5 10672.1 15961.9 16373.7 17913.6 18296.2 18331.6 6832.0 6925.9 7027.6 7204.9 7310.4 790.0 888.6 913.1 920.2 927.5 26458.6 27215.0 28032.3 28037.7 28069.2 912.7 944.1 958.2 967.2 1013.0 13807.9 14511.4 14601.6 14798.8 14815.9 399114.0 400752.0 402857.0 403284.0 403686.0 42155.0 43683.3 43747.0 47137.0 47648.5 1161.6 1167.1 1192.8 1193.4 1197.2 26553.0 27995.6 28555.1 28608.9 28763.6 41284.4 41659.8 41669.6 41671.2 41720.0 271768.0 399469.0 407670.0 411389.0 629901.0 36746.0 36864.3 36874.4 36994.4 37529.8 39994.0 40028.8 40181.8 40436.0 40831.4 34662.8 34858.7 34935.7 35210.8 35339.6 34449.7 34773.0 34842.8 34926.3 35115.6 34260.0 34887.0 35131.1 35180.5 35709.5 29474.6 31227.7 31406.7 31429.0 31990.8 24294.8 24656.4 24692.3 24780.8 25103.2 11:26:43 INFO - PROCESS | 21219 | 11:26:43 INFO - PROCESS | 21219 | [#2] jquery.html Cycles:180 Average:24310.68 Median:24854.63 stddev:58423.11 (235.1%) stddev-sans-first:58559.27 11:26:43 INFO - PROCESS | 21219 | Values: 336.6 349.7 370.2 374.7 385.4 12404.3 16552.6 17236.2 18459.4 18613.4 16666.7 16812.0 17460.5 17524.9 17609.7 4898.6 5090.5 5204.7 5223.4 5231.4 3738.9 3924.7 5134.0 5241.1 5244.6 5759.4 6027.9 6049.5 6122.6 6131.6 6076.9 6093.3 6523.3 6827.2 6866.1 6528.4 6697.9 6707.1 6711.9 6716.6 22005.9 22229.8 22525.6 22882.5 22910.9 2091.7 2217.2 2260.8 2427.0 2502.0 13291.5 14021.6 14603.6 14624.6 15102.5 1730.9 1831.2 1836.9 1844.6 1847.7 78129.0 79772.0 79926.6 80899.6 82905.0 16168.4 16171.3 16227.5 16525.6 16645.3 28820.6 28952.7 29051.4 29096.6 29308.1 8614.8 8967.8 8968.1 8984.4 9295.0 7282.7 7498.4 7515.0 7568.8 7618.9 7968.1 8336.5 8438.0 8623.0 8639.8 3115.8 3143.4 3310.0 3324.5 3356.7 768.5 806.3 824.7 826.7 859.4 16377.8 16678.7 17159.8 17173.0 17464.0 769.4 775.6 790.0 799.8 810.5 7133.8 9063.7 9122.8 9460.5 9848.3 337709.0 346009.0 358795.0 361021.0 361102.0 61346.0 61547.0 68432.7 69333.3 79199.2 859.6 869.4 896.2 900.5 901.0 15433.8 15438.3 16097.3 16329.3 16396.9 34393.8 34588.7 35008.5 35288.8 35312.0 45784.5 49305.8 49334.5 49350.0 49432.3 7134.6 7148.1 7249.6 7331.4 7348.4 11234.3 11943.9 11989.5 12298.3 12402.1 9688.6 9742.4 10056.3 10218.2 10802.6 7207.9 7282.3 7593.2 9593.3 10122.4 7592.7 7629.0 7780.8 8028.9 8057.8 11336.7 11424.0 11609.5 11715.2 11818.7 10921.5 11319.0 11408.3 11427.0 11650.7 11:26:43 INFO - PROCESS | 21219 | 11:26:43 INFO - PROCESS | 21219 | [#3] mootools.html Cycles:180 Average:4838.12 Median:5965.37 stddev:2750.17 (46.1%) stddev-sans-first:2744.93 11:26:43 INFO - PROCESS | 21219 | Values: 1285.2 1355.1 1356.6 1599.2 1645.5 6684.5 6924.6 7112.3 7680.2 7683.1 7047.9 7344.6 7347.2 7504.0 7510.0 1916.4 1942.8 1951.8 1956.7 1956.8 1644.0 1695.5 1805.9 1940.2 1960.9 1958.3 1972.7 1974.9 1976.8 1977.4 1884.2 1897.9 1904.2 1904.8 1906.8 1912.1 1916.8 1917.9 1919.3 1923.5 7400.9 7559.4 7561.5 7564.4 7567.3 4251.0 4375.5 4376.9 4380.1 4384.9 2579.0 2615.3 2644.4 2667.9 2685.2 796.3 820.5 831.9 832.0 836.8 9757.9 9844.8 9945.8 10005.9 10017.0 3632.5 3769.8 3802.9 3858.0 3879.7 8629.5 8640.3 8643.7 8645.4 8650.7 4320.3 4320.5 4323.2 4325.4 4334.5 3979.8 3980.3 3982.4 3988.6 3993.1 3115.5 3159.5 3195.3 3212.8 3228.1 984.5 987.8 1003.7 1005.2 1010.6 763.8 777.7 792.1 792.9 805.2 4923.6 4934.6 4961.8 5065.0 5221.9 833.4 865.1 877.8 887.5 890.7 3193.6 3270.2 3281.0 3284.8 3406.7 8676.7 8995.5 9004.6 9007.6 9009.9 8930.1 8940.5 8941.9 8952.0 8957.7 7046.2 7166.8 7175.5 7183.1 7186.0 4867.2 4928.6 4962.7 5038.7 5199.9 8545.2 8577.3 8579.1 8702.7 8752.6 8015.8 8413.3 8417.7 8692.2 8702.8 6563.1 6715.3 6719.8 6730.9 6735.8 6304.7 6551.4 7167.8 7213.8 7247.2 5957.5 5973.3 6290.8 6340.2 6437.4 6493.5 6494.2 6585.1 6620.4 6624.5 6039.3 6133.8 6133.9 6139.0 6143.3 4260.5 4352.3 4398.4 4495.7 4580.5 4387.0 4449.8 4488.0 4490.8 4498.7 11:26:43 INFO - PROCESS | 21219 | 11:26:43 INFO - PROCESS | 21219 | [#4] prototype.html Cycles:180 Average:4159.94 Median:4556.43 stddev:1203.30 (26.4%) stddev-sans-first:1170.70 11:26:43 INFO - PROCESS | 21219 | Values: 269.4 283.9 285.2 286.2 295.5 4843.6 4876.3 4876.9 4878.0 4884.6 4765.3 4780.0 4838.7 4843.7 4849.4 3567.3 3678.0 3686.9 3769.8 3821.6 3814.4 3816.4 3837.9 3859.2 3863.3 3772.5 3796.7 3801.4 3814.9 3815.0 3593.7 3660.0 3725.8 3771.4 3802.7 3327.6 3337.4 3340.7 3341.1 3343.0 4686.1 4695.9 4716.4 4723.6 4748.2 4243.8 4345.8 4367.2 4372.6 4375.6 5059.5 5069.5 5081.8 5088.5 5090.9 3690.7 3692.9 3696.9 3699.9 3704.2 5166.7 5299.5 5304.7 5307.3 5321.3 3699.1 3703.5 3722.9 3731.3 3742.0 3770.9 3771.3 3771.5 3788.2 3803.2 4317.4 4332.8 4334.5 4336.7 4347.8 4885.8 5032.3 5052.7 5053.8 5136.8 1315.4 1331.3 1333.3 1333.6 1334.3 832.3 842.9 858.3 870.3 878.5 4364.5 4410.0 4562.6 4575.7 4586.7 5102.6 5232.4 5234.2 5242.9 5254.1 4487.4 4517.6 4517.9 4552.6 4560.3 2641.8 2769.1 2776.7 2786.9 2820.6 4973.8 4979.8 4995.0 5019.2 5021.6 5246.5 5379.5 5379.7 5404.0 5412.4 4953.6 5015.3 5020.2 5029.7 5032.4 5269.7 5269.9 5272.8 5340.4 5341.4 5000.9 5132.5 5162.5 5178.7 5192.7 4980.6 5001.2 5015.2 5026.7 5030.5 3290.0 3321.5 3325.0 3325.4 3337.3 4417.0 4517.9 4639.4 4660.2 4660.3 4487.3 4520.3 4522.5 4532.5 4543.5 4487.4 4503.8 4515.3 4581.5 4607.2 4492.2 4494.2 4520.6 4524.9 4527.4 4789.7 4917.8 4917.9 5032.6 5182.9 4973.2 4973.4 4974.8 4976.7 4989.9 11:26:43 INFO - PROCESS | 21219 | 11:26:43 INFO - PROCESS | 21219 | [#5] yui.html Cycles:180 Average:15819.53 Median:24097.32 stddev:21054.64 (87.4%) stddev-sans-first:21082.77 11:26:43 INFO - PROCESS | 21219 | Values: 621.8 691.2 710.3 720.0 747.9 13501.1 14002.8 14200.6 14217.4 14239.4 13002.0 13346.5 13421.1 13450.0 13467.3 732.3 733.4 733.5 740.5 741.3 619.1 630.4 715.3 738.0 740.0 798.0 798.5 798.9 799.7 800.1 791.6 791.7 791.9 791.9 791.9 470.9 479.1 480.1 480.9 481.2 11832.3 12213.8 12263.0 12657.9 12692.5 12659.9 13191.7 13602.8 13765.7 14121.4 10197.1 10421.7 10463.3 10643.9 10859.6 3185.8 3204.0 3205.5 3225.2 3265.3 60166.7 60428.1 60984.0 61626.4 62584.7 9900.6 9993.6 10027.3 10154.8 10233.5 18060.6 18086.9 18096.5 18204.2 18221.2 6548.3 6560.3 6581.8 6642.0 6700.9 3620.2 3639.3 3661.0 3739.7 3741.9 2762.4 2859.8 2896.3 2898.1 2923.1 490.1 496.2 497.2 507.3 513.2 582.4 597.9 614.0 618.4 624.0 7816.9 8138.9 8350.8 8392.0 8523.0 553.3 616.4 616.4 620.4 628.2 3790.9 3897.4 3959.6 4117.7 4122.5 57376.0 57485.7 57576.7 74639.6 102302.5 52360.0 53146.7 53221.2 84867.0 87591.0 46274.8 46674.3 47723.8 59407.7 76193.0 8058.2 8061.1 8461.1 8495.4 8551.0 39406.2 40315.6 41631.0 41890.0 42613.1 62184.7 62644.7 64043.0 64588.7 65389.3 10042.3 10134.2 10315.3 10333.9 10684.9 11869.3 12073.5 12120.9 12496.4 12503.0 11452.9 11661.2 11969.0 12322.5 12340.3 10964.3 11470.3 11536.1 11666.3 12049.3 11113.2 11265.5 11508.1 11574.9 11814.9 9275.6 9501.2 9610.7 9742.8 9746.8 9773.6 10376.2 10414.9 10439.7 10467.9 11:26:43 INFO - PROCESS | 21219 | -------- Summary: end -------- 11:26:43 INFO - PROCESS | 21219 | 11:26:44 INFO - TEST-INFO | 21219: exit 0 11:26:44 INFO - TEST-OK | dromaeo_css | took 1121495ms 11:26:44 INFO - TEST-START | kraken 11:26:44 INFO - operating with platform_type : linux_ 11:26:44 INFO - Initialising browser for kraken test... 11:26:44 INFO - TEST-INFO | started process 21528 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQUzm23/profile http://localhost:33206/getInfo.html) 11:26:49 INFO - PROCESS | 21528 | __metrics Screen width/height:1600/1200 11:26:49 INFO - PROCESS | 21528 | colorDepth:24 11:26:49 INFO - PROCESS | 21528 | Browser inner width/height: 1024/697 11:26:49 INFO - PROCESS | 21528 | __metrics 11:26:49 INFO - PROCESS | 21528 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:26:49 INFO - PROCESS | 21528 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:26:50 INFO - PROCESS | 21528 | console.error: PushService: 11:26:50 INFO - PROCESS | 21528 | stateChangeProcessEnqueue: Error transitioning state 11:26:50 INFO - PROCESS | 21528 | UnknownError 11:26:50 INFO - TEST-INFO | 21528: exit 0 11:26:50 INFO - Browser initialized. 11:26:50 INFO - Running cycle 1/1 for kraken test... 11:26:50 INFO - TEST-INFO | started process 21608 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQUzm23/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:27:03 INFO - PROCESS | 21608 | RSS: Main: 175824896 11:27:03 INFO - PROCESS | 21608 | 11:27:05 INFO - PROCESS | 21608 | Cycle 1(1): loaded http://localhost:33206/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33206/tests/kraken/driver.html?testName=audio-beat-detection) 11:27:06 INFO - PROCESS | 21608 | RSS: Main: 234700800 11:27:06 INFO - PROCESS | 21608 | 11:27:09 INFO - PROCESS | 21608 | Cycle 1(1): loaded http://localhost:33206/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33206/tests/kraken/driver.html?testName=audio-dft) 11:27:10 INFO - PROCESS | 21608 | RSS: Main: 219144192 11:27:10 INFO - PROCESS | 21608 | 11:27:13 INFO - PROCESS | 21608 | Cycle 1(1): loaded http://localhost:33206/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33206/tests/kraken/driver.html?testName=audio-fft) 11:27:14 INFO - PROCESS | 21608 | RSS: Main: 301928448 11:27:14 INFO - PROCESS | 21608 | 11:27:16 INFO - PROCESS | 21608 | Cycle 1(1): loaded http://localhost:33206/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33206/tests/kraken/driver.html?testName=audio-oscillator) 11:27:16 INFO - PROCESS | 21608 | RSS: Main: 212529152 11:27:16 INFO - PROCESS | 21608 | 11:27:19 INFO - PROCESS | 21608 | Cycle 1(1): loaded http://localhost:33206/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33206/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:27:19 INFO - PROCESS | 21608 | RSS: Main: 215080960 11:27:19 INFO - PROCESS | 21608 | 11:27:23 INFO - PROCESS | 21608 | Cycle 1(1): loaded http://localhost:33206/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33206/tests/kraken/driver.html?testName=imaging-darkroom) 11:27:23 INFO - PROCESS | 21608 | RSS: Main: 251482112 11:27:23 INFO - PROCESS | 21608 | 11:27:27 INFO - PROCESS | 21608 | Cycle 1(1): loaded http://localhost:33206/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33206/tests/kraken/driver.html?testName=imaging-desaturate) 11:27:27 INFO - PROCESS | 21608 | RSS: Main: 250011648 11:27:27 INFO - PROCESS | 21608 | 11:27:30 INFO - PROCESS | 21608 | Cycle 1(1): loaded http://localhost:33206/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33206/tests/kraken/driver.html?testName=json-parse-financial) 11:27:31 INFO - PROCESS | 21608 | RSS: Main: 250044416 11:27:31 INFO - PROCESS | 21608 | 11:27:32 INFO - PROCESS | 21608 | Cycle 1(1): loaded http://localhost:33206/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33206/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:27:33 INFO - PROCESS | 21608 | RSS: Main: 212520960 11:27:33 INFO - PROCESS | 21608 | 11:27:35 INFO - PROCESS | 21608 | Cycle 1(1): loaded http://localhost:33206/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33206/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:27:36 INFO - PROCESS | 21608 | RSS: Main: 219865088 11:27:36 INFO - PROCESS | 21608 | 11:27:38 INFO - PROCESS | 21608 | Cycle 1(1): loaded http://localhost:33206/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33206/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:27:38 INFO - PROCESS | 21608 | RSS: Main: 229163008 11:27:38 INFO - PROCESS | 21608 | 11:27:41 INFO - PROCESS | 21608 | Cycle 1(1): loaded http://localhost:33206/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33206/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:27:42 INFO - PROCESS | 21608 | RSS: Main: 237494272 11:27:42 INFO - PROCESS | 21608 | 11:27:45 INFO - PROCESS | 21608 | Cycle 1(1): loaded http://localhost:33206/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33206/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:27:46 INFO - PROCESS | 21608 | RSS: Main: 234205184 11:27:46 INFO - PROCESS | 21608 | 11:27:47 INFO - PROCESS | 21608 | Cycle 1(1): loaded http://localhost:33206/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33206/tests/kraken/driver.html?testName=ai-astar) 11:27:48 INFO - PROCESS | 21608 | RSS: Main: 284282880 11:27:48 INFO - PROCESS | 21608 | 11:27:48 INFO - PROCESS | 21608 | __start_tp_report 11:27:48 INFO - PROCESS | 21608 | _x_x_mozilla_page_load 11:27:48 INFO - PROCESS | 21608 | _x_x_mozilla_page_load_details 11:27:48 INFO - PROCESS | 21608 | |i|pagename|runs| 11:27:48 INFO - PROCESS | 21608 | |0;ai-astar;111;115;116;114;114;115;115;114;114;113 11:27:48 INFO - PROCESS | 21608 | |1;audio-beat-detection;154;130;127;167;130;130;129;128;171;129 11:27:48 INFO - PROCESS | 21608 | |2;audio-dft;160;160;161;161;162;162;161;163;162;161 11:27:48 INFO - PROCESS | 21608 | |3;audio-fft;76;77;75;105;76;76;79;77;108;78 11:27:48 INFO - PROCESS | 21608 | |4;audio-oscillator;85;83;114;84;83;84;113;84;83;118 11:27:48 INFO - PROCESS | 21608 | |5;imaging-gaussian-blur;117;117;118;116;118;117;118;117;117;117 11:27:48 INFO - PROCESS | 21608 | |6;imaging-darkroom;146;146;146;146;146;146;147;146;146;154 11:27:48 INFO - PROCESS | 21608 | |7;imaging-desaturate;96;95;95;96;95;95;95;95;95;95 11:27:48 INFO - PROCESS | 21608 | |8;json-parse-financial;65;64;64;64;66;64;64;64;65;64 11:27:48 INFO - PROCESS | 21608 | |9;json-stringify-tinderbox;66;66;66;65;66;66;66;66;66;67 11:27:48 INFO - PROCESS | 21608 | |10;stanford-crypto-aes;85;91;91;85;85;93;83;83;95;83 11:27:48 INFO - PROCESS | 21608 | |11;stanford-crypto-ccm;144;141;140;149;162;138;138;138;187;147 11:27:48 INFO - PROCESS | 21608 | |12;stanford-crypto-pbkdf2;181;179;176;183;173;174;179;180;175;174 11:27:48 INFO - PROCESS | 21608 | |13;stanford-crypto-sha256-iterative;71;70;71;75;76;71;72;71;70;74 11:27:48 INFO - PROCESS | 21608 | __end_tp_report 11:27:48 INFO - PROCESS | 21608 | __start_cc_report 11:27:48 INFO - PROCESS | 21608 | _x_x_mozilla_cycle_collect,1921 11:27:48 INFO - PROCESS | 21608 | __end_cc_report 11:27:48 INFO - PROCESS | 21608 | __startTimestamp1475605668189__endTimestamp 11:27:48 INFO - PROCESS | 21608 | 11:27:48 INFO - PROCESS | 21608 | ------- Summary: start ------- 11:27:48 INFO - PROCESS | 21608 | Number of tests: 14 11:27:48 INFO - PROCESS | 21608 | 11:27:48 INFO - PROCESS | 21608 | [#0] ai-astar Cycles:10 Average:114.10 Median:114.50 stddev:1.37 (1.2%) stddev-sans-first:0.88 11:27:48 INFO - PROCESS | 21608 | Values: 111.0 115.0 116.0 114.0 114.0 115.0 115.0 114.0 114.0 113.0 11:27:48 INFO - PROCESS | 21608 | 11:27:48 INFO - PROCESS | 21608 | [#1] audio-beat-detection Cycles:10 Average:139.50 Median:130.00 stddev:17.44 (13.4%) stddev-sans-first:17.69 11:27:48 INFO - PROCESS | 21608 | Values: 154.0 130.0 127.0 167.0 130.0 130.0 129.0 128.0 171.0 129.0 11:27:48 INFO - PROCESS | 21608 | 11:27:48 INFO - PROCESS | 21608 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.95 (0.6%) stddev-sans-first:0.88 11:27:48 INFO - PROCESS | 21608 | Values: 160.0 160.0 161.0 161.0 162.0 162.0 161.0 163.0 162.0 161.0 11:27:48 INFO - PROCESS | 21608 | 11:27:48 INFO - PROCESS | 21608 | [#3] audio-fft Cycles:10 Average:82.70 Median:76.50 stddev:12.61 (16.5%) stddev-sans-first:13.14 11:27:48 INFO - PROCESS | 21608 | Values: 76.0 77.0 75.0 105.0 76.0 76.0 79.0 77.0 108.0 78.0 11:27:48 INFO - PROCESS | 21608 | 11:27:48 INFO - PROCESS | 21608 | [#4] audio-oscillator Cycles:10 Average:93.10 Median:83.50 stddev:15.18 (18.2%) stddev-sans-first:15.81 11:27:48 INFO - PROCESS | 21608 | Values: 85.0 83.0 114.0 84.0 83.0 84.0 113.0 84.0 83.0 118.0 11:27:48 INFO - PROCESS | 21608 | 11:27:48 INFO - PROCESS | 21608 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 11:27:48 INFO - PROCESS | 21608 | Values: 117.0 117.0 118.0 116.0 118.0 117.0 118.0 117.0 117.0 117.0 11:27:48 INFO - PROCESS | 21608 | 11:27:48 INFO - PROCESS | 21608 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:146.00 stddev:2.51 (1.7%) stddev-sans-first:2.65 11:27:48 INFO - PROCESS | 21608 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 154.0 11:27:48 INFO - PROCESS | 21608 | 11:27:48 INFO - PROCESS | 21608 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 11:27:48 INFO - PROCESS | 21608 | Values: 96.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 11:27:48 INFO - PROCESS | 21608 | 11:27:48 INFO - PROCESS | 21608 | [#8] json-parse-financial Cycles:10 Average:64.40 Median:64.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 11:27:48 INFO - PROCESS | 21608 | Values: 65.0 64.0 64.0 64.0 66.0 64.0 64.0 64.0 65.0 64.0 11:27:48 INFO - PROCESS | 21608 | 11:27:48 INFO - PROCESS | 21608 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 11:27:48 INFO - PROCESS | 21608 | Values: 66.0 66.0 66.0 65.0 66.0 66.0 66.0 66.0 66.0 67.0 11:27:48 INFO - PROCESS | 21608 | 11:27:48 INFO - PROCESS | 21608 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:88.00 stddev:4.60 (5.2%) stddev-sans-first:4.80 11:27:48 INFO - PROCESS | 21608 | Values: 85.0 91.0 91.0 85.0 85.0 93.0 83.0 83.0 95.0 83.0 11:27:48 INFO - PROCESS | 21608 | 11:27:48 INFO - PROCESS | 21608 | [#11] stanford-crypto-ccm Cycles:10 Average:148.40 Median:145.50 stddev:15.44 (10.6%) stddev-sans-first:16.30 11:27:48 INFO - PROCESS | 21608 | Values: 144.0 141.0 140.0 149.0 162.0 138.0 138.0 138.0 187.0 147.0 11:27:48 INFO - PROCESS | 21608 | 11:27:48 INFO - PROCESS | 21608 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.40 Median:179.00 stddev:3.44 (1.9%) stddev-sans-first:3.39 11:27:48 INFO - PROCESS | 21608 | Values: 181.0 179.0 176.0 183.0 173.0 174.0 179.0 180.0 175.0 174.0 11:27:48 INFO - PROCESS | 21608 | 11:27:48 INFO - PROCESS | 21608 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.10 Median:71.50 stddev:2.13 (3.0%) stddev-sans-first:2.22 11:27:48 INFO - PROCESS | 21608 | Values: 71.0 70.0 71.0 75.0 76.0 71.0 72.0 71.0 70.0 74.0 11:27:48 INFO - PROCESS | 21608 | -------- Summary: end -------- 11:27:48 INFO - PROCESS | 21608 | 11:27:49 INFO - TEST-INFO | 21608: exit 0 11:27:49 INFO - TEST-OK | kraken | took 64795ms 11:27:49 INFO - SUITE-END | took 1186s 11:27:49 INFO - Completed test suite (00:19:46) 11:27:49 INFO - javascript benchmark 11:27:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2508.172303139964, 2534.898604055838, 2571.7299683533224, 2575.098715449593, 2585.831920925141, 4426.800793964271, 4494.595486406222, 4587.266037434011, 4594.7013444126105, 4617.653675974303, 4524.592786649201, 4548.363229147922, 4580.793864276107, 4618.445786505624, 4661.230896902007, 4161.979190104061, 4173.603507666767, 4211.368294755781, 4220.915581688364, 4235.174141042498, 4238.088810905655, 4250.6386957108525, 4289.914201715964, 4299.763513006784, 4336.891577710551, 4097.282975479279, 4205.831766729358, 4233.153369326147, 4274.145170965804, 4332.97833510832, 4100.405441211008, 4124.175164967019, 4158.542560318362, 4160.667146628262, 4195.0, 4194.412782210493, 4226.5773422657485, 4261.957380426187, 4268.530461649216, 4281.7002809803325, 4533.591976722111, 4563.885902852422, 4587.036722288323, 4606.953930460686, 4629.23617603095, 4746.738929358884, 4924.138275801721, 4926.433460152092, 4933.851984440436, 4983.825566105169, 4820.68665536739, 4834.58905992991, 4925.236588328779, 4930.654854160211, 4982.725950072744, 4591.609713174417, 4627.051454451829, 4640.141573808856, 4646.465656449518, 4646.651501137429, 5087.796488140433, 5088.542031217208, 5093.1341671915125, 5103.260027296022, 5163.251328557338, 4694.131585656664, 4747.430308362949, 4748.430188377417, 4775.976120119377, 4816.627261230603, 4932.8520144395725, 4933.260010998307, 4934.703917764946, 4980.651354405157, 4998.5751211146735, 4843.660943733905, 4874.488178741252, 4882.6826256293225, 4949.331840201598, 4955.876103097451, 4662.463816661059, 4666.32338310943, 4701.506341834127, 4844.854654360375, 4849.636277279218, 4045.9190816183514, 4049.8785036448953, 4055.270051390719, 4059.6752259819145, 4059.8985025374013, 3568.6074531801482, 3589.5513060867393, 3601.9639803602154, 3619.3847046002243, 3643.562772467321, 4256.446661933991, 4261.978690106592, 4306.784660766949, 4308.4399028126145, 4318.611324980767, 4811.9518804811505, 4832.420109586872, 4872.4153101628035, 4880.560749532488, 4890.339804126468, 4183.644390226804, 4196.790160492024, 4208.263553878059, 4211.915761684749, 4231.449911511545, 4289.785510724451, 4318.676099292566, 4356.803943822472, 4410.933835992462, 4416.558344165558, 4602.05657840142, 4608.700434471749, 4611.976940115278, 4654.581087701988, 4656.557627025427, 4730.053989202104, 4771.23660214364, 4829.66192366531, 4832.323474713613, 4839.927401089057, 4562.749048802348, 4592.288195329729, 4604.677672562889, 4613.492515823324, 4618.56123668251, 4744.074905393415, 4745.9050818984115, 4746.762661866962, 4797.544233297831, 4847.830325938575, 4884.63365247615, 4934.55588996992, 4943.9505604944925, 4945.406551213878, 4947.703137811743, 4748.145333839942, 4749.786259618395, 4750.192467280502, 4766.95233047679, 4817.0125124350125, 4602.539746025371, 4743.335932969456, 4756.476787553435, 4807.206810876166, 4872.43966943806, 4632.420947381577, 4711.646626502958, 4750.406199225097, 4750.477447480844, 4802.73584952831, 4770.475247722818, 4797.136515427117, 4811.374521312207, 4824.396950381202, 4885.633577481774, 4734.242521196592, 4743.0988112258565, 4746.7389293589185, 4800.567948884617, 4803.903921921612], "value": 4491.0650881370075, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.9322779945902, 566.1027271774241, 566.611870868455, 571.5713215088683, 578.5516224925685, 27521.587176192374, 28233.294167645818, 37611.24777504452, 38375.23249535008, 38455.0, 40196.39705404414, 40534.189316213655, 40595.79702101493, 40630.39054414186, 40639.796801016026, 7544.321011108999, 7683.0, 7686.923130768677, 7693.346065584432, 7696.345810606077, 7092.326229008236, 7278.708851645928, 7280.162781280141, 7485.139208990954, 7600.315971562558, 9578.425294482318, 9925.305228633999, 9933.751656208617, 10244.129249013842, 10244.28290019699, 9948.104670579647, 9966.601335946554, 10008.799824003552, 10012.94993525035, 10014.24893133018, 7002.089728335335, 7237.638118094127, 9423.48170850603, 9481.715548533555, 9484.430934143973, 35669.28661426757, 36257.824530528254, 36437.81781091104, 39975.0, 40198.0, 2770.6259654946525, 2772.237634650467, 2811.550151975674, 3143.8899638512544, 3319.079210294949, 27311.45377092467, 27417.177484675292, 27601.171964841087, 27746.306342341402, 28217.576736348972, 3432.70821980132, 3544.0962554548423, 3549.716022718176, 3572.7316802535247, 3579.3736096183065, 250906.0, 255174.72412638002, 255780.0, 255798.44201558118, 255826.0, 47760.52239477561, 47974.520254797004, 47983.28025079626, 53420.73289633527, 53726.0, 53926.460735392146, 59047.0, 59115.40884591185, 59149.40850591439, 59191.0, 13754.793678094837, 13861.237631930138, 13870.583882483541, 13875.236861972688, 13877.514286999907, 10504.264701470824, 10560.577576896838, 10569.312994655324, 10669.466526673636, 10672.146228301717, 15961.920190399205, 16373.672526549402, 17913.641727165385, 18296.17667204979, 18331.63336733258, 6831.950414875518, 6925.896111558331, 7027.578345299298, 7204.855902882018, 7310.417895231299, 789.9802504937422, 888.6045709659139, 913.0686699566538, 920.1626519866888, 927.5037854747812, 26458.6031209532, 27215.0, 28032.29919252035, 28037.719622803917, 28069.157925262276, 912.6714382822179, 944.1172503708917, 958.2142643032646, 967.1972263021676, 1012.9949350253202, 13807.930960345135, 14511.419543218364, 14601.561953141423, 14798.778018329735, 14815.92592037033, 399114.0, 400752.0, 402857.0, 403284.0, 403686.0, 42155.0, 43683.34474982878, 43747.0, 47137.0, 47648.523514764405, 1161.5818305410046, 1167.0896700573567, 1192.8389667394965, 1193.3973343461496, 1197.203859433467, 26553.0, 27995.58006629943, 28555.143345699664, 28608.856955715088, 28763.568546472237, 41284.38073428841, 41659.7917010413, 41669.58330416657, 41671.16657666769, 41720.0, 271768.0, 399469.0, 407670.0, 411389.0, 629901.0, 36746.0, 36864.25850571303, 36874.44688329624, 36994.44508332323, 37529.81235093807, 39994.0, 40028.799856000536, 40181.79909100436, 40436.0, 40831.38752918768, 34662.82668586641, 34858.65141348554, 34935.65064349426, 35210.8239458801, 35339.646603533634, 34449.65550344565, 34773.0, 34842.82578587091, 34926.30147397089, 35115.64884351124, 34260.0, 34887.0, 35131.121721957155, 35180.472292916136, 35709.46435803413, 29474.557881632223, 31227.68772312248, 31406.685933140376, 31429.0, 31990.84004579962, 24294.76395621024, 24656.383590410383, 24692.259232223063, 24780.752192477845, 25103.246902592953], "value": 17768.44777798807, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.5675107486878, 349.7114880223816, 370.24100593782737, 374.67403359077605, 385.37761515153034, 12404.255744655327, 16552.58618534537, 17236.22436990334, 18459.35392261271, 18613.441596752084, 16666.66666666669, 16812.0, 17460.47618571442, 17524.912375438136, 17609.710737604124, 4898.608111351093, 5090.541851233388, 5204.661696989702, 5223.399309079447, 5231.372235331765, 3738.9252214955686, 3924.725269231155, 5134.0, 5241.135212689921, 5244.632875698702, 5759.366469688331, 6027.879442411171, 6049.546284028694, 6122.63264204147, 6131.63210207389, 6076.878462430771, 6093.268807743055, 6523.347665233438, 6827.180738311435, 6866.073080134168, 6528.37980391862, 6697.933020669829, 6707.128073350482, 6711.899321510181, 6716.5634233774645, 22005.889970550044, 22229.77770222293, 22525.648461092223, 22882.542349152925, 22910.885445572832, 2091.6862470629376, 2217.1796435318875, 2260.8417410781253, 2426.9514609707708, 2502.0117053763843, 13291.53479628218, 14021.64945876351, 14603.634909127251, 14624.634384140376, 15102.471413500474, 1730.8788384813067, 1831.157667472964, 1836.8714190006706, 1844.6495165918432, 1847.7228415737613, 78129.0, 79772.0, 79926.60036699838, 80899.5955020227, 82905.0, 16168.434104806276, 16171.259202983007, 16227.513174604781, 16525.58686032859, 16645.3341866324, 28820.567691484644, 28952.710472895, 29051.41897162045, 29096.563551546744, 29308.120756377342, 8614.78463038429, 8967.820643587222, 8968.10318968098, 8984.371094023356, 9295.0, 7282.708691652275, 7498.4001279897475, 7514.9624251878395, 7568.810779730551, 7618.923810761821, 7968.099618734436, 8336.499810011419, 8438.0, 8623.0, 8639.827203455896, 3115.750739940799, 3143.355612099514, 3310.0235430548046, 3324.492660243466, 3356.681115294043, 768.4774353439715, 806.2743530822307, 824.6577670266772, 826.7313123234852, 859.3855393393753, 16377.754333685005, 16678.749818752727, 17159.828401716073, 17173.0, 17464.0, 769.4440593373134, 775.6160700453312, 790.020374735324, 799.8280369720538, 810.5217921426387, 7133.785986420416, 9063.68277110298, 9122.817543649222, 9460.479673618018, 9848.2613803965, 337709.0, 346009.0, 358795.0, 361021.0, 361102.0, 61346.0, 61547.0, 68432.6578367115, 69333.3066669337, 79199.20800792033, 859.6293999069532, 869.3914260018013, 896.2381975321056, 900.5092224737534, 901.0223907060912, 15433.768493472831, 15438.30527626282, 16097.275622597246, 16329.346826126823, 16396.918015409847, 34393.828030860685, 34588.654113459546, 35008.47487287642, 35288.82355588206, 35312.0, 45784.54215457803, 49305.75347123241, 49334.50665493443, 49350.0, 49432.25851612157, 7134.643267836691, 7148.106486689164, 7249.565026098451, 7331.41348692114, 7348.412127029718, 11234.3259404436, 11943.940280298542, 11989.520419183134, 12298.323592202514, 12402.13185077036, 9688.564014619218, 9742.366746161477, 10056.34633748804, 10218.1825453965, 10802.567897284021, 7207.855842883008, 7282.344588987016, 7593.1647518774, 9593.328467007243, 10122.44326562046, 7592.734254301073, 7629.0, 7780.766577002699, 8028.87956680662, 8057.758267251992, 11336.716582085513, 11424.0, 11609.47757350938, 11715.1799374043, 11818.704532386759, 10921.453927303763, 11319.0, 11408.258463199865, 11427.0, 11650.70873228176], "value": 9035.634021189799, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1285.1967520299813, 1355.0853174107474, 1356.6201463590191, 1599.1524492019234, 1645.5227983884668, 6684.4986626003, 6924.619145946971, 7112.288771122885, 7680.193579674131, 7683.11644160921, 7047.85904281914, 7344.596047217401, 7347.191808901017, 7504.0, 7510.023696919407, 1916.396335154429, 1942.8445724342089, 1951.8145776151243, 1956.6967120096338, 1956.7945365736607, 1643.967120657586, 1695.5252529291818, 1805.9458216253468, 1940.1754254441876, 1960.9411717648422, 1958.2558627721446, 1972.6843705007202, 1974.891380974053, 1976.8023197680188, 1977.3672424824063, 1884.1521315407983, 1897.857660675448, 1904.1812020831037, 1904.7714274287175, 1906.780720217172, 1912.129980858706, 1916.8370688491495, 1917.8561607879465, 1919.280269898788, 1923.4614307993784, 7400.925990740131, 7559.433042521833, 7561.508501947411, 7564.394848412114, 7567.281108294703, 4251.0, 4375.496817865955, 4376.868693939187, 4380.0582874682095, 4384.89037774055, 2578.9871050644815, 2615.3069436599317, 2644.431447238853, 2667.919962401131, 2685.1810197889636, 796.3151689546985, 820.4912953968518, 831.9209675080918, 831.9584020798997, 836.8326334733077, 9757.90242097577, 9844.803103937953, 9945.75135621608, 10005.899941000569, 10017.0, 3632.4914511968345, 3769.754965927206, 3802.9049273767823, 3858.0354911272184, 3879.650831425185, 8629.482231066031, 8640.30877529796, 8643.740687779376, 8645.3948223625, 8650.697225597074, 4320.330348795942, 4320.481542214954, 4323.156984388077, 4325.351197320364, 4334.544872788375, 3979.7612143271494, 3980.3233450313514, 3982.4424580558743, 3988.581198974066, 3993.121513267077, 3115.5326700995033, 3159.4786860167815, 3195.2650890295363, 3212.759043071779, 3228.0961330826935, 984.5421878826237, 987.7728122531857, 1003.7490627343165, 1005.1606908231562, 1010.5654568535454, 763.8128658478709, 777.739457281817, 792.1049214387705, 792.8572856885701, 805.2430715127762, 4923.556879880828, 4934.629902757308, 4961.809165800254, 5064.974675126601, 5221.947780522146, 833.3666413525764, 865.1485820344468, 877.7849426890452, 887.5074333744705, 890.6838072484175, 3193.568868202763, 3270.1661076425357, 3280.967190328066, 3284.802911825298, 3406.7444941628983, 8676.6529338827, 8995.505247211466, 9004.63981440735, 9007.594658240396, 9009.909900900908, 8930.062343453974, 8940.46357218556, 8941.910580894239, 8952.0, 8957.686480973265, 7046.154461464657, 7166.784996450115, 7175.461840361993, 7183.102112235971, 7186.0, 4867.221244600847, 4928.581070608895, 4962.6774259673, 5038.672486288379, 5199.896002080013, 8545.2309292164, 8577.270931970852, 8579.056303806452, 8702.695405661025, 8752.606132723915, 8015.799605009922, 8413.326933845156, 8417.663293468193, 8692.174243446863, 8702.82594348122, 6563.113979612691, 6715.294894036056, 6719.798406047827, 6730.899036514358, 6735.831604209934, 6304.71628776697, 6551.44312733423, 7167.820804479929, 7213.819654508679, 7247.166575843846, 5957.49361304294, 5973.253343332083, 6290.778653717312, 6340.239171299474, 6437.420632142942, 6493.480521558358, 6494.220693516808, 6585.078089067631, 6620.404163625297, 6624.4700423965005, 6039.335673076046, 6133.803908237851, 6133.877322453437, 6139.048447490646, 6143.262808463013, 4260.531341552489, 4352.347147927836, 4398.428204333544, 4495.730256184639, 4580.473245576802, 4386.978065109654, 4449.822007119679, 4487.955120448753, 4490.797914093939, 4498.70758400716], "value": 3860.630824388093, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [269.36564390859525, 283.88218889161, 285.2469480571292, 286.2100602337549, 295.4784804819493, 4843.636727245457, 4876.317315575822, 4876.926846097307, 4877.975610121949, 4884.5848102911295, 4765.332853400527, 4780.0, 4838.669365924373, 4843.66094373394, 4849.393825771778, 3567.340042092215, 3677.999999999987, 3686.907827304312, 3769.792661403622, 3821.5987321331277, 3814.389697648377, 3816.3893776995687, 3837.9424308635394, 3859.20886218326, 3863.3239183142978, 3772.5284339457567, 3796.6962642988633, 3801.4107813288983, 3814.923701525982, 3814.980925095371, 3593.730470214731, 3660.0, 3725.8137093145506, 3771.434284857266, 3802.707079592924, 3327.584051993501, 3337.398048936524, 3340.716039136652, 3341.1313058604937, 3342.9607939157095, 4686.109639168547, 4695.906081878344, 4716.38686970695, 4723.5984941279685, 4748.169070412699, 4243.830246790125, 4345.804438800262, 4367.235733746582, 4372.5627437256335, 4375.562443755631, 5059.494050594948, 5069.467705890866, 5081.771320290559, 5088.542031217208, 5090.9236361454605, 3690.741648084635, 3692.907677308062, 3696.8890933272046, 3699.9445008324897, 3704.1850792825803, 5166.689998600096, 5299.470052994747, 5304.708241046779, 5307.2569840222395, 5321.308229930084, 3699.1122130688977, 3703.518542589446, 3722.925541489209, 3731.253749250161, 3742.045778326509, 3770.8506151493384, 3771.2834561433788, 3771.5097037384962, 3788.2384691118764, 3803.174476251415, 4317.395564620955, 4332.783360832009, 4334.4798624165305, 4336.674749393808, 4347.782610869507, 4885.828995985124, 5032.270320803463, 5052.72210028452, 5053.772580233898, 5136.768845401966, 1315.4475120449433, 1331.3343328335832, 1333.313343628013, 1333.599920023989, 1334.252818421687, 832.3008672714949, 842.8819965204876, 858.3390789092364, 870.303756994402, 878.5124256037833, 4364.4980827204645, 4410.0, 4562.612177964844, 4575.656825738017, 4586.656000799953, 5102.617303702237, 5232.3721153461065, 5234.214867769789, 5242.895142097137, 5254.108520932461, 4487.41663583732, 4517.599544141327, 4517.93828450314, 4552.588697503785, 4560.270356742905, 2641.828281161718, 2769.1138835572424, 2776.6529183852017, 2786.874590643426, 2820.576913462956, 4973.801047958041, 4979.755061234691, 4994.9500504994485, 5019.196928491497, 5021.648484606042, 5246.501582349671, 5379.5427388671615, 5379.67721936685, 5404.0, 5412.377576578744, 4953.6037117030555, 5015.3229314042865, 5020.221865610836, 5029.748512574357, 5032.446430892525, 5269.657472264291, 5269.868253293698, 5272.815451459181, 5340.412554618911, 5341.439148889311, 5000.87497812543, 5132.538071573576, 5162.483751624807, 5178.71517066565, 5192.740362981911, 4980.626453015966, 5001.24981252815, 5015.194529969281, 5026.673266237683, 5030.496950305087, 3289.950650740289, 3321.534985102039, 3325.0024992502636, 3325.3681800457834, 3337.349216902681, 4417.00617361104, 4517.887052823706, 4639.35049093134, 4660.229112937062, 4660.347551342883, 4487.304467807495, 4520.259700015452, 4522.525134860924, 4532.546745325441, 4543.4775000874, 4487.439070116236, 4503.797329120263, 4515.322701594787, 4581.496035436033, 4607.170709272363, 4492.213862574102, 4494.213512635341, 4520.638348932143, 4524.88687782808, 4527.4340707411575, 4789.712617242976, 4917.754112294299, 4917.9016419672125, 5032.6225533084435, 5182.896342073062, 4973.179425394769, 4973.35346404965, 4974.825881094144, 4976.726280054631, 4989.9251511228085], "value": 3775.8231984189174, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [621.7606221604682, 691.1636919327616, 710.2577806192528, 719.9568025918442, 747.8541684371546, 13501.122427042248, 14002.789958150635, 14200.644983875409, 14217.431302747891, 14239.430422783102, 13002.0, 13346.532871349506, 13421.127626704258, 13450.0, 13467.326633668326, 732.3226015935238, 733.4205977277944, 733.4719002318323, 740.459464590849, 741.2550386861224, 619.1239396254294, 630.385374260095, 715.3061530315586, 737.9815504612374, 739.9593022383793, 797.9680812767482, 798.5208874675207, 798.9280964713174, 799.6601444386142, 800.0559339978822, 791.639803889229, 791.6516732637679, 791.9089304729914, 791.9089304729944, 791.9406044546653, 470.8822794301425, 479.0753845078996, 480.07824976045725, 480.9470958194631, 481.1555719711918, 11832.349220792852, 12213.755724885452, 12263.0189584833, 12657.873421265762, 12692.492300307977, 12659.936700316532, 13191.736165276641, 13602.795958060637, 13765.655858603615, 14121.364538595684, 10197.082262596401, 10421.739456513573, 10463.267571270015, 10643.893561064368, 10859.619913302997, 3185.761067919915, 3203.9679603203904, 3205.487122060459, 3225.161458020908, 3265.297960938386, 60166.69916650389, 60428.09357859636, 60984.0, 61626.38373616251, 62584.68707656478, 9900.55447504864, 9993.550290236812, 10027.29808913369, 10154.796904061877, 10233.48832558369, 18060.638787224445, 18086.90956545209, 18096.45710628683, 18204.180811863233, 18221.18004689792, 6548.345165483509, 6560.311167327457, 6581.76963806274, 6641.966790166019, 6700.932990670129, 3620.2035552178477, 3639.253952939641, 3661.0, 3739.6634302912867, 3741.8877433677035, 2762.4198918226994, 2859.7998140130408, 2896.3483216276168, 2898.145047211078, 2923.0646193217967, 490.0835437731465, 496.2481840012384, 497.2417063977463, 507.2948601443996, 513.2455290722631, 582.4379473807711, 597.8909123575792, 614.015572858732, 618.4464903910974, 623.9563230573816, 7816.921830781619, 8138.877916831252, 8350.791230219293, 8392.0, 8522.957385213158, 553.327706836196, 616.3928530397554, 616.4298024327479, 620.3703241210176, 628.1645411602558, 3790.905227369338, 3897.3569361055675, 3959.604039596075, 4117.732347397409, 4122.464079669624, 57376.0, 57485.71257143771, 57576.71211643915, 74639.62680186673, 102302.48848755709, 52360.0, 53146.73426632842, 53221.2016819748, 84867.0, 87591.0, 46274.768626156656, 46674.29988550174, 47723.761381192875, 59407.702961484916, 76193.0, 8058.234467725557, 8061.113277539584, 8461.133253158101, 8495.447795893248, 8550.957245213984, 39406.2118757629, 40315.596844031184, 41630.95922601959, 41890.0, 42613.14773704571, 62184.68907655433, 62644.686776565824, 64043.0, 64588.677056616296, 65389.34610653832, 10042.347247428894, 10134.239932005277, 10315.27793054509, 10333.948330258301, 10684.893151068702, 11869.347185904859, 12073.517059317528, 12120.93939530332, 12496.375181241083, 12503.0, 11452.885471145182, 11661.183717139718, 11969.0, 12322.507099715911, 12340.259584424963, 10964.28732132409, 11470.254433461798, 11536.134789890959, 11666.300021998708, 12049.277043377426, 11113.166512511432, 11265.472085467556, 11508.13688973347, 11574.88425115738, 11814.94092529532, 9275.582598783207, 9501.239900808057, 9610.711678649652, 9742.756431088996, 9746.781652293463, 9773.634887912875, 10376.169906407318, 10414.947925260325, 10439.739006524898, 10467.895321046692], "value": 6297.15038461842, "unit": "score"}], "name": "dromaeo_css", "value": 6360.2068302207335, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 115.0, 116.0, 114.0, 114.0, 115.0, 115.0, 114.0, 114.0, 113.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 130.0, 127.0, 167.0, 130.0, 130.0, 129.0, 128.0, 171.0, 129.0], "value": 139.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 161.0, 162.0, 162.0, 161.0, 163.0, 162.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 75.0, 105.0, 76.0, 76.0, 79.0, 77.0, 108.0, 78.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 114.0, 84.0, 83.0, 84.0, 113.0, 84.0, 83.0, 118.0], "value": 93.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 116.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 154.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 64.0, 66.0, 64.0, 64.0, 64.0, 65.0, 64.0], "value": 64.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 65.0, 66.0, 66.0, 66.0, 66.0, 66.0, 67.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 91.0, 91.0, 85.0, 85.0, 93.0, 83.0, 83.0, 95.0, 83.0], "value": 87.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 141.0, 140.0, 149.0, 162.0, 138.0, 138.0, 138.0, 187.0, 147.0], "value": 148.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 179.0, 176.0, 183.0, 173.0, 174.0, 179.0, 180.0, 175.0, 174.0], "value": 177.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 71.0, 75.0, 76.0, 71.0, 72.0, 71.0, 70.0, 74.0], "value": 72.1, "unit": "score"}], "name": "kraken", "value": 1565.7000000000003, "alertThreshold": 2.0}]} 11:27:49 INFO - Return code: 0 11:27:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:27:49 INFO - # TBPL SUCCESS # 11:27:49 INFO - Running post-action listener: _resource_record_post_action 11:27:49 INFO - [mozharness: 2016-10-04 18:27:49.969594Z] Finished run-tests step (success) 11:27:49 INFO - Running post-run listener: _resource_record_post_run 11:27:50 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 403783680; Read time: 16; Write time: 238236 11:27:50 INFO - TinderboxPrint: CPU usage
13.1% 11:27:50 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 11:27:50 INFO - TinderboxPrint: I/O write bytes / time
403,783,680 / 238,236 11:27:50 INFO - TinderboxPrint: CPU idle
8,344.3 (86.9%) 11:27:50 INFO - TinderboxPrint: CPU user
1,206.4 (12.6%) 11:27:50 INFO - TinderboxPrint: Swap in / out
0 / 0 11:27:50 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110465024; Read time: 0; Write time: 61100 11:27:50 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 292323328; Read time: 0; Write time: 177108 11:27:50 INFO - Running post-run listener: _upload_blobber_files 11:27:50 INFO - Blob upload gear active. 11:27:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:27:50 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 11:27:50 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:27:50 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:27:51 INFO - (blobuploader) - INFO - Open directory for files ... 11:27:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:27:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:27:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:27:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:27:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:27:59 INFO - (blobuploader) - INFO - Done attempting. 11:27:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:27:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:27:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:28:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:28:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:28:00 INFO - (blobuploader) - INFO - Done attempting. 11:28:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:28:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:28:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:28:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:28:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:28:01 INFO - (blobuploader) - INFO - Done attempting. 11:28:01 INFO - (blobuploader) - INFO - Iteration through files over. 11:28:01 INFO - Return code: 0 11:28:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:28:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:28:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2ae13d5adae715b9d7fe13192121edc9632a5ab8c392f08043a5a465c831e36b3ad2ead2cbf0a6358560bde0944a180d6d581429cbd9a2334cb76b02c1ea99f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8b2bb6791f11885ffbfc82a31d56a3f6e1b1d3251bd50e3744b78f20a76b04735ea07df04217a316856caecfccd01879837720775276ba9b043bc017f5c57fcc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/84a9253107c1413b51ab9ae78963f53f938534a3c16ca719ded24d3c517748356ecf5ce9b22192907dc8a560612cec60274f788847e75bed8145ca56c87ea8c9"} 11:28:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:28:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:28:01 INFO - Contents: 11:28:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2ae13d5adae715b9d7fe13192121edc9632a5ab8c392f08043a5a465c831e36b3ad2ead2cbf0a6358560bde0944a180d6d581429cbd9a2334cb76b02c1ea99f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8b2bb6791f11885ffbfc82a31d56a3f6e1b1d3251bd50e3744b78f20a76b04735ea07df04217a316856caecfccd01879837720775276ba9b043bc017f5c57fcc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/84a9253107c1413b51ab9ae78963f53f938534a3c16ca719ded24d3c517748356ecf5ce9b22192907dc8a560612cec60274f788847e75bed8145ca56c87ea8c9"} 11:28:01 INFO - Running post-run listener: copy_logs_to_upload_dir 11:28:01 INFO - Copying logs to upload dir... 11:28:01 INFO - mkdir: /builds/slave/test/build/upload/logs 11:28:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.514221 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-10-04 11:28:01.211777) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 11:28:01.215252) ========= 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=1f5564757af27664ca02d71f000001b0-1475603429.973071-1518134071 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2ae13d5adae715b9d7fe13192121edc9632a5ab8c392f08043a5a465c831e36b3ad2ead2cbf0a6358560bde0944a180d6d581429cbd9a2334cb76b02c1ea99f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8b2bb6791f11885ffbfc82a31d56a3f6e1b1d3251bd50e3744b78f20a76b04735ea07df04217a316856caecfccd01879837720775276ba9b043bc017f5c57fcc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/84a9253107c1413b51ab9ae78963f53f938534a3c16ca719ded24d3c517748356ecf5ce9b22192907dc8a560612cec60274f788847e75bed8145ca56c87ea8c9"} build_url:https://queue.taskcluster.net/v1/task/eWQrRHLxTiqHAP79VaSgVw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011397 build_url: 'https://queue.taskcluster.net/v1/task/eWQrRHLxTiqHAP79VaSgVw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2ae13d5adae715b9d7fe13192121edc9632a5ab8c392f08043a5a465c831e36b3ad2ead2cbf0a6358560bde0944a180d6d581429cbd9a2334cb76b02c1ea99f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8b2bb6791f11885ffbfc82a31d56a3f6e1b1d3251bd50e3744b78f20a76b04735ea07df04217a316856caecfccd01879837720775276ba9b043bc017f5c57fcc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/84a9253107c1413b51ab9ae78963f53f938534a3c16ca719ded24d3c517748356ecf5ce9b22192907dc8a560612cec60274f788847e75bed8145ca56c87ea8c9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 11:28:01.241704) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 11:28:01.242068) ========= 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=1f5564757af27664ca02d71f000001b0-1475603429.973071-1518134071 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004429 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 11:28:01.326387) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 11:28:01.326852) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 11:28:01.327259) ========= ========= Total master_lag: 0.18 =========