builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-020 starttime: 1475525638.72 results: success (0) buildid: 20161003122159 builduid: 43bcc9a87e384a6d9a5ca31fddf95756 revision: e8f4dc9c44cc79fcc35913c8d87063dfabbe127e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 13:13:58.724060) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 13:13:58.725058) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 13:13:58.725799) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 13:13:58.770641) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 13:13:58.771043) ========= 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=af724c981e2a0f424dbabf99000001e7-1475525218.857237-1488815137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-03 13:13:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 207M=0s 2016-10-03 13:13:58 (207 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093644 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 13:13:58.881900) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 13:13:58.882315) ========= 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=af724c981e2a0f424dbabf99000001e7-1475525218.857237-1488815137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023408 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 13:13:58.934946) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 13:13:58.935318) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev e8f4dc9c44cc79fcc35913c8d87063dfabbe127e --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 e8f4dc9c44cc79fcc35913c8d87063dfabbe127e --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=af724c981e2a0f424dbabf99000001e7-1475525218.857237-1488815137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-03 13:13:59,105 truncating revision to first 12 chars 2016-10-03 13:13:59,105 Setting DEBUG logging. 2016-10-03 13:13:59,105 attempt 1/10 2016-10-03 13:13:59,105 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/e8f4dc9c44cc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-03 13:13:59,479 unpacking tar archive at: autoland-e8f4dc9c44cc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.712142 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 13:13:59.663873) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 13:13:59.664473) ========= script_repo_revision: e8f4dc9c44cc79fcc35913c8d87063dfabbe127e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 13:13:59.665212) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 13:13:59.665876) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 13:13:59.676815) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-10-03 13:13:59.677132) ========= /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=af724c981e2a0f424dbabf99000001e7-1475525218.857237-1488815137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:13:59 INFO - MultiFileLogger online at 20161003 13:13:59 in /builds/slave/test 13:13:59 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 13:13:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:13:59 INFO - {'append_to_log': False, 13:13:59 INFO - 'base_work_dir': '/builds/slave/test', 13:13:59 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 13:13:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:13:59 INFO - 'branch': 'Autoland-Non-PGO', 13:13:59 INFO - 'buildbot_json_path': 'buildprops.json', 13:13:59 INFO - 'config_files': ('talos/linux_config.py',), 13:13:59 INFO - 'default_actions': ('clobber', 13:13:59 INFO - 'read-buildbot-config', 13:13:59 INFO - 'download-and-extract', 13:13:59 INFO - 'populate-webroot', 13:13:59 INFO - 'create-virtualenv', 13:13:59 INFO - 'install', 13:13:59 INFO - 'run-tests'), 13:13:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:13:59 INFO - 'download_minidump_stackwalk': True, 13:13:59 INFO - 'download_symbols': 'ondemand', 13:13:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:13:59 INFO - 'tooltool.py': '/tools/tooltool.py', 13:13:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:13:59 INFO - '/tools/misc-python/virtualenv.py')}, 13:13:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:13:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:13:59 INFO - 'installer_path': 'installer.exe', 13:13:59 INFO - 'log_level': 'info', 13:13:59 INFO - 'log_name': 'talos', 13:13:59 INFO - 'log_to_console': True, 13:13:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:13:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:13:59 INFO - 'opt_config_files': (), 13:13:59 INFO - 'pip_index': False, 13:13:59 INFO - 'sps_profile': False, 13:13:59 INFO - 'sps_profile_interval': 0, 13:13:59 INFO - 'suite': 'dromaeojs', 13:13:59 INFO - 'system_bits': '32', 13:13:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:13:59 INFO - 'title': 'talos-linux64-ix-020', 13:13:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:13:59 INFO - 'use_talos_json': True, 13:13:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:13:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:13:59 INFO - 'work_dir': 'build'} 13:13:59 INFO - [mozharness: 2016-10-03 20:13:59.940628Z] Running clobber step. 13:13:59 INFO - Running pre-action listener: _resource_record_pre_action 13:13:59 INFO - Running main action method: clobber 13:13:59 INFO - rmtree: /builds/slave/test/build 13:13:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:14:00 INFO - Running post-action listener: _resource_record_post_action 13:14:00 INFO - [mozharness: 2016-10-03 20:14:00.395308Z] Finished clobber step (success) 13:14:00 INFO - [mozharness: 2016-10-03 20:14:00.395407Z] Running read-buildbot-config step. 13:14:00 INFO - Running pre-action listener: _resource_record_pre_action 13:14:00 INFO - Running main action method: read_buildbot_config 13:14:00 INFO - Using buildbot properties: 13:14:00 INFO - { 13:14:00 INFO - "project": "", 13:14:00 INFO - "product": "firefox", 13:14:00 INFO - "script_repo_revision": "production", 13:14:00 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 13:14:00 INFO - "repository": "", 13:14:00 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 13:14:00 INFO - "buildid": "20161003122159", 13:14:00 INFO - "pgo_build": "False", 13:14:00 INFO - "basedir": "/builds/slave/test", 13:14:00 INFO - "buildnumber": 612, 13:14:00 INFO - "slavename": "talos-linux64-ix-020", 13:14:00 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:14:00 INFO - "platform": "ubuntu64_hw", 13:14:00 INFO - "scheduler": "tests-autoland-linux64-talos", 13:14:00 INFO - "branch": "autoland", 13:14:00 INFO - "repo_path": "integration/autoland", 13:14:00 INFO - "revision": "e8f4dc9c44cc79fcc35913c8d87063dfabbe127e", 13:14:00 INFO - "stage_platform": "linux64", 13:14:00 INFO - "builduid": "43bcc9a87e384a6d9a5ca31fddf95756", 13:14:00 INFO - "slavebuilddir": "test" 13:14:00 INFO - } 13:14:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/YEbVpFKMTrWnjJnxGmPEFw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 13:14:00 INFO - Running post-action listener: _resource_record_post_action 13:14:00 INFO - [mozharness: 2016-10-03 20:14:00.398118Z] Finished read-buildbot-config step (success) 13:14:00 INFO - [mozharness: 2016-10-03 20:14:00.398206Z] Running download-and-extract step. 13:14:00 INFO - Running pre-action listener: _resource_record_pre_action 13:14:00 INFO - Running main action method: download_and_extract 13:14:00 INFO - mkdir: /builds/slave/test/build/tests 13:14:00 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')]} 13:14:00 INFO - trying https://queue.taskcluster.net/v1/task/YEbVpFKMTrWnjJnxGmPEFw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 13:14:00 INFO - Downloading https://queue.taskcluster.net/v1/task/YEbVpFKMTrWnjJnxGmPEFw/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 13:14:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YEbVpFKMTrWnjJnxGmPEFw/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 13:14:00 INFO - Downloaded 1361 bytes. 13:14:00 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 13:14:00 INFO - Using the following test package requirements: 13:14:00 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 13:14:00 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:14:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:14:00 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:14:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:14:00 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:14:00 INFO - u'jsshell-linux-x86_64.zip'], 13:14:00 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:14:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:14:00 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 13:14:00 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:14:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:14:00 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:14:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:14:00 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:14:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:14:00 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:14:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:14:00 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:14:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YEbVpFKMTrWnjJnxGmPEFw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 13:14:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YEbVpFKMTrWnjJnxGmPEFw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:14:00 INFO - Fetch https://queue.taskcluster.net/v1/task/YEbVpFKMTrWnjJnxGmPEFw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 13:14:01 INFO - Http code: 200 13:14:01 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 13:14:01 INFO - x-amz-cf-id: Z_z8G8sj57_YVJMn4pwJ6j5S2dIafGn1twgSYUg9gu-VyyM9VCBpjw== 13:14:01 INFO - x-amz-version-id: FV5Fy.wO4eS6PUygY3tF8T9wEqgilSCK 13:14:01 INFO - Expected file size: 20420645 13:14:01 INFO - Obtained file size: 20420645 13:14:05 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 13:14:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YEbVpFKMTrWnjJnxGmPEFw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 13:14:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YEbVpFKMTrWnjJnxGmPEFw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:14:05 INFO - Fetch https://queue.taskcluster.net/v1/task/YEbVpFKMTrWnjJnxGmPEFw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 13:14:06 INFO - Http code: 200 13:14:06 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 13:14:06 INFO - x-amz-cf-id: voytZDa8wT0gnyVM6RurTNrJ3SP1GGq5aUT9CG14qKBF-n0tQ6T7Tg== 13:14:06 INFO - x-amz-version-id: FV5Fy.wO4eS6PUygY3tF8T9wEqgilSCK 13:14:06 INFO - Expected file size: 20420645 13:14:06 INFO - Obtained file size: 20420645 13:14:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YEbVpFKMTrWnjJnxGmPEFw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 13:14:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YEbVpFKMTrWnjJnxGmPEFw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:14:11 INFO - Fetch https://queue.taskcluster.net/v1/task/YEbVpFKMTrWnjJnxGmPEFw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 13:14:11 INFO - Http code: 200 13:14:11 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 13:14:11 INFO - x-amz-cf-id: bD9ClAhyfOwvXHSrSDMIrEsbwthcrcFxO62STqwX1DryFaltOwjhLA== 13:14:11 INFO - x-amz-version-id: DotUgPJO_4BRZWDCQFwWvZfXA2nXU9bE 13:14:12 INFO - Expected file size: 14408522 13:14:12 INFO - Obtained file size: 14408522 13:14:12 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')]} 13:14:12 INFO - trying https://queue.taskcluster.net/v1/task/YEbVpFKMTrWnjJnxGmPEFw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:14:12 INFO - Downloading https://queue.taskcluster.net/v1/task/YEbVpFKMTrWnjJnxGmPEFw/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 13:14:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YEbVpFKMTrWnjJnxGmPEFw/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 13:14:14 INFO - Downloaded 55829070 bytes. 13:14:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YEbVpFKMTrWnjJnxGmPEFw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:14:14 INFO - mkdir: /builds/slave/test/properties 13:14:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:14:14 INFO - Writing to file /builds/slave/test/properties/build_url 13:14:14 INFO - Contents: 13:14:14 INFO - build_url:https://queue.taskcluster.net/v1/task/YEbVpFKMTrWnjJnxGmPEFw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:14:15 INFO - Running post-action listener: _resource_record_post_action 13:14:15 INFO - Running post-action listener: set_extra_try_arguments 13:14:15 INFO - [mozharness: 2016-10-03 20:14:15.661106Z] Finished download-and-extract step (success) 13:14:15 INFO - [mozharness: 2016-10-03 20:14:15.661330Z] Running populate-webroot step. 13:14:15 INFO - Running pre-action listener: _resource_record_pre_action 13:14:15 INFO - Running main action method: populate_webroot 13:14:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:14:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:14:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:14:15 INFO - '--tppagecycles', 13:14:15 INFO - '7'], 13:14:15 INFO - 'tests': ['tsvgm']}}, 13:14:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:14:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:14:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:14:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:14:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:14:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:14:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:14:15 INFO - 'talos_options': ['--disable-e10s'], 13:14:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:14:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:14:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:14:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:14:15 INFO - 'talos_options': ['--disable-e10s'], 13:14:15 INFO - 'tests': ['damp', 'tps']}, 13:14:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:14:15 INFO - 'tests': ['damp', 'tps']}, 13:14:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:14:15 INFO - 'tests': ['dromaeo_dom']}, 13:14:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:14:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:14:15 INFO - 'tests': ['basic_compositor_video']}, 13:14:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:14:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:14:15 INFO - 'tests': ['a11yr', 13:14:15 INFO - 'ts_paint', 13:14:15 INFO - 'tpaint', 13:14:15 INFO - 'sessionrestore', 13:14:15 INFO - 'sessionrestore_no_auto_restore', 13:14:15 INFO - 'tabpaint']}, 13:14:15 INFO - 'other-e10s': {'tests': ['a11yr', 13:14:15 INFO - 'ts_paint', 13:14:15 INFO - 'tpaint', 13:14:15 INFO - 'sessionrestore', 13:14:15 INFO - 'sessionrestore_no_auto_restore', 13:14:15 INFO - 'tabpaint']}, 13:14:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:14:15 INFO - 'ts_paint', 13:14:15 INFO - 'tpaint', 13:14:15 INFO - 'sessionrestore', 13:14:15 INFO - 'sessionrestore_no_auto_restore', 13:14:15 INFO - 'tabpaint']}, 13:14:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:14:15 INFO - 'ts_paint', 13:14:15 INFO - 'tpaint', 13:14:15 INFO - 'sessionrestore', 13:14:15 INFO - 'sessionrestore_no_auto_restore', 13:14:15 INFO - 'tabpaint']}, 13:14:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:14:15 INFO - 'tests': ['a11yr', 13:14:15 INFO - 'ts_paint', 13:14:15 INFO - 'tpaint', 13:14:15 INFO - 'sessionrestore', 13:14:15 INFO - 'sessionrestore_no_auto_restore', 13:14:15 INFO - 'tabpaint']}, 13:14:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:14:15 INFO - 'tests': ['a11yr', 13:14:15 INFO - 'ts_paint', 13:14:15 INFO - 'tpaint', 13:14:15 INFO - 'sessionrestore', 13:14:15 INFO - 'sessionrestore_no_auto_restore', 13:14:15 INFO - 'tabpaint']}, 13:14:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:14:15 INFO - 'tests': ['tsvgx', 13:14:15 INFO - 'tsvgr_opacity', 13:14:15 INFO - 'tart', 13:14:15 INFO - 'tscrollx', 13:14:15 INFO - 'cart']}, 13:14:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:14:15 INFO - 'tsvgr_opacity', 13:14:15 INFO - 'tart', 13:14:15 INFO - 'tscrollx', 13:14:15 INFO - 'cart']}, 13:14:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:14:15 INFO - 'talos_options': ['--disable-e10s'], 13:14:15 INFO - 'tests': ['tp5o']}, 13:14:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:14:15 INFO - 'tests': ['tp5o']}, 13:14:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:14:15 INFO - 'talos_options': ['--disable-e10s', 13:14:15 INFO - '--xperf_path', 13:14:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:14:15 INFO - 'tests': ['tp5n']}, 13:14:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:14:15 INFO - 'talos_options': ['--xperf_path', 13:14:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:14:15 INFO - 'tests': ['tp5n']}}, 13:14:15 INFO - 'talos.zip': {'path': '', 13:14:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:14:15 INFO - Running post-action listener: _resource_record_post_action 13:14:15 INFO - [mozharness: 2016-10-03 20:14:15.679006Z] Finished populate-webroot step (success) 13:14:15 INFO - [mozharness: 2016-10-03 20:14:15.679094Z] Running create-virtualenv step. 13:14:15 INFO - Running pre-action listener: _resource_record_pre_action 13:14:15 INFO - Running main action method: create_virtualenv 13:14:15 INFO - Creating virtualenv /builds/slave/test/build/venv 13:14:15 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 13:14:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:14:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:14:15 INFO - Using real prefix '/usr' 13:14:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:14:16 INFO - Installing distribute.............................................................................................................................................................................................done. 13:14:18 INFO - Installing pip.................done. 13:14:18 INFO - Return code: 0 13:14:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:14:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:14:18 INFO - Reading from file tmpfile_stdout 13:14:18 INFO - Output received: 13:14:18 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) 13:14:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:14:18 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')]} 13:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:14:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:18 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')]} 13:14:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:14:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:18 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 0x7f5188116f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d2f60>, '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 0x18d3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d41d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1475525218.857237-1488815137', '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 13:14:18 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 13:14:18 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 13:14:18 INFO - Using env: {'DISPLAY': ':0', 13:14:18 INFO - 'HOME': '/home/cltbld', 13:14:18 INFO - 'LANG': 'en_US.UTF-8', 13:14:18 INFO - 'LANGUAGE': 'en_US:en', 13:14:18 INFO - 'LOGNAME': 'cltbld', 13:14:18 INFO - 'MAIL': '/var/mail/cltbld', 13:14:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:14:18 INFO - 'MOZ_NO_REMOTE': '1', 13:14:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:14:18 INFO - 'NO_EM_RESTART': '1', 13:14:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:14:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:14:18 INFO - 'PWD': '/builds/slave/test', 13:14:18 INFO - 'SHELL': '/bin/bash', 13:14:18 INFO - 'SHLVL': '1', 13:14:18 INFO - 'TERM': 'linux', 13:14:18 INFO - 'TMOUT': '86400', 13:14:18 INFO - 'USER': 'cltbld', 13:14:18 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1475525218.857237-1488815137', 13:14:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:14:18 INFO - '_': '/tools/buildbot/bin/python'} 13:14:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:14:18 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 13:14:18 INFO - Cleaning up... 13:14:18 INFO - Return code: 0 13:14:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:14:18 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')]} 13:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:14:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:18 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')]} 13:14:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:14:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:18 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 0x7f5188116f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d2f60>, '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 0x18d3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d41d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1475525218.857237-1488815137', '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 13:14:18 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 13:14:18 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 13:14:18 INFO - Using env: {'DISPLAY': ':0', 13:14:18 INFO - 'HOME': '/home/cltbld', 13:14:18 INFO - 'LANG': 'en_US.UTF-8', 13:14:18 INFO - 'LANGUAGE': 'en_US:en', 13:14:18 INFO - 'LOGNAME': 'cltbld', 13:14:18 INFO - 'MAIL': '/var/mail/cltbld', 13:14:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:14:18 INFO - 'MOZ_NO_REMOTE': '1', 13:14:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:14:18 INFO - 'NO_EM_RESTART': '1', 13:14:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:14:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:14:18 INFO - 'PWD': '/builds/slave/test', 13:14:18 INFO - 'SHELL': '/bin/bash', 13:14:18 INFO - 'SHLVL': '1', 13:14:18 INFO - 'TERM': 'linux', 13:14:18 INFO - 'TMOUT': '86400', 13:14:18 INFO - 'USER': 'cltbld', 13:14:18 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1475525218.857237-1488815137', 13:14:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:14:18 INFO - '_': '/tools/buildbot/bin/python'} 13:14:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:14:18 INFO - Downloading/unpacking psutil>=3.1.1 13:14:18 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 13:14:18 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 13:14:18 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 13:14:18 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 13:14:18 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 13:14:18 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 13:14:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:14:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:14:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:14:20 INFO - Installing collected packages: psutil 13:14:20 INFO - Running setup.py install for psutil 13:14:20 INFO - building 'psutil._psutil_linux' extension 13:14:20 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 13:14:21 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 13:14:21 INFO - building 'psutil._psutil_posix' extension 13:14:21 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 13:14:21 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 13:14:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:14:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:14:21 INFO - Successfully installed psutil 13:14:21 INFO - Cleaning up... 13:14:21 INFO - Return code: 0 13:14:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:14:21 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')]} 13:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:14:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:21 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')]} 13:14:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:14:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:21 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 0x7f5188116f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d2f60>, '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 0x18d3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d41d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1475525218.857237-1488815137', '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 13:14:21 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 13:14:21 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 13:14:21 INFO - Using env: {'DISPLAY': ':0', 13:14:21 INFO - 'HOME': '/home/cltbld', 13:14:21 INFO - 'LANG': 'en_US.UTF-8', 13:14:21 INFO - 'LANGUAGE': 'en_US:en', 13:14:21 INFO - 'LOGNAME': 'cltbld', 13:14:21 INFO - 'MAIL': '/var/mail/cltbld', 13:14:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:14:21 INFO - 'MOZ_NO_REMOTE': '1', 13:14:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:14:21 INFO - 'NO_EM_RESTART': '1', 13:14:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:14:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:14:21 INFO - 'PWD': '/builds/slave/test', 13:14:21 INFO - 'SHELL': '/bin/bash', 13:14:21 INFO - 'SHLVL': '1', 13:14:21 INFO - 'TERM': 'linux', 13:14:21 INFO - 'TMOUT': '86400', 13:14:21 INFO - 'USER': 'cltbld', 13:14:21 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1475525218.857237-1488815137', 13:14:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:14:21 INFO - '_': '/tools/buildbot/bin/python'} 13:14:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:14:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:14:21 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 13:14:21 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 13:14:21 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 13:14:21 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 13:14:21 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 13:14:21 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 13:14:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:14:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:14:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:14:23 INFO - Installing collected packages: mozsystemmonitor 13:14:23 INFO - Running setup.py install for mozsystemmonitor 13:14:23 INFO - Successfully installed mozsystemmonitor 13:14:23 INFO - Cleaning up... 13:14:23 INFO - Return code: 0 13:14:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:14:23 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')]} 13:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:14:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:23 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')]} 13:14:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:14:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:23 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 0x7f5188116f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d2f60>, '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 0x18d3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d41d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1475525218.857237-1488815137', '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 13:14:23 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 13:14:23 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 13:14:23 INFO - Using env: {'DISPLAY': ':0', 13:14:23 INFO - 'HOME': '/home/cltbld', 13:14:23 INFO - 'LANG': 'en_US.UTF-8', 13:14:23 INFO - 'LANGUAGE': 'en_US:en', 13:14:23 INFO - 'LOGNAME': 'cltbld', 13:14:23 INFO - 'MAIL': '/var/mail/cltbld', 13:14:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:14:23 INFO - 'MOZ_NO_REMOTE': '1', 13:14:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:14:23 INFO - 'NO_EM_RESTART': '1', 13:14:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:14:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:14:23 INFO - 'PWD': '/builds/slave/test', 13:14:23 INFO - 'SHELL': '/bin/bash', 13:14:23 INFO - 'SHLVL': '1', 13:14:23 INFO - 'TERM': 'linux', 13:14:23 INFO - 'TMOUT': '86400', 13:14:23 INFO - 'USER': 'cltbld', 13:14:23 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1475525218.857237-1488815137', 13:14:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:14:23 INFO - '_': '/tools/buildbot/bin/python'} 13:14:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:14:23 INFO - Downloading/unpacking jsonschema==2.5.1 13:14:23 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 13:14:23 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 13:14:23 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 13:14:23 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 13:14:23 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 13:14:23 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 13:14:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:14:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:14:25 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 13:14:25 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 13:14:25 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 13:14:25 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 13:14:25 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 13:14:25 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 13:14:26 INFO - Downloading functools32-3.2.3-2.tar.gz 13:14:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:14:26 INFO - warning: no files found matching '*.txt' 13:14:26 INFO - no previously-included directories found matching 'build' 13:14:26 INFO - no previously-included directories found matching 'dist' 13:14:26 INFO - no previously-included directories found matching '.git*' 13:14:26 INFO - Installing collected packages: jsonschema, functools32 13:14:26 INFO - Running setup.py install for functools32 13:14:26 INFO - warning: no files found matching '*.txt' 13:14:26 INFO - no previously-included directories found matching 'build' 13:14:26 INFO - no previously-included directories found matching 'dist' 13:14:26 INFO - no previously-included directories found matching '.git*' 13:14:26 INFO - Successfully installed jsonschema functools32 13:14:26 INFO - Cleaning up... 13:14:26 INFO - Return code: 0 13:14:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:14: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')]} 13:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:14:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14: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')]} 13:14:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:14:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14: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', '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 0x7f5188116f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d2f60>, '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 0x18d3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d41d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1475525218.857237-1488815137', '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 13:14: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:14: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 functools32==3.2.3-2 13:14:26 INFO - Using env: {'DISPLAY': ':0', 13:14:26 INFO - 'HOME': '/home/cltbld', 13:14:26 INFO - 'LANG': 'en_US.UTF-8', 13:14:26 INFO - 'LANGUAGE': 'en_US:en', 13:14:26 INFO - 'LOGNAME': 'cltbld', 13:14:26 INFO - 'MAIL': '/var/mail/cltbld', 13:14:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:14:26 INFO - 'MOZ_NO_REMOTE': '1', 13:14:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:14:26 INFO - 'NO_EM_RESTART': '1', 13:14:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:14:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:14:26 INFO - 'PWD': '/builds/slave/test', 13:14:26 INFO - 'SHELL': '/bin/bash', 13:14:26 INFO - 'SHLVL': '1', 13:14:26 INFO - 'TERM': 'linux', 13:14:26 INFO - 'TMOUT': '86400', 13:14:26 INFO - 'USER': 'cltbld', 13:14:26 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1475525218.857237-1488815137', 13:14:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:14:26 INFO - '_': '/tools/buildbot/bin/python'} 13:14:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:14:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:14:26 INFO - Cleaning up... 13:14:26 INFO - Return code: 0 13:14:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:14: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')]} 13:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:14:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14: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')]} 13:14:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:14:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14: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', '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 0x7f5188116f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d2f60>, '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 0x18d3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d41d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1475525218.857237-1488815137', '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 13:14: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:14: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 blobuploader==1.2.4 13:14:26 INFO - Using env: {'DISPLAY': ':0', 13:14:26 INFO - 'HOME': '/home/cltbld', 13:14:26 INFO - 'LANG': 'en_US.UTF-8', 13:14:26 INFO - 'LANGUAGE': 'en_US:en', 13:14:26 INFO - 'LOGNAME': 'cltbld', 13:14:26 INFO - 'MAIL': '/var/mail/cltbld', 13:14:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:14:26 INFO - 'MOZ_NO_REMOTE': '1', 13:14:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:14:26 INFO - 'NO_EM_RESTART': '1', 13:14:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:14:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:14:26 INFO - 'PWD': '/builds/slave/test', 13:14:26 INFO - 'SHELL': '/bin/bash', 13:14:26 INFO - 'SHLVL': '1', 13:14:26 INFO - 'TERM': 'linux', 13:14:26 INFO - 'TMOUT': '86400', 13:14:26 INFO - 'USER': 'cltbld', 13:14:26 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1475525218.857237-1488815137', 13:14:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:14:26 INFO - '_': '/tools/buildbot/bin/python'} 13:14:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:14:26 INFO - Downloading/unpacking blobuploader==1.2.4 13:14:26 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 13:14:26 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 13:14:26 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 13:14:26 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 13:14:26 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 13:14:26 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 13:14:28 INFO - Downloading blobuploader-1.2.4.tar.gz 13:14:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:14:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:14:28 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 13:14:28 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 13:14:28 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 13:14:28 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 13:14:28 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 13:14:28 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 13:14:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:14:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:14:29 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 13:14:29 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 13:14:29 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 13:14:29 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 13:14:29 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 13:14:29 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 13:14:29 INFO - Downloading docopt-0.6.1.tar.gz 13:14:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:14:29 INFO - Installing collected packages: blobuploader, requests, docopt 13:14:29 INFO - Running setup.py install for blobuploader 13:14:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:14:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:14:29 INFO - Running setup.py install for requests 13:14:29 INFO - Running setup.py install for docopt 13:14:29 INFO - Successfully installed blobuploader requests docopt 13:14:29 INFO - Cleaning up... 13:14:30 INFO - Return code: 0 13:14:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:14:30 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')]} 13:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:14:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:30 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')]} 13:14:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:14:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:30 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 0x7f5188116f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d2f60>, '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 0x18d3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d41d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1475525218.857237-1488815137', '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 13:14:30 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 13:14:30 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 13:14:30 INFO - Using env: {'DISPLAY': ':0', 13:14:30 INFO - 'HOME': '/home/cltbld', 13:14:30 INFO - 'LANG': 'en_US.UTF-8', 13:14:30 INFO - 'LANGUAGE': 'en_US:en', 13:14:30 INFO - 'LOGNAME': 'cltbld', 13:14:30 INFO - 'MAIL': '/var/mail/cltbld', 13:14:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:14:30 INFO - 'MOZ_NO_REMOTE': '1', 13:14:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:14:30 INFO - 'NO_EM_RESTART': '1', 13:14:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:14:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:14:30 INFO - 'PWD': '/builds/slave/test', 13:14:30 INFO - 'SHELL': '/bin/bash', 13:14:30 INFO - 'SHLVL': '1', 13:14:30 INFO - 'TERM': 'linux', 13:14:30 INFO - 'TMOUT': '86400', 13:14:30 INFO - 'USER': 'cltbld', 13:14:30 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1475525218.857237-1488815137', 13:14:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:14:30 INFO - '_': '/tools/buildbot/bin/python'} 13:14:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:14:30 INFO - Running setup.py (path:/tmp/pip-2wlRvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:14:30 INFO - Running setup.py (path:/tmp/pip-KGFAW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:14:30 INFO - Running setup.py (path:/tmp/pip-OQIo9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:14:30 INFO - Running setup.py (path:/tmp/pip-pAALIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:14:30 INFO - Running setup.py (path:/tmp/pip-RElCHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:14:30 INFO - Running setup.py (path:/tmp/pip-FHsvJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:14:30 INFO - Running setup.py (path:/tmp/pip-dNyMLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:14:30 INFO - Running setup.py (path:/tmp/pip-Fi74U4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:14:30 INFO - Running setup.py (path:/tmp/pip-QGq_Qt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:14:30 INFO - Running setup.py (path:/tmp/pip-fgeDI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:14:30 INFO - Running setup.py (path:/tmp/pip-oRGcNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:14:31 INFO - Running setup.py (path:/tmp/pip-ulZ_uC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:14:31 INFO - Running setup.py (path:/tmp/pip-dFviyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:14:31 INFO - Running setup.py (path:/tmp/pip-Ratg7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:14:31 INFO - Running setup.py (path:/tmp/pip-qho9pu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:14:31 INFO - Running setup.py (path:/tmp/pip-ysH_W7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:14:31 INFO - Running setup.py (path:/tmp/pip-w40jyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:14:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:14:31 INFO - Running setup.py install for manifestparser 13:14:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:14:31 INFO - Running setup.py install for mozcrash 13:14:31 INFO - Running setup.py install for mozdebug 13:14:31 INFO - Running setup.py install for mozdevice 13:14:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:14:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:14:31 INFO - Running setup.py install for mozfile 13:14:32 INFO - Running setup.py install for mozhttpd 13:14:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:14:32 INFO - Running setup.py install for mozinfo 13:14:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:14:32 INFO - Running setup.py install for mozInstall 13:14:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:14:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:14:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:14:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:14:32 INFO - Running setup.py install for mozleak 13:14:32 INFO - Running setup.py install for mozlog 13:14:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:14:32 INFO - Running setup.py install for moznetwork 13:14:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:14:32 INFO - Running setup.py install for mozprocess 13:14:32 INFO - Running setup.py install for mozprofile 13:14:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:14:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:14:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:14:32 INFO - Running setup.py install for mozrunner 13:14:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:14:32 INFO - Running setup.py install for mozscreenshot 13:14:33 INFO - Running setup.py install for moztest 13:14:33 INFO - Running setup.py install for mozversion 13:14:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:14:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:14:33 INFO - Cleaning up... 13:14:33 INFO - Return code: 0 13:14:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:14:33 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')]} 13:14:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:14:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:33 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')]} 13:14:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:14:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:33 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 0x7f5188116f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d2f60>, '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 0x18d3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d41d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1475525218.857237-1488815137', '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 13:14:33 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 13:14:33 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 13:14:33 INFO - Using env: {'DISPLAY': ':0', 13:14:33 INFO - 'HOME': '/home/cltbld', 13:14:33 INFO - 'LANG': 'en_US.UTF-8', 13:14:33 INFO - 'LANGUAGE': 'en_US:en', 13:14:33 INFO - 'LOGNAME': 'cltbld', 13:14:33 INFO - 'MAIL': '/var/mail/cltbld', 13:14:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:14:33 INFO - 'MOZ_NO_REMOTE': '1', 13:14:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:14:33 INFO - 'NO_EM_RESTART': '1', 13:14:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:14:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:14:33 INFO - 'PWD': '/builds/slave/test', 13:14:33 INFO - 'SHELL': '/bin/bash', 13:14:33 INFO - 'SHLVL': '1', 13:14:33 INFO - 'TERM': 'linux', 13:14:33 INFO - 'TMOUT': '86400', 13:14:33 INFO - 'USER': 'cltbld', 13:14:33 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1475525218.857237-1488815137', 13:14:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:14:33 INFO - '_': '/tools/buildbot/bin/python'} 13:14:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:14:33 INFO - Running setup.py (path:/tmp/pip-1kJBSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:14:33 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)) 13:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:14:33 INFO - Running setup.py (path:/tmp/pip-VKf8xS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:14:33 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)) 13:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:14:33 INFO - Running setup.py (path:/tmp/pip-Iq70Uh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:14:33 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)) 13:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:14:33 INFO - Running setup.py (path:/tmp/pip-x2QJX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:14:33 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)) 13:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:14:33 INFO - Running setup.py (path:/tmp/pip-iTO5xL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:14:33 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)) 13:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:14:33 INFO - Running setup.py (path:/tmp/pip-TPnhuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:14:33 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)) 13:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:14:33 INFO - Running setup.py (path:/tmp/pip-QCFm__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:14:34 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)) 13:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:14:34 INFO - Running setup.py (path:/tmp/pip-dwctq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:14:34 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)) 13:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:14:34 INFO - Running setup.py (path:/tmp/pip-e4oEaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:14:34 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)) 13:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:14:34 INFO - Running setup.py (path:/tmp/pip-xfxpHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:14:34 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)) 13:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:14:34 INFO - Running setup.py (path:/tmp/pip-JXNUqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:14:34 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)) 13:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:14:34 INFO - Running setup.py (path:/tmp/pip-DPA3G2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:14:34 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)) 13:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:14:34 INFO - Running setup.py (path:/tmp/pip-RfTvom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:14:34 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)) 13:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:14:34 INFO - Running setup.py (path:/tmp/pip-Y835RJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:14:34 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)) 13:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:14:34 INFO - Running setup.py (path:/tmp/pip-RqcMRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:14:34 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)) 13:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:14:34 INFO - Running setup.py (path:/tmp/pip-_ELBIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:14:34 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)) 13:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:14:34 INFO - Running setup.py (path:/tmp/pip-Od_G4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:14:34 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)) 13:14:34 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)) 13:14:34 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)) 13:14:34 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)) 13:14:34 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)) 13:14:34 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)) 13:14:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:14: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 13:14: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 13:14: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 13:14: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 13:14: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 13:14: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 13:14:36 INFO - Downloading blessings-1.6.tar.gz 13:14:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:14:36 INFO - Installing collected packages: blessings 13:14:36 INFO - Running setup.py install for blessings 13:14:36 INFO - Successfully installed blessings 13:14:36 INFO - Cleaning up... 13:14:36 INFO - Return code: 0 13:14:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:14:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:14:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:14:37 INFO - Reading from file tmpfile_stdout 13:14:37 INFO - Current package versions: 13:14:37 INFO - argparse == 1.2.1 13:14:37 INFO - blessings == 1.6 13:14:37 INFO - blobuploader == 1.2.4 13:14:37 INFO - docopt == 0.6.1 13:14:37 INFO - functools32 == 3.2.3-2 13:14:37 INFO - jsonschema == 2.5.1 13:14:37 INFO - manifestparser == 1.1 13:14:37 INFO - mozInstall == 1.12 13:14:37 INFO - mozcrash == 0.17 13:14:37 INFO - mozdebug == 0.1 13:14:37 INFO - mozdevice == 0.48 13:14:37 INFO - mozfile == 1.2 13:14:37 INFO - mozhttpd == 0.7 13:14:37 INFO - mozinfo == 0.9 13:14:37 INFO - mozleak == 0.1 13:14:37 INFO - mozlog == 3.4 13:14:37 INFO - moznetwork == 0.27 13:14:37 INFO - mozprocess == 0.23 13:14:37 INFO - mozprofile == 0.28 13:14:37 INFO - mozrunner == 6.12 13:14:37 INFO - mozscreenshot == 0.1 13:14:37 INFO - mozsystemmonitor == 0.3 13:14:37 INFO - moztest == 0.7 13:14:37 INFO - mozversion == 1.4 13:14:37 INFO - psutil == 3.1.1 13:14:37 INFO - requests == 1.2.3 13:14:37 INFO - wsgiref == 0.1.2 13:14:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:14:37 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')]} 13:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:14:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:37 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')]} 13:14:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:14:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:37 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 0x7f5188116f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d2f60>, '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 0x18d3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d41d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1475525218.857237-1488815137', '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 13:14:37 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 13:14:37 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 13:14:37 INFO - Using env: {'DISPLAY': ':0', 13:14:37 INFO - 'HOME': '/home/cltbld', 13:14:37 INFO - 'LANG': 'en_US.UTF-8', 13:14:37 INFO - 'LANGUAGE': 'en_US:en', 13:14:37 INFO - 'LOGNAME': 'cltbld', 13:14:37 INFO - 'MAIL': '/var/mail/cltbld', 13:14:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:14:37 INFO - 'MOZ_NO_REMOTE': '1', 13:14:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:14:37 INFO - 'NO_EM_RESTART': '1', 13:14:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:14:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:14:37 INFO - 'PWD': '/builds/slave/test', 13:14:37 INFO - 'SHELL': '/bin/bash', 13:14:37 INFO - 'SHLVL': '1', 13:14:37 INFO - 'TERM': 'linux', 13:14:37 INFO - 'TMOUT': '86400', 13:14:37 INFO - 'USER': 'cltbld', 13:14:37 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1475525218.857237-1488815137', 13:14:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:14:37 INFO - '_': '/tools/buildbot/bin/python'} 13:14:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:14:37 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)) 13:14:37 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)) 13:14:37 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)) 13:14:37 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)) 13:14:37 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)) 13:14:37 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)) 13:14:37 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)) 13:14:37 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)) 13:14:37 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)) 13:14:37 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)) 13:14:37 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)) 13:14:37 INFO - Cleaning up... 13:14:37 INFO - Return code: 0 13:14:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:14:37 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')]} 13:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:14:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:37 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')]} 13:14:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:14:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:37 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 0x7f5188116f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d2f60>, '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 0x18d3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d41d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1475525218.857237-1488815137', '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 13:14:37 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 13:14:37 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 13:14:37 INFO - Using env: {'DISPLAY': ':0', 13:14:37 INFO - 'HOME': '/home/cltbld', 13:14:37 INFO - 'LANG': 'en_US.UTF-8', 13:14:37 INFO - 'LANGUAGE': 'en_US:en', 13:14:37 INFO - 'LOGNAME': 'cltbld', 13:14:37 INFO - 'MAIL': '/var/mail/cltbld', 13:14:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:14:37 INFO - 'MOZ_NO_REMOTE': '1', 13:14:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:14:37 INFO - 'NO_EM_RESTART': '1', 13:14:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:14:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:14:37 INFO - 'PWD': '/builds/slave/test', 13:14:37 INFO - 'SHELL': '/bin/bash', 13:14:37 INFO - 'SHLVL': '1', 13:14:37 INFO - 'TERM': 'linux', 13:14:37 INFO - 'TMOUT': '86400', 13:14:37 INFO - 'USER': 'cltbld', 13:14:37 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1475525218.857237-1488815137', 13:14:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:14:37 INFO - '_': '/tools/buildbot/bin/python'} 13:14:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:14:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:14:37 INFO - Cleaning up... 13:14:37 INFO - Return code: 0 13:14:37 INFO - Running post-action listener: _resource_record_post_action 13:14:37 INFO - Running post-action listener: _start_resource_monitoring 13:14:37 INFO - Starting resource monitoring. 13:14:37 INFO - [mozharness: 2016-10-03 20:14:37.609046Z] Finished create-virtualenv step (success) 13:14:37 INFO - [mozharness: 2016-10-03 20:14:37.609549Z] Running install step. 13:14:37 INFO - Running pre-action listener: _resource_record_pre_action 13:14:37 INFO - Running main action method: install 13:14:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:14:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:14:37 INFO - Reading from file tmpfile_stdout 13:14:37 INFO - Detecting whether we're running mozinstall >=1.0... 13:14:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:14:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:14:37 INFO - Reading from file tmpfile_stdout 13:14:37 INFO - Output received: 13:14:37 INFO - Usage: mozinstall [options] installer 13:14:37 INFO - Options: 13:14:37 INFO - -h, --help show this help message and exit 13:14:37 INFO - -d DEST, --destination=DEST 13:14:37 INFO - Directory to install application into. [default: 13:14:37 INFO - "/builds/slave/test"] 13:14:37 INFO - --app=APP Application being installed. [default: firefox] 13:14:37 INFO - mkdir: /builds/slave/test/build/application 13:14:37 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'] 13:14:37 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 13:14:54 INFO - Reading from file tmpfile_stdout 13:14:54 INFO - Output received: 13:14:54 INFO - /builds/slave/test/build/application/firefox/firefox 13:14:54 INFO - Running post-action listener: _resource_record_post_action 13:14:54 INFO - [mozharness: 2016-10-03 20:14:54.040940Z] Finished install step (success) 13:14:54 INFO - [mozharness: 2016-10-03 20:14:54.041183Z] Running run-tests step. 13:14:54 INFO - Running pre-action listener: _resource_record_pre_action 13:14:54 INFO - Running main action method: run_tests 13:14:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:14:54 INFO - Python 2.7.3 13:14:54 INFO - Return code: 0 13:14:54 INFO - grabbing minidump binary from tooltool 13:14:54 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')]} 13:14:54 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 0x18d2f60>, '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 0x18d3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d41d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:14:54 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 13:14:54 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 13:14:54 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 13:14:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:14:54 INFO - Return code: 0 13:14:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:14:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:14:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:14:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:14:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:14:54 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/YEbVpFKMTrWnjJnxGmPEFw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 13:14:54 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/YEbVpFKMTrWnjJnxGmPEFw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 13:14:54 INFO - Using env: {'DISPLAY': ':0', 13:14:54 INFO - 'HOME': '/home/cltbld', 13:14:54 INFO - 'LANG': 'en_US.UTF-8', 13:14:54 INFO - 'LANGUAGE': 'en_US:en', 13:14:54 INFO - 'LOGNAME': 'cltbld', 13:14:54 INFO - 'MAIL': '/var/mail/cltbld', 13:14:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:14:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:14:54 INFO - 'MOZ_NO_REMOTE': '1', 13:14:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:14:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:14:54 INFO - 'NO_EM_RESTART': '1', 13:14:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:14:54 INFO - 'PWD': '/builds/slave/test', 13:14:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:14:54 INFO - 'SHELL': '/bin/bash', 13:14:54 INFO - 'SHLVL': '1', 13:14:54 INFO - 'TERM': 'linux', 13:14:54 INFO - 'TMOUT': '86400', 13:14:54 INFO - 'USER': 'cltbld', 13:14:54 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1475525218.857237-1488815137', 13:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:14:54 INFO - '_': '/tools/buildbot/bin/python'} 13:14:54 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/YEbVpFKMTrWnjJnxGmPEFw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 13:14:54 INFO - mozversion application_buildid: 20161003122159 13:14:54 INFO - mozversion application_changeset: e8f4dc9c44cc79fcc35913c8d87063dfabbe127e 13:14:54 INFO - mozversion application_display_name: Nightly 13:14:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:14:54 INFO - mozversion application_name: Firefox 13:14:54 INFO - mozversion application_remotingname: firefox 13:14:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 13:14:54 INFO - mozversion application_vendor: Mozilla 13:14:54 INFO - mozversion application_version: 52.0a1 13:14:54 INFO - mozversion platform_buildid: 20161003122159 13:14:54 INFO - mozversion platform_changeset: e8f4dc9c44cc79fcc35913c8d87063dfabbe127e 13:14:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 13:14:54 INFO - mozversion platform_version: 52.0a1 13:14:54 INFO - using testdate: 1475525694 13:14:54 INFO - actual date: 1475525694 13:14:54 INFO - starting webserver on 'localhost:53600' 13:14:54 INFO - SUITE-START | Running 2 tests 13:14:54 INFO - TEST-START | dromaeo_css 13:14:54 INFO - operating with platform_type : linux_ 13:14:54 INFO - Initialising browser for dromaeo_css test... 13:14:54 INFO - TEST-INFO | started process 25813 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_2hYS2/profile http://localhost:53600/getInfo.html) 13:14:59 INFO - PROCESS | 25813 | __metrics Screen width/height:1600/1200 13:14:59 INFO - PROCESS | 25813 | colorDepth:24 13:14:59 INFO - PROCESS | 25813 | Browser inner width/height: 1024/697 13:14:59 INFO - PROCESS | 25813 | __metrics 13:15:00 INFO - PROCESS | 25813 | 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" 13:15:00 INFO - PROCESS | 25813 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:15:00 INFO - PROCESS | 25813 | console.error: PushService: 13:15:00 INFO - PROCESS | 25813 | stateChangeProcessEnqueue: Error transitioning state 13:15:00 INFO - PROCESS | 25813 | UnknownError 13:15:01 INFO - TEST-INFO | 25813: exit 0 13:15:01 INFO - Browser initialized. 13:15:01 INFO - Running cycle 1/1 for dromaeo_css test... 13:15:01 INFO - TEST-INFO | started process 25892 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_2hYS2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:15:13 INFO - PROCESS | 25892 | RSS: Main: 175493120 13:15:13 INFO - PROCESS | 25892 | 13:16:05 INFO - PROCESS | 25892 | 1475525765554 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] 13:18:17 INFO - PROCESS | 25892 | Cycle 1(1): loaded http://localhost:53600/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53600/tests/dromaeo/cssquery-ext.html) 13:18:19 INFO - PROCESS | 25892 | RSS: Main: 323903488 13:18:19 INFO - PROCESS | 25892 | 13:21:22 INFO - PROCESS | 25892 | Cycle 1(1): loaded http://localhost:53600/tests/dromaeo/cssquery-ext.html (next: http://localhost:53600/tests/dromaeo/cssquery-jquery.html) 13:21:22 INFO - PROCESS | 25892 | RSS: Main: 274812928 13:21:22 INFO - PROCESS | 25892 | 13:24:24 INFO - PROCESS | 25892 | Cycle 1(1): loaded http://localhost:53600/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53600/tests/dromaeo/cssquery-mootools.html) 13:24:25 INFO - PROCESS | 25892 | RSS: Main: 250519552 13:24:25 INFO - PROCESS | 25892 | 13:27:27 INFO - PROCESS | 25892 | Cycle 1(1): loaded http://localhost:53600/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53600/tests/dromaeo/cssquery-prototype.html) 13:27:28 INFO - PROCESS | 25892 | RSS: Main: 220479488 13:27:28 INFO - PROCESS | 25892 | 13:30:31 INFO - PROCESS | 25892 | Cycle 1(1): loaded http://localhost:53600/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53600/tests/dromaeo/cssquery-yui.html) 13:30:31 INFO - PROCESS | 25892 | RSS: Main: 220794880 13:30:31 INFO - PROCESS | 25892 | 13:33:34 INFO - PROCESS | 25892 | Cycle 1(1): loaded http://localhost:53600/tests/dromaeo/cssquery-yui.html (next: http://localhost:53600/tests/dromaeo/cssquery-dojo.html) 13:33:35 INFO - PROCESS | 25892 | RSS: Main: 317157376 13:33:35 INFO - PROCESS | 25892 | 13:33:35 INFO - PROCESS | 25892 | __start_tp_report 13:33:35 INFO - PROCESS | 25892 | _x_x_mozilla_page_load 13:33:35 INFO - PROCESS | 25892 | _x_x_mozilla_page_load_details 13:33:35 INFO - PROCESS | 25892 | |i|pagename|runs| 13:33:35 INFO - PROCESS | 25892 | |0;dojo.html;2561.129216066537;2595.286296268527;2608.165387076135;2632.4077082656404;2645.0742240215914;4562.885927851806;4633.675642705012;4634.374359461472;4649.0701859628125;4673.392458980332;4656.837010704626;4665.393498845154;4679.227927391985;4682.250839865622;4682.97658511707;4262.552431994634;4283.742975421469;4285.228658841407;4314.568543145691;4331.263685173512;4296.914061718764;4337.54455782143;4367.4322338096;4382.496012958519;4382.627476664487;4317.740935543861;4338;4341.565843415649;4390.956090439086;4402.625776808959;95.40276907735773;4283.721558098745;4284.164587905359;4318.352247162935;4339.848105316299;4263.97868010661;4267.615914567673;4277.401163837066;4278.721883077621;4335.739855608674;4675.228587283094;4680.81276748933;4688.601468875149;4724.196886529264;4747;4781.6891902026255;4846.5880400166025;4990.201567749143;5002.824901128443;5005.499450055002;4949.307097006422;4982.427020892607;4984.401871775374;4988.6009119270375;4990.975045124787;4595.586397224199;4628.722276663378;4635.837745678885;4640.071985602893;4698.671093023456;4927.728974906415;5024.899502010013;5081.060003899291;5086.847394578169;5162.561182299547;4833.275008748646;4840.273958906122;4840.806367745251;4845.927311090337;4851.054044461367;4921.50784921505;4928.6303527235605;4932.556069953722;4990.775415106329;4994.076095922193;4941.777620007108;4944.307796908436;4944.3572335596145;4945.653804233741;5000.099982003201;4933.950660493421;4934.407871055425;4941.036497882878;4942.2092465206115;4992.500749925051;4041.4341992121126;4080.7143499955314;4089.1003979124544;4133.04939863833;4200.180964711913;3621.9637803622154;3639.94540081899;3676.17286110623;3700.8519659213866;3716.7955762433326;4307.569243075667;4322.740635561876;4337.566243375637;4342.32693932441;4397.2304846651705;4852.660313778072;4990.476000020019;5001.149804533238;5004.799808007711;5066.670666406671;4257.212415703105;4346.673999450054;4370.8907277317685;4382.211201983673;4431;4493;4496.055828276033;4499.640028797754;4506.909861802746;4556.498785133633;4786.497417771084;4789.712617242976;4803.18345881201;4803.735794531334;4861.124997500484;4834.0331933614125;4910.680805747615;4970.6023518117745;5030.0694371541385;5033.446320904771;4788.401449818773;4789.329493870791;4790.4251489821445;4816.20532612115;4855.927161092657;4931.753412329297;4937.136001199704;4942.184539550934;4942.950570494249;5004.4495105537635;4808.831690890802;4851.708897466164;4852.514748525119;5002.299678045149;5016.799328026838;4729;4751.263554149113;4764.809407623795;4773.37946067009;4777.3072904429355;4723.338732577373;4788.066327066189;4795.904081918272;4840.273958906192;4853.854384368475;4698.788554514987;4710.9764451177525;4716.504766999416;4725.173094708481;4785.330053792542;4719.693219940693;4784;4812.398450193726;4818.301346304836;4822.373091498082;4643.86068417948;4764.642651801059;4790.0419916016235;4805.37530121096;4860.222364421676 13:33:35 INFO - PROCESS | 25892 | |1;ext.html;565.3978512883776;568.232885604434;577.2005772005773;577.8526475748683;581.0963951056106;27973.720262797367;37895.62104378956;39223.215535689305;39243.60756392435;42801.57198428015;39438;39891.40162897559;39931.20137597254;40002;40075.79962100193;7731.304182623563;7881.133075361706;7885.645145968445;7890;7890.644920978541;7705.768826935201;7807.570583617927;7810.570418626973;7815.101263354702;7816.452848300622;7797.922020779804;7831.41264405169;7840.607969601526;7842.254985776371;7844.019497562805;7758.224177582225;7810.1408845027;7816.452848300622;7819.0226221722;7823.452358334919;7682.500637458603;7754.457187996843;7756.495827771233;7757.107932587768;7761.534307941485;36890.99071176495;37295.202859785626;37317.81341093277;37341.06647333811;37394;2817.3520090379125;2835.1211124551455;3012.8493575321145;3166.224275052627;3225.3226822367333;27305.72694273052;28105;28274.858625706944;28595.142145735663;29615.11154665342;3435.415979283503;3437.295354452331;3548.9112772180642;3552.1474846036767;3561.8041007744564;244205;245086;245496;245693.99999999822;246104;31368.37263254722;32292.192695182337;50419.24371134436;50629.493705063214;50672.74663626658;32732.509012364833;33080.83459582687;33163.83418082942;33197.83401082979;33212.66787332144;12145.210561313486;12262.693432664077;12275.447604857804;12279;12280.140390172603;9372.43765374066;9396.718098457057;9398.248140148771;9429.3399462037;9452.810943781085;7842.803929901684;7882.172371900982;7941.126476087626;7947.880781788278;7993.68025278994;2763.5025695375025;2796.45469133517;2804.57931310301;2822.4778415993105;2835.75896048834;743.8177646476539;808.8544062068767;889.479654402182;955.8996305387973;997.2420960070399;24439.877800610884;25675;25711.61432578513;26069.087581934542;26837.86581067082;926.7405126564573;931.9860202096974;943.528235882059;949.9952500237455;972.7713987212999;13110.475580976654;13705;14007.509737159151;14088.506902258578;14193;390745;391208;391632;391730;394032;49322;49595.75202124038;49894;49911.75044124756;49921;1009.5810238750983;1067.0503252105632;1108.2740804773048;1142.7942970265265;1155.7919574476675;24687.38281542976;27315.317117071438;27440.588391174548;27756.722432776223;28002.2999425016;41586.792066039474;41815.37276940788;41824.3726344099;42215.57784422117;42256.15487690167;236730;237296;237424;238150;238178;20651.793482065586;24873;24963;25353.11264105821;26841.597376038986;38554.22891542097;38771;38782;38959.2208155841;39058.6094139055;33705.83147084249;33795.32409351848;34113.48829767605;34170.65829341774;34365;32954.670453296116;32971.340573188885;33773.49339759856;33947.66052339544;34658.65341346655;32873.342533149684;33456;33542.664573353955;33945.66054339425;33976.32047359089;29457.705422945495;30054;30569.847150764104;30816.53775193329;31307.53038704467;22949.655755164018;23023.65464518067;23278.88360558254;23311.300660980196;23315.533689326458 13:33:35 INFO - PROCESS | 25892 | |2;jquery.html;349.942259527178;357.74242545367326;365.95242618459594;366.14505130520223;393.9684825213983;11466.604506296222;12178.391080445976;15500.379984800622;16176.919115404437;17312.653746925054;15977.84022159778;16154.111523866182;16504;16818;17162.39931602394;4004.5394779600283;4975.7512124393725;4983.202687569989;5222.503862133091;5224.7387630618505;5014.373203349582;5097.413797413308;5146.562542183919;5170.1986192140275;5173.042987047389;4842.346283251751;5114.232865070232;5119.12974794284;5122.129238029544;5133.255677926699;5055;5127.7948882044675;5129.820456284031;5133.486651334874;5133.614978876599;4409.250427427313;4590.219662657323;4597.7011494252765;4598.379218805452;4601.562851529099;20105.8994705027;20182.293619723237;20237.696434553494;20336.491587710425;20459.28392506255;1818.8999605021718;1843.6681397348473;1882.6987681970818;1905.0855589317066;2051.066764622093;9370.953145234298;11771.058315334752;12472.875271247261;12728.745425091447;13945.233012184326;1720.6902757503644;1728.498735366742;1806.7380229866596;1821.3625231169117;1847.3441928115594;60861;69360;69693.30306696969;71593;71594.28405715928;9687.17658998979;9826.4104153751;9847.60609575609;9886.80226395468;9934.701958941243;13279.203247805162;13422.39599218018;13423.664408389868;13429;13451.865481345258;5381.67709937405;5478.369987451414;5510.834674959758;5745.913811292834;7105.786826395217;6407.615543067431;6509.934900651027;6555.01674748782;6608.669566521655;6621.33786621334;4136.772477513706;4238.788060596958;4263.70154089217;4326.935095973563;4353.325234588644;1741.4514427955153;1820.1081470079566;1825.616620509708;1864.3008871673123;1865.4123950955407;709.3474003916409;836.6611522333465;884.6726711116928;893.0043002052664;906.3112034853427;15356.155411452477;16144.950578212378;16462.63740108872;16599;17219.569510762332;824.114077366833;832.3965125284242;854.5513605357237;855.4311382930406;909.8635204719345;9066.410683305565;9475.90524094764;9519.476428796344;9588.520573971273;9757.804843903225;358614;367021;369311;379037;379511;73593.2640673597;75072;75894;76973.23026769773;77762.6111869437;854.5812551849549;885.703289398046;904.0462312260628;912.4890061565544;915.7756349694234;15602.297896594453;15603.843961560238;16311.347546098497;16448.259828307517;16475;36939;37012.259754805295;37601;38048.195180482835;38050.238995219384;45146.77426612846;46460.53539464562;47337.763311183226;49028.75485622549;55069.724651376484;6666.699998499982;6883.27725588806;6896.448284137156;6909.44724422035;7200.49596528238;8917.598708058284;11089.611863584736;11850.525978960744;12367.443465044274;12517;10385.117265032557;10542.472876355998;10652.786944261226;10812.783744324912;10894.891051089704;9971.700848974542;10530.789384212427;10634.41510716918;10647.467626618483;10788.352698838095;10200.4389758564;10595.894041059799;10701.357918524913;10925.508352124014;10938.12495000414;6876.449884009367;6888.138982627172;7022.087128673445;7241.674124664508;7295.4528410368375;7849.599280952646;9743.171830394213;10624.244023115834;10724.624638137628;10857.185711071543 13:33:35 INFO - PROCESS | 25892 | |3;mootools.html;1208.7642909632614;1353.242184376749;1379.910305830121;1450.187894778924;1667.0831042926388;6680;7212.531185472941;7261.5280006799585;7574.318311351977;7578.280063393969;7611.238876112386;7694.846103077935;7698.730544430946;7700.614969251543;7707.460477766558;2119.2688522459725;2141.379000089972;2145.6566949288117;2148.4414052346424;2150.354893531942;2082.6771850363143;2115.7355330583678;2118.4492032071616;2118.6821976703463;2119.2264823339524;2044.1108117968656;2060.0420804325986;2071.989640051798;2077.9168833246727;2126.5002724359765;2107.1676687708346;2111.1133324003877;2111.514351699118;2111.609352269835;2111.7571479279773;2037.2054898589563;2061.80412860778;2069.658506346451;2071.326818783901;2072.875627462357;7442.47902646815;7553.055868016498;7580.317771400545;7626.389888808882;7630.7329243476215;4297.484301883794;4442.2004039272915;4447.177272204653;4498.617617502517;4500.077484115748;2641.168032069892;2775.597538356947;2794.287456698529;2800.943981120366;2807.8736456859288;819.2258315891485;834.4367551902502;841.7096101844854;845.2984023260678;854.5513605357175;10147.391156530557;10236.744081398025;10300.433476158732;10310.587576496931;10383.06552410279;3701.1117331840164;3799.658030777188;3938.468306778548;3950.683945284428;3973.165635216579;8160.143184965612;8160.551169685606;8160.591970401456;8171.7548473545885;8179.795505112301;4452.398926144993;4453.910921781546;4458.799354029076;4461.5092339842595;4463.352813841975;3434.00413879977;3539.3806083935724;3970.960290397059;4131.607497287753;4132.173565286955;3250.106220789302;3255.7558183135884;3291.2759192977505;3383.2725963917383;3402.1324562236473;1011.6256984915628;1015.4516561056946;1018.1549314069305;1022.1414012229762;1037.7820657661975;698.3051863395954;728.5446595877577;766.5477368352699;775.0583041604477;801.4790386248985;4952.108620448282;5057.544820966131;5095;5193.76628051731;5393.703346315911;367.81609195402297;369.7541135145152;372.54363404828865;373.7458528200795;374.2664377819504;3265.6562482856057;3575.4279315309946;3640.0717816956508;3648.3432982062955;3662.6520480554304;8847.203751662253;9336.859947100798;9365.62537498506;9387.483688397204;9389.530523473799;9314.208292295096;9332.113449222448;9335;9335.066493350747;9335.439873607605;7037.824054398681;7079.8938015930835;7094.077769889881;7115.217326094125;7117.145942486831;5090.363704536933;5098;5172.172452407597;5183.533481986639;5201.921971170511;8243.505389676639;8376.916230837858;8450.577471126297;8579.699710510102;8633.223009929137;8414.453060551044;8563.529005904486;8674.609642565974;8695.869561956702;8700.60847261862;6228.159198508143;6257.405546473078;6291.339409361951;6341.0805433212845;6399.8720025598295;7158.141023077264;7202.927970720226;7219.422446204186;7220.927790722026;7221.783346499614;6308.779192728232;6400.967995159995;6484.935150648433;6549.639769812706;6572;6414.262359828679;6440.935590644033;6456.612603243821;6473.287938326686;6546.869062618816;5982.341942386421;6093.542984276109;6103.7253323601435;6110.205673262448;6116.938830611637;4412.51462339136;4425.690201685851;4479.552044795494;4572.565606267399;4597.310403439511;4347.695661303678;4559.430071241095;4563.38394316763;4586.564276393738;4597.908041839211 13:33:35 INFO - PROCESS | 25892 | |4;prototype.html;288.3799830364717;292.4385180453529;298.267752667202;298.69980669427207;302.9121554749123;4817.855464336067;4844.781984810683;4851.830185943492;4854.6844455110395;4862.878428039292;4738.881527961794;4773.355596994405;4776.37907072081;4781.784819683114;4804.375431193948;3748.7760525947733;3768.547774267092;3780.527434070741;3783.05423644089;3794.4118661607495;3597.982010089946;3796.126890815114;3812.5234345706785;3827.4067519534515;3850.903727406809;3724.1992971511118;3744.6629803317696;3763.416670416076;3775.8300876460626;3782.6784723298415;3710.424884142962;3727.9627203727887;3740.1584643455276;3745.569259535134;3749.625037496256;3066.693330666938;3178.0624715708923;3306.96693033069;3311.4867195584484;3314.254292784128;4467.441569803775;4633.6061434778085;4675.555822196886;4681.578657920803;4685.641164062452;4217.797927590622;4245.702800803945;4247.893802654928;4254.532001479834;4256.574342565749;4718.0328032753205;4767.737774422405;5002.2246551784165;5008.924866127011;5055.140626093573;3300.174956260935;3526.188976535386;3535.1692352297446;3547.255076433952;3549.467579863041;5170.819021334235;5185;5190.792368305263;5198.532132108091;5201;3624.347617428888;3627.383344831385;3642.7814331139684;3644.7084233261276;3648.7263455240964;3488.877889273914;3660.9633903660624;3671.1189314564313;3693.6306369362846;3694.168812017275;4153.982274342806;4154.231467178582;4162.2716024696165;4166.145940082276;4175.937360939588;4913.1893237616105;4932.753362331869;4933.383327084114;4946.8763280918265;4949;1217.4643157010887;1242.6023672424737;1244.8733895824294;1249.6001279590444;1261.7602655495427;787.896316834043;790.6481615680967;811.9634616442274;811.975640730779;818.7953011747063;4022.365350695299;4045.474088368493;4049.493813273341;4053.594640535982;4065.207284579538;4539.205639013159;4556.908861822812;4564.726116433025;4592.954070459253;4616;3985;4002.959970400317;4009.195861862174;4038.818253178614;4047.838086476567;2342.6837376953895;2412.843165194257;2432;2432.2338463383976;2448.5347783920997;4359.433273674402;4365.3670217818235;4371.453568303962;4679.368285281444;4848.660593758474;5102.749826292582;5208.8437346879655;5224.373075230997;5244.9737751310995;5263.026340127089;4937.950620493821;4939;4943.456219815817;4960.25500746941;4972.154733695353;4971.179755340473;5121.92317115251;5160.612954028388;5164.690118592896;5186.2479940409185;5019.146745053276;5022.949770502249;5035.672681275705;5045.99080183972;5047.924281135713;4923.483034281349;4933.827316043921;4934.741640881696;4937.061958227925;4943.505649435027;3464.2378676691087;3583.802890841029;3585.498030275816;3600.351936651428;3629;5144;5144.614153938544;5145.228215767665;5154.7938082476285;5163.328767260232;5032.899342013213;5034.899302014012;5046.7224302662235;5049.469805670352;5051.116054690341;4823.009733964964;5010.448850626355;5024.799008039784;5046.9747651261505;5057.494250574913;4896.506565497415;4907.214845624683;4907.509249075064;4911.312416261798;4921;4973.502649735142;5006.674566153189;5024.648274620888;5045.167547354792;5046;4638.234691276037;4927.852164435073;4941.431735350337;4949.232868905326;4973.68723543554 13:33:35 INFO - PROCESS | 25892 | |5;yui.html;580.9477147056764;596.7523477756731;636.7962252079334;647.889858724017;647.977320793772;11484;12162.878371216275;12177.269363838175;12476.25142491449;12503.937480312608;10470.790584188311;12430.751384972295;12559.937200314009;12565.434555445005;12569.183003104792;744.7207297263526;771.9652615632282;773.1920143450108;773.5320131320555;774.0015380159615;770.8304173081913;773.3581127664025;773.3928865840288;774.543019618425;775.1666958020123;816.0330008939396;817.5952903312839;818.9631466583988;819.2422009641087;819.6188772220916;808.1716240853114;808.8301456694131;808.9514629122242;809.0776514773163;809.1706001348606;587.6356658871484;588.7792077970761;590.1531302580768;590.2562770908643;596.8179705189915;12478.251304921643;12502.249865008038;12517.49930002808;12525.311107889063;12530.060245481625;12286.569970051005;12663.936680316632;12694.365281735969;12991.870081299161;13357.797798198111;9654.871555903734;9709.563069661812;9755.268354873413;9888.159506441962;9931.957144499796;3168.7940283881476;3183.2519357950864;3189.888353907602;3195.792273502215;3247.675232476757;60854.39145608576;61731.07403388953;61775.69112154455;61940.99999999955;62784.68607656978;9682.128608425275;10162.593496260066;10188.592456301812;10218.897811021794;10233.181345492343;16333.754993675104;17208.483745487654;17365.565860853327;17461.912690436468;17488.387906423468;6373.745050198033;6382.074599183093;6430.0676401921455;6491.9350806492275;6628.370304821035;3589;3593.568771747407;3608.242269123461;3640.417533194729;3672.137047793766;2651.098626466972;2764.682061562946;2771.2240572639694;2777.472280266743;2777.7361150690654;462.65301024231826;477.38894215403644;483.78471580147203;493.73091665042637;520.6589683757145;528.9365276166884;548.4707257496535;550.9063459211943;561.3964987638224;570.6490508337425;7567.432442566829;7969.481983671043;8024.438289319692;8079.151689072681;8091.554964476893;505.6637336171405;519.9688018718889;522.8457605006456;561.2703485468874;562.3982338897422;3590.2101537661674;3762.206202448254;3801.50580424543;3954.762714237155;4083.1425400666194;86166;86562.56718716366;101113;105019.47490262499;105318;75063.24936750672;78323;78598.21401786023;79108;80387.59806200932;46951.29573056475;57669.711651441474;58746.41253587495;59526;69479.30520694729;7537.321641052332;7551.867219916837;7576.583287919218;7684.760309610561;7824.726134585262;40746.79626601848;41076;41564;42638.786806067015;44294;55108.72445637746;55117;61309.693451534244;61786.69106654438;63976;11014.44927753625;11254.409116081388;11429.714257143638;12343.69140771488;12425.565105221274;11883.762324753283;12282.877171228174;12613.432395542039;12658.936705316415;13449;11397.487113080097;11494.19540632181;11528.250663706833;12017.399130043637;12161.574344897886;11168;11635.41822908868;11670.416479175838;12217.08371872131;12449.564265250672;10490.213234007328;11094.44527773592;11302.152338574804;11465.598704045318;11842.111841612086;9315.813683726423;9473;9559.474228917476;9681.322307438411;10628.681139565826;8560.91439085601;9063.818723625622;9365.765855853386;9392.295577831826;9767.462789546644 13:33:35 INFO - PROCESS | 25892 | __end_tp_report 13:33:35 INFO - PROCESS | 25892 | __start_cc_report 13:33:35 INFO - PROCESS | 25892 | _x_x_mozilla_cycle_collect,1454 13:33:35 INFO - PROCESS | 25892 | __end_cc_report 13:33:35 INFO - PROCESS | 25892 | __startTimestamp1475526815029__endTimestamp 13:33:35 INFO - PROCESS | 25892 | 13:33:35 INFO - PROCESS | 25892 | ------- Summary: start ------- 13:33:35 INFO - PROCESS | 25892 | Number of tests: 6 13:33:35 INFO - PROCESS | 25892 | 13:33:35 INFO - PROCESS | 25892 | [#0] dojo.html Cycles:165 Average:4573.54 Median:4751.26 stddev:587.42 (12.4%) stddev-sans-first:567.61 13:33:35 INFO - PROCESS | 25892 | Values: 2561.1 2595.3 2608.2 2632.4 2645.1 4562.9 4633.7 4634.4 4649.1 4673.4 4656.8 4665.4 4679.2 4682.3 4683.0 4262.6 4283.7 4285.2 4314.6 4331.3 4296.9 4337.5 4367.4 4382.5 4382.6 4317.7 4338.0 4341.6 4391.0 4402.6 95.4 4283.7 4284.2 4318.4 4339.8 4264.0 4267.6 4277.4 4278.7 4335.7 4675.2 4680.8 4688.6 4724.2 4747.0 4781.7 4846.6 4990.2 5002.8 5005.5 4949.3 4982.4 4984.4 4988.6 4991.0 4595.6 4628.7 4635.8 4640.1 4698.7 4927.7 5024.9 5081.1 5086.8 5162.6 4833.3 4840.3 4840.8 4845.9 4851.1 4921.5 4928.6 4932.6 4990.8 4994.1 4941.8 4944.3 4944.4 4945.7 5000.1 4934.0 4934.4 4941.0 4942.2 4992.5 4041.4 4080.7 4089.1 4133.0 4200.2 3622.0 3639.9 3676.2 3700.9 3716.8 4307.6 4322.7 4337.6 4342.3 4397.2 4852.7 4990.5 5001.1 5004.8 5066.7 4257.2 4346.7 4370.9 4382.2 4431.0 4493.0 4496.1 4499.6 4506.9 4556.5 4786.5 4789.7 4803.2 4803.7 4861.1 4834.0 4910.7 4970.6 5030.1 5033.4 4788.4 4789.3 4790.4 4816.2 4855.9 4931.8 4937.1 4942.2 4943.0 5004.4 4808.8 4851.7 4852.5 5002.3 5016.8 4729.0 4751.3 4764.8 4773.4 4777.3 4723.3 4788.1 4795.9 4840.3 4853.9 4698.8 4711.0 4716.5 4725.2 4785.3 4719.7 4784.0 4812.4 4818.3 4822.4 4643.9 4764.6 4790.0 4805.4 4860.2 13:33:35 INFO - PROCESS | 25892 | 13:33:35 INFO - PROCESS | 25892 | [#1] ext.html Cycles:180 Average:43104.08 Median:3550.53 stddev:79275.09 (2232.8%) stddev-sans-first:79433.14 13:33:35 INFO - PROCESS | 25892 | Values: 565.4 568.2 577.2 577.9 581.1 27973.7 37895.6 39223.2 39243.6 42801.6 39438.0 39891.4 39931.2 40002.0 40075.8 7731.3 7881.1 7885.6 7890.0 7890.6 7705.8 7807.6 7810.6 7815.1 7816.5 7797.9 7831.4 7840.6 7842.3 7844.0 7758.2 7810.1 7816.5 7819.0 7823.5 7682.5 7754.5 7756.5 7757.1 7761.5 36891.0 37295.2 37317.8 37341.1 37394.0 2817.4 2835.1 3012.8 3166.2 3225.3 27305.7 28105.0 28274.9 28595.1 29615.1 3435.4 3437.3 3548.9 3552.1 3561.8 244205.0 245086.0 245496.0 245694.0 246104.0 31368.4 32292.2 50419.2 50629.5 50672.7 32732.5 33080.8 33163.8 33197.8 33212.7 12145.2 12262.7 12275.4 12279.0 12280.1 9372.4 9396.7 9398.2 9429.3 9452.8 7842.8 7882.2 7941.1 7947.9 7993.7 2763.5 2796.5 2804.6 2822.5 2835.8 743.8 808.9 889.5 955.9 997.2 24439.9 25675.0 25711.6 26069.1 26837.9 926.7 932.0 943.5 950.0 972.8 13110.5 13705.0 14007.5 14088.5 14193.0 390745.0 391208.0 391632.0 391730.0 394032.0 49322.0 49595.8 49894.0 49911.8 49921.0 1009.6 1067.1 1108.3 1142.8 1155.8 24687.4 27315.3 27440.6 27756.7 28002.3 41586.8 41815.4 41824.4 42215.6 42256.2 236730.0 237296.0 237424.0 238150.0 238178.0 20651.8 24873.0 24963.0 25353.1 26841.6 38554.2 38771.0 38782.0 38959.2 39058.6 33705.8 33795.3 34113.5 34170.7 34365.0 32954.7 32971.3 33773.5 33947.7 34658.7 32873.3 33456.0 33542.7 33945.7 33976.3 29457.7 30054.0 30569.8 30816.5 31307.5 22949.7 23023.7 23278.9 23311.3 23315.5 13:33:35 INFO - PROCESS | 25892 | 13:33:35 INFO - PROCESS | 25892 | [#2] jquery.html Cycles:180 Average:23523.50 Median:4381.29 stddev:61331.24 (1399.8%) stddev-sans-first:61478.61 13:33:35 INFO - PROCESS | 25892 | Values: 349.9 357.7 366.0 366.1 394.0 11466.6 12178.4 15500.4 16176.9 17312.7 15977.8 16154.1 16504.0 16818.0 17162.4 4004.5 4975.8 4983.2 5222.5 5224.7 5014.4 5097.4 5146.6 5170.2 5173.0 4842.3 5114.2 5119.1 5122.1 5133.3 5055.0 5127.8 5129.8 5133.5 5133.6 4409.3 4590.2 4597.7 4598.4 4601.6 20105.9 20182.3 20237.7 20336.5 20459.3 1818.9 1843.7 1882.7 1905.1 2051.1 9371.0 11771.1 12472.9 12728.7 13945.2 1720.7 1728.5 1806.7 1821.4 1847.3 60861.0 69360.0 69693.3 71593.0 71594.3 9687.2 9826.4 9847.6 9886.8 9934.7 13279.2 13422.4 13423.7 13429.0 13451.9 5381.7 5478.4 5510.8 5745.9 7105.8 6407.6 6509.9 6555.0 6608.7 6621.3 4136.8 4238.8 4263.7 4326.9 4353.3 1741.5 1820.1 1825.6 1864.3 1865.4 709.3 836.7 884.7 893.0 906.3 15356.2 16145.0 16462.6 16599.0 17219.6 824.1 832.4 854.6 855.4 909.9 9066.4 9475.9 9519.5 9588.5 9757.8 358614.0 367021.0 369311.0 379037.0 379511.0 73593.3 75072.0 75894.0 76973.2 77762.6 854.6 885.7 904.0 912.5 915.8 15602.3 15603.8 16311.3 16448.3 16475.0 36939.0 37012.3 37601.0 38048.2 38050.2 45146.8 46460.5 47337.8 49028.8 55069.7 6666.7 6883.3 6896.4 6909.4 7200.5 8917.6 11089.6 11850.5 12367.4 12517.0 10385.1 10542.5 10652.8 10812.8 10894.9 9971.7 10530.8 10634.4 10647.5 10788.4 10200.4 10595.9 10701.4 10925.5 10938.1 6876.4 6888.1 7022.1 7241.7 7295.5 7849.6 9743.2 10624.2 10724.6 10857.2 13:33:35 INFO - PROCESS | 25892 | 13:33:35 INFO - PROCESS | 25892 | [#3] mootools.html Cycles:180 Average:4907.95 Median:5004.83 stddev:2778.32 (55.5%) stddev-sans-first:2772.20 13:33:35 INFO - PROCESS | 25892 | Values: 1208.8 1353.2 1379.9 1450.2 1667.1 6680.0 7212.5 7261.5 7574.3 7578.3 7611.2 7694.8 7698.7 7700.6 7707.5 2119.3 2141.4 2145.7 2148.4 2150.4 2082.7 2115.7 2118.4 2118.7 2119.2 2044.1 2060.0 2072.0 2077.9 2126.5 2107.2 2111.1 2111.5 2111.6 2111.8 2037.2 2061.8 2069.7 2071.3 2072.9 7442.5 7553.1 7580.3 7626.4 7630.7 4297.5 4442.2 4447.2 4498.6 4500.1 2641.2 2775.6 2794.3 2800.9 2807.9 819.2 834.4 841.7 845.3 854.6 10147.4 10236.7 10300.4 10310.6 10383.1 3701.1 3799.7 3938.5 3950.7 3973.2 8160.1 8160.6 8160.6 8171.8 8179.8 4452.4 4453.9 4458.8 4461.5 4463.4 3434.0 3539.4 3971.0 4131.6 4132.2 3250.1 3255.8 3291.3 3383.3 3402.1 1011.6 1015.5 1018.2 1022.1 1037.8 698.3 728.5 766.5 775.1 801.5 4952.1 5057.5 5095.0 5193.8 5393.7 367.8 369.8 372.5 373.7 374.3 3265.7 3575.4 3640.1 3648.3 3662.7 8847.2 9336.9 9365.6 9387.5 9389.5 9314.2 9332.1 9335.0 9335.1 9335.4 7037.8 7079.9 7094.1 7115.2 7117.1 5090.4 5098.0 5172.2 5183.5 5201.9 8243.5 8376.9 8450.6 8579.7 8633.2 8414.5 8563.5 8674.6 8695.9 8700.6 6228.2 6257.4 6291.3 6341.1 6399.9 7158.1 7202.9 7219.4 7220.9 7221.8 6308.8 6401.0 6484.9 6549.6 6572.0 6414.3 6440.9 6456.6 6473.3 6546.9 5982.3 6093.5 6103.7 6110.2 6116.9 4412.5 4425.7 4479.6 4572.6 4597.3 4347.7 4559.4 4563.4 4586.6 4597.9 13:33:35 INFO - PROCESS | 25892 | 13:33:35 INFO - PROCESS | 25892 | [#4] prototype.html Cycles:180 Average:4096.81 Median:4656.90 stddev:1211.00 (26.0%) stddev-sans-first:1180.17 13:33:35 INFO - PROCESS | 25892 | Values: 288.4 292.4 298.3 298.7 302.9 4817.9 4844.8 4851.8 4854.7 4862.9 4738.9 4773.4 4776.4 4781.8 4804.4 3748.8 3768.5 3780.5 3783.1 3794.4 3598.0 3796.1 3812.5 3827.4 3850.9 3724.2 3744.7 3763.4 3775.8 3782.7 3710.4 3728.0 3740.2 3745.6 3749.6 3066.7 3178.1 3307.0 3311.5 3314.3 4467.4 4633.6 4675.6 4681.6 4685.6 4217.8 4245.7 4247.9 4254.5 4256.6 4718.0 4767.7 5002.2 5008.9 5055.1 3300.2 3526.2 3535.2 3547.3 3549.5 5170.8 5185.0 5190.8 5198.5 5201.0 3624.3 3627.4 3642.8 3644.7 3648.7 3488.9 3661.0 3671.1 3693.6 3694.2 4154.0 4154.2 4162.3 4166.1 4175.9 4913.2 4932.8 4933.4 4946.9 4949.0 1217.5 1242.6 1244.9 1249.6 1261.8 787.9 790.6 812.0 812.0 818.8 4022.4 4045.5 4049.5 4053.6 4065.2 4539.2 4556.9 4564.7 4593.0 4616.0 3985.0 4003.0 4009.2 4038.8 4047.8 2342.7 2412.8 2432.0 2432.2 2448.5 4359.4 4365.4 4371.5 4679.4 4848.7 5102.7 5208.8 5224.4 5245.0 5263.0 4938.0 4939.0 4943.5 4960.3 4972.2 4971.2 5121.9 5160.6 5164.7 5186.2 5019.1 5022.9 5035.7 5046.0 5047.9 4923.5 4933.8 4934.7 4937.1 4943.5 3464.2 3583.8 3585.5 3600.4 3629.0 5144.0 5144.6 5145.2 5154.8 5163.3 5032.9 5034.9 5046.7 5049.5 5051.1 4823.0 5010.4 5024.8 5047.0 5057.5 4896.5 4907.2 4907.5 4911.3 4921.0 4973.5 5006.7 5024.6 5045.2 5046.0 4638.2 4927.9 4941.4 4949.2 4973.7 13:33:35 INFO - PROCESS | 25892 | 13:33:35 INFO - PROCESS | 25892 | [#5] yui.html Cycles:180 Average:16750.43 Median:521.75 stddev:23811.95 (4563.8%) stddev-sans-first:23847.79 13:33:35 INFO - PROCESS | 25892 | Values: 580.9 596.8 636.8 647.9 648.0 11484.0 12162.9 12177.3 12476.3 12503.9 10470.8 12430.8 12559.9 12565.4 12569.2 744.7 772.0 773.2 773.5 774.0 770.8 773.4 773.4 774.5 775.2 816.0 817.6 819.0 819.2 819.6 808.2 808.8 809.0 809.1 809.2 587.6 588.8 590.2 590.3 596.8 12478.3 12502.2 12517.5 12525.3 12530.1 12286.6 12663.9 12694.4 12991.9 13357.8 9654.9 9709.6 9755.3 9888.2 9932.0 3168.8 3183.3 3189.9 3195.8 3247.7 60854.4 61731.1 61775.7 61941.0 62784.7 9682.1 10162.6 10188.6 10218.9 10233.2 16333.8 17208.5 17365.6 17461.9 17488.4 6373.7 6382.1 6430.1 6491.9 6628.4 3589.0 3593.6 3608.2 3640.4 3672.1 2651.1 2764.7 2771.2 2777.5 2777.7 462.7 477.4 483.8 493.7 520.7 528.9 548.5 550.9 561.4 570.6 7567.4 7969.5 8024.4 8079.2 8091.6 505.7 520.0 522.8 561.3 562.4 3590.2 3762.2 3801.5 3954.8 4083.1 86166.0 86562.6 101113.0 105019.5 105318.0 75063.2 78323.0 78598.2 79108.0 80387.6 46951.3 57669.7 58746.4 59526.0 69479.3 7537.3 7551.9 7576.6 7684.8 7824.7 40746.8 41076.0 41564.0 42638.8 44294.0 55108.7 55117.0 61309.7 61786.7 63976.0 11014.4 11254.4 11429.7 12343.7 12425.6 11883.8 12282.9 12613.4 12658.9 13449.0 11397.5 11494.2 11528.3 12017.4 12161.6 11168.0 11635.4 11670.4 12217.1 12449.6 10490.2 11094.4 11302.2 11465.6 11842.1 9315.8 9473.0 9559.5 9681.3 10628.7 8560.9 9063.8 9365.8 9392.3 9767.5 13:33:35 INFO - PROCESS | 25892 | -------- Summary: end -------- 13:33:35 INFO - PROCESS | 25892 | 13:33:36 INFO - TEST-INFO | 25892: exit 0 13:33:36 INFO - TEST-OK | dromaeo_css | took 1121728ms 13:33:36 INFO - TEST-START | kraken 13:33:36 INFO - operating with platform_type : linux_ 13:33:36 INFO - Initialising browser for kraken test... 13:33:36 INFO - TEST-INFO | started process 26200 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa8kn5F/profile http://localhost:53600/getInfo.html) 13:33:40 INFO - PROCESS | 26200 | __metrics Screen width/height:1600/1200 13:33:40 INFO - PROCESS | 26200 | colorDepth:24 13:33:40 INFO - PROCESS | 26200 | Browser inner width/height: 1024/697 13:33:40 INFO - PROCESS | 26200 | __metrics 13:33:41 INFO - PROCESS | 26200 | 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" 13:33:41 INFO - PROCESS | 26200 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:33:42 INFO - PROCESS | 26200 | console.error: PushService: 13:33:42 INFO - PROCESS | 26200 | stateChangeProcessEnqueue: Error transitioning state 13:33:42 INFO - PROCESS | 26200 | UnknownError 13:33:42 INFO - TEST-INFO | 26200: exit 0 13:33:42 INFO - Browser initialized. 13:33:42 INFO - Running cycle 1/1 for kraken test... 13:33:42 INFO - TEST-INFO | started process 26281 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa8kn5F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:33:55 INFO - PROCESS | 26281 | RSS: Main: 175161344 13:33:55 INFO - PROCESS | 26281 | 13:33:57 INFO - PROCESS | 26281 | Cycle 1(1): loaded http://localhost:53600/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53600/tests/kraken/driver.html?testName=audio-beat-detection) 13:33:58 INFO - PROCESS | 26281 | RSS: Main: 242962432 13:33:58 INFO - PROCESS | 26281 | 13:34:01 INFO - PROCESS | 26281 | Cycle 1(1): loaded http://localhost:53600/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53600/tests/kraken/driver.html?testName=audio-dft) 13:34:02 INFO - PROCESS | 26281 | RSS: Main: 218443776 13:34:02 INFO - PROCESS | 26281 | 13:34:05 INFO - PROCESS | 26281 | Cycle 1(1): loaded http://localhost:53600/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53600/tests/kraken/driver.html?testName=audio-fft) 13:34:06 INFO - PROCESS | 26281 | RSS: Main: 301592576 13:34:06 INFO - PROCESS | 26281 | 13:34:08 INFO - PROCESS | 26281 | Cycle 1(1): loaded http://localhost:53600/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53600/tests/kraken/driver.html?testName=audio-oscillator) 13:34:08 INFO - PROCESS | 26281 | RSS: Main: 212013056 13:34:08 INFO - PROCESS | 26281 | 13:34:11 INFO - PROCESS | 26281 | Cycle 1(1): loaded http://localhost:53600/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53600/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:34:11 INFO - PROCESS | 26281 | RSS: Main: 214585344 13:34:11 INFO - PROCESS | 26281 | 13:34:15 INFO - PROCESS | 26281 | Cycle 1(1): loaded http://localhost:53600/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53600/tests/kraken/driver.html?testName=imaging-darkroom) 13:34:15 INFO - PROCESS | 26281 | RSS: Main: 250937344 13:34:15 INFO - PROCESS | 26281 | 13:34:19 INFO - PROCESS | 26281 | Cycle 1(1): loaded http://localhost:53600/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53600/tests/kraken/driver.html?testName=imaging-desaturate) 13:34:19 INFO - PROCESS | 26281 | RSS: Main: 245166080 13:34:19 INFO - PROCESS | 26281 | 13:34:22 INFO - PROCESS | 26281 | Cycle 1(1): loaded http://localhost:53600/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53600/tests/kraken/driver.html?testName=json-parse-financial) 13:34:23 INFO - PROCESS | 26281 | RSS: Main: 247939072 13:34:23 INFO - PROCESS | 26281 | 13:34:25 INFO - PROCESS | 26281 | Cycle 1(1): loaded http://localhost:53600/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53600/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:34:25 INFO - PROCESS | 26281 | RSS: Main: 211288064 13:34:25 INFO - PROCESS | 26281 | 13:34:27 INFO - PROCESS | 26281 | Cycle 1(1): loaded http://localhost:53600/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53600/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:34:28 INFO - PROCESS | 26281 | RSS: Main: 218886144 13:34:28 INFO - PROCESS | 26281 | 13:34:30 INFO - PROCESS | 26281 | Cycle 1(1): loaded http://localhost:53600/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53600/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:34:30 INFO - PROCESS | 26281 | RSS: Main: 228073472 13:34:30 INFO - PROCESS | 26281 | 13:34:33 INFO - PROCESS | 26281 | Cycle 1(1): loaded http://localhost:53600/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53600/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:34:34 INFO - PROCESS | 26281 | RSS: Main: 236404736 13:34:34 INFO - PROCESS | 26281 | 13:34:37 INFO - PROCESS | 26281 | Cycle 1(1): loaded http://localhost:53600/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53600/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:34:38 INFO - PROCESS | 26281 | RSS: Main: 233541632 13:34:38 INFO - PROCESS | 26281 | 13:34:39 INFO - PROCESS | 26281 | Cycle 1(1): loaded http://localhost:53600/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53600/tests/kraken/driver.html?testName=ai-astar) 13:34:40 INFO - PROCESS | 26281 | RSS: Main: 284667904 13:34:40 INFO - PROCESS | 26281 | 13:34:40 INFO - PROCESS | 26281 | __start_tp_report 13:34:40 INFO - PROCESS | 26281 | _x_x_mozilla_page_load 13:34:40 INFO - PROCESS | 26281 | _x_x_mozilla_page_load_details 13:34:40 INFO - PROCESS | 26281 | |i|pagename|runs| 13:34:40 INFO - PROCESS | 26281 | |0;ai-astar;112;114;115;115;113;115;114;114;117;113 13:34:40 INFO - PROCESS | 26281 | |1;audio-beat-detection;151;127;129;166;133;128;129;129;160;134 13:34:40 INFO - PROCESS | 26281 | |2;audio-dft;162;162;163;162;163;163;161;159;161;160 13:34:40 INFO - PROCESS | 26281 | |3;audio-fft;78;77;76;123;77;78;77;77;102;76 13:34:40 INFO - PROCESS | 26281 | |4;audio-oscillator;83;83;117;84;84;84;107;84;85;114 13:34:40 INFO - PROCESS | 26281 | |5;imaging-gaussian-blur;118;117;117;117;117;117;116;117;117;117 13:34:40 INFO - PROCESS | 26281 | |6;imaging-darkroom;147;148;146;146;146;149;147;147;145;146 13:34:40 INFO - PROCESS | 26281 | |7;imaging-desaturate;96;96;96;95;95;95;95;95;95;95 13:34:40 INFO - PROCESS | 26281 | |8;json-parse-financial;66;65;65;66;66;65;67;66;71;65 13:34:40 INFO - PROCESS | 26281 | |9;json-stringify-tinderbox;67;66;66;68;66;65;66;66;66;67 13:34:40 INFO - PROCESS | 26281 | |10;stanford-crypto-aes;84;83;83;83;84;83;83;83;83;83 13:34:40 INFO - PROCESS | 26281 | |11;stanford-crypto-ccm;139;140;139;141;138;138;146;146;179;142 13:34:40 INFO - PROCESS | 26281 | |12;stanford-crypto-pbkdf2;175;174;178;179;178;174;173;172;179;176 13:34:40 INFO - PROCESS | 26281 | |13;stanford-crypto-sha256-iterative;71;73;69;69;73;80;69;74;70;69 13:34:40 INFO - PROCESS | 26281 | __end_tp_report 13:34:40 INFO - PROCESS | 26281 | __start_cc_report 13:34:40 INFO - PROCESS | 26281 | _x_x_mozilla_cycle_collect,1927 13:34:40 INFO - PROCESS | 26281 | __end_cc_report 13:34:40 INFO - PROCESS | 26281 | __startTimestamp1475526880182__endTimestamp 13:34:40 INFO - PROCESS | 26281 | 13:34:40 INFO - PROCESS | 26281 | ------- Summary: start ------- 13:34:40 INFO - PROCESS | 26281 | Number of tests: 14 13:34:40 INFO - PROCESS | 26281 | 13:34:40 INFO - PROCESS | 26281 | [#0] ai-astar Cycles:10 Average:114.20 Median:114.50 stddev:1.40 (1.2%) stddev-sans-first:1.24 13:34:40 INFO - PROCESS | 26281 | Values: 112.0 114.0 115.0 115.0 113.0 115.0 114.0 114.0 117.0 113.0 13:34:40 INFO - PROCESS | 26281 | 13:34:40 INFO - PROCESS | 26281 | [#1] audio-beat-detection Cycles:10 Average:138.60 Median:133.50 stddev:14.68 (11.0%) stddev-sans-first:14.86 13:34:40 INFO - PROCESS | 26281 | Values: 151.0 127.0 129.0 166.0 133.0 128.0 129.0 129.0 160.0 134.0 13:34:40 INFO - PROCESS | 26281 | 13:34:40 INFO - PROCESS | 26281 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.35 (0.8%) stddev-sans-first:1.42 13:34:40 INFO - PROCESS | 26281 | Values: 162.0 162.0 163.0 162.0 163.0 163.0 161.0 159.0 161.0 160.0 13:34:40 INFO - PROCESS | 26281 | 13:34:40 INFO - PROCESS | 26281 | [#3] audio-fft Cycles:10 Average:84.10 Median:77.00 stddev:15.78 (20.5%) stddev-sans-first:16.58 13:34:40 INFO - PROCESS | 26281 | Values: 78.0 77.0 76.0 123.0 77.0 78.0 77.0 77.0 102.0 76.0 13:34:40 INFO - PROCESS | 26281 | 13:34:40 INFO - PROCESS | 26281 | [#4] audio-oscillator Cycles:10 Average:92.50 Median:84.00 stddev:14.14 (16.8%) stddev-sans-first:14.57 13:34:40 INFO - PROCESS | 26281 | Values: 83.0 83.0 117.0 84.0 84.0 84.0 107.0 84.0 85.0 114.0 13:34:40 INFO - PROCESS | 26281 | 13:34:40 INFO - PROCESS | 26281 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 13:34:40 INFO - PROCESS | 26281 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 13:34:40 INFO - PROCESS | 26281 | 13:34:40 INFO - PROCESS | 26281 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:1.16 (0.8%) stddev-sans-first:1.22 13:34:40 INFO - PROCESS | 26281 | Values: 147.0 148.0 146.0 146.0 146.0 149.0 147.0 147.0 145.0 146.0 13:34:40 INFO - PROCESS | 26281 | 13:34:40 INFO - PROCESS | 26281 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 13:34:40 INFO - PROCESS | 26281 | Values: 96.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 13:34:40 INFO - PROCESS | 26281 | 13:34:40 INFO - PROCESS | 26281 | [#8] json-parse-financial Cycles:10 Average:66.20 Median:66.00 stddev:1.81 (2.7%) stddev-sans-first:1.92 13:34:40 INFO - PROCESS | 26281 | Values: 66.0 65.0 65.0 66.0 66.0 65.0 67.0 66.0 71.0 65.0 13:34:40 INFO - PROCESS | 26281 | 13:34:40 INFO - PROCESS | 26281 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.00 stddev:0.82 (1.2%) stddev-sans-first:0.83 13:34:40 INFO - PROCESS | 26281 | Values: 67.0 66.0 66.0 68.0 66.0 65.0 66.0 66.0 66.0 67.0 13:34:40 INFO - PROCESS | 26281 | 13:34:40 INFO - PROCESS | 26281 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:83.00 stddev:0.42 (0.5%) stddev-sans-first:0.33 13:34:40 INFO - PROCESS | 26281 | Values: 84.0 83.0 83.0 83.0 84.0 83.0 83.0 83.0 83.0 83.0 13:34:40 INFO - PROCESS | 26281 | 13:34:40 INFO - PROCESS | 26281 | [#11] stanford-crypto-ccm Cycles:10 Average:144.80 Median:141.50 stddev:12.37 (8.7%) stddev-sans-first:12.94 13:34:40 INFO - PROCESS | 26281 | Values: 139.0 140.0 139.0 141.0 138.0 138.0 146.0 146.0 179.0 142.0 13:34:40 INFO - PROCESS | 26281 | 13:34:40 INFO - PROCESS | 26281 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.80 Median:177.00 stddev:2.57 (1.5%) stddev-sans-first:2.71 13:34:40 INFO - PROCESS | 26281 | Values: 175.0 174.0 178.0 179.0 178.0 174.0 173.0 172.0 179.0 176.0 13:34:40 INFO - PROCESS | 26281 | 13:34:40 INFO - PROCESS | 26281 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.70 Median:72.00 stddev:3.50 (4.9%) stddev-sans-first:3.70 13:34:40 INFO - PROCESS | 26281 | Values: 71.0 73.0 69.0 69.0 73.0 80.0 69.0 74.0 70.0 69.0 13:34:40 INFO - PROCESS | 26281 | -------- Summary: end -------- 13:34:40 INFO - PROCESS | 26281 | 13:34:41 INFO - TEST-INFO | 26281: exit 0 13:34:41 INFO - TEST-OK | kraken | took 65519ms 13:34:41 INFO - SUITE-END | took 1187s 13:34:41 INFO - Completed test suite (00:19:47) 13:34:41 INFO - javascript benchmark 13:34:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2561.129216066537, 2595.286296268527, 2608.165387076135, 2632.4077082656404, 2645.0742240215914, 4562.885927851806, 4633.675642705012, 4634.374359461472, 4649.0701859628125, 4673.392458980332, 4656.837010704626, 4665.393498845154, 4679.227927391985, 4682.250839865622, 4682.97658511707, 4262.552431994634, 4283.742975421469, 4285.228658841407, 4314.568543145691, 4331.263685173512, 4296.914061718764, 4337.54455782143, 4367.4322338096, 4382.496012958519, 4382.627476664487, 4317.740935543861, 4338.0, 4341.565843415649, 4390.956090439086, 4402.625776808959, 95.40276907735773, 4283.721558098745, 4284.164587905359, 4318.352247162935, 4339.848105316299, 4263.97868010661, 4267.615914567673, 4277.401163837066, 4278.721883077621, 4335.739855608674, 4675.228587283094, 4680.81276748933, 4688.601468875149, 4724.196886529264, 4747.0, 4781.6891902026255, 4846.5880400166025, 4990.201567749143, 5002.824901128443, 5005.499450055002, 4949.307097006422, 4982.427020892607, 4984.401871775374, 4988.6009119270375, 4990.975045124787, 4595.586397224199, 4628.722276663378, 4635.837745678885, 4640.071985602893, 4698.671093023456, 4927.728974906415, 5024.899502010013, 5081.060003899291, 5086.847394578169, 5162.561182299547, 4833.275008748646, 4840.273958906122, 4840.806367745251, 4845.927311090337, 4851.054044461367, 4921.50784921505, 4928.6303527235605, 4932.556069953722, 4990.775415106329, 4994.076095922193, 4941.777620007108, 4944.307796908436, 4944.3572335596145, 4945.653804233741, 5000.099982003201, 4933.950660493421, 4934.407871055425, 4941.036497882878, 4942.2092465206115, 4992.500749925051, 4041.4341992121126, 4080.7143499955314, 4089.1003979124544, 4133.04939863833, 4200.180964711913, 3621.9637803622154, 3639.94540081899, 3676.17286110623, 3700.8519659213866, 3716.7955762433326, 4307.569243075667, 4322.740635561876, 4337.566243375637, 4342.32693932441, 4397.2304846651705, 4852.660313778072, 4990.476000020019, 5001.149804533238, 5004.799808007711, 5066.670666406671, 4257.212415703105, 4346.673999450054, 4370.8907277317685, 4382.211201983673, 4431.0, 4493.0, 4496.055828276033, 4499.640028797754, 4506.909861802746, 4556.498785133633, 4786.497417771084, 4789.712617242976, 4803.18345881201, 4803.735794531334, 4861.124997500484, 4834.0331933614125, 4910.680805747615, 4970.6023518117745, 5030.0694371541385, 5033.446320904771, 4788.401449818773, 4789.329493870791, 4790.4251489821445, 4816.20532612115, 4855.927161092657, 4931.753412329297, 4937.136001199704, 4942.184539550934, 4942.950570494249, 5004.4495105537635, 4808.831690890802, 4851.708897466164, 4852.514748525119, 5002.299678045149, 5016.799328026838, 4729.0, 4751.263554149113, 4764.809407623795, 4773.37946067009, 4777.3072904429355, 4723.338732577373, 4788.066327066189, 4795.904081918272, 4840.273958906192, 4853.854384368475, 4698.788554514987, 4710.9764451177525, 4716.504766999416, 4725.173094708481, 4785.330053792542, 4719.693219940693, 4784.0, 4812.398450193726, 4818.301346304836, 4822.373091498082, 4643.86068417948, 4764.642651801059, 4790.0419916016235, 4805.37530121096, 4860.222364421676], "value": 4539.305350729491, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.3978512883776, 568.232885604434, 577.2005772005773, 577.8526475748683, 581.0963951056106, 27973.720262797367, 37895.62104378956, 39223.215535689305, 39243.60756392435, 42801.57198428015, 39438.0, 39891.40162897559, 39931.20137597254, 40002.0, 40075.79962100193, 7731.304182623563, 7881.133075361706, 7885.645145968445, 7890.0, 7890.644920978541, 7705.768826935201, 7807.570583617927, 7810.570418626973, 7815.101263354702, 7816.452848300622, 7797.922020779804, 7831.41264405169, 7840.607969601526, 7842.254985776371, 7844.019497562805, 7758.224177582225, 7810.1408845027, 7816.452848300622, 7819.0226221722, 7823.452358334919, 7682.500637458603, 7754.457187996843, 7756.495827771233, 7757.107932587768, 7761.534307941485, 36890.99071176495, 37295.202859785626, 37317.81341093277, 37341.06647333811, 37394.0, 2817.3520090379125, 2835.1211124551455, 3012.8493575321145, 3166.224275052627, 3225.3226822367333, 27305.72694273052, 28105.0, 28274.858625706944, 28595.142145735663, 29615.11154665342, 3435.415979283503, 3437.295354452331, 3548.9112772180642, 3552.1474846036767, 3561.8041007744564, 244205.0, 245086.0, 245496.0, 245693.99999999822, 246104.0, 31368.37263254722, 32292.192695182337, 50419.24371134436, 50629.493705063214, 50672.74663626658, 32732.509012364833, 33080.83459582687, 33163.83418082942, 33197.83401082979, 33212.66787332144, 12145.210561313486, 12262.693432664077, 12275.447604857804, 12279.0, 12280.140390172603, 9372.43765374066, 9396.718098457057, 9398.248140148771, 9429.3399462037, 9452.810943781085, 7842.803929901684, 7882.172371900982, 7941.126476087626, 7947.880781788278, 7993.68025278994, 2763.5025695375025, 2796.45469133517, 2804.57931310301, 2822.4778415993105, 2835.75896048834, 743.8177646476539, 808.8544062068767, 889.479654402182, 955.8996305387973, 997.2420960070399, 24439.877800610884, 25675.0, 25711.61432578513, 26069.087581934542, 26837.86581067082, 926.7405126564573, 931.9860202096974, 943.528235882059, 949.9952500237455, 972.7713987212999, 13110.475580976654, 13705.0, 14007.509737159151, 14088.506902258578, 14193.0, 390745.0, 391208.0, 391632.0, 391730.0, 394032.0, 49322.0, 49595.75202124038, 49894.0, 49911.75044124756, 49921.0, 1009.5810238750983, 1067.0503252105632, 1108.2740804773048, 1142.7942970265265, 1155.7919574476675, 24687.38281542976, 27315.317117071438, 27440.588391174548, 27756.722432776223, 28002.2999425016, 41586.792066039474, 41815.37276940788, 41824.3726344099, 42215.57784422117, 42256.15487690167, 236730.0, 237296.0, 237424.0, 238150.0, 238178.0, 20651.793482065586, 24873.0, 24963.0, 25353.11264105821, 26841.597376038986, 38554.22891542097, 38771.0, 38782.0, 38959.2208155841, 39058.6094139055, 33705.83147084249, 33795.32409351848, 34113.48829767605, 34170.65829341774, 34365.0, 32954.670453296116, 32971.340573188885, 33773.49339759856, 33947.66052339544, 34658.65341346655, 32873.342533149684, 33456.0, 33542.664573353955, 33945.66054339425, 33976.32047359089, 29457.705422945495, 30054.0, 30569.847150764104, 30816.53775193329, 31307.53038704467, 22949.655755164018, 23023.65464518067, 23278.88360558254, 23311.300660980196, 23315.533689326458], "value": 15687.179844768549, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.942259527178, 357.74242545367326, 365.95242618459594, 366.14505130520223, 393.9684825213983, 11466.604506296222, 12178.391080445976, 15500.379984800622, 16176.919115404437, 17312.653746925054, 15977.84022159778, 16154.111523866182, 16504.0, 16818.0, 17162.39931602394, 4004.5394779600283, 4975.7512124393725, 4983.202687569989, 5222.503862133091, 5224.7387630618505, 5014.373203349582, 5097.413797413308, 5146.562542183919, 5170.1986192140275, 5173.042987047389, 4842.346283251751, 5114.232865070232, 5119.12974794284, 5122.129238029544, 5133.255677926699, 5055.0, 5127.7948882044675, 5129.820456284031, 5133.486651334874, 5133.614978876599, 4409.250427427313, 4590.219662657323, 4597.7011494252765, 4598.379218805452, 4601.562851529099, 20105.8994705027, 20182.293619723237, 20237.696434553494, 20336.491587710425, 20459.28392506255, 1818.8999605021718, 1843.6681397348473, 1882.6987681970818, 1905.0855589317066, 2051.066764622093, 9370.953145234298, 11771.058315334752, 12472.875271247261, 12728.745425091447, 13945.233012184326, 1720.6902757503644, 1728.498735366742, 1806.7380229866596, 1821.3625231169117, 1847.3441928115594, 60861.0, 69360.0, 69693.30306696969, 71593.0, 71594.28405715928, 9687.17658998979, 9826.4104153751, 9847.60609575609, 9886.80226395468, 9934.701958941243, 13279.203247805162, 13422.39599218018, 13423.664408389868, 13429.0, 13451.865481345258, 5381.67709937405, 5478.369987451414, 5510.834674959758, 5745.913811292834, 7105.786826395217, 6407.615543067431, 6509.934900651027, 6555.01674748782, 6608.669566521655, 6621.33786621334, 4136.772477513706, 4238.788060596958, 4263.70154089217, 4326.935095973563, 4353.325234588644, 1741.4514427955153, 1820.1081470079566, 1825.616620509708, 1864.3008871673123, 1865.4123950955407, 709.3474003916409, 836.6611522333465, 884.6726711116928, 893.0043002052664, 906.3112034853427, 15356.155411452477, 16144.950578212378, 16462.63740108872, 16599.0, 17219.569510762332, 824.114077366833, 832.3965125284242, 854.5513605357237, 855.4311382930406, 909.8635204719345, 9066.410683305565, 9475.90524094764, 9519.476428796344, 9588.520573971273, 9757.804843903225, 358614.0, 367021.0, 369311.0, 379037.0, 379511.0, 73593.2640673597, 75072.0, 75894.0, 76973.23026769773, 77762.6111869437, 854.5812551849549, 885.703289398046, 904.0462312260628, 912.4890061565544, 915.7756349694234, 15602.297896594453, 15603.843961560238, 16311.347546098497, 16448.259828307517, 16475.0, 36939.0, 37012.259754805295, 37601.0, 38048.195180482835, 38050.238995219384, 45146.77426612846, 46460.53539464562, 47337.763311183226, 49028.75485622549, 55069.724651376484, 6666.699998499982, 6883.27725588806, 6896.448284137156, 6909.44724422035, 7200.49596528238, 8917.598708058284, 11089.611863584736, 11850.525978960744, 12367.443465044274, 12517.0, 10385.117265032557, 10542.472876355998, 10652.786944261226, 10812.783744324912, 10894.891051089704, 9971.700848974542, 10530.789384212427, 10634.41510716918, 10647.467626618483, 10788.352698838095, 10200.4389758564, 10595.894041059799, 10701.357918524913, 10925.508352124014, 10938.12495000414, 6876.449884009367, 6888.138982627172, 7022.087128673445, 7241.674124664508, 7295.4528410368375, 7849.599280952646, 9743.171830394213, 10624.244023115834, 10724.624638137628, 10857.185711071543], "value": 7996.082269588817, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1208.7642909632614, 1353.242184376749, 1379.910305830121, 1450.187894778924, 1667.0831042926388, 6680.0, 7212.531185472941, 7261.5280006799585, 7574.318311351977, 7578.280063393969, 7611.238876112386, 7694.846103077935, 7698.730544430946, 7700.614969251543, 7707.460477766558, 2119.2688522459725, 2141.379000089972, 2145.6566949288117, 2148.4414052346424, 2150.354893531942, 2082.6771850363143, 2115.7355330583678, 2118.4492032071616, 2118.6821976703463, 2119.2264823339524, 2044.1108117968656, 2060.0420804325986, 2071.989640051798, 2077.9168833246727, 2126.5002724359765, 2107.1676687708346, 2111.1133324003877, 2111.514351699118, 2111.609352269835, 2111.7571479279773, 2037.2054898589563, 2061.80412860778, 2069.658506346451, 2071.326818783901, 2072.875627462357, 7442.47902646815, 7553.055868016498, 7580.317771400545, 7626.389888808882, 7630.7329243476215, 4297.484301883794, 4442.2004039272915, 4447.177272204653, 4498.617617502517, 4500.077484115748, 2641.168032069892, 2775.597538356947, 2794.287456698529, 2800.943981120366, 2807.8736456859288, 819.2258315891485, 834.4367551902502, 841.7096101844854, 845.2984023260678, 854.5513605357175, 10147.391156530557, 10236.744081398025, 10300.433476158732, 10310.587576496931, 10383.06552410279, 3701.1117331840164, 3799.658030777188, 3938.468306778548, 3950.683945284428, 3973.165635216579, 8160.143184965612, 8160.551169685606, 8160.591970401456, 8171.7548473545885, 8179.795505112301, 4452.398926144993, 4453.910921781546, 4458.799354029076, 4461.5092339842595, 4463.352813841975, 3434.00413879977, 3539.3806083935724, 3970.960290397059, 4131.607497287753, 4132.173565286955, 3250.106220789302, 3255.7558183135884, 3291.2759192977505, 3383.2725963917383, 3402.1324562236473, 1011.6256984915628, 1015.4516561056946, 1018.1549314069305, 1022.1414012229762, 1037.7820657661975, 698.3051863395954, 728.5446595877577, 766.5477368352699, 775.0583041604477, 801.4790386248985, 4952.108620448282, 5057.544820966131, 5095.0, 5193.76628051731, 5393.703346315911, 367.81609195402297, 369.7541135145152, 372.54363404828865, 373.7458528200795, 374.2664377819504, 3265.6562482856057, 3575.4279315309946, 3640.0717816956508, 3648.3432982062955, 3662.6520480554304, 8847.203751662253, 9336.859947100798, 9365.62537498506, 9387.483688397204, 9389.530523473799, 9314.208292295096, 9332.113449222448, 9335.0, 9335.066493350747, 9335.439873607605, 7037.824054398681, 7079.8938015930835, 7094.077769889881, 7115.217326094125, 7117.145942486831, 5090.363704536933, 5098.0, 5172.172452407597, 5183.533481986639, 5201.921971170511, 8243.505389676639, 8376.916230837858, 8450.577471126297, 8579.699710510102, 8633.223009929137, 8414.453060551044, 8563.529005904486, 8674.609642565974, 8695.869561956702, 8700.60847261862, 6228.159198508143, 6257.405546473078, 6291.339409361951, 6341.0805433212845, 6399.8720025598295, 7158.141023077264, 7202.927970720226, 7219.422446204186, 7220.927790722026, 7221.783346499614, 6308.779192728232, 6400.967995159995, 6484.935150648433, 6549.639769812706, 6572.0, 6414.262359828679, 6440.935590644033, 6456.612603243821, 6473.287938326686, 6546.869062618816, 5982.341942386421, 6093.542984276109, 6103.7253323601435, 6110.205673262448, 6116.938830611637, 4412.51462339136, 4425.690201685851, 4479.552044795494, 4572.565606267399, 4597.310403439511, 4347.695661303678, 4559.430071241095, 4563.38394316763, 4586.564276393738, 4597.908041839211], "value": 3860.3026130300796, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.3799830364717, 292.4385180453529, 298.267752667202, 298.69980669427207, 302.9121554749123, 4817.855464336067, 4844.781984810683, 4851.830185943492, 4854.6844455110395, 4862.878428039292, 4738.881527961794, 4773.355596994405, 4776.37907072081, 4781.784819683114, 4804.375431193948, 3748.7760525947733, 3768.547774267092, 3780.527434070741, 3783.05423644089, 3794.4118661607495, 3597.982010089946, 3796.126890815114, 3812.5234345706785, 3827.4067519534515, 3850.903727406809, 3724.1992971511118, 3744.6629803317696, 3763.416670416076, 3775.8300876460626, 3782.6784723298415, 3710.424884142962, 3727.9627203727887, 3740.1584643455276, 3745.569259535134, 3749.625037496256, 3066.693330666938, 3178.0624715708923, 3306.96693033069, 3311.4867195584484, 3314.254292784128, 4467.441569803775, 4633.6061434778085, 4675.555822196886, 4681.578657920803, 4685.641164062452, 4217.797927590622, 4245.702800803945, 4247.893802654928, 4254.532001479834, 4256.574342565749, 4718.0328032753205, 4767.737774422405, 5002.2246551784165, 5008.924866127011, 5055.140626093573, 3300.174956260935, 3526.188976535386, 3535.1692352297446, 3547.255076433952, 3549.467579863041, 5170.819021334235, 5185.0, 5190.792368305263, 5198.532132108091, 5201.0, 3624.347617428888, 3627.383344831385, 3642.7814331139684, 3644.7084233261276, 3648.7263455240964, 3488.877889273914, 3660.9633903660624, 3671.1189314564313, 3693.6306369362846, 3694.168812017275, 4153.982274342806, 4154.231467178582, 4162.2716024696165, 4166.145940082276, 4175.937360939588, 4913.1893237616105, 4932.753362331869, 4933.383327084114, 4946.8763280918265, 4949.0, 1217.4643157010887, 1242.6023672424737, 1244.8733895824294, 1249.6001279590444, 1261.7602655495427, 787.896316834043, 790.6481615680967, 811.9634616442274, 811.975640730779, 818.7953011747063, 4022.365350695299, 4045.474088368493, 4049.493813273341, 4053.594640535982, 4065.207284579538, 4539.205639013159, 4556.908861822812, 4564.726116433025, 4592.954070459253, 4616.0, 3985.0, 4002.959970400317, 4009.195861862174, 4038.818253178614, 4047.838086476567, 2342.6837376953895, 2412.843165194257, 2432.0, 2432.2338463383976, 2448.5347783920997, 4359.433273674402, 4365.3670217818235, 4371.453568303962, 4679.368285281444, 4848.660593758474, 5102.749826292582, 5208.8437346879655, 5224.373075230997, 5244.9737751310995, 5263.026340127089, 4937.950620493821, 4939.0, 4943.456219815817, 4960.25500746941, 4972.154733695353, 4971.179755340473, 5121.92317115251, 5160.612954028388, 5164.690118592896, 5186.2479940409185, 5019.146745053276, 5022.949770502249, 5035.672681275705, 5045.99080183972, 5047.924281135713, 4923.483034281349, 4933.827316043921, 4934.741640881696, 4937.061958227925, 4943.505649435027, 3464.2378676691087, 3583.802890841029, 3585.498030275816, 3600.351936651428, 3629.0, 5144.0, 5144.614153938544, 5145.228215767665, 5154.7938082476285, 5163.328767260232, 5032.899342013213, 5034.899302014012, 5046.7224302662235, 5049.469805670352, 5051.116054690341, 4823.009733964964, 5010.448850626355, 5024.799008039784, 5046.9747651261505, 5057.494250574913, 4896.506565497415, 4907.214845624683, 4907.509249075064, 4911.312416261798, 4921.0, 4973.502649735142, 5006.674566153189, 5024.648274620888, 5045.167547354792, 5046.0, 4638.234691276037, 4927.852164435073, 4941.431735350337, 4949.232868905326, 4973.68723543554], "value": 3710.0884664354694, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.9477147056764, 596.7523477756731, 636.7962252079334, 647.889858724017, 647.977320793772, 11484.0, 12162.878371216275, 12177.269363838175, 12476.25142491449, 12503.937480312608, 10470.790584188311, 12430.751384972295, 12559.937200314009, 12565.434555445005, 12569.183003104792, 744.7207297263526, 771.9652615632282, 773.1920143450108, 773.5320131320555, 774.0015380159615, 770.8304173081913, 773.3581127664025, 773.3928865840288, 774.543019618425, 775.1666958020123, 816.0330008939396, 817.5952903312839, 818.9631466583988, 819.2422009641087, 819.6188772220916, 808.1716240853114, 808.8301456694131, 808.9514629122242, 809.0776514773163, 809.1706001348606, 587.6356658871484, 588.7792077970761, 590.1531302580768, 590.2562770908643, 596.8179705189915, 12478.251304921643, 12502.249865008038, 12517.49930002808, 12525.311107889063, 12530.060245481625, 12286.569970051005, 12663.936680316632, 12694.365281735969, 12991.870081299161, 13357.797798198111, 9654.871555903734, 9709.563069661812, 9755.268354873413, 9888.159506441962, 9931.957144499796, 3168.7940283881476, 3183.2519357950864, 3189.888353907602, 3195.792273502215, 3247.675232476757, 60854.39145608576, 61731.07403388953, 61775.69112154455, 61940.99999999955, 62784.68607656978, 9682.128608425275, 10162.593496260066, 10188.592456301812, 10218.897811021794, 10233.181345492343, 16333.754993675104, 17208.483745487654, 17365.565860853327, 17461.912690436468, 17488.387906423468, 6373.745050198033, 6382.074599183093, 6430.0676401921455, 6491.9350806492275, 6628.370304821035, 3589.0, 3593.568771747407, 3608.242269123461, 3640.417533194729, 3672.137047793766, 2651.098626466972, 2764.682061562946, 2771.2240572639694, 2777.472280266743, 2777.7361150690654, 462.65301024231826, 477.38894215403644, 483.78471580147203, 493.73091665042637, 520.6589683757145, 528.9365276166884, 548.4707257496535, 550.9063459211943, 561.3964987638224, 570.6490508337425, 7567.432442566829, 7969.481983671043, 8024.438289319692, 8079.151689072681, 8091.554964476893, 505.6637336171405, 519.9688018718889, 522.8457605006456, 561.2703485468874, 562.3982338897422, 3590.2101537661674, 3762.206202448254, 3801.50580424543, 3954.762714237155, 4083.1425400666194, 86166.0, 86562.56718716366, 101113.0, 105019.47490262499, 105318.0, 75063.24936750672, 78323.0, 78598.21401786023, 79108.0, 80387.59806200932, 46951.29573056475, 57669.711651441474, 58746.41253587495, 59526.0, 69479.30520694729, 7537.321641052332, 7551.867219916837, 7576.583287919218, 7684.760309610561, 7824.726134585262, 40746.79626601848, 41076.0, 41564.0, 42638.786806067015, 44294.0, 55108.72445637746, 55117.0, 61309.693451534244, 61786.69106654438, 63976.0, 11014.44927753625, 11254.409116081388, 11429.714257143638, 12343.69140771488, 12425.565105221274, 11883.762324753283, 12282.877171228174, 12613.432395542039, 12658.936705316415, 13449.0, 11397.487113080097, 11494.19540632181, 11528.250663706833, 12017.399130043637, 12161.574344897886, 11168.0, 11635.41822908868, 11670.416479175838, 12217.08371872131, 12449.564265250672, 10490.213234007328, 11094.44527773592, 11302.152338574804, 11465.598704045318, 11842.111841612086, 9315.813683726423, 9473.0, 9559.474228917476, 9681.322307438411, 10628.681139565826, 8560.91439085601, 9063.818723625622, 9365.765855853386, 9392.295577831826, 9767.462789546644], "value": 6291.255375198938, "unit": "score"}], "name": "dromaeo_css", "value": 6095.844407686214, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 115.0, 115.0, 113.0, 115.0, 114.0, 114.0, 117.0, 113.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 127.0, 129.0, 166.0, 133.0, 128.0, 129.0, 129.0, 160.0, 134.0], "value": 138.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 162.0, 163.0, 163.0, 161.0, 159.0, 161.0, 160.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 76.0, 123.0, 77.0, 78.0, 77.0, 77.0, 102.0, 76.0], "value": 84.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 117.0, 84.0, 84.0, 84.0, 107.0, 84.0, 85.0, 114.0], "value": 92.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 146.0, 146.0, 146.0, 149.0, 147.0, 147.0, 145.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 66.0, 66.0, 65.0, 67.0, 66.0, 71.0, 65.0], "value": 66.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 68.0, 66.0, 65.0, 66.0, 66.0, 66.0, 67.0], "value": 66.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 83.0, 83.0, 84.0, 83.0, 83.0, 83.0, 83.0, 83.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 140.0, 139.0, 141.0, 138.0, 138.0, 146.0, 146.0, 179.0, 142.0], "value": 144.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 174.0, 178.0, 179.0, 178.0, 174.0, 173.0, 172.0, 179.0, 176.0], "value": 175.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 73.0, 69.0, 69.0, 73.0, 80.0, 69.0, 74.0, 70.0, 69.0], "value": 71.7, "unit": "score"}], "name": "kraken", "value": 1558.0, "alertThreshold": 2.0}]} 13:34:41 INFO - Return code: 0 13:34:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:34:41 INFO - # TBPL SUCCESS # 13:34:41 INFO - Running post-action listener: _resource_record_post_action 13:34:41 INFO - [mozharness: 2016-10-03 20:34:41.992844Z] Finished run-tests step (success) 13:34:41 INFO - Running post-run listener: _resource_record_post_run 13:34:42 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 401567744; Read time: 4; Write time: 408428 13:34:42 INFO - TinderboxPrint: CPU usage
13.1% 13:34:42 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 13:34:42 INFO - TinderboxPrint: I/O write bytes / time
401,567,744 / 408,428 13:34:42 INFO - TinderboxPrint: CPU idle
8,351.1 (86.9%) 13:34:42 INFO - TinderboxPrint: CPU user
1,203.9 (12.5%) 13:34:42 INFO - TinderboxPrint: Swap in / out
0 / 0 13:34:42 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110825472; Read time: 0; Write time: 98676 13:34:42 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 289837056; Read time: 0; Write time: 309716 13:34:42 INFO - Running post-run listener: _upload_blobber_files 13:34:42 INFO - Blob upload gear active. 13:34:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:34:42 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 13:34:42 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'] 13:34:42 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 13:34:43 INFO - (blobuploader) - INFO - Open directory for files ... 13:34:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:34:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:34:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:34:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:34:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:34:48 INFO - (blobuploader) - INFO - Done attempting. 13:34:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:34:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:34:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:34:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:34:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:34:49 INFO - (blobuploader) - INFO - Done attempting. 13:34:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:34:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:34:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:34:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:34:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:34:50 INFO - (blobuploader) - INFO - Done attempting. 13:34:50 INFO - (blobuploader) - INFO - Iteration through files over. 13:34:50 INFO - Return code: 0 13:34:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:34:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:34:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8d3ab93202bd3455c37f232f2e1867e6b04eecde83de9a176f34b420e926c5d217462a62412ecde7742d27d03ebff8a3fc9db8ac2f1e7678a1754cb3c2f51cca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/830cd6ba94959777a4312d1d4a2bcaf12e05613603df649b488a55ceeccf7a48ee805e518fc43c389c57cc99b3bb11987d82bda35631024032577c1cd945ba7b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3b23a2479cffd66afaef9dfe486b9a262b0f3b887bc19d6cce8afb10128c266d8875b429273e8252583d8df92bcdd9452463c4b4e9c878ec840fd525f43c56c2"} 13:34:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:34:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:34:50 INFO - Contents: 13:34:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8d3ab93202bd3455c37f232f2e1867e6b04eecde83de9a176f34b420e926c5d217462a62412ecde7742d27d03ebff8a3fc9db8ac2f1e7678a1754cb3c2f51cca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/830cd6ba94959777a4312d1d4a2bcaf12e05613603df649b488a55ceeccf7a48ee805e518fc43c389c57cc99b3bb11987d82bda35631024032577c1cd945ba7b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3b23a2479cffd66afaef9dfe486b9a262b0f3b887bc19d6cce8afb10128c266d8875b429273e8252583d8df92bcdd9452463c4b4e9c878ec840fd525f43c56c2"} 13:34:50 INFO - Running post-run listener: copy_logs_to_upload_dir 13:34:50 INFO - Copying logs to upload dir... 13:34:50 INFO - mkdir: /builds/slave/test/build/upload/logs 13:34:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.666305 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-10-03 13:34:50.364027) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 13:34:50.367667) ========= 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=af724c981e2a0f424dbabf99000001e7-1475525218.857237-1488815137 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/8d3ab93202bd3455c37f232f2e1867e6b04eecde83de9a176f34b420e926c5d217462a62412ecde7742d27d03ebff8a3fc9db8ac2f1e7678a1754cb3c2f51cca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/830cd6ba94959777a4312d1d4a2bcaf12e05613603df649b488a55ceeccf7a48ee805e518fc43c389c57cc99b3bb11987d82bda35631024032577c1cd945ba7b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3b23a2479cffd66afaef9dfe486b9a262b0f3b887bc19d6cce8afb10128c266d8875b429273e8252583d8df92bcdd9452463c4b4e9c878ec840fd525f43c56c2"} build_url:https://queue.taskcluster.net/v1/task/YEbVpFKMTrWnjJnxGmPEFw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011412 build_url: 'https://queue.taskcluster.net/v1/task/YEbVpFKMTrWnjJnxGmPEFw/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/8d3ab93202bd3455c37f232f2e1867e6b04eecde83de9a176f34b420e926c5d217462a62412ecde7742d27d03ebff8a3fc9db8ac2f1e7678a1754cb3c2f51cca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/830cd6ba94959777a4312d1d4a2bcaf12e05613603df649b488a55ceeccf7a48ee805e518fc43c389c57cc99b3bb11987d82bda35631024032577c1cd945ba7b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3b23a2479cffd66afaef9dfe486b9a262b0f3b887bc19d6cce8afb10128c266d8875b429273e8252583d8df92bcdd9452463c4b4e9c878ec840fd525f43c56c2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 13:34:50.393879) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 13:34:50.394256) ========= 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=af724c981e2a0f424dbabf99000001e7-1475525218.857237-1488815137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004484 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 13:34:50.479335) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 13:34:50.480088) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 13:34:50.480825) ========= ========= Total master_lag: 0.18 =========