builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-038 starttime: 1475641359.44 results: success (0) buildid: 20161004183012 builduid: c68dad5f1a0044e0ab0e39d2debedc38 revision: ea104eeb14cc54da9a06c3766da63f73117723a0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 21:22:39.444739) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 21:22:39.445232) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 21:22:39.445523) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 21:22:39.465540) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 21:22:39.465826) ========= 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=8783db0840cc980e80bb0bd400000236-1475641283.651804-1466413039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-04 21:22:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-10-04 21:22:39 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085458 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 21:22:39.566497) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 21:22:39.566931) ========= 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=8783db0840cc980e80bb0bd400000236-1475641283.651804-1466413039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017751 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 21:22:39.617710) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 21:22:39.618111) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ea104eeb14cc54da9a06c3766da63f73117723a0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev ea104eeb14cc54da9a06c3766da63f73117723a0 --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=8783db0840cc980e80bb0bd400000236-1475641283.651804-1466413039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-04 21:22:39,946 truncating revision to first 12 chars 2016-10-04 21:22:39,946 Setting DEBUG logging. 2016-10-04 21:22:39,946 attempt 1/10 2016-10-04 21:22:39,946 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ea104eeb14cc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-04 21:22:40,437 unpacking tar archive at: fx-team-ea104eeb14cc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.860615 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 21:22:40.493276) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 21:22:40.493655) ========= script_repo_revision: ea104eeb14cc54da9a06c3766da63f73117723a0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 21:22:40.494066) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 21:22:40.494386) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 21:22:40.505657) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-10-04 21:22:40.506257) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=8783db0840cc980e80bb0bd400000236-1475641283.651804-1466413039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:22:40 INFO - MultiFileLogger online at 20161004 21:22:40 in /builds/slave/test 21:22:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 21:22:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:22:40 INFO - {'append_to_log': False, 21:22:40 INFO - 'base_work_dir': '/builds/slave/test', 21:22:40 INFO - 'blob_upload_branch': 'Fx-Team', 21:22:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:22:40 INFO - 'branch': 'Fx-Team', 21:22:40 INFO - 'buildbot_json_path': 'buildprops.json', 21:22:40 INFO - 'config_files': ('talos/linux_config.py',), 21:22:40 INFO - 'default_actions': ('clobber', 21:22:40 INFO - 'read-buildbot-config', 21:22:40 INFO - 'download-and-extract', 21:22:40 INFO - 'populate-webroot', 21:22:40 INFO - 'create-virtualenv', 21:22:40 INFO - 'install', 21:22:40 INFO - 'run-tests'), 21:22:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:22:40 INFO - 'download_minidump_stackwalk': True, 21:22:40 INFO - 'download_symbols': 'ondemand', 21:22:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:22:40 INFO - 'tooltool.py': '/tools/tooltool.py', 21:22:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:22:40 INFO - '/tools/misc-python/virtualenv.py')}, 21:22:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:22:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:22:40 INFO - 'installer_path': 'installer.exe', 21:22:40 INFO - 'log_level': 'info', 21:22:40 INFO - 'log_name': 'talos', 21:22:40 INFO - 'log_to_console': True, 21:22:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:22:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:22:40 INFO - 'opt_config_files': (), 21:22:40 INFO - 'pip_index': False, 21:22:40 INFO - 'sps_profile': False, 21:22:40 INFO - 'sps_profile_interval': 0, 21:22:40 INFO - 'suite': 'dromaeojs', 21:22:40 INFO - 'system_bits': '32', 21:22:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:22:40 INFO - 'title': 'talos-linux64-ix-038', 21:22:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:22:40 INFO - 'use_talos_json': True, 21:22:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:22:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:22:40 INFO - 'work_dir': 'build'} 21:22:40 INFO - [mozharness: 2016-10-05 04:22:40.933821Z] Running clobber step. 21:22:40 INFO - Running pre-action listener: _resource_record_pre_action 21:22:40 INFO - Running main action method: clobber 21:22:40 INFO - rmtree: /builds/slave/test/build 21:22:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:22:41 INFO - Running post-action listener: _resource_record_post_action 21:22:41 INFO - [mozharness: 2016-10-05 04:22:41.390538Z] Finished clobber step (success) 21:22:41 INFO - [mozharness: 2016-10-05 04:22:41.390638Z] Running read-buildbot-config step. 21:22:41 INFO - Running pre-action listener: _resource_record_pre_action 21:22:41 INFO - Running main action method: read_buildbot_config 21:22:41 INFO - Using buildbot properties: 21:22:41 INFO - { 21:22:41 INFO - "project": "", 21:22:41 INFO - "product": "firefox", 21:22:41 INFO - "script_repo_revision": "production", 21:22:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 21:22:41 INFO - "repository": "", 21:22:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 21:22:41 INFO - "buildid": "20161004183012", 21:22:41 INFO - "pgo_build": "True", 21:22:41 INFO - "basedir": "/builds/slave/test", 21:22:41 INFO - "buildnumber": 503, 21:22:41 INFO - "slavename": "talos-linux64-ix-038", 21:22:41 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:22:41 INFO - "platform": "ubuntu64_hw", 21:22:41 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 21:22:41 INFO - "branch": "fx-team", 21:22:41 INFO - "repo_path": "integration/fx-team", 21:22:41 INFO - "revision": "ea104eeb14cc54da9a06c3766da63f73117723a0", 21:22:41 INFO - "stage_platform": "linux64-pgo", 21:22:41 INFO - "builduid": "c68dad5f1a0044e0ab0e39d2debedc38", 21:22:41 INFO - "slavebuilddir": "test" 21:22:41 INFO - } 21:22:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/HKYUcS24RDijALaidsFNpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 21:22:41 INFO - Running post-action listener: _resource_record_post_action 21:22:41 INFO - [mozharness: 2016-10-05 04:22:41.393068Z] Finished read-buildbot-config step (success) 21:22:41 INFO - [mozharness: 2016-10-05 04:22:41.393155Z] Running download-and-extract step. 21:22:41 INFO - Running pre-action listener: _resource_record_pre_action 21:22:41 INFO - Running main action method: download_and_extract 21:22:41 INFO - mkdir: /builds/slave/test/build/tests 21:22:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:22:41 INFO - trying https://queue.taskcluster.net/v1/task/HKYUcS24RDijALaidsFNpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:22:41 INFO - Downloading https://queue.taskcluster.net/v1/task/HKYUcS24RDijALaidsFNpg/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 21:22:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HKYUcS24RDijALaidsFNpg/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 21:22:42 INFO - Downloaded 1361 bytes. 21:22:42 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:22:42 INFO - Using the following test package requirements: 21:22:42 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:22:42 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:22:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:22:42 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:22:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:22:42 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:22:42 INFO - u'jsshell-linux-x86_64.zip'], 21:22:42 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:22:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:22:42 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:22:42 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:22:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:22:42 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:22:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:22:42 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:22:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:22:42 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:22:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:22:42 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:22:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HKYUcS24RDijALaidsFNpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:22:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HKYUcS24RDijALaidsFNpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:22:42 INFO - Fetch https://queue.taskcluster.net/v1/task/HKYUcS24RDijALaidsFNpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:22:42 INFO - Http code: 200 21:22:42 INFO - via: 1.1 aa89533ad2ec5e0edba466c9920bd000.cloudfront.net (CloudFront) 21:22:42 INFO - x-amz-cf-id: mXafsuFwGojRCojtNiv1GXyG-3lLN43H_Jk0EtbWx4RCUvBZurt_Hg== 21:22:42 INFO - x-amz-version-id: TjFMFZva8VLRdiFY1zlkCM6Ouo5chA2R 21:22:52 INFO - Expected file size: 21992819 21:22:52 INFO - Obtained file size: 21992819 21:22:56 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 21:22:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HKYUcS24RDijALaidsFNpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:22:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HKYUcS24RDijALaidsFNpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:22:56 INFO - Fetch https://queue.taskcluster.net/v1/task/HKYUcS24RDijALaidsFNpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:22:56 INFO - Http code: 200 21:22:56 INFO - via: 1.1 88972e3933cc06dd11a6fa704a208631.cloudfront.net (CloudFront) 21:22:56 INFO - x-amz-cf-id: _LynQXWBe7SKUKT1zq9QnyUDrlOKNbi7Q_LhWsdgiBqjySFyNljrig== 21:22:56 INFO - x-amz-version-id: TjFMFZva8VLRdiFY1zlkCM6Ouo5chA2R 21:22:57 INFO - Expected file size: 21992819 21:22:57 INFO - Obtained file size: 21992819 21:23:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HKYUcS24RDijALaidsFNpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 21:23:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HKYUcS24RDijALaidsFNpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:23:01 INFO - Fetch https://queue.taskcluster.net/v1/task/HKYUcS24RDijALaidsFNpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 21:23:02 INFO - Http code: 200 21:23:02 INFO - via: 1.1 2239f0bfe6d7427183a4e375c4638619.cloudfront.net (CloudFront) 21:23:02 INFO - x-amz-cf-id: 2yDQ5NGPTpAdauCiA5ZnqroVRgvWkohmLWtuj_3dcK3ACitkhtjPCA== 21:23:02 INFO - x-amz-version-id: 2YI2oxxCwR1mKNtF4TjZLozg0tDuIgqR 21:23:04 INFO - Expected file size: 14409006 21:23:04 INFO - Obtained file size: 14409006 21:23:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:23:04 INFO - trying https://queue.taskcluster.net/v1/task/HKYUcS24RDijALaidsFNpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:23:04 INFO - Downloading https://queue.taskcluster.net/v1/task/HKYUcS24RDijALaidsFNpg/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 21:23:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HKYUcS24RDijALaidsFNpg/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 21:23:06 INFO - Downloaded 59706709 bytes. 21:23:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HKYUcS24RDijALaidsFNpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:23:06 INFO - mkdir: /builds/slave/test/properties 21:23:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:23:06 INFO - Writing to file /builds/slave/test/properties/build_url 21:23:06 INFO - Contents: 21:23:06 INFO - build_url:https://queue.taskcluster.net/v1/task/HKYUcS24RDijALaidsFNpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:23:07 INFO - Running post-action listener: _resource_record_post_action 21:23:07 INFO - Running post-action listener: set_extra_try_arguments 21:23:07 INFO - [mozharness: 2016-10-05 04:23:07.218317Z] Finished download-and-extract step (success) 21:23:07 INFO - [mozharness: 2016-10-05 04:23:07.218542Z] Running populate-webroot step. 21:23:07 INFO - Running pre-action listener: _resource_record_pre_action 21:23:07 INFO - Running main action method: populate_webroot 21:23:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:23:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:23:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:23:07 INFO - '--tppagecycles', 21:23:07 INFO - '7'], 21:23:07 INFO - 'tests': ['tsvgm']}}, 21:23:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:23:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:23:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:23:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:23:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:23:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:23:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:07 INFO - 'talos_options': ['--disable-e10s'], 21:23:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:23:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:23:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:07 INFO - 'talos_options': ['--disable-e10s'], 21:23:07 INFO - 'tests': ['damp', 'tps']}, 21:23:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:07 INFO - 'tests': ['damp', 'tps']}, 21:23:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:23:07 INFO - 'tests': ['dromaeo_dom']}, 21:23:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:23:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:23:07 INFO - 'tests': ['basic_compositor_video']}, 21:23:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:23:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:23:07 INFO - 'tests': ['a11yr', 21:23:07 INFO - 'ts_paint', 21:23:07 INFO - 'tpaint', 21:23:07 INFO - 'sessionrestore', 21:23:07 INFO - 'sessionrestore_no_auto_restore', 21:23:07 INFO - 'tabpaint']}, 21:23:07 INFO - 'other-e10s': {'tests': ['a11yr', 21:23:07 INFO - 'ts_paint', 21:23:07 INFO - 'tpaint', 21:23:07 INFO - 'sessionrestore', 21:23:07 INFO - 'sessionrestore_no_auto_restore', 21:23:07 INFO - 'tabpaint']}, 21:23:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:23:07 INFO - 'ts_paint', 21:23:07 INFO - 'tpaint', 21:23:07 INFO - 'sessionrestore', 21:23:07 INFO - 'sessionrestore_no_auto_restore', 21:23:07 INFO - 'tabpaint']}, 21:23:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:23:07 INFO - 'ts_paint', 21:23:07 INFO - 'tpaint', 21:23:07 INFO - 'sessionrestore', 21:23:07 INFO - 'sessionrestore_no_auto_restore', 21:23:07 INFO - 'tabpaint']}, 21:23:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:23:07 INFO - 'tests': ['a11yr', 21:23:07 INFO - 'ts_paint', 21:23:07 INFO - 'tpaint', 21:23:07 INFO - 'sessionrestore', 21:23:07 INFO - 'sessionrestore_no_auto_restore', 21:23:07 INFO - 'tabpaint']}, 21:23:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:23:07 INFO - 'tests': ['a11yr', 21:23:07 INFO - 'ts_paint', 21:23:07 INFO - 'tpaint', 21:23:07 INFO - 'sessionrestore', 21:23:07 INFO - 'sessionrestore_no_auto_restore', 21:23:07 INFO - 'tabpaint']}, 21:23:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:23:07 INFO - 'tests': ['tsvgx', 21:23:07 INFO - 'tsvgr_opacity', 21:23:07 INFO - 'tart', 21:23:07 INFO - 'tscrollx', 21:23:07 INFO - 'cart']}, 21:23:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:23:07 INFO - 'tsvgr_opacity', 21:23:07 INFO - 'tart', 21:23:07 INFO - 'tscrollx', 21:23:07 INFO - 'cart']}, 21:23:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:07 INFO - 'talos_options': ['--disable-e10s'], 21:23:07 INFO - 'tests': ['tp5o']}, 21:23:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:07 INFO - 'tests': ['tp5o']}, 21:23:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:07 INFO - 'talos_options': ['--disable-e10s', 21:23:07 INFO - '--xperf_path', 21:23:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:23:07 INFO - 'tests': ['tp5n']}, 21:23:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:07 INFO - 'talos_options': ['--xperf_path', 21:23:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:23:07 INFO - 'tests': ['tp5n']}}, 21:23:07 INFO - 'talos.zip': {'path': '', 21:23:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:23:07 INFO - Running post-action listener: _resource_record_post_action 21:23:07 INFO - [mozharness: 2016-10-05 04:23:07.233597Z] Finished populate-webroot step (success) 21:23:07 INFO - [mozharness: 2016-10-05 04:23:07.233685Z] Running create-virtualenv step. 21:23:07 INFO - Running pre-action listener: _resource_record_pre_action 21:23:07 INFO - Running main action method: create_virtualenv 21:23:07 INFO - Creating virtualenv /builds/slave/test/build/venv 21:23:07 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 21:23:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:23:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:23:07 INFO - Using real prefix '/usr' 21:23:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:23:07 INFO - Installing distribute.............................................................................................................................................................................................done. 21:23:09 INFO - Installing pip.................done. 21:23:09 INFO - Return code: 0 21:23:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:23:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:23:10 INFO - Reading from file tmpfile_stdout 21:23:10 INFO - Output received: 21:23:10 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) 21:23:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:23:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:23:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:10 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 0x7ff1d95d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2766790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2763930>, '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 0x2764830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2764cc0>, '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': '8783db0840cc980e80bb0bd400000236-1475641283.651804-1466413039', '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 21:23:10 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 21:23:10 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 21:23:10 INFO - Using env: {'DISPLAY': ':0', 21:23:10 INFO - 'HOME': '/home/cltbld', 21:23:10 INFO - 'LANG': 'en_US.UTF-8', 21:23:10 INFO - 'LANGUAGE': 'en_US:en', 21:23:10 INFO - 'LOGNAME': 'cltbld', 21:23:10 INFO - 'MAIL': '/var/mail/cltbld', 21:23:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:10 INFO - 'MOZ_NO_REMOTE': '1', 21:23:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:10 INFO - 'NO_EM_RESTART': '1', 21:23:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:10 INFO - 'PWD': '/builds/slave/test', 21:23:10 INFO - 'SHELL': '/bin/bash', 21:23:10 INFO - 'SHLVL': '1', 21:23:10 INFO - 'TERM': 'linux', 21:23:10 INFO - 'TMOUT': '86400', 21:23:10 INFO - 'USER': 'cltbld', 21:23:10 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1475641283.651804-1466413039', 21:23:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:10 INFO - '_': '/tools/buildbot/bin/python'} 21:23:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:10 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 21:23:10 INFO - Cleaning up... 21:23:10 INFO - Return code: 0 21:23:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:23:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:23:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:10 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 0x7ff1d95d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2766790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2763930>, '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 0x2764830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2764cc0>, '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': '8783db0840cc980e80bb0bd400000236-1475641283.651804-1466413039', '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 21:23:10 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 21:23:10 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 21:23:10 INFO - Using env: {'DISPLAY': ':0', 21:23:10 INFO - 'HOME': '/home/cltbld', 21:23:10 INFO - 'LANG': 'en_US.UTF-8', 21:23:10 INFO - 'LANGUAGE': 'en_US:en', 21:23:10 INFO - 'LOGNAME': 'cltbld', 21:23:10 INFO - 'MAIL': '/var/mail/cltbld', 21:23:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:10 INFO - 'MOZ_NO_REMOTE': '1', 21:23:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:10 INFO - 'NO_EM_RESTART': '1', 21:23:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:10 INFO - 'PWD': '/builds/slave/test', 21:23:10 INFO - 'SHELL': '/bin/bash', 21:23:10 INFO - 'SHLVL': '1', 21:23:10 INFO - 'TERM': 'linux', 21:23:10 INFO - 'TMOUT': '86400', 21:23:10 INFO - 'USER': 'cltbld', 21:23:10 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1475641283.651804-1466413039', 21:23:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:10 INFO - '_': '/tools/buildbot/bin/python'} 21:23:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:10 INFO - Downloading/unpacking psutil>=3.1.1 21:23:10 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 21:23:10 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 21:23:10 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 21:23:10 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 21:23:10 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 21:23:10 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 21:23:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:23:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:23:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:23:12 INFO - Installing collected packages: psutil 21:23:12 INFO - Running setup.py install for psutil 21:23:12 INFO - building 'psutil._psutil_linux' extension 21:23:12 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 21:23:12 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 21:23:12 INFO - building 'psutil._psutil_posix' extension 21:23:12 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 21:23:12 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 21:23:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:23:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:23:12 INFO - Successfully installed psutil 21:23:12 INFO - Cleaning up... 21:23:13 INFO - Return code: 0 21:23:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:23:13 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')]} 21:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:13 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')]} 21:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:13 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 0x7ff1d95d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2766790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2763930>, '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 0x2764830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2764cc0>, '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': '8783db0840cc980e80bb0bd400000236-1475641283.651804-1466413039', '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 21:23:13 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 21:23:13 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 21:23:13 INFO - Using env: {'DISPLAY': ':0', 21:23:13 INFO - 'HOME': '/home/cltbld', 21:23:13 INFO - 'LANG': 'en_US.UTF-8', 21:23:13 INFO - 'LANGUAGE': 'en_US:en', 21:23:13 INFO - 'LOGNAME': 'cltbld', 21:23:13 INFO - 'MAIL': '/var/mail/cltbld', 21:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:13 INFO - 'MOZ_NO_REMOTE': '1', 21:23:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:13 INFO - 'NO_EM_RESTART': '1', 21:23:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:13 INFO - 'PWD': '/builds/slave/test', 21:23:13 INFO - 'SHELL': '/bin/bash', 21:23:13 INFO - 'SHLVL': '1', 21:23:13 INFO - 'TERM': 'linux', 21:23:13 INFO - 'TMOUT': '86400', 21:23:13 INFO - 'USER': 'cltbld', 21:23:13 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1475641283.651804-1466413039', 21:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:13 INFO - '_': '/tools/buildbot/bin/python'} 21:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:23:13 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 21:23:13 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 21:23:13 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 21:23:13 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 21:23:13 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 21:23:13 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 21:23:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:23:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:23:15 INFO - Installing collected packages: mozsystemmonitor 21:23:15 INFO - Running setup.py install for mozsystemmonitor 21:23:15 INFO - Successfully installed mozsystemmonitor 21:23:15 INFO - Cleaning up... 21:23:15 INFO - Return code: 0 21:23:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:23:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:23:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1d95d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2766790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2763930>, '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 0x2764830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2764cc0>, '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': '8783db0840cc980e80bb0bd400000236-1475641283.651804-1466413039', '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 21:23:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:23:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:23:15 INFO - Using env: {'DISPLAY': ':0', 21:23:15 INFO - 'HOME': '/home/cltbld', 21:23:15 INFO - 'LANG': 'en_US.UTF-8', 21:23:15 INFO - 'LANGUAGE': 'en_US:en', 21:23:15 INFO - 'LOGNAME': 'cltbld', 21:23:15 INFO - 'MAIL': '/var/mail/cltbld', 21:23:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:15 INFO - 'MOZ_NO_REMOTE': '1', 21:23:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:15 INFO - 'NO_EM_RESTART': '1', 21:23:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:15 INFO - 'PWD': '/builds/slave/test', 21:23:15 INFO - 'SHELL': '/bin/bash', 21:23:15 INFO - 'SHLVL': '1', 21:23:15 INFO - 'TERM': 'linux', 21:23:15 INFO - 'TMOUT': '86400', 21:23:15 INFO - 'USER': 'cltbld', 21:23:15 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1475641283.651804-1466413039', 21:23:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:15 INFO - '_': '/tools/buildbot/bin/python'} 21:23:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:15 INFO - Downloading/unpacking jsonschema==2.5.1 21:23:15 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 21:23:15 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 21:23:15 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 21:23:15 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 21:23:15 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 21:23:15 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 21:23:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:23:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:23:17 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 21:23:17 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 21:23:17 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 21:23:17 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 21:23:17 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 21:23:17 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 21:23:17 INFO - Downloading functools32-3.2.3-2.tar.gz 21:23:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:23:17 INFO - warning: no files found matching '*.txt' 21:23:17 INFO - no previously-included directories found matching 'build' 21:23:17 INFO - no previously-included directories found matching 'dist' 21:23:17 INFO - no previously-included directories found matching '.git*' 21:23:17 INFO - Installing collected packages: jsonschema, functools32 21:23:17 INFO - Running setup.py install for functools32 21:23:17 INFO - warning: no files found matching '*.txt' 21:23:17 INFO - no previously-included directories found matching 'build' 21:23:17 INFO - no previously-included directories found matching 'dist' 21:23:17 INFO - no previously-included directories found matching '.git*' 21:23:17 INFO - Successfully installed jsonschema functools32 21:23:17 INFO - Cleaning up... 21:23:17 INFO - Return code: 0 21:23:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:23:17 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')]} 21:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:17 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')]} 21:23:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:17 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 0x7ff1d95d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2766790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2763930>, '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 0x2764830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2764cc0>, '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': '8783db0840cc980e80bb0bd400000236-1475641283.651804-1466413039', '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 21:23:17 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 21:23:17 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 21:23:17 INFO - Using env: {'DISPLAY': ':0', 21:23:17 INFO - 'HOME': '/home/cltbld', 21:23:17 INFO - 'LANG': 'en_US.UTF-8', 21:23:17 INFO - 'LANGUAGE': 'en_US:en', 21:23:17 INFO - 'LOGNAME': 'cltbld', 21:23:17 INFO - 'MAIL': '/var/mail/cltbld', 21:23:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:17 INFO - 'MOZ_NO_REMOTE': '1', 21:23:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:17 INFO - 'NO_EM_RESTART': '1', 21:23:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:17 INFO - 'PWD': '/builds/slave/test', 21:23:17 INFO - 'SHELL': '/bin/bash', 21:23:17 INFO - 'SHLVL': '1', 21:23:17 INFO - 'TERM': 'linux', 21:23:17 INFO - 'TMOUT': '86400', 21:23:17 INFO - 'USER': 'cltbld', 21:23:17 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1475641283.651804-1466413039', 21:23:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:17 INFO - '_': '/tools/buildbot/bin/python'} 21:23:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:23:18 INFO - Cleaning up... 21:23:18 INFO - Return code: 0 21:23:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:23: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')]} 21:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23: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')]} 21:23:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23: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', '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 0x7ff1d95d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2766790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2763930>, '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 0x2764830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2764cc0>, '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': '8783db0840cc980e80bb0bd400000236-1475641283.651804-1466413039', '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 21:23: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:23: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 blobuploader==1.2.4 21:23:18 INFO - Using env: {'DISPLAY': ':0', 21:23:18 INFO - 'HOME': '/home/cltbld', 21:23:18 INFO - 'LANG': 'en_US.UTF-8', 21:23:18 INFO - 'LANGUAGE': 'en_US:en', 21:23:18 INFO - 'LOGNAME': 'cltbld', 21:23:18 INFO - 'MAIL': '/var/mail/cltbld', 21:23:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:18 INFO - 'MOZ_NO_REMOTE': '1', 21:23:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:18 INFO - 'NO_EM_RESTART': '1', 21:23:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:18 INFO - 'PWD': '/builds/slave/test', 21:23:18 INFO - 'SHELL': '/bin/bash', 21:23:18 INFO - 'SHLVL': '1', 21:23:18 INFO - 'TERM': 'linux', 21:23:18 INFO - 'TMOUT': '86400', 21:23:18 INFO - 'USER': 'cltbld', 21:23:18 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1475641283.651804-1466413039', 21:23:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:18 INFO - '_': '/tools/buildbot/bin/python'} 21:23:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:18 INFO - Downloading/unpacking blobuploader==1.2.4 21:23: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 21:23: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 21:23: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 21:23: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 21:23: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 21:23: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 21:23:20 INFO - Downloading blobuploader-1.2.4.tar.gz 21:23:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:23:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:23:20 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 21:23:20 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 21:23:20 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 21:23:20 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 21:23:20 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 21:23:20 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 21:23:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:23:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:23:20 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 21:23:20 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 21:23:20 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 21:23:20 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 21:23:20 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 21:23:20 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 21:23:21 INFO - Downloading docopt-0.6.1.tar.gz 21:23:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:23:21 INFO - Installing collected packages: blobuploader, requests, docopt 21:23:21 INFO - Running setup.py install for blobuploader 21:23:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:23:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:23:21 INFO - Running setup.py install for requests 21:23:21 INFO - Running setup.py install for docopt 21:23:21 INFO - Successfully installed blobuploader requests docopt 21:23:21 INFO - Cleaning up... 21:23:21 INFO - Return code: 0 21:23:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:23: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')]} 21:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23: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')]} 21:23:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:21 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 0x7ff1d95d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2766790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2763930>, '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 0x2764830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2764cc0>, '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': '8783db0840cc980e80bb0bd400000236-1475641283.651804-1466413039', '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 21:23:21 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 21:23:21 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 21:23:21 INFO - Using env: {'DISPLAY': ':0', 21:23:21 INFO - 'HOME': '/home/cltbld', 21:23:21 INFO - 'LANG': 'en_US.UTF-8', 21:23:21 INFO - 'LANGUAGE': 'en_US:en', 21:23:21 INFO - 'LOGNAME': 'cltbld', 21:23:21 INFO - 'MAIL': '/var/mail/cltbld', 21:23:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:21 INFO - 'MOZ_NO_REMOTE': '1', 21:23:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:21 INFO - 'NO_EM_RESTART': '1', 21:23:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:21 INFO - 'PWD': '/builds/slave/test', 21:23:21 INFO - 'SHELL': '/bin/bash', 21:23:21 INFO - 'SHLVL': '1', 21:23:21 INFO - 'TERM': 'linux', 21:23:21 INFO - 'TMOUT': '86400', 21:23:21 INFO - 'USER': 'cltbld', 21:23:21 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1475641283.651804-1466413039', 21:23:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:21 INFO - '_': '/tools/buildbot/bin/python'} 21:23:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:23:22 INFO - Running setup.py (path:/tmp/pip-Guah28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:23:22 INFO - Running setup.py (path:/tmp/pip-gJI74H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:23:22 INFO - Running setup.py (path:/tmp/pip-inIzp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:23:22 INFO - Running setup.py (path:/tmp/pip-weMbPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:23:22 INFO - Running setup.py (path:/tmp/pip-3kiNdo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:23:22 INFO - Running setup.py (path:/tmp/pip-Y3uKDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:23:22 INFO - Running setup.py (path:/tmp/pip-yu0_7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:23:22 INFO - Running setup.py (path:/tmp/pip-2jXagn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:23:22 INFO - Running setup.py (path:/tmp/pip-5xKLpF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:23:22 INFO - Running setup.py (path:/tmp/pip-aq8bel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:23:22 INFO - Running setup.py (path:/tmp/pip-Px8UsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:23:22 INFO - Running setup.py (path:/tmp/pip-5kjnrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:23:22 INFO - Running setup.py (path:/tmp/pip-vS3v46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:23:22 INFO - Running setup.py (path:/tmp/pip-Xk_dGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:23:23 INFO - Running setup.py (path:/tmp/pip-ihn48r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:23:23 INFO - Running setup.py (path:/tmp/pip-ZjoYXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:23:23 INFO - Running setup.py (path:/tmp/pip-aO7DGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:23:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:23:23 INFO - Running setup.py install for manifestparser 21:23:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:23:23 INFO - Running setup.py install for mozcrash 21:23:23 INFO - Running setup.py install for mozdebug 21:23:23 INFO - Running setup.py install for mozdevice 21:23:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:23:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:23:23 INFO - Running setup.py install for mozfile 21:23:23 INFO - Running setup.py install for mozhttpd 21:23:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:23:23 INFO - Running setup.py install for mozinfo 21:23:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:23:23 INFO - Running setup.py install for mozInstall 21:23:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:23:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:23:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:23:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:23:24 INFO - Running setup.py install for mozleak 21:23:24 INFO - Running setup.py install for mozlog 21:23:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:23:24 INFO - Running setup.py install for moznetwork 21:23:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:23:24 INFO - Running setup.py install for mozprocess 21:23:24 INFO - Running setup.py install for mozprofile 21:23:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:23:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:23:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:23:24 INFO - Running setup.py install for mozrunner 21:23:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:23:24 INFO - Running setup.py install for mozscreenshot 21:23:24 INFO - Running setup.py install for moztest 21:23:24 INFO - Running setup.py install for mozversion 21:23:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:23:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:23:25 INFO - Cleaning up... 21:23:25 INFO - Return code: 0 21:23:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:23:25 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')]} 21:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:25 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')]} 21:23:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:25 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 0x7ff1d95d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2766790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2763930>, '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 0x2764830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2764cc0>, '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': '8783db0840cc980e80bb0bd400000236-1475641283.651804-1466413039', '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 21:23:25 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 21:23:25 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 21:23:25 INFO - Using env: {'DISPLAY': ':0', 21:23:25 INFO - 'HOME': '/home/cltbld', 21:23:25 INFO - 'LANG': 'en_US.UTF-8', 21:23:25 INFO - 'LANGUAGE': 'en_US:en', 21:23:25 INFO - 'LOGNAME': 'cltbld', 21:23:25 INFO - 'MAIL': '/var/mail/cltbld', 21:23:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:25 INFO - 'MOZ_NO_REMOTE': '1', 21:23:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:25 INFO - 'NO_EM_RESTART': '1', 21:23:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:25 INFO - 'PWD': '/builds/slave/test', 21:23:25 INFO - 'SHELL': '/bin/bash', 21:23:25 INFO - 'SHLVL': '1', 21:23:25 INFO - 'TERM': 'linux', 21:23:25 INFO - 'TMOUT': '86400', 21:23:25 INFO - 'USER': 'cltbld', 21:23:25 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1475641283.651804-1466413039', 21:23:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:25 INFO - '_': '/tools/buildbot/bin/python'} 21:23:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:23:25 INFO - Running setup.py (path:/tmp/pip-9lt8qs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:23:25 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)) 21:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:23:25 INFO - Running setup.py (path:/tmp/pip-NPljyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:23:25 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)) 21:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:23:25 INFO - Running setup.py (path:/tmp/pip-nttKvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:23:25 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)) 21:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:23:25 INFO - Running setup.py (path:/tmp/pip-ThW6dj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:23:25 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)) 21:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:23:25 INFO - Running setup.py (path:/tmp/pip-zllMUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:23:25 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)) 21:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:23:25 INFO - Running setup.py (path:/tmp/pip-665DA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:23:25 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)) 21:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:23:25 INFO - Running setup.py (path:/tmp/pip-d2R_Hl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:23:25 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)) 21:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:23:25 INFO - Running setup.py (path:/tmp/pip-CnqTVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:23:25 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)) 21:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:23:25 INFO - Running setup.py (path:/tmp/pip-XF2TAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:23:25 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)) 21:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:23:25 INFO - Running setup.py (path:/tmp/pip-pzNNxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:23:26 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)) 21:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:23:26 INFO - Running setup.py (path:/tmp/pip-KpoM_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:23:26 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)) 21:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:23:26 INFO - Running setup.py (path:/tmp/pip-WZlPhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:23:26 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)) 21:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:23:26 INFO - Running setup.py (path:/tmp/pip-Hab6vA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:23:26 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)) 21:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:23:26 INFO - Running setup.py (path:/tmp/pip-5DmGV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:23:26 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)) 21:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:23:26 INFO - Running setup.py (path:/tmp/pip-3rgnen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:23:26 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)) 21:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:23:26 INFO - Running setup.py (path:/tmp/pip-bGhTyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:23:26 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)) 21:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:23:26 INFO - Running setup.py (path:/tmp/pip-uDD5VN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:23:26 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)) 21:23:26 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)) 21:23:26 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)) 21:23:26 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)) 21:23:26 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)) 21:23:26 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)) 21:23:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:23: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 21:23: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 21:23: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 21:23: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 21:23: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 21:23: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 21:23:28 INFO - Downloading blessings-1.6.tar.gz 21:23:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:23:28 INFO - Installing collected packages: blessings 21:23:28 INFO - Running setup.py install for blessings 21:23:28 INFO - Successfully installed blessings 21:23:28 INFO - Cleaning up... 21:23:28 INFO - Return code: 0 21:23:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:23:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:23:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:23:28 INFO - Reading from file tmpfile_stdout 21:23:28 INFO - Current package versions: 21:23:28 INFO - argparse == 1.2.1 21:23:28 INFO - blessings == 1.6 21:23:28 INFO - blobuploader == 1.2.4 21:23:28 INFO - docopt == 0.6.1 21:23:28 INFO - functools32 == 3.2.3-2 21:23:28 INFO - jsonschema == 2.5.1 21:23:28 INFO - manifestparser == 1.1 21:23:28 INFO - mozInstall == 1.12 21:23:28 INFO - mozcrash == 0.17 21:23:28 INFO - mozdebug == 0.1 21:23:28 INFO - mozdevice == 0.48 21:23:28 INFO - mozfile == 1.2 21:23:28 INFO - mozhttpd == 0.7 21:23:28 INFO - mozinfo == 0.9 21:23:28 INFO - mozleak == 0.1 21:23:28 INFO - mozlog == 3.4 21:23:28 INFO - moznetwork == 0.27 21:23:28 INFO - mozprocess == 0.23 21:23:28 INFO - mozprofile == 0.28 21:23:28 INFO - mozrunner == 6.12 21:23:28 INFO - mozscreenshot == 0.1 21:23:28 INFO - mozsystemmonitor == 0.3 21:23:28 INFO - moztest == 0.7 21:23:28 INFO - mozversion == 1.4 21:23:28 INFO - psutil == 3.1.1 21:23:28 INFO - requests == 1.2.3 21:23:28 INFO - wsgiref == 0.1.2 21:23:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:23:28 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')]} 21:23:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:28 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')]} 21:23:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:28 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 0x7ff1d95d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2766790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2763930>, '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 0x2764830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2764cc0>, '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': '8783db0840cc980e80bb0bd400000236-1475641283.651804-1466413039', '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 21:23:28 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 21:23:28 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 21:23:28 INFO - Using env: {'DISPLAY': ':0', 21:23:28 INFO - 'HOME': '/home/cltbld', 21:23:28 INFO - 'LANG': 'en_US.UTF-8', 21:23:28 INFO - 'LANGUAGE': 'en_US:en', 21:23:28 INFO - 'LOGNAME': 'cltbld', 21:23:28 INFO - 'MAIL': '/var/mail/cltbld', 21:23:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:28 INFO - 'MOZ_NO_REMOTE': '1', 21:23:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:28 INFO - 'NO_EM_RESTART': '1', 21:23:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:28 INFO - 'PWD': '/builds/slave/test', 21:23:28 INFO - 'SHELL': '/bin/bash', 21:23:28 INFO - 'SHLVL': '1', 21:23:28 INFO - 'TERM': 'linux', 21:23:28 INFO - 'TMOUT': '86400', 21:23:28 INFO - 'USER': 'cltbld', 21:23:28 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1475641283.651804-1466413039', 21:23:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:28 INFO - '_': '/tools/buildbot/bin/python'} 21:23:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:29 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)) 21:23:29 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)) 21:23:29 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)) 21:23:29 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)) 21:23:29 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)) 21:23:29 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)) 21:23:29 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)) 21:23:29 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)) 21:23:29 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)) 21:23:29 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)) 21:23:29 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)) 21:23:29 INFO - Cleaning up... 21:23:29 INFO - Return code: 0 21:23:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:23:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:23:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1d95d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2766790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2763930>, '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 0x2764830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2764cc0>, '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': '8783db0840cc980e80bb0bd400000236-1475641283.651804-1466413039', '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 21:23:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:23:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:23:29 INFO - Using env: {'DISPLAY': ':0', 21:23:29 INFO - 'HOME': '/home/cltbld', 21:23:29 INFO - 'LANG': 'en_US.UTF-8', 21:23:29 INFO - 'LANGUAGE': 'en_US:en', 21:23:29 INFO - 'LOGNAME': 'cltbld', 21:23:29 INFO - 'MAIL': '/var/mail/cltbld', 21:23:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:29 INFO - 'MOZ_NO_REMOTE': '1', 21:23:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:29 INFO - 'NO_EM_RESTART': '1', 21:23:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:29 INFO - 'PWD': '/builds/slave/test', 21:23:29 INFO - 'SHELL': '/bin/bash', 21:23:29 INFO - 'SHLVL': '1', 21:23:29 INFO - 'TERM': 'linux', 21:23:29 INFO - 'TMOUT': '86400', 21:23:29 INFO - 'USER': 'cltbld', 21:23:29 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1475641283.651804-1466413039', 21:23:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:29 INFO - '_': '/tools/buildbot/bin/python'} 21:23:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:23:29 INFO - Cleaning up... 21:23:29 INFO - Return code: 0 21:23:29 INFO - Running post-action listener: _resource_record_post_action 21:23:29 INFO - Running post-action listener: _start_resource_monitoring 21:23:29 INFO - Starting resource monitoring. 21:23:29 INFO - [mozharness: 2016-10-05 04:23:29.367528Z] Finished create-virtualenv step (success) 21:23:29 INFO - [mozharness: 2016-10-05 04:23:29.368032Z] Running install step. 21:23:29 INFO - Running pre-action listener: _resource_record_pre_action 21:23:29 INFO - Running main action method: install 21:23:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:23:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:23:29 INFO - Reading from file tmpfile_stdout 21:23:29 INFO - Detecting whether we're running mozinstall >=1.0... 21:23:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:23:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:23:29 INFO - Reading from file tmpfile_stdout 21:23:29 INFO - Output received: 21:23:29 INFO - Usage: mozinstall [options] installer 21:23:29 INFO - Options: 21:23:29 INFO - -h, --help show this help message and exit 21:23:29 INFO - -d DEST, --destination=DEST 21:23:29 INFO - Directory to install application into. [default: 21:23:29 INFO - "/builds/slave/test"] 21:23:29 INFO - --app=APP Application being installed. [default: firefox] 21:23:29 INFO - mkdir: /builds/slave/test/build/application 21:23:29 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'] 21:23:29 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 21:23:46 INFO - Reading from file tmpfile_stdout 21:23:46 INFO - Output received: 21:23:46 INFO - /builds/slave/test/build/application/firefox/firefox 21:23:46 INFO - Running post-action listener: _resource_record_post_action 21:23:46 INFO - [mozharness: 2016-10-05 04:23:46.664568Z] Finished install step (success) 21:23:46 INFO - [mozharness: 2016-10-05 04:23:46.664814Z] Running run-tests step. 21:23:46 INFO - Running pre-action listener: _resource_record_pre_action 21:23:46 INFO - Running main action method: run_tests 21:23:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:23:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:23:46 INFO - Python 2.7.3 21:23:46 INFO - Return code: 0 21:23:46 INFO - grabbing minidump binary from tooltool 21:23:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:23:46 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 0x2763930>, '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 0x2764830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2764cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:23:46 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 21:23:46 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 21:23:46 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 21:23:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:23:46 INFO - Return code: 0 21:23:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:23:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:23:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:23:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:23:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:23:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HKYUcS24RDijALaidsFNpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 21:23:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HKYUcS24RDijALaidsFNpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --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 21:23:46 INFO - Using env: {'DISPLAY': ':0', 21:23:46 INFO - 'HOME': '/home/cltbld', 21:23:46 INFO - 'LANG': 'en_US.UTF-8', 21:23:46 INFO - 'LANGUAGE': 'en_US:en', 21:23:46 INFO - 'LOGNAME': 'cltbld', 21:23:46 INFO - 'MAIL': '/var/mail/cltbld', 21:23:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:23:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:23:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:46 INFO - 'MOZ_NO_REMOTE': '1', 21:23:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:23:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:46 INFO - 'NO_EM_RESTART': '1', 21:23:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:46 INFO - 'PWD': '/builds/slave/test', 21:23:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:23:46 INFO - 'SHELL': '/bin/bash', 21:23:46 INFO - 'SHLVL': '1', 21:23:46 INFO - 'TERM': 'linux', 21:23:46 INFO - 'TMOUT': '86400', 21:23:46 INFO - 'USER': 'cltbld', 21:23:46 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1475641283.651804-1466413039', 21:23:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:46 INFO - '_': '/tools/buildbot/bin/python'} 21:23:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HKYUcS24RDijALaidsFNpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 21:23:46 INFO - mozversion application_buildid: 20161004183012 21:23:46 INFO - mozversion application_changeset: ea104eeb14cc54da9a06c3766da63f73117723a0 21:23:46 INFO - mozversion application_display_name: Nightly 21:23:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:23:46 INFO - mozversion application_name: Firefox 21:23:46 INFO - mozversion application_remotingname: firefox 21:23:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:23:46 INFO - mozversion application_vendor: Mozilla 21:23:46 INFO - mozversion application_version: 52.0a1 21:23:46 INFO - mozversion platform_buildid: 20161004183012 21:23:46 INFO - mozversion platform_changeset: ea104eeb14cc54da9a06c3766da63f73117723a0 21:23:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:23:46 INFO - mozversion platform_version: 52.0a1 21:23:46 INFO - using testdate: 1475641426 21:23:46 INFO - actual date: 1475641426 21:23:46 INFO - starting webserver on 'localhost:47618' 21:23:46 INFO - SUITE-START | Running 2 tests 21:23:46 INFO - TEST-START | dromaeo_css 21:23:46 INFO - operating with platform_type : linux_ 21:23:46 INFO - Initialising browser for dromaeo_css test... 21:23:46 INFO - TEST-INFO | started process 6899 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGhXbP_/profile http://localhost:47618/getInfo.html) 21:23:52 INFO - PROCESS | 6899 | __metrics Screen width/height:1600/1200 21:23:52 INFO - PROCESS | 6899 | colorDepth:24 21:23:52 INFO - PROCESS | 6899 | Browser inner width/height: 1024/697 21:23:52 INFO - PROCESS | 6899 | __metrics 21:23:52 INFO - PROCESS | 6899 | 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" 21:23:52 INFO - PROCESS | 6899 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:23:53 INFO - PROCESS | 6899 | console.error: PushService: 21:23:53 INFO - PROCESS | 6899 | stateChangeProcessEnqueue: Error transitioning state 21:23:53 INFO - PROCESS | 6899 | UnknownError 21:23:54 INFO - TEST-INFO | 6899: exit 0 21:23:54 INFO - Browser initialized. 21:23:54 INFO - Running cycle 1/1 for dromaeo_css test... 21:23:54 INFO - TEST-INFO | started process 6981 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGhXbP_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:24:06 INFO - PROCESS | 6981 | RSS: Main: 174125056 21:24:06 INFO - PROCESS | 6981 | 21:24:57 INFO - PROCESS | 6981 | 1475641497786 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] 21:27:08 INFO - PROCESS | 6981 | Cycle 1(1): loaded http://localhost:47618/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47618/tests/dromaeo/cssquery-ext.html) 21:27:09 INFO - PROCESS | 6981 | RSS: Main: 342949888 21:27:09 INFO - PROCESS | 6981 | 21:30:12 INFO - PROCESS | 6981 | Cycle 1(1): loaded http://localhost:47618/tests/dromaeo/cssquery-ext.html (next: http://localhost:47618/tests/dromaeo/cssquery-jquery.html) 21:30:12 INFO - PROCESS | 6981 | RSS: Main: 280276992 21:30:12 INFO - PROCESS | 6981 | 21:33:14 INFO - PROCESS | 6981 | Cycle 1(1): loaded http://localhost:47618/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47618/tests/dromaeo/cssquery-mootools.html) 21:33:15 INFO - PROCESS | 6981 | RSS: Main: 244760576 21:33:15 INFO - PROCESS | 6981 | 21:36:17 INFO - PROCESS | 6981 | Cycle 1(1): loaded http://localhost:47618/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47618/tests/dromaeo/cssquery-prototype.html) 21:36:17 INFO - PROCESS | 6981 | RSS: Main: 242872320 21:36:17 INFO - PROCESS | 6981 | 21:39:20 INFO - PROCESS | 6981 | Cycle 1(1): loaded http://localhost:47618/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47618/tests/dromaeo/cssquery-yui.html) 21:39:21 INFO - PROCESS | 6981 | RSS: Main: 216272896 21:39:21 INFO - PROCESS | 6981 | 21:42:24 INFO - PROCESS | 6981 | Cycle 1(1): loaded http://localhost:47618/tests/dromaeo/cssquery-yui.html (next: http://localhost:47618/tests/dromaeo/cssquery-dojo.html) 21:42:24 INFO - PROCESS | 6981 | RSS: Main: 309243904 21:42:24 INFO - PROCESS | 6981 | 21:42:24 INFO - PROCESS | 6981 | __start_tp_report 21:42:24 INFO - PROCESS | 6981 | _x_x_mozilla_page_load 21:42:24 INFO - PROCESS | 6981 | _x_x_mozilla_page_load_details 21:42:24 INFO - PROCESS | 6981 | |i|pagename|runs| 21:42:24 INFO - PROCESS | 6981 | |0;dojo.html;3020.8187508749475;3049.0700336397404;3049.542568614709;3088.675689052651;3103.394838006588;5063.088644044071;5099.821506247282;5180.1970694542315;5219.164933610623;5269.209618557214;5138.332016837806;5159.174532074869;5165.044466773649;5375.11310633745;5444.482774136461;4895;4920.261960705896;4942.678725882806;4960.305557221992;4972.602191824663;4861;4880.731559764212;4934.703917764928;4939.58013568847;4979.427365852937;4980.477049909761;4986.601071914256;5034.320366750497;5038.496150384951;5040.5967522598285;4853.95146048542;4897.730624815634;4899;4921.384826896638;4933;4622.445306563201;4648.23304154814;4786.569208771192;4800.855974320776;4823.03539292143;5083.61872859537;5125.641205115643;5130.589552835764;5155.432902380735;5164.2253661950635;5566.192902029224;5570.2480165177585;5574.0928320324365;5587.916181257285;5631.831045068613;5395.7032363220005;5413.160960051198;5591.496765291103;5653.745581448845;5710.14347847822;5319.601029922771;5335.626506144533;5342.545883599938;5344.839654810362;5387.4073851876265;5842.912356314659;5853.239078919713;5856.502197313276;5856.677882716492;5856.765729370863;5326.094563924142;5393.110136827458;5472.425395333512;5510.283663123768;5607.467290607386;5600.35595906476;5609.915851262234;5611.3266408031295;5665.773369065191;5677.063284558084;5578.637388569811;5582.385937546866;5587.580931430159;5592.5805564582815;5655.293088363955;5377.973110134502;5488.725563721798;5504.779808807683;5587.1339942309005;5592.2730045094695;4293.162833247549;4338.457692788402;4339.132173565236;4339.652827773771;4341.39220509129;3830.6743926766535;3853.9036524087123;3900.863469778601;3905.72659913809;3918;5274.789008439696;5276.709780962007;5283.735813209324;5288.0745869472685;5329.333833270841;5531.225628412026;5575.107982722745;5576.944230557642;5594.384617692051;5598;5199.688018718889;5255.211718242218;5288.2596436498925;5362.570994320445;5364.570834333244;4871.318015477836;4898.951010489921;4909.604239932651;4913.11563918491;4942.036302920896;5940.8811823764145;5946.226990491295;5947.6431414115295;5949.732262048132;6005.729742161613;5497.065498865282;5552.750126244409;5640.633358831663;5673.205751194753;5722.084466485342;6003.90994135097;6007;6029.487493563096;6057.606255593372;6068.7269072892705;5638.746256418389;5645.125005624135;5646.548276137817;5647.576431767716;5648.23748793924;5463.48096930791;5515.806946756844;5729.427057294237;5742.0812669974275;5743.310802703702;5507.531859791802;5526.557875370041;5532.2254884317035;5576.637518561281;5641;5446.645968012067;5546.889062218814;5551.750171242385;5561.527270181918;5561.694106824163;5319.202119682079;5517.641353312022;5522.751476183501;5523.8895222096135;5586.86032849182;5429.375621803385;5505.064139096283;5517.420670829505;5517.834464966058;5522.2544956430365;5409.945900540944;5410.242566040679;5417.51242388187;5420.078586640359;5425.701586412785 21:42:24 INFO - PROCESS | 6981 | |1;ext.html;567.5289509706944;597.9760809567616;606.6602702486608;613.4172536090715;626.2735227136521;31582.68417315826;34456.65543344566;34528.48207276893;34542.30915381694;34584.30831383371;35081.47377789329;43986.34020489695;45161.77419112908;45237.32144017842;48955.51044489554;8903.866442003391;8995.910040899606;9037.683681071163;9048.728538143834;9050.456972581665;8776;8847.690330838423;8863.77840553988;8872.11278872114;8872.334574906876;8085.919140808575;8212.46618969768;8212.917870821275;8379.95810020952;10699;10534.315269507457;10939.671809845717;10945.726356841064;10947.069499092586;10955.287906286067;10632.255742098056;10697.304675196086;10699.893001069968;10706.197035222312;10750.301230420077;42377.36433953493;42765.57234427647;42777.144457111;42816.785916070534;42855.14289714188;3460.9826950865336;3586.946195807065;3624.6012938576737;3917.099067214528;4001.3994402239045;31163;31440.842795786102;31505.369892602248;31545.84227078873;33314.16714582131;4252.340887162464;4445.8221671133115;4502.189605870942;4506.616937560311;4522.9547704522865;334032;334518.99999999756;334519;335010;336391;59640.70179649074;59716.70141649351;59878.70060649756;59896;59953;61580;62277;62602.686986565684;62884.37115628877;62907;15267;15535.145566993924;15582.454614088452;15589.376424943102;15589.68820623581;11572.42137893102;11653.941730291293;11740.471678774476;11742.17804753659;11750.177487575787;15416.691666166615;17907.73138402925;18031.72952405715;18063.819361806476;18321.17554710041;5376.1398176291605;6078.787242446493;6258.3428739982555;6328.841778955563;6375.075614035939;922.110163692027;974.5224839828433;1054.620336678795;1078.2991055813627;1097.7475180708482;30050.54924176139;31758.2060448486;31855.203619909225;31867;32587.837060814545;1011.9342242754198;1052.1057101463696;1061.4745700878116;1080.7460246841986;1168.193946177135;15811.841881581267;16943.322267109423;16984.915075424542;16987.150642467826;17077.045667140228;457231;461883;462549;464033;464070;57281.42718572761;57777.711111445016;57888;58060.709696451246;58190.709046454496;1199.9280043197436;1214.271437137728;1295.164618820874;1323.2788130468919;1346.8249127613346;29651.110466686034;32647.347053059282;32789.83605081959;32850.83574582112;33443.832780836914;49986;53808;55430.44569554253;55547.44452555423;60297.397026029175;424924;427227;428376;429141;429274;27609.23907609223;27892.442151156458;28094.85952570224;28463.857680711462;28908.27729306784;46351.11635251613;46351.30473042974;47896;49779;50840.49159508358;39672.40491392689;39877.80061099676;40884.59115408808;40946.79526602348;41676.374854376605;38523.42214866723;39818.80090599528;39977.80011099926;40136.39795403013;41364.79317603393;40338;40999.18001639891;41610.79194604007;41997.37003945004;42042.789786050875;33439.49840752439;36035.19824008737;36411.27177456383;36589.451158232114;36621.450678239315;27552.724472755017;27795.44409111766;27964.580531292453;27998.44003119967;28122.156335309974 21:42:24 INFO - PROCESS | 6981 | |2;jquery.html;382.47027866405057;401.141557067875;408.89164371441575;411.85585045234166;431.18075656253114;13314.533991310294;15460.226988650578;19069.332573359952;19344.22623095078;19943.700844487306;17360.652786944254;17426.82573174268;17465.214065367058;17802;18892.433227003214;5022.949770502303;5613.46672066154;5835;5844.853878653046;5845.56158288128;5616.5787565932715;5648.802291919784;5676.205331253628;5679.204911312419;5682.26130603021;5446.482584154499;5631.239782629354;5635.802746903859;5639.210510528509;5640.5487560995025;5675.5459563234845;5719.799807006735;5720.370759216483;5725.599208055459;5727.713614319288;4933.383327084114;5113.335266415343;5134.563562097189;5139.614528910347;5175.223716442526;22586.548269034527;22686.886565567067;22752.317430477113;22811.42971425711;22872.542549148922;2450.0812195426715;2499.4751102268547;2721.5917612358107;3053.4656435123766;3154.542591324268;13194;14019.789703154462;14409.78385324221;14775.482858099915;14789;1878.117284876106;1910.551020510179;1953.5213872601303;1975.8221760041665;1984.9305274315475;79128.60435697784;80353;82169;82589.58705206496;82630.58684706598;10202.795944081077;10495.370277783204;10725.356478611307;11166.609168679057;11743.941280293544;15346.079235245921;15357.462488812838;15379.846201538065;15394.15332156742;15409.224739938787;6921.446284297244;7466.738664146729;7475.738349157753;7574.573563155362;7696.576688282198;6865.112094174042;6948.783863950999;7128.714851405989;7243.89134162988;7299.656704260956;6142.815715528452;6534.132071606684;6553.541252112402;6558.704858281293;6635.9336406636285;1976.150255390196;2006.4682859042366;2011.309247530768;2018.7880272571463;2028.2495476673726;913.9862902056475;945.6359301668907;1010.408910787183;1029.089256008423;1042.7393151712072;18406;19171;19204.807951920582;19391.612167756564;19479.12343944526;982.3467394182932;998.510729742421;1032.2670903658486;1041.317936751429;1051.747580580655;9220.861687074565;10667.83998240027;10934.507947142398;11013.6145234918;11051.392173430379;416789;428690;439915;443965;444680;72517;77185;77466.6126669363;77573.22426775773;82560;1021.4892553723139;1063.31416236527;1081.1350919264557;1088.711491454765;1098.3958822647512;16013.279402427152;16856.831431685525;17105.401310954057;17214.913925430294;17526.649467010844;37582.8120859394;37880.43179352257;38705.6129438702;45125.77437112793;45660;57009;57231.42768572261;59346.406535935814;59833;60873;7375.668094935848;7444.664990075568;7979.840403191787;8025.5585942773705;8092.393070519853;11385.829212561652;12238.632841014783;12312.445939932546;12378.62864114078;12591.24452532851;10457.581696732046;10534.947325263325;10695.251332406657;10848.240623156304;11553.13351498624;10539.841902371623;10547.103496202908;10585.682429527127;10748.892511075102;10843.45782710877;10852.348859068481;10931.83602245951;11311.547538098714;11331.886681133083;11381.886181138083;7547.358474529507;7598.202188770099;7653;7734.419918506247;7861.764147075597;10761.569537218737;10875.564977400816;10906.563737450413;10913.454327283764;10983 21:42:24 INFO - PROCESS | 6981 | |3;mootools.html;1353.5533274019574;1483.9554813355603;1508.3363320139138;1647.983520164798;1823.261579060481;7908.2487163719425;8768.517731524771;9015.954920225406;9032.50321232332;9267.443953362786;9069.95465022674;9128.817423651522;9158.771030724218;9166.724998250047;9169.908300916988;2386.296042667413;2411.8914648840846;2413.806895448369;2416.1060407649106;2418.2866054513875;2331.7901388875;2361.5867223235864;2407.8555286682767;2411.8432301900407;2415.8792060397;2313.849599776009;2340.262817212581;2343.1096183450263;2345.0736958901225;2354.517323948595;2243.14760391052;2270.4664403865077;2279;2281.7490076091617;2329.138218859016;2282.733083138857;2283.6003699352545;2285.931422057341;2288.336382449088;2293.1056887813766;8999.460032398012;9100.544972751402;9114.908850911472;9186.586603602855;9206.585703643284;5367.087595108841;5606.523445507137;5607.467290607386;5608.327000759894;5620.241267428926;3680.429533422324;3696.852125914987;3717.256548690246;3801.0877389426614;3805.06775839921;1152.2913408253946;1182.308349615476;1186.5313201285444;1204.482072708735;2181.8399784213675;12285.508579656804;12454.065945054066;12824;12862.678433039062;12872.22766634005;4922.458529561745;4963.950360496421;5061.367329083864;5061.898762024739;5104.387473503203;10908.127349811995;10922.945385273182;10924.235303528676;10925.617603384002;10952.4523773811;5651.9152212716845;5654.236678048493;5656.179853921159;5657.462541058593;5657.547396208376;4292.463442069741;4536.5236650151255;4685.484596694361;5044.218146187273;5112.006317536164;3994.4807175067635;4063.1264278180333;4133.524644665842;4141.81361838718;4225.556316586775;1328.8538260791306;1335.419092694681;1338.9933050334687;1348.9797653035212;1356.0710913024413;889.7241855024834;947.9478628675489;985.3250523391499;988.1156365053237;1026.3174988632475;5819.330776960619;6144.324124346318;6155.815325540241;6190.226221722285;6281.403266689748;452.80981987565303;461.5684335146649;466.9696469729525;480.5002797090986;488.64084897600236;4050.23045621331;4165.937510937339;4256.787160641956;4258.1696569169335;4284.91430171401;10997.725056873642;11280.492377843017;11312.095032397388;11387.430628468543;11402.885971140182;10507.31702439339;10976.396298203676;11184.888151118548;11188.832167517494;11215.43922803873;8205.302549283258;8442.409031367746;8443;8446.746597602081;8449.36629752771;6085.391460853879;6257.5932564383165;6315.810525684236;6349.599619440209;6398.808035758934;10417.739556511147;10579.788404231718;10596.20528460384;10625.734356641145;10765.946170269099;9164.541772911462;9305.534723263674;10005.249606279704;10276.023777741102;10754.946225269137;7601.885971710318;8053.758387248392;8056.154103819014;8059.717909873127;8060.83878322442;8337.499750015018;8623.267022303175;8697.91302086971;8869.68956086534;8971.32715046361;7814.062312522534;7883.172266911892;7973.202679732212;8015.398845086525;8037.276645101969;7352.228016058237;7388.889166662612;7682.923170768444;7732.9226707732205;7811.101723301893;7149.892751608626;7238.8914166286495;7251.274872512707;7253.419726421979;7258.383037441877;5204.869878253074;5231.346081739783;5254.6847189168775;5399.082156033405;5582.553395728413;5353.330833645794;5362.115250983544;5362.839114826562;5429.782808687766;5477.67133971963 21:42:24 INFO - PROCESS | 6981 | |4;prototype.html;332.96836800503957;348.23736018120314;350.0077280908625;355.5537800060923;356.21276977878887;5211.296474975882;5220.243064755608;5228.954209158174;5245.160774276116;5276.15581506959;4923.729194894279;5002.374703162105;5086.898262034766;5110.105731496982;5231.947680523193;4078.3066878630702;4103.569125241844;4108.897277568055;4126.668432335736;4143.233501802161;4102.405151253067;4116.217918595457;4142.295809712341;4167.812448439812;4177.665786737054;3837.5417341410366;3931.9606803932024;4091.6112969267874;4130.038231839882;4133.607307305816;4059.8985025374304;4067.5525692173837;4088.7955602219918;4100.605794030014;4122.835086596532;3692.7599706019023;3693.649103335179;3699.3896007158787;3701.3152566774966;3709.8330575124182;4982.676126051795;5019.19692849146;5020.623453241022;5113.974430127862;5132.612475765976;4655.627549796042;4668.276417155346;4676.789544470507;4687.179743544866;4687.789049492781;5366.838994830161;5368.731563421852;5372.328458942632;5399.487048730364;5430.59270554706;3746.850125994957;3937.960620393788;4025.1144748155357;4031.3549832026733;4043.73715708478;5588.636738611977;5599.376180907532;5600;5612.550995920357;5615.5507559395555;4051.513818341818;4058.5794971759647;4062.1672557125717;4072.2873497137884;4094.733842300241;3920.666743326849;4134.1731653669385;4134.751914885116;4139.875803725893;4142.668586513072;4619.95380046202;4629.791659375336;4638.141943740419;4673.766311684402;4679.555442232982;5401.623985009369;5409.486098820606;5414.485623865805;5431.972840135853;5509.669419834822;1379.4551152294787;1409.59121854661;1428.1859340176;1434.397553027731;1435.167602790379;901.5537309032071;921.870938068671;926.0507979321115;929.8651695504115;935.0555938502162;4643.721376717408;4655.579098868569;4673.649476289292;4703.858884233478;4706.3411122442885;4501.3248012797685;4879.975205206875;4903.779329930162;4907.386576677915;4914.33656456381;4621.827740961742;4639.399407204509;4645.535446455395;4656.464506581787;4674.813007479663;2611.4907593019557;2611.595202743578;2612.20327800019;2617.7120516743144;2618.279973007438;4942.57988071018;5016.774245158977;5047.4952504749235;5095.8726031848755;5109.978004399135;4950.925736113961;4964.088825802092;4977.328060711758;4977.975110124498;4984.601231901439;4958.256261560723;5014.297998280171;5044.747762611854;5073.619478539124;5082.009008243357;4523.4797998229305;4801.351817504592;4833.468318485035;4839.830605928775;4850.80596776125;4852.223644216909;4858.368412106403;4865.343178670834;4888.193448081169;4899.877503062452;4996.750162491788;5015.448300686994;5041.596672266137;5101.642884998015;5122.565681609155;3540.5574303212097;3610.765300255475;3678.3378991781738;3686.391745361985;3698.926021479609;4798.632389769039;5199.818006369759;5305.628605997697;5378.946210537844;5502;5333.78664853417;5393;5393.788546695836;5413.891722165614;5420.100246368174;5140.509252316786;5343.332083489564;5364.283429302585;5377.311344327836;5415.891682166413;5247.265382846481;5247.763850626808;5285.524302812765;5308.867278317918;5335.386430560535;5411.675299482044;5414.756335964812;5433.8369848904595;5437.4562543745305;5470.425605311544;5081.8475445736685;5209.7395130244095;5307.946920530745;5340.572754179579;5348.448949804513 21:42:24 INFO - PROCESS | 6981 | |5;yui.html;711.8718630646483;734.7391675955035;736.5323019882374;737.7049180327868;776.7436745873862;13948.302584870755;14233.64415889602;14253.857461425383;14332.785008224871;14450.277486125704;13329;13357.666058348546;13367.532136375228;13372.732545349112;13390.531331403403;665.9234188068385;807.1242701668682;828.3952714518405;829.9709510167145;830.3232865214861;687.663045107896;780.5472825761045;799.5402643479994;805.1867613710136;812.5246730662569;847.5380917400001;850.6172222499869;852.7186028610574;852.778277647813;853.0232883348593;695.8782213112736;843.6625349860075;847.4364547575855;847.8558645030329;848.7114381110421;521.9478052194788;603.1917230910601;611.8684482836212;612.1063247658424;618.1315252070848;14609.488667896572;14668;14672.92663536686;14674.413023479156;14686.485972991;13704.588862334145;14395.496157634432;14711;14832.258387080603;15036.548903532912;12092.33492157931;12186.634400967985;12319.93840030803;12400.635930047687;12523.56167534141;4441.489228738672;4456.509783923798;4496.2581174106235;4505.3917721107555;4550.68145229834;80326.19673803245;85607;85785.57107214487;86295.13704862933;86684;11498.367589782642;11524.481398337095;11595.76808463826;11864.822027669592;12326.876731232753;22296.21963231279;22297.77702222957;22329.776702233095;22340;22443.551128977328;8526.65893364271;8533.658653653783;8681.739547813575;8727.519986400808;9100.362974591715;4457.197704413236;4515.729056256635;4732.976335118371;4780.545848144421;4805.591524720368;3653.1962968146963;3752.512173417438;3758.1356288053903;3777.490038844721;3779.8110094495164;621.8849512840048;640.3564417760215;642.3961476212439;646.1599920103846;647.439964430764;677.9864402712017;689.4828878341244;691.9342662447059;696.7979286007002;711.9572825630376;8698.347623928104;9334;9370.62517499306;9416.152546270732;9631.422114673001;541.9620626556182;544.2978557660653;655.8130932684162;655.8294843340766;717.5730440387961;4327.350897365421;4610.838620648261;4637.86086417408;4682.180618391768;4798;94394.5280273608;99167;99534;109266;111119;95150.52424737831;96805.51597241969;96823.51588242014;98086.87305975266;101311;54870.72564637151;72192.27807721961;82369.58815205886;85977;86459.56770216109;9436.764080898032;9512.952435238056;9843;10008.299662546631;10066.848997265193;50634.49365506298;50691.49308506868;51249.23126153036;52368;52454.73772631113;72632.27367726466;74135;75393;75588;78118;12586.748265034832;12608.621741347773;12608.74782504363;12737.55418560383;12976.545820896223;13743.312834358441;14339.713205735618;14560.781588276397;14689.779653304995;14739.92630036843;10668;13814.37835297394;13859.930700346435;13949.790753138914;14020.789688154482;13188.87756876957;13568.864311357154;13907.30463476802;14018.439262429796;14243.145411275356;12342.321172335607;12491.562795302121;12622.621321360373;12628.179168354027;13102.541411050568;10675.957631602567;10688.25182237236;10708.357498550113;11354.489047993025;11389.373584452935;10051.949740251252;10633.734156645836;11589.768204636028;11930.821037684615;12059.397030148633 21:42:24 INFO - PROCESS | 6981 | __end_tp_report 21:42:24 INFO - PROCESS | 6981 | __start_cc_report 21:42:24 INFO - PROCESS | 6981 | _x_x_mozilla_cycle_collect,1461 21:42:24 INFO - PROCESS | 6981 | __end_cc_report 21:42:24 INFO - PROCESS | 6981 | __startTimestamp1475642544285__endTimestamp 21:42:24 INFO - PROCESS | 6981 | 21:42:24 INFO - PROCESS | 6981 | ------- Summary: start ------- 21:42:24 INFO - PROCESS | 6981 | Number of tests: 6 21:42:24 INFO - PROCESS | 6981 | 21:42:24 INFO - PROCESS | 6981 | [#0] dojo.html Cycles:165 Average:5252.76 Median:5417.51 stddev:588.28 (10.9%) stddev-sans-first:563.43 21:42:24 INFO - PROCESS | 6981 | Values: 3020.8 3049.1 3049.5 3088.7 3103.4 5063.1 5099.8 5180.2 5219.2 5269.2 5138.3 5159.2 5165.0 5375.1 5444.5 4895.0 4920.3 4942.7 4960.3 4972.6 4861.0 4880.7 4934.7 4939.6 4979.4 4980.5 4986.6 5034.3 5038.5 5040.6 4854.0 4897.7 4899.0 4921.4 4933.0 4622.4 4648.2 4786.6 4800.9 4823.0 5083.6 5125.6 5130.6 5155.4 5164.2 5566.2 5570.2 5574.1 5587.9 5631.8 5395.7 5413.2 5591.5 5653.7 5710.1 5319.6 5335.6 5342.5 5344.8 5387.4 5842.9 5853.2 5856.5 5856.7 5856.8 5326.1 5393.1 5472.4 5510.3 5607.5 5600.4 5609.9 5611.3 5665.8 5677.1 5578.6 5582.4 5587.6 5592.6 5655.3 5378.0 5488.7 5504.8 5587.1 5592.3 4293.2 4338.5 4339.1 4339.7 4341.4 3830.7 3853.9 3900.9 3905.7 3918.0 5274.8 5276.7 5283.7 5288.1 5329.3 5531.2 5575.1 5576.9 5594.4 5598.0 5199.7 5255.2 5288.3 5362.6 5364.6 4871.3 4899.0 4909.6 4913.1 4942.0 5940.9 5946.2 5947.6 5949.7 6005.7 5497.1 5552.8 5640.6 5673.2 5722.1 6003.9 6007.0 6029.5 6057.6 6068.7 5638.7 5645.1 5646.5 5647.6 5648.2 5463.5 5515.8 5729.4 5742.1 5743.3 5507.5 5526.6 5532.2 5576.6 5641.0 5446.6 5546.9 5551.8 5561.5 5561.7 5319.2 5517.6 5522.8 5523.9 5586.9 5429.4 5505.1 5517.4 5517.8 5522.3 5409.9 5410.2 5417.5 5420.1 5425.7 21:42:24 INFO - PROCESS | 6981 | 21:42:24 INFO - PROCESS | 6981 | [#1] ext.html Cycles:180 Average:57382.85 Median:39745.60 stddev:108765.71 (273.7%) stddev-sans-first:108987.18 21:42:24 INFO - PROCESS | 6981 | Values: 567.5 598.0 606.7 613.4 626.3 31582.7 34456.7 34528.5 34542.3 34584.3 35081.5 43986.3 45161.8 45237.3 48955.5 8903.9 8995.9 9037.7 9048.7 9050.5 8776.0 8847.7 8863.8 8872.1 8872.3 8085.9 8212.5 8212.9 8380.0 10699.0 10534.3 10939.7 10945.7 10947.1 10955.3 10632.3 10697.3 10699.9 10706.2 10750.3 42377.4 42765.6 42777.1 42816.8 42855.1 3461.0 3586.9 3624.6 3917.1 4001.4 31163.0 31440.8 31505.4 31545.8 33314.2 4252.3 4445.8 4502.2 4506.6 4523.0 334032.0 334519.0 334519.0 335010.0 336391.0 59640.7 59716.7 59878.7 59896.0 59953.0 61580.0 62277.0 62602.7 62884.4 62907.0 15267.0 15535.1 15582.5 15589.4 15589.7 11572.4 11653.9 11740.5 11742.2 11750.2 15416.7 17907.7 18031.7 18063.8 18321.2 5376.1 6078.8 6258.3 6328.8 6375.1 922.1 974.5 1054.6 1078.3 1097.7 30050.5 31758.2 31855.2 31867.0 32587.8 1011.9 1052.1 1061.5 1080.7 1168.2 15811.8 16943.3 16984.9 16987.2 17077.0 457231.0 461883.0 462549.0 464033.0 464070.0 57281.4 57777.7 57888.0 58060.7 58190.7 1199.9 1214.3 1295.2 1323.3 1346.8 29651.1 32647.3 32789.8 32850.8 33443.8 49986.0 53808.0 55430.4 55547.4 60297.4 424924.0 427227.0 428376.0 429141.0 429274.0 27609.2 27892.4 28094.9 28463.9 28908.3 46351.1 46351.3 47896.0 49779.0 50840.5 39672.4 39877.8 40884.6 40946.8 41676.4 38523.4 39818.8 39977.8 40136.4 41364.8 40338.0 40999.2 41610.8 41997.4 42042.8 33439.5 36035.2 36411.3 36589.5 36621.5 27552.7 27795.4 27964.6 27998.4 28122.2 21:42:24 INFO - PROCESS | 6981 | 21:42:24 INFO - PROCESS | 6981 | [#2] jquery.html Cycles:180 Average:26907.60 Median:2474.78 stddev:71775.49 (2900.3%) stddev-sans-first:71949.21 21:42:24 INFO - PROCESS | 6981 | Values: 382.5 401.1 408.9 411.9 431.2 13314.5 15460.2 19069.3 19344.2 19943.7 17360.7 17426.8 17465.2 17802.0 18892.4 5022.9 5613.5 5835.0 5844.9 5845.6 5616.6 5648.8 5676.2 5679.2 5682.3 5446.5 5631.2 5635.8 5639.2 5640.5 5675.5 5719.8 5720.4 5725.6 5727.7 4933.4 5113.3 5134.6 5139.6 5175.2 22586.5 22686.9 22752.3 22811.4 22872.5 2450.1 2499.5 2721.6 3053.5 3154.5 13194.0 14019.8 14409.8 14775.5 14789.0 1878.1 1910.6 1953.5 1975.8 1984.9 79128.6 80353.0 82169.0 82589.6 82630.6 10202.8 10495.4 10725.4 11166.6 11743.9 15346.1 15357.5 15379.8 15394.2 15409.2 6921.4 7466.7 7475.7 7574.6 7696.6 6865.1 6948.8 7128.7 7243.9 7299.7 6142.8 6534.1 6553.5 6558.7 6635.9 1976.2 2006.5 2011.3 2018.8 2028.2 914.0 945.6 1010.4 1029.1 1042.7 18406.0 19171.0 19204.8 19391.6 19479.1 982.3 998.5 1032.3 1041.3 1051.7 9220.9 10667.8 10934.5 11013.6 11051.4 416789.0 428690.0 439915.0 443965.0 444680.0 72517.0 77185.0 77466.6 77573.2 82560.0 1021.5 1063.3 1081.1 1088.7 1098.4 16013.3 16856.8 17105.4 17214.9 17526.6 37582.8 37880.4 38705.6 45125.8 45660.0 57009.0 57231.4 59346.4 59833.0 60873.0 7375.7 7444.7 7979.8 8025.6 8092.4 11385.8 12238.6 12312.4 12378.6 12591.2 10457.6 10534.9 10695.3 10848.2 11553.1 10539.8 10547.1 10585.7 10748.9 10843.5 10852.3 10931.8 11311.5 11331.9 11381.9 7547.4 7598.2 7653.0 7734.4 7861.8 10761.6 10875.6 10906.6 10913.5 10983.0 21:42:24 INFO - PROCESS | 6981 | 21:42:24 INFO - PROCESS | 6981 | [#3] mootools.html Cycles:180 Average:5968.15 Median:484.57 stddev:3394.94 (700.6%) stddev-sans-first:3386.75 21:42:24 INFO - PROCESS | 6981 | Values: 1353.6 1484.0 1508.3 1648.0 1823.3 7908.2 8768.5 9016.0 9032.5 9267.4 9070.0 9128.8 9158.8 9166.7 9169.9 2386.3 2411.9 2413.8 2416.1 2418.3 2331.8 2361.6 2407.9 2411.8 2415.9 2313.8 2340.3 2343.1 2345.1 2354.5 2243.1 2270.5 2279.0 2281.7 2329.1 2282.7 2283.6 2285.9 2288.3 2293.1 8999.5 9100.5 9114.9 9186.6 9206.6 5367.1 5606.5 5607.5 5608.3 5620.2 3680.4 3696.9 3717.3 3801.1 3805.1 1152.3 1182.3 1186.5 1204.5 2181.8 12285.5 12454.1 12824.0 12862.7 12872.2 4922.5 4964.0 5061.4 5061.9 5104.4 10908.1 10922.9 10924.2 10925.6 10952.5 5651.9 5654.2 5656.2 5657.5 5657.5 4292.5 4536.5 4685.5 5044.2 5112.0 3994.5 4063.1 4133.5 4141.8 4225.6 1328.9 1335.4 1339.0 1349.0 1356.1 889.7 947.9 985.3 988.1 1026.3 5819.3 6144.3 6155.8 6190.2 6281.4 452.8 461.6 467.0 480.5 488.6 4050.2 4165.9 4256.8 4258.2 4284.9 10997.7 11280.5 11312.1 11387.4 11402.9 10507.3 10976.4 11184.9 11188.8 11215.4 8205.3 8442.4 8443.0 8446.7 8449.4 6085.4 6257.6 6315.8 6349.6 6398.8 10417.7 10579.8 10596.2 10625.7 10765.9 9164.5 9305.5 10005.2 10276.0 10754.9 7601.9 8053.8 8056.2 8059.7 8060.8 8337.5 8623.3 8697.9 8869.7 8971.3 7814.1 7883.2 7973.2 8015.4 8037.3 7352.2 7388.9 7682.9 7732.9 7811.1 7149.9 7238.9 7251.3 7253.4 7258.4 5204.9 5231.3 5254.7 5399.1 5582.6 5353.3 5362.1 5362.8 5429.8 5477.7 21:42:24 INFO - PROCESS | 6981 | 21:42:24 INFO - PROCESS | 6981 | [#4] prototype.html Cycles:180 Average:4390.67 Median:4884.08 stddev:1241.85 (25.4%) stddev-sans-first:1207.41 21:42:24 INFO - PROCESS | 6981 | Values: 333.0 348.2 350.0 355.6 356.2 5211.3 5220.2 5229.0 5245.2 5276.2 4923.7 5002.4 5086.9 5110.1 5231.9 4078.3 4103.6 4108.9 4126.7 4143.2 4102.4 4116.2 4142.3 4167.8 4177.7 3837.5 3932.0 4091.6 4130.0 4133.6 4059.9 4067.6 4088.8 4100.6 4122.8 3692.8 3693.6 3699.4 3701.3 3709.8 4982.7 5019.2 5020.6 5114.0 5132.6 4655.6 4668.3 4676.8 4687.2 4687.8 5366.8 5368.7 5372.3 5399.5 5430.6 3746.9 3938.0 4025.1 4031.4 4043.7 5588.6 5599.4 5600.0 5612.6 5615.6 4051.5 4058.6 4062.2 4072.3 4094.7 3920.7 4134.2 4134.8 4139.9 4142.7 4620.0 4629.8 4638.1 4673.8 4679.6 5401.6 5409.5 5414.5 5432.0 5509.7 1379.5 1409.6 1428.2 1434.4 1435.2 901.6 921.9 926.1 929.9 935.1 4643.7 4655.6 4673.6 4703.9 4706.3 4501.3 4880.0 4903.8 4907.4 4914.3 4621.8 4639.4 4645.5 4656.5 4674.8 2611.5 2611.6 2612.2 2617.7 2618.3 4942.6 5016.8 5047.5 5095.9 5110.0 4950.9 4964.1 4977.3 4978.0 4984.6 4958.3 5014.3 5044.7 5073.6 5082.0 4523.5 4801.4 4833.5 4839.8 4850.8 4852.2 4858.4 4865.3 4888.2 4899.9 4996.8 5015.4 5041.6 5101.6 5122.6 3540.6 3610.8 3678.3 3686.4 3698.9 4798.6 5199.8 5305.6 5378.9 5502.0 5333.8 5393.0 5393.8 5413.9 5420.1 5140.5 5343.3 5364.3 5377.3 5415.9 5247.3 5247.8 5285.5 5308.9 5335.4 5411.7 5414.8 5433.8 5437.5 5470.4 5081.8 5209.7 5307.9 5340.6 5348.4 21:42:24 INFO - PROCESS | 6981 | 21:42:24 INFO - PROCESS | 6981 | [#5] yui.html Cycles:180 Average:20342.78 Median:4707.58 stddev:28855.38 (613.0%) stddev-sans-first:28898.67 21:42:24 INFO - PROCESS | 6981 | Values: 711.9 734.7 736.5 737.7 776.7 13948.3 14233.6 14253.9 14332.8 14450.3 13329.0 13357.7 13367.5 13372.7 13390.5 665.9 807.1 828.4 830.0 830.3 687.7 780.5 799.5 805.2 812.5 847.5 850.6 852.7 852.8 853.0 695.9 843.7 847.4 847.9 848.7 521.9 603.2 611.9 612.1 618.1 14609.5 14668.0 14672.9 14674.4 14686.5 13704.6 14395.5 14711.0 14832.3 15036.5 12092.3 12186.6 12319.9 12400.6 12523.6 4441.5 4456.5 4496.3 4505.4 4550.7 80326.2 85607.0 85785.6 86295.1 86684.0 11498.4 11524.5 11595.8 11864.8 12326.9 22296.2 22297.8 22329.8 22340.0 22443.6 8526.7 8533.7 8681.7 8727.5 9100.4 4457.2 4515.7 4733.0 4780.5 4805.6 3653.2 3752.5 3758.1 3777.5 3779.8 621.9 640.4 642.4 646.2 647.4 678.0 689.5 691.9 696.8 712.0 8698.3 9334.0 9370.6 9416.2 9631.4 542.0 544.3 655.8 655.8 717.6 4327.4 4610.8 4637.9 4682.2 4798.0 94394.5 99167.0 99534.0 109266.0 111119.0 95150.5 96805.5 96823.5 98086.9 101311.0 54870.7 72192.3 82369.6 85977.0 86459.6 9436.8 9513.0 9843.0 10008.3 10066.8 50634.5 50691.5 51249.2 52368.0 52454.7 72632.3 74135.0 75393.0 75588.0 78118.0 12586.7 12608.6 12608.7 12737.6 12976.5 13743.3 14339.7 14560.8 14689.8 14739.9 10668.0 13814.4 13859.9 13949.8 14020.8 13188.9 13568.9 13907.3 14018.4 14243.1 12342.3 12491.6 12622.6 12628.2 13102.5 10676.0 10688.3 10708.4 11354.5 11389.4 10051.9 10633.7 11589.8 11930.8 12059.4 21:42:24 INFO - PROCESS | 6981 | -------- Summary: end -------- 21:42:24 INFO - PROCESS | 6981 | 21:42:25 INFO - TEST-INFO | 6981: exit 0 21:42:25 INFO - TEST-OK | dromaeo_css | took 1118359ms 21:42:25 INFO - TEST-START | kraken 21:42:25 INFO - operating with platform_type : linux_ 21:42:25 INFO - Initialising browser for kraken test... 21:42:25 INFO - TEST-INFO | started process 7285 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf7xrDP/profile http://localhost:47618/getInfo.html) 21:42:30 INFO - PROCESS | 7285 | __metrics Screen width/height:1600/1200 21:42:30 INFO - PROCESS | 7285 | colorDepth:24 21:42:30 INFO - PROCESS | 7285 | Browser inner width/height: 1024/697 21:42:30 INFO - PROCESS | 7285 | __metrics 21:42:30 INFO - PROCESS | 7285 | 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" 21:42:30 INFO - PROCESS | 7285 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:42:31 INFO - PROCESS | 7285 | console.error: PushService: 21:42:31 INFO - PROCESS | 7285 | stateChangeProcessEnqueue: Error transitioning state 21:42:31 INFO - PROCESS | 7285 | UnknownError 21:42:31 INFO - TEST-INFO | 7285: exit 0 21:42:31 INFO - Browser initialized. 21:42:31 INFO - Running cycle 1/1 for kraken test... 21:42:31 INFO - TEST-INFO | started process 7367 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf7xrDP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:42:44 INFO - PROCESS | 7367 | RSS: Main: 173826048 21:42:44 INFO - PROCESS | 7367 | 21:42:46 INFO - PROCESS | 7367 | Cycle 1(1): loaded http://localhost:47618/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47618/tests/kraken/driver.html?testName=audio-beat-detection) 21:42:47 INFO - PROCESS | 7367 | RSS: Main: 233291776 21:42:47 INFO - PROCESS | 7367 | 21:42:50 INFO - PROCESS | 7367 | Cycle 1(1): loaded http://localhost:47618/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47618/tests/kraken/driver.html?testName=audio-dft) 21:42:50 INFO - PROCESS | 7367 | RSS: Main: 217473024 21:42:50 INFO - PROCESS | 7367 | 21:42:53 INFO - PROCESS | 7367 | Cycle 1(1): loaded http://localhost:47618/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47618/tests/kraken/driver.html?testName=audio-fft) 21:42:54 INFO - PROCESS | 7367 | RSS: Main: 300011520 21:42:54 INFO - PROCESS | 7367 | 21:42:56 INFO - PROCESS | 7367 | Cycle 1(1): loaded http://localhost:47618/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47618/tests/kraken/driver.html?testName=audio-oscillator) 21:42:57 INFO - PROCESS | 7367 | RSS: Main: 211218432 21:42:57 INFO - PROCESS | 7367 | 21:42:59 INFO - PROCESS | 7367 | Cycle 1(1): loaded http://localhost:47618/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47618/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:42:59 INFO - PROCESS | 7367 | RSS: Main: 213544960 21:42:59 INFO - PROCESS | 7367 | 21:43:02 INFO - PROCESS | 7367 | Cycle 1(1): loaded http://localhost:47618/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47618/tests/kraken/driver.html?testName=imaging-darkroom) 21:43:03 INFO - PROCESS | 7367 | RSS: Main: 250011648 21:43:03 INFO - PROCESS | 7367 | 21:43:06 INFO - PROCESS | 7367 | Cycle 1(1): loaded http://localhost:47618/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47618/tests/kraken/driver.html?testName=imaging-desaturate) 21:43:07 INFO - PROCESS | 7367 | RSS: Main: 248655872 21:43:07 INFO - PROCESS | 7367 | 21:43:10 INFO - PROCESS | 7367 | Cycle 1(1): loaded http://localhost:47618/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47618/tests/kraken/driver.html?testName=json-parse-financial) 21:43:10 INFO - PROCESS | 7367 | RSS: Main: 248582144 21:43:10 INFO - PROCESS | 7367 | 21:43:12 INFO - PROCESS | 7367 | Cycle 1(1): loaded http://localhost:47618/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47618/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:43:12 INFO - PROCESS | 7367 | RSS: Main: 211066880 21:43:12 INFO - PROCESS | 7367 | 21:43:14 INFO - PROCESS | 7367 | Cycle 1(1): loaded http://localhost:47618/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47618/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:43:15 INFO - PROCESS | 7367 | RSS: Main: 218718208 21:43:15 INFO - PROCESS | 7367 | 21:43:17 INFO - PROCESS | 7367 | Cycle 1(1): loaded http://localhost:47618/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47618/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:43:17 INFO - PROCESS | 7367 | RSS: Main: 228478976 21:43:17 INFO - PROCESS | 7367 | 21:43:20 INFO - PROCESS | 7367 | Cycle 1(1): loaded http://localhost:47618/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47618/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:43:21 INFO - PROCESS | 7367 | RSS: Main: 237379584 21:43:21 INFO - PROCESS | 7367 | 21:43:24 INFO - PROCESS | 7367 | Cycle 1(1): loaded http://localhost:47618/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47618/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:43:24 INFO - PROCESS | 7367 | RSS: Main: 233488384 21:43:24 INFO - PROCESS | 7367 | 21:43:26 INFO - PROCESS | 7367 | Cycle 1(1): loaded http://localhost:47618/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47618/tests/kraken/driver.html?testName=ai-astar) 21:43:26 INFO - PROCESS | 7367 | RSS: Main: 282337280 21:43:26 INFO - PROCESS | 7367 | 21:43:26 INFO - PROCESS | 7367 | __start_tp_report 21:43:26 INFO - PROCESS | 7367 | _x_x_mozilla_page_load 21:43:26 INFO - PROCESS | 7367 | _x_x_mozilla_page_load_details 21:43:26 INFO - PROCESS | 7367 | |i|pagename|runs| 21:43:26 INFO - PROCESS | 7367 | |0;ai-astar;108;111;111;113;112;111;111;111;109;111 21:43:26 INFO - PROCESS | 7367 | |1;audio-beat-detection;158;121;123;158;127;123;124;123;154;125 21:43:26 INFO - PROCESS | 7367 | |2;audio-dft;161;170;160;160;161;164;162;161;160;163 21:43:26 INFO - PROCESS | 7367 | |3;audio-fft;75;77;77;113;76;77;76;76;98;75 21:43:26 INFO - PROCESS | 7367 | |4;audio-oscillator;82;82;118;82;81;83;103;84;83;114 21:43:26 INFO - PROCESS | 7367 | |5;imaging-gaussian-blur;117;117;116;117;117;118;117;117;118;117 21:43:26 INFO - PROCESS | 7367 | |6;imaging-darkroom;146;147;147;147;146;147;146;147;146;146 21:43:26 INFO - PROCESS | 7367 | |7;imaging-desaturate;95;95;95;95;95;96;95;95;95;94 21:43:26 INFO - PROCESS | 7367 | |8;json-parse-financial;52;51;51;51;52;53;53;53;53;52 21:43:26 INFO - PROCESS | 7367 | |9;json-stringify-tinderbox;61;63;62;62;61;61;60;61;61;62 21:43:26 INFO - PROCESS | 7367 | |10;stanford-crypto-aes;86;79;83;86;90;80;80;88;79;80 21:43:26 INFO - PROCESS | 7367 | |11;stanford-crypto-ccm;132;132;131;131;130;129;132;139;177;128 21:43:26 INFO - PROCESS | 7367 | |12;stanford-crypto-pbkdf2;168;167;165;165;166;172;166;167;168;166 21:43:26 INFO - PROCESS | 7367 | |13;stanford-crypto-sha256-iterative;70;65;66;66;67;67;67;71;74;65 21:43:26 INFO - PROCESS | 7367 | __end_tp_report 21:43:26 INFO - PROCESS | 7367 | __start_cc_report 21:43:26 INFO - PROCESS | 7367 | _x_x_mozilla_cycle_collect,1637 21:43:26 INFO - PROCESS | 7367 | __end_cc_report 21:43:26 INFO - PROCESS | 7367 | __startTimestamp1475642606580__endTimestamp 21:43:26 INFO - PROCESS | 7367 | 21:43:26 INFO - PROCESS | 7367 | ------- Summary: start ------- 21:43:26 INFO - PROCESS | 7367 | Number of tests: 14 21:43:26 INFO - PROCESS | 7367 | 21:43:26 INFO - PROCESS | 7367 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:1.40 (1.3%) stddev-sans-first:1.05 21:43:26 INFO - PROCESS | 7367 | Values: 108.0 111.0 111.0 113.0 112.0 111.0 111.0 111.0 109.0 111.0 21:43:26 INFO - PROCESS | 7367 | 21:43:26 INFO - PROCESS | 7367 | [#1] audio-beat-detection Cycles:10 Average:133.60 Median:126.00 stddev:16.03 (12.7%) stddev-sans-first:14.37 21:43:26 INFO - PROCESS | 7367 | Values: 158.0 121.0 123.0 158.0 127.0 123.0 124.0 123.0 154.0 125.0 21:43:26 INFO - PROCESS | 7367 | 21:43:26 INFO - PROCESS | 7367 | [#2] audio-dft Cycles:10 Average:162.20 Median:161.50 stddev:3.05 (1.9%) stddev-sans-first:3.20 21:43:26 INFO - PROCESS | 7367 | Values: 161.0 170.0 160.0 160.0 161.0 164.0 162.0 161.0 160.0 163.0 21:43:26 INFO - PROCESS | 7367 | 21:43:26 INFO - PROCESS | 7367 | [#3] audio-fft Cycles:10 Average:82.00 Median:76.50 stddev:12.90 (16.9%) stddev-sans-first:13.43 21:43:26 INFO - PROCESS | 7367 | Values: 75.0 77.0 77.0 113.0 76.0 77.0 76.0 76.0 98.0 75.0 21:43:26 INFO - PROCESS | 7367 | 21:43:26 INFO - PROCESS | 7367 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:82.00 stddev:14.61 (17.8%) stddev-sans-first:15.11 21:43:26 INFO - PROCESS | 7367 | Values: 82.0 82.0 118.0 82.0 81.0 83.0 103.0 84.0 83.0 114.0 21:43:26 INFO - PROCESS | 7367 | 21:43:26 INFO - PROCESS | 7367 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 21:43:26 INFO - PROCESS | 7367 | Values: 117.0 117.0 116.0 117.0 117.0 118.0 117.0 117.0 118.0 117.0 21:43:26 INFO - PROCESS | 7367 | 21:43:26 INFO - PROCESS | 7367 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 21:43:26 INFO - PROCESS | 7367 | Values: 146.0 147.0 147.0 147.0 146.0 147.0 146.0 147.0 146.0 146.0 21:43:26 INFO - PROCESS | 7367 | 21:43:26 INFO - PROCESS | 7367 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 21:43:26 INFO - PROCESS | 7367 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 94.0 21:43:26 INFO - PROCESS | 7367 | 21:43:26 INFO - PROCESS | 7367 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.50 stddev:0.88 (1.7%) stddev-sans-first:0.93 21:43:26 INFO - PROCESS | 7367 | Values: 52.0 51.0 51.0 51.0 52.0 53.0 53.0 53.0 53.0 52.0 21:43:26 INFO - PROCESS | 7367 | 21:43:26 INFO - PROCESS | 7367 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:61.50 stddev:0.84 (1.4%) stddev-sans-first:0.88 21:43:26 INFO - PROCESS | 7367 | Values: 61.0 63.0 62.0 62.0 61.0 61.0 60.0 61.0 61.0 62.0 21:43:26 INFO - PROCESS | 7367 | 21:43:26 INFO - PROCESS | 7367 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:84.50 stddev:4.09 (4.8%) stddev-sans-first:4.21 21:43:26 INFO - PROCESS | 7367 | Values: 86.0 79.0 83.0 86.0 90.0 80.0 80.0 88.0 79.0 80.0 21:43:26 INFO - PROCESS | 7367 | 21:43:26 INFO - PROCESS | 7367 | [#11] stanford-crypto-ccm Cycles:10 Average:136.10 Median:132.00 stddev:14.67 (11.1%) stddev-sans-first:15.48 21:43:26 INFO - PROCESS | 7367 | Values: 132.0 132.0 131.0 131.0 130.0 129.0 132.0 139.0 177.0 128.0 21:43:26 INFO - PROCESS | 7367 | 21:43:26 INFO - PROCESS | 7367 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.00 Median:167.00 stddev:2.05 (1.2%) stddev-sans-first:2.15 21:43:26 INFO - PROCESS | 7367 | Values: 168.0 167.0 165.0 165.0 166.0 172.0 166.0 167.0 168.0 166.0 21:43:26 INFO - PROCESS | 7367 | 21:43:26 INFO - PROCESS | 7367 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:67.00 stddev:2.94 (4.4%) stddev-sans-first:3.00 21:43:26 INFO - PROCESS | 7367 | Values: 70.0 65.0 66.0 66.0 67.0 67.0 67.0 71.0 74.0 65.0 21:43:26 INFO - PROCESS | 7367 | -------- Summary: end -------- 21:43:26 INFO - PROCESS | 7367 | 21:43:27 INFO - TEST-INFO | 7367: exit 0 21:43:27 INFO - TEST-OK | kraken | took 62497ms 21:43:27 INFO - SUITE-END | took 1180s 21:43:28 INFO - Completed test suite (00:19:41) 21:43:28 INFO - javascript benchmark 21:43:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3020.8187508749475, 3049.0700336397404, 3049.542568614709, 3088.675689052651, 3103.394838006588, 5063.088644044071, 5099.821506247282, 5180.1970694542315, 5219.164933610623, 5269.209618557214, 5138.332016837806, 5159.174532074869, 5165.044466773649, 5375.11310633745, 5444.482774136461, 4895.0, 4920.261960705896, 4942.678725882806, 4960.305557221992, 4972.602191824663, 4861.0, 4880.731559764212, 4934.703917764928, 4939.58013568847, 4979.427365852937, 4980.477049909761, 4986.601071914256, 5034.320366750497, 5038.496150384951, 5040.5967522598285, 4853.95146048542, 4897.730624815634, 4899.0, 4921.384826896638, 4933.0, 4622.445306563201, 4648.23304154814, 4786.569208771192, 4800.855974320776, 4823.03539292143, 5083.61872859537, 5125.641205115643, 5130.589552835764, 5155.432902380735, 5164.2253661950635, 5566.192902029224, 5570.2480165177585, 5574.0928320324365, 5587.916181257285, 5631.831045068613, 5395.7032363220005, 5413.160960051198, 5591.496765291103, 5653.745581448845, 5710.14347847822, 5319.601029922771, 5335.626506144533, 5342.545883599938, 5344.839654810362, 5387.4073851876265, 5842.912356314659, 5853.239078919713, 5856.502197313276, 5856.677882716492, 5856.765729370863, 5326.094563924142, 5393.110136827458, 5472.425395333512, 5510.283663123768, 5607.467290607386, 5600.35595906476, 5609.915851262234, 5611.3266408031295, 5665.773369065191, 5677.063284558084, 5578.637388569811, 5582.385937546866, 5587.580931430159, 5592.5805564582815, 5655.293088363955, 5377.973110134502, 5488.725563721798, 5504.779808807683, 5587.1339942309005, 5592.2730045094695, 4293.162833247549, 4338.457692788402, 4339.132173565236, 4339.652827773771, 4341.39220509129, 3830.6743926766535, 3853.9036524087123, 3900.863469778601, 3905.72659913809, 3918.0, 5274.789008439696, 5276.709780962007, 5283.735813209324, 5288.0745869472685, 5329.333833270841, 5531.225628412026, 5575.107982722745, 5576.944230557642, 5594.384617692051, 5598.0, 5199.688018718889, 5255.211718242218, 5288.2596436498925, 5362.570994320445, 5364.570834333244, 4871.318015477836, 4898.951010489921, 4909.604239932651, 4913.11563918491, 4942.036302920896, 5940.8811823764145, 5946.226990491295, 5947.6431414115295, 5949.732262048132, 6005.729742161613, 5497.065498865282, 5552.750126244409, 5640.633358831663, 5673.205751194753, 5722.084466485342, 6003.90994135097, 6007.0, 6029.487493563096, 6057.606255593372, 6068.7269072892705, 5638.746256418389, 5645.125005624135, 5646.548276137817, 5647.576431767716, 5648.23748793924, 5463.48096930791, 5515.806946756844, 5729.427057294237, 5742.0812669974275, 5743.310802703702, 5507.531859791802, 5526.557875370041, 5532.2254884317035, 5576.637518561281, 5641.0, 5446.645968012067, 5546.889062218814, 5551.750171242385, 5561.527270181918, 5561.694106824163, 5319.202119682079, 5517.641353312022, 5522.751476183501, 5523.8895222096135, 5586.86032849182, 5429.375621803385, 5505.064139096283, 5517.420670829505, 5517.834464966058, 5522.2544956430365, 5409.945900540944, 5410.242566040679, 5417.51242388187, 5420.078586640359, 5425.701586412785], "value": 5213.710239558016, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.5289509706944, 597.9760809567616, 606.6602702486608, 613.4172536090715, 626.2735227136521, 31582.68417315826, 34456.65543344566, 34528.48207276893, 34542.30915381694, 34584.30831383371, 35081.47377789329, 43986.34020489695, 45161.77419112908, 45237.32144017842, 48955.51044489554, 8903.866442003391, 8995.910040899606, 9037.683681071163, 9048.728538143834, 9050.456972581665, 8776.0, 8847.690330838423, 8863.77840553988, 8872.11278872114, 8872.334574906876, 8085.919140808575, 8212.46618969768, 8212.917870821275, 8379.95810020952, 10699.0, 10534.315269507457, 10939.671809845717, 10945.726356841064, 10947.069499092586, 10955.287906286067, 10632.255742098056, 10697.304675196086, 10699.893001069968, 10706.197035222312, 10750.301230420077, 42377.36433953493, 42765.57234427647, 42777.144457111, 42816.785916070534, 42855.14289714188, 3460.9826950865336, 3586.946195807065, 3624.6012938576737, 3917.099067214528, 4001.3994402239045, 31163.0, 31440.842795786102, 31505.369892602248, 31545.84227078873, 33314.16714582131, 4252.340887162464, 4445.8221671133115, 4502.189605870942, 4506.616937560311, 4522.9547704522865, 334032.0, 334518.99999999756, 334519.0, 335010.0, 336391.0, 59640.70179649074, 59716.70141649351, 59878.70060649756, 59896.0, 59953.0, 61580.0, 62277.0, 62602.686986565684, 62884.37115628877, 62907.0, 15267.0, 15535.145566993924, 15582.454614088452, 15589.376424943102, 15589.68820623581, 11572.42137893102, 11653.941730291293, 11740.471678774476, 11742.17804753659, 11750.177487575787, 15416.691666166615, 17907.73138402925, 18031.72952405715, 18063.819361806476, 18321.17554710041, 5376.1398176291605, 6078.787242446493, 6258.3428739982555, 6328.841778955563, 6375.075614035939, 922.110163692027, 974.5224839828433, 1054.620336678795, 1078.2991055813627, 1097.7475180708482, 30050.54924176139, 31758.2060448486, 31855.203619909225, 31867.0, 32587.837060814545, 1011.9342242754198, 1052.1057101463696, 1061.4745700878116, 1080.7460246841986, 1168.193946177135, 15811.841881581267, 16943.322267109423, 16984.915075424542, 16987.150642467826, 17077.045667140228, 457231.0, 461883.0, 462549.0, 464033.0, 464070.0, 57281.42718572761, 57777.711111445016, 57888.0, 58060.709696451246, 58190.709046454496, 1199.9280043197436, 1214.271437137728, 1295.164618820874, 1323.2788130468919, 1346.8249127613346, 29651.110466686034, 32647.347053059282, 32789.83605081959, 32850.83574582112, 33443.832780836914, 49986.0, 53808.0, 55430.44569554253, 55547.44452555423, 60297.397026029175, 424924.0, 427227.0, 428376.0, 429141.0, 429274.0, 27609.23907609223, 27892.442151156458, 28094.85952570224, 28463.857680711462, 28908.27729306784, 46351.11635251613, 46351.30473042974, 47896.0, 49779.0, 50840.49159508358, 39672.40491392689, 39877.80061099676, 40884.59115408808, 40946.79526602348, 41676.374854376605, 38523.42214866723, 39818.80090599528, 39977.80011099926, 40136.39795403013, 41364.79317603393, 40338.0, 40999.18001639891, 41610.79194604007, 41997.37003945004, 42042.789786050875, 33439.49840752439, 36035.19824008737, 36411.27177456383, 36589.451158232114, 36621.450678239315, 27552.724472755017, 27795.44409111766, 27964.580531292453, 27998.44003119967, 28122.156335309974], "value": 19870.568509678928, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.47027866405057, 401.141557067875, 408.89164371441575, 411.85585045234166, 431.18075656253114, 13314.533991310294, 15460.226988650578, 19069.332573359952, 19344.22623095078, 19943.700844487306, 17360.652786944254, 17426.82573174268, 17465.214065367058, 17802.0, 18892.433227003214, 5022.949770502303, 5613.46672066154, 5835.0, 5844.853878653046, 5845.56158288128, 5616.5787565932715, 5648.802291919784, 5676.205331253628, 5679.204911312419, 5682.26130603021, 5446.482584154499, 5631.239782629354, 5635.802746903859, 5639.210510528509, 5640.5487560995025, 5675.5459563234845, 5719.799807006735, 5720.370759216483, 5725.599208055459, 5727.713614319288, 4933.383327084114, 5113.335266415343, 5134.563562097189, 5139.614528910347, 5175.223716442526, 22586.548269034527, 22686.886565567067, 22752.317430477113, 22811.42971425711, 22872.542549148922, 2450.0812195426715, 2499.4751102268547, 2721.5917612358107, 3053.4656435123766, 3154.542591324268, 13194.0, 14019.789703154462, 14409.78385324221, 14775.482858099915, 14789.0, 1878.117284876106, 1910.551020510179, 1953.5213872601303, 1975.8221760041665, 1984.9305274315475, 79128.60435697784, 80353.0, 82169.0, 82589.58705206496, 82630.58684706598, 10202.795944081077, 10495.370277783204, 10725.356478611307, 11166.609168679057, 11743.941280293544, 15346.079235245921, 15357.462488812838, 15379.846201538065, 15394.15332156742, 15409.224739938787, 6921.446284297244, 7466.738664146729, 7475.738349157753, 7574.573563155362, 7696.576688282198, 6865.112094174042, 6948.783863950999, 7128.714851405989, 7243.89134162988, 7299.656704260956, 6142.815715528452, 6534.132071606684, 6553.541252112402, 6558.704858281293, 6635.9336406636285, 1976.150255390196, 2006.4682859042366, 2011.309247530768, 2018.7880272571463, 2028.2495476673726, 913.9862902056475, 945.6359301668907, 1010.408910787183, 1029.089256008423, 1042.7393151712072, 18406.0, 19171.0, 19204.807951920582, 19391.612167756564, 19479.12343944526, 982.3467394182932, 998.510729742421, 1032.2670903658486, 1041.317936751429, 1051.747580580655, 9220.861687074565, 10667.83998240027, 10934.507947142398, 11013.6145234918, 11051.392173430379, 416789.0, 428690.0, 439915.0, 443965.0, 444680.0, 72517.0, 77185.0, 77466.6126669363, 77573.22426775773, 82560.0, 1021.4892553723139, 1063.31416236527, 1081.1350919264557, 1088.711491454765, 1098.3958822647512, 16013.279402427152, 16856.831431685525, 17105.401310954057, 17214.913925430294, 17526.649467010844, 37582.8120859394, 37880.43179352257, 38705.6129438702, 45125.77437112793, 45660.0, 57009.0, 57231.42768572261, 59346.406535935814, 59833.0, 60873.0, 7375.668094935848, 7444.664990075568, 7979.840403191787, 8025.5585942773705, 8092.393070519853, 11385.829212561652, 12238.632841014783, 12312.445939932546, 12378.62864114078, 12591.24452532851, 10457.581696732046, 10534.947325263325, 10695.251332406657, 10848.240623156304, 11553.13351498624, 10539.841902371623, 10547.103496202908, 10585.682429527127, 10748.892511075102, 10843.45782710877, 10852.348859068481, 10931.83602245951, 11311.547538098714, 11331.886681133083, 11381.886181138083, 7547.358474529507, 7598.202188770099, 7653.0, 7734.419918506247, 7861.764147075597, 10761.569537218737, 10875.564977400816, 10906.563737450413, 10913.454327283764, 10983.0], "value": 9095.852555502011, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1353.5533274019574, 1483.9554813355603, 1508.3363320139138, 1647.983520164798, 1823.261579060481, 7908.2487163719425, 8768.517731524771, 9015.954920225406, 9032.50321232332, 9267.443953362786, 9069.95465022674, 9128.817423651522, 9158.771030724218, 9166.724998250047, 9169.908300916988, 2386.296042667413, 2411.8914648840846, 2413.806895448369, 2416.1060407649106, 2418.2866054513875, 2331.7901388875, 2361.5867223235864, 2407.8555286682767, 2411.8432301900407, 2415.8792060397, 2313.849599776009, 2340.262817212581, 2343.1096183450263, 2345.0736958901225, 2354.517323948595, 2243.14760391052, 2270.4664403865077, 2279.0, 2281.7490076091617, 2329.138218859016, 2282.733083138857, 2283.6003699352545, 2285.931422057341, 2288.336382449088, 2293.1056887813766, 8999.460032398012, 9100.544972751402, 9114.908850911472, 9186.586603602855, 9206.585703643284, 5367.087595108841, 5606.523445507137, 5607.467290607386, 5608.327000759894, 5620.241267428926, 3680.429533422324, 3696.852125914987, 3717.256548690246, 3801.0877389426614, 3805.06775839921, 1152.2913408253946, 1182.308349615476, 1186.5313201285444, 1204.482072708735, 2181.8399784213675, 12285.508579656804, 12454.065945054066, 12824.0, 12862.678433039062, 12872.22766634005, 4922.458529561745, 4963.950360496421, 5061.367329083864, 5061.898762024739, 5104.387473503203, 10908.127349811995, 10922.945385273182, 10924.235303528676, 10925.617603384002, 10952.4523773811, 5651.9152212716845, 5654.236678048493, 5656.179853921159, 5657.462541058593, 5657.547396208376, 4292.463442069741, 4536.5236650151255, 4685.484596694361, 5044.218146187273, 5112.006317536164, 3994.4807175067635, 4063.1264278180333, 4133.524644665842, 4141.81361838718, 4225.556316586775, 1328.8538260791306, 1335.419092694681, 1338.9933050334687, 1348.9797653035212, 1356.0710913024413, 889.7241855024834, 947.9478628675489, 985.3250523391499, 988.1156365053237, 1026.3174988632475, 5819.330776960619, 6144.324124346318, 6155.815325540241, 6190.226221722285, 6281.403266689748, 452.80981987565303, 461.5684335146649, 466.9696469729525, 480.5002797090986, 488.64084897600236, 4050.23045621331, 4165.937510937339, 4256.787160641956, 4258.1696569169335, 4284.91430171401, 10997.725056873642, 11280.492377843017, 11312.095032397388, 11387.430628468543, 11402.885971140182, 10507.31702439339, 10976.396298203676, 11184.888151118548, 11188.832167517494, 11215.43922803873, 8205.302549283258, 8442.409031367746, 8443.0, 8446.746597602081, 8449.36629752771, 6085.391460853879, 6257.5932564383165, 6315.810525684236, 6349.599619440209, 6398.808035758934, 10417.739556511147, 10579.788404231718, 10596.20528460384, 10625.734356641145, 10765.946170269099, 9164.541772911462, 9305.534723263674, 10005.249606279704, 10276.023777741102, 10754.946225269137, 7601.885971710318, 8053.758387248392, 8056.154103819014, 8059.717909873127, 8060.83878322442, 8337.499750015018, 8623.267022303175, 8697.91302086971, 8869.68956086534, 8971.32715046361, 7814.062312522534, 7883.172266911892, 7973.202679732212, 8015.398845086525, 8037.276645101969, 7352.228016058237, 7388.889166662612, 7682.923170768444, 7732.9226707732205, 7811.101723301893, 7149.892751608626, 7238.8914166286495, 7251.274872512707, 7253.419726421979, 7258.383037441877, 5204.869878253074, 5231.346081739783, 5254.6847189168775, 5399.082156033405, 5582.553395728413, 5353.330833645794, 5362.115250983544, 5362.839114826562, 5429.782808687766, 5477.67133971963], "value": 4707.838755911482, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.96836800503957, 348.23736018120314, 350.0077280908625, 355.5537800060923, 356.21276977878887, 5211.296474975882, 5220.243064755608, 5228.954209158174, 5245.160774276116, 5276.15581506959, 4923.729194894279, 5002.374703162105, 5086.898262034766, 5110.105731496982, 5231.947680523193, 4078.3066878630702, 4103.569125241844, 4108.897277568055, 4126.668432335736, 4143.233501802161, 4102.405151253067, 4116.217918595457, 4142.295809712341, 4167.812448439812, 4177.665786737054, 3837.5417341410366, 3931.9606803932024, 4091.6112969267874, 4130.038231839882, 4133.607307305816, 4059.8985025374304, 4067.5525692173837, 4088.7955602219918, 4100.605794030014, 4122.835086596532, 3692.7599706019023, 3693.649103335179, 3699.3896007158787, 3701.3152566774966, 3709.8330575124182, 4982.676126051795, 5019.19692849146, 5020.623453241022, 5113.974430127862, 5132.612475765976, 4655.627549796042, 4668.276417155346, 4676.789544470507, 4687.179743544866, 4687.789049492781, 5366.838994830161, 5368.731563421852, 5372.328458942632, 5399.487048730364, 5430.59270554706, 3746.850125994957, 3937.960620393788, 4025.1144748155357, 4031.3549832026733, 4043.73715708478, 5588.636738611977, 5599.376180907532, 5600.0, 5612.550995920357, 5615.5507559395555, 4051.513818341818, 4058.5794971759647, 4062.1672557125717, 4072.2873497137884, 4094.733842300241, 3920.666743326849, 4134.1731653669385, 4134.751914885116, 4139.875803725893, 4142.668586513072, 4619.95380046202, 4629.791659375336, 4638.141943740419, 4673.766311684402, 4679.555442232982, 5401.623985009369, 5409.486098820606, 5414.485623865805, 5431.972840135853, 5509.669419834822, 1379.4551152294787, 1409.59121854661, 1428.1859340176, 1434.397553027731, 1435.167602790379, 901.5537309032071, 921.870938068671, 926.0507979321115, 929.8651695504115, 935.0555938502162, 4643.721376717408, 4655.579098868569, 4673.649476289292, 4703.858884233478, 4706.3411122442885, 4501.3248012797685, 4879.975205206875, 4903.779329930162, 4907.386576677915, 4914.33656456381, 4621.827740961742, 4639.399407204509, 4645.535446455395, 4656.464506581787, 4674.813007479663, 2611.4907593019557, 2611.595202743578, 2612.20327800019, 2617.7120516743144, 2618.279973007438, 4942.57988071018, 5016.774245158977, 5047.4952504749235, 5095.8726031848755, 5109.978004399135, 4950.925736113961, 4964.088825802092, 4977.328060711758, 4977.975110124498, 4984.601231901439, 4958.256261560723, 5014.297998280171, 5044.747762611854, 5073.619478539124, 5082.009008243357, 4523.4797998229305, 4801.351817504592, 4833.468318485035, 4839.830605928775, 4850.80596776125, 4852.223644216909, 4858.368412106403, 4865.343178670834, 4888.193448081169, 4899.877503062452, 4996.750162491788, 5015.448300686994, 5041.596672266137, 5101.642884998015, 5122.565681609155, 3540.5574303212097, 3610.765300255475, 3678.3378991781738, 3686.391745361985, 3698.926021479609, 4798.632389769039, 5199.818006369759, 5305.628605997697, 5378.946210537844, 5502.0, 5333.78664853417, 5393.0, 5393.788546695836, 5413.891722165614, 5420.100246368174, 5140.509252316786, 5343.332083489564, 5364.283429302585, 5377.311344327836, 5415.891682166413, 5247.265382846481, 5247.763850626808, 5285.524302812765, 5308.867278317918, 5335.386430560535, 5411.675299482044, 5414.756335964812, 5433.8369848904595, 5437.4562543745305, 5470.425605311544, 5081.8475445736685, 5209.7395130244095, 5307.946920530745, 5340.572754179579, 5348.448949804513], "value": 4006.859581607781, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.8718630646483, 734.7391675955035, 736.5323019882374, 737.7049180327868, 776.7436745873862, 13948.302584870755, 14233.64415889602, 14253.857461425383, 14332.785008224871, 14450.277486125704, 13329.0, 13357.666058348546, 13367.532136375228, 13372.732545349112, 13390.531331403403, 665.9234188068385, 807.1242701668682, 828.3952714518405, 829.9709510167145, 830.3232865214861, 687.663045107896, 780.5472825761045, 799.5402643479994, 805.1867613710136, 812.5246730662569, 847.5380917400001, 850.6172222499869, 852.7186028610574, 852.778277647813, 853.0232883348593, 695.8782213112736, 843.6625349860075, 847.4364547575855, 847.8558645030329, 848.7114381110421, 521.9478052194788, 603.1917230910601, 611.8684482836212, 612.1063247658424, 618.1315252070848, 14609.488667896572, 14668.0, 14672.92663536686, 14674.413023479156, 14686.485972991, 13704.588862334145, 14395.496157634432, 14711.0, 14832.258387080603, 15036.548903532912, 12092.33492157931, 12186.634400967985, 12319.93840030803, 12400.635930047687, 12523.56167534141, 4441.489228738672, 4456.509783923798, 4496.2581174106235, 4505.3917721107555, 4550.68145229834, 80326.19673803245, 85607.0, 85785.57107214487, 86295.13704862933, 86684.0, 11498.367589782642, 11524.481398337095, 11595.76808463826, 11864.822027669592, 12326.876731232753, 22296.21963231279, 22297.77702222957, 22329.776702233095, 22340.0, 22443.551128977328, 8526.65893364271, 8533.658653653783, 8681.739547813575, 8727.519986400808, 9100.362974591715, 4457.197704413236, 4515.729056256635, 4732.976335118371, 4780.545848144421, 4805.591524720368, 3653.1962968146963, 3752.512173417438, 3758.1356288053903, 3777.490038844721, 3779.8110094495164, 621.8849512840048, 640.3564417760215, 642.3961476212439, 646.1599920103846, 647.439964430764, 677.9864402712017, 689.4828878341244, 691.9342662447059, 696.7979286007002, 711.9572825630376, 8698.347623928104, 9334.0, 9370.62517499306, 9416.152546270732, 9631.422114673001, 541.9620626556182, 544.2978557660653, 655.8130932684162, 655.8294843340766, 717.5730440387961, 4327.350897365421, 4610.838620648261, 4637.86086417408, 4682.180618391768, 4798.0, 94394.5280273608, 99167.0, 99534.0, 109266.0, 111119.0, 95150.52424737831, 96805.51597241969, 96823.51588242014, 98086.87305975266, 101311.0, 54870.72564637151, 72192.27807721961, 82369.58815205886, 85977.0, 86459.56770216109, 9436.764080898032, 9512.952435238056, 9843.0, 10008.299662546631, 10066.848997265193, 50634.49365506298, 50691.49308506868, 51249.23126153036, 52368.0, 52454.73772631113, 72632.27367726466, 74135.0, 75393.0, 75588.0, 78118.0, 12586.748265034832, 12608.621741347773, 12608.74782504363, 12737.55418560383, 12976.545820896223, 13743.312834358441, 14339.713205735618, 14560.781588276397, 14689.779653304995, 14739.92630036843, 10668.0, 13814.37835297394, 13859.930700346435, 13949.790753138914, 14020.789688154482, 13188.87756876957, 13568.864311357154, 13907.30463476802, 14018.439262429796, 14243.145411275356, 12342.321172335607, 12491.562795302121, 12622.621321360373, 12628.179168354027, 13102.541411050568, 10675.957631602567, 10688.25182237236, 10708.357498550113, 11354.489047993025, 11389.373584452935, 10051.949740251252, 10633.734156645836, 11589.768204636028, 11930.821037684615, 12059.397030148633], "value": 7456.993489558762, "unit": "score"}], "name": "dromaeo_css", "value": 7140.678579305919, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 111.0, 111.0, 113.0, 112.0, 111.0, 111.0, 111.0, 109.0, 111.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 121.0, 123.0, 158.0, 127.0, 123.0, 124.0, 123.0, 154.0, 125.0], "value": 133.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 170.0, 160.0, 160.0, 161.0, 164.0, 162.0, 161.0, 160.0, 163.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 77.0, 113.0, 76.0, 77.0, 76.0, 76.0, 98.0, 75.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 118.0, 82.0, 81.0, 83.0, 103.0, 84.0, 83.0, 114.0], "value": 91.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 51.0, 51.0, 52.0, 53.0, 53.0, 53.0, 53.0, 52.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 62.0, 62.0, 61.0, 61.0, 60.0, 61.0, 61.0, 62.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 79.0, 83.0, 86.0, 90.0, 80.0, 80.0, 88.0, 79.0, 80.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 132.0, 131.0, 131.0, 130.0, 129.0, 132.0, 139.0, 177.0, 128.0], "value": 136.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 167.0, 165.0, 165.0, 166.0, 172.0, 166.0, 167.0, 168.0, 166.0], "value": 167.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 65.0, 66.0, 66.0, 67.0, 67.0, 67.0, 71.0, 74.0, 65.0], "value": 67.8, "unit": "score"}], "name": "kraken", "value": 1505.8999999999999, "alertThreshold": 2.0}]} 21:43:28 INFO - Return code: 0 21:43:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:43:28 INFO - # TBPL SUCCESS # 21:43:28 INFO - Running post-action listener: _resource_record_post_action 21:43:28 INFO - [mozharness: 2016-10-05 04:43:28.396390Z] Finished run-tests step (success) 21:43:28 INFO - Running post-run listener: _resource_record_post_run 21:43:28 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 393523200; Read time: 12; Write time: 795664 21:43:28 INFO - TinderboxPrint: CPU usage
13.2% 21:43:28 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 21:43:28 INFO - TinderboxPrint: I/O write bytes / time
393,523,200 / 795,664 21:43:28 INFO - TinderboxPrint: CPU idle
8,298.5 (86.8%) 21:43:28 INFO - TinderboxPrint: CPU user
1,205.6 (12.6%) 21:43:28 INFO - TinderboxPrint: Swap in / out
0 / 0 21:43:28 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 104144896; Read time: 0; Write time: 236552 21:43:28 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 289378304; Read time: 0; Write time: 559112 21:43:29 INFO - Running post-run listener: _upload_blobber_files 21:43:29 INFO - Blob upload gear active. 21:43:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:43:29 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 21:43:29 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:43:29 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:43:29 INFO - (blobuploader) - INFO - Open directory for files ... 21:43:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:43:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:43:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:43:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:43:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:43:30 INFO - (blobuploader) - INFO - Done attempting. 21:43:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:43:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:43:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:43:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:43:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:43:33 INFO - (blobuploader) - INFO - Done attempting. 21:43:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:43:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:43:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:43:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:43:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:43:34 INFO - (blobuploader) - INFO - Done attempting. 21:43:34 INFO - (blobuploader) - INFO - Iteration through files over. 21:43:34 INFO - Return code: 0 21:43:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:43:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:43:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c694f1f4bd2693dad3336995a3d305fd41083b2c67aaf7a9f80c74d142b91964bda7838d9a59f875aa4f4b2d427737dc995e6fe18c427b22f12959162a0b61d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/14b417dc800994a09df4c67e26c24498dfb61e6daf41e035ca24761a577385274c0b91faa7d51abcb9bfa4dba67f44fc118189a23cdec98113ff887e09a9ffcc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ff334400a424d63a8dd81091c66d51458916c1cfdde2a6c71c04e2dff569144d682cd7ac9e18f7b6c3ed66660bdc8cc0c866aa905cf8fdc2153132bb4d90ace4"} 21:43:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:43:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:43:34 INFO - Contents: 21:43:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c694f1f4bd2693dad3336995a3d305fd41083b2c67aaf7a9f80c74d142b91964bda7838d9a59f875aa4f4b2d427737dc995e6fe18c427b22f12959162a0b61d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/14b417dc800994a09df4c67e26c24498dfb61e6daf41e035ca24761a577385274c0b91faa7d51abcb9bfa4dba67f44fc118189a23cdec98113ff887e09a9ffcc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ff334400a424d63a8dd81091c66d51458916c1cfdde2a6c71c04e2dff569144d682cd7ac9e18f7b6c3ed66660bdc8cc0c866aa905cf8fdc2153132bb4d90ace4"} 21:43:34 INFO - Running post-run listener: copy_logs_to_upload_dir 21:43:34 INFO - Copying logs to upload dir... 21:43:34 INFO - mkdir: /builds/slave/test/build/upload/logs 21:43:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.596638 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-10-04 21:43:34.122194) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 21:43:34.125595) ========= 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=8783db0840cc980e80bb0bd400000236-1475641283.651804-1466413039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c694f1f4bd2693dad3336995a3d305fd41083b2c67aaf7a9f80c74d142b91964bda7838d9a59f875aa4f4b2d427737dc995e6fe18c427b22f12959162a0b61d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/14b417dc800994a09df4c67e26c24498dfb61e6daf41e035ca24761a577385274c0b91faa7d51abcb9bfa4dba67f44fc118189a23cdec98113ff887e09a9ffcc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ff334400a424d63a8dd81091c66d51458916c1cfdde2a6c71c04e2dff569144d682cd7ac9e18f7b6c3ed66660bdc8cc0c866aa905cf8fdc2153132bb4d90ace4"} build_url:https://queue.taskcluster.net/v1/task/HKYUcS24RDijALaidsFNpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011423 build_url: 'https://queue.taskcluster.net/v1/task/HKYUcS24RDijALaidsFNpg/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/Fx-Team/sha512/c694f1f4bd2693dad3336995a3d305fd41083b2c67aaf7a9f80c74d142b91964bda7838d9a59f875aa4f4b2d427737dc995e6fe18c427b22f12959162a0b61d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/14b417dc800994a09df4c67e26c24498dfb61e6daf41e035ca24761a577385274c0b91faa7d51abcb9bfa4dba67f44fc118189a23cdec98113ff887e09a9ffcc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ff334400a424d63a8dd81091c66d51458916c1cfdde2a6c71c04e2dff569144d682cd7ac9e18f7b6c3ed66660bdc8cc0c866aa905cf8fdc2153132bb4d90ace4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 21:43:34.150698) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 21:43:34.151135) ========= 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=8783db0840cc980e80bb0bd400000236-1475641283.651804-1466413039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004714 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 21:43:34.202981) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 21:43:34.203305) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 21:43:34.203581) ========= ========= Total master_lag: 0.14 =========