builder: autoland_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-007 starttime: 1476926023.77 results: success (0) buildid: 20161019153225 builduid: 51ec7489c600412ba00ca8fc9d18192b revision: 83a03cc29bb7674645a46b805cafdc75502f2afe ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 18:13:43.768494) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 18:13:43.768909) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 18:13:43.769189) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 18:13:43.810371) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 18:13:43.810677) ========= 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=923d835db2ba3686ebe126b700000192-1476925311.829349-1161084094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-19 18:13:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 111M=0s 2016-10-19 18:13:44 (111 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125067 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 18:13:43.955622) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 18:13:43.955950) ========= 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=923d835db2ba3686ebe126b700000192-1476925311.829349-1161084094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019156 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 18:13:44.005925) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 18:13:44.006292) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 83a03cc29bb7674645a46b805cafdc75502f2afe --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 83a03cc29bb7674645a46b805cafdc75502f2afe --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=923d835db2ba3686ebe126b700000192-1476925311.829349-1161084094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-19 18:13:44,743 truncating revision to first 12 chars 2016-10-19 18:13:44,743 Setting DEBUG logging. 2016-10-19 18:13:44,743 attempt 1/10 2016-10-19 18:13:44,743 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/83a03cc29bb7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-19 18:13:45,044 unpacking tar archive at: autoland-83a03cc29bb7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.621259 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 18:13:44.642203) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 18:13:44.642506) ========= script_repo_revision: 83a03cc29bb7674645a46b805cafdc75502f2afe ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 18:13:44.642932) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 18:13:44.643240) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 18:13:44.653614) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-10-19 18:13:44.654055) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=923d835db2ba3686ebe126b700000192-1476925311.829349-1161084094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:13:45 INFO - MultiFileLogger online at 20161019 18:13:45 in /builds/slave/test 18:13:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 18:13:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:13:45 INFO - {'append_to_log': False, 18:13:45 INFO - 'base_work_dir': '/builds/slave/test', 18:13:45 INFO - 'blob_upload_branch': 'Autoland', 18:13:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:13:45 INFO - 'branch': 'Autoland', 18:13:45 INFO - 'buildbot_json_path': 'buildprops.json', 18:13:45 INFO - 'config_files': ('talos/linux_config.py',), 18:13:45 INFO - 'default_actions': ('clobber', 18:13:45 INFO - 'read-buildbot-config', 18:13:45 INFO - 'download-and-extract', 18:13:45 INFO - 'populate-webroot', 18:13:45 INFO - 'create-virtualenv', 18:13:45 INFO - 'install', 18:13:45 INFO - 'run-tests'), 18:13:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:13:45 INFO - 'download_minidump_stackwalk': True, 18:13:45 INFO - 'download_symbols': 'ondemand', 18:13:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:13:45 INFO - 'tooltool.py': '/tools/tooltool.py', 18:13:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:13:45 INFO - '/tools/misc-python/virtualenv.py')}, 18:13:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:13:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:13:45 INFO - 'installer_path': 'installer.exe', 18:13:45 INFO - 'log_level': 'info', 18:13:45 INFO - 'log_name': 'talos', 18:13:45 INFO - 'log_to_console': True, 18:13:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:13:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:13:45 INFO - 'opt_config_files': (), 18:13:45 INFO - 'pip_index': False, 18:13:45 INFO - 'sps_profile': False, 18:13:45 INFO - 'sps_profile_interval': 0, 18:13:45 INFO - 'suite': 'dromaeojs-e10s', 18:13:45 INFO - 'system_bits': '32', 18:13:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:13:45 INFO - 'title': 'talos-linux64-ix-007', 18:13:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:13:45 INFO - 'use_talos_json': True, 18:13:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:13:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:13:45 INFO - 'work_dir': 'build'} 18:13:45 INFO - [mozharness: 2016-10-20 01:13:45.490732Z] Running clobber step. 18:13:45 INFO - Running pre-action listener: _resource_record_pre_action 18:13:45 INFO - Running main action method: clobber 18:13:45 INFO - rmtree: /builds/slave/test/build 18:13:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:13:45 INFO - Running post-action listener: _resource_record_post_action 18:13:45 INFO - [mozharness: 2016-10-20 01:13:45.948909Z] Finished clobber step (success) 18:13:45 INFO - [mozharness: 2016-10-20 01:13:45.949007Z] Running read-buildbot-config step. 18:13:45 INFO - Running pre-action listener: _resource_record_pre_action 18:13:45 INFO - Running main action method: read_buildbot_config 18:13:45 INFO - Using buildbot properties: 18:13:45 INFO - { 18:13:45 INFO - "project": "", 18:13:45 INFO - "product": "firefox", 18:13:45 INFO - "script_repo_revision": "production", 18:13:45 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 18:13:45 INFO - "repository": "", 18:13:45 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs-e10s", 18:13:45 INFO - "buildid": "20161019153225", 18:13:45 INFO - "pgo_build": "True", 18:13:45 INFO - "basedir": "/builds/slave/test", 18:13:45 INFO - "buildnumber": 418, 18:13:45 INFO - "slavename": "talos-linux64-ix-007", 18:13:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:13:45 INFO - "platform": "ubuntu64_hw", 18:13:45 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 18:13:45 INFO - "branch": "autoland", 18:13:45 INFO - "repo_path": "integration/autoland", 18:13:45 INFO - "revision": "83a03cc29bb7674645a46b805cafdc75502f2afe", 18:13:45 INFO - "stage_platform": "linux64-pgo", 18:13:45 INFO - "builduid": "51ec7489c600412ba00ca8fc9d18192b", 18:13:45 INFO - "slavebuilddir": "test" 18:13:45 INFO - } 18:13:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/S6NhpWKkRN-9JuRmZ0MnPQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 18:13:45 INFO - Running post-action listener: _resource_record_post_action 18:13:45 INFO - [mozharness: 2016-10-20 01:13:45.951422Z] Finished read-buildbot-config step (success) 18:13:45 INFO - [mozharness: 2016-10-20 01:13:45.951510Z] Running download-and-extract step. 18:13:45 INFO - Running pre-action listener: _resource_record_pre_action 18:13:45 INFO - Running main action method: download_and_extract 18:13:45 INFO - mkdir: /builds/slave/test/build/tests 18:13:45 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')]} 18:13:45 INFO - trying https://queue.taskcluster.net/v1/task/S6NhpWKkRN-9JuRmZ0MnPQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:13:45 INFO - Downloading https://queue.taskcluster.net/v1/task/S6NhpWKkRN-9JuRmZ0MnPQ/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 18:13:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S6NhpWKkRN-9JuRmZ0MnPQ/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 18:13:46 INFO - Downloaded 1361 bytes. 18:13:46 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:13:46 INFO - Using the following test package requirements: 18:13:46 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:13:46 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:13:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:13:46 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:13:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:13:46 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:13:46 INFO - u'jsshell-linux-x86_64.zip'], 18:13:46 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:13:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:13:46 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:13:46 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:13:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:13:46 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:13:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:13:46 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:13:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:13:46 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:13:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:13:46 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:13:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S6NhpWKkRN-9JuRmZ0MnPQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:13:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S6NhpWKkRN-9JuRmZ0MnPQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:13:46 INFO - Fetch https://queue.taskcluster.net/v1/task/S6NhpWKkRN-9JuRmZ0MnPQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:13:47 INFO - Http code: 200 18:13:47 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 18:13:47 INFO - x-amz-cf-id: THXrz6nVK9mwR6QB-KQASsZYCRVw-8Orw9kpF-dpBwleg8stZfXf3g== 18:13:47 INFO - x-amz-version-id: bhElEePEW0e6tPKOobLFdGUbW.R3insN 18:13:48 INFO - Expected file size: 22111207 18:13:48 INFO - Obtained file size: 22111207 18:13:52 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 18:13:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S6NhpWKkRN-9JuRmZ0MnPQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:13:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S6NhpWKkRN-9JuRmZ0MnPQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:13:52 INFO - Fetch https://queue.taskcluster.net/v1/task/S6NhpWKkRN-9JuRmZ0MnPQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:13:52 INFO - Http code: 200 18:13:52 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 18:13:52 INFO - x-amz-cf-id: I880nBPvcpe6Q3bh-49KW1Ak5ICB_xATWoeqKLqSf5duCSHDMHgT6g== 18:13:52 INFO - x-amz-version-id: bhElEePEW0e6tPKOobLFdGUbW.R3insN 18:13:53 INFO - Expected file size: 22111207 18:13:53 INFO - Obtained file size: 22111207 18:13:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S6NhpWKkRN-9JuRmZ0MnPQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 18:13:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S6NhpWKkRN-9JuRmZ0MnPQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:13:57 INFO - Fetch https://queue.taskcluster.net/v1/task/S6NhpWKkRN-9JuRmZ0MnPQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 18:13:58 INFO - Http code: 200 18:13:58 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 18:13:58 INFO - x-amz-cf-id: lMcZBQZeYDmO2VN50Fohe88FE9-NieZNvuV0xF9oUYCltzgjNPPvqQ== 18:13:58 INFO - x-amz-version-id: da2y.t8W.7AAlGyEpcwYenDgoC2vo85a 18:13:59 INFO - Expected file size: 14409028 18:13:59 INFO - Obtained file size: 14409028 18:13:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:13:59 INFO - trying https://queue.taskcluster.net/v1/task/S6NhpWKkRN-9JuRmZ0MnPQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:13:59 INFO - Downloading https://queue.taskcluster.net/v1/task/S6NhpWKkRN-9JuRmZ0MnPQ/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 18:13:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S6NhpWKkRN-9JuRmZ0MnPQ/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 18:14:02 INFO - Downloaded 59459460 bytes. 18:14:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S6NhpWKkRN-9JuRmZ0MnPQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:14:02 INFO - mkdir: /builds/slave/test/properties 18:14:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:14:02 INFO - Writing to file /builds/slave/test/properties/build_url 18:14:02 INFO - Contents: 18:14:02 INFO - build_url:https://queue.taskcluster.net/v1/task/S6NhpWKkRN-9JuRmZ0MnPQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:14:02 INFO - Running post-action listener: _resource_record_post_action 18:14:02 INFO - Running post-action listener: set_extra_try_arguments 18:14:02 INFO - [mozharness: 2016-10-20 01:14:02.639344Z] Finished download-and-extract step (success) 18:14:02 INFO - [mozharness: 2016-10-20 01:14:02.639569Z] Running populate-webroot step. 18:14:02 INFO - Running pre-action listener: _resource_record_pre_action 18:14:02 INFO - Running main action method: populate_webroot 18:14:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:14:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:14:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:14:02 INFO - '--tppagecycles', 18:14:02 INFO - '7'], 18:14:02 INFO - 'tests': ['tsvgm']}}, 18:14:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:14:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:14:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:14:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:14:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:14:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:14:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:14:02 INFO - 'talos_options': ['--disable-e10s'], 18:14:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:14:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:14:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:14:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:14:02 INFO - 'talos_options': ['--disable-e10s'], 18:14:02 INFO - 'tests': ['damp', 'tps']}, 18:14:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:14:02 INFO - 'tests': ['damp', 'tps']}, 18:14:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:14:02 INFO - 'tests': ['dromaeo_dom']}, 18:14:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:14:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:14:02 INFO - 'tests': ['basic_compositor_video']}, 18:14:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:14:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:14:02 INFO - 'tests': ['a11yr', 18:14:02 INFO - 'ts_paint', 18:14:02 INFO - 'tpaint', 18:14:02 INFO - 'sessionrestore', 18:14:02 INFO - 'sessionrestore_no_auto_restore', 18:14:02 INFO - 'tabpaint']}, 18:14:02 INFO - 'other-e10s': {'tests': ['a11yr', 18:14:02 INFO - 'ts_paint', 18:14:02 INFO - 'tpaint', 18:14:02 INFO - 'sessionrestore', 18:14:02 INFO - 'sessionrestore_no_auto_restore', 18:14:02 INFO - 'tabpaint']}, 18:14:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:14:02 INFO - 'ts_paint', 18:14:02 INFO - 'tpaint', 18:14:02 INFO - 'sessionrestore', 18:14:02 INFO - 'sessionrestore_no_auto_restore', 18:14:02 INFO - 'tabpaint']}, 18:14:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:14:02 INFO - 'ts_paint', 18:14:02 INFO - 'tpaint', 18:14:02 INFO - 'sessionrestore', 18:14:02 INFO - 'sessionrestore_no_auto_restore', 18:14:02 INFO - 'tabpaint']}, 18:14:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:14:02 INFO - 'tests': ['a11yr', 18:14:02 INFO - 'ts_paint', 18:14:02 INFO - 'tpaint', 18:14:02 INFO - 'sessionrestore', 18:14:02 INFO - 'sessionrestore_no_auto_restore', 18:14:02 INFO - 'tabpaint']}, 18:14:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:14:02 INFO - 'tests': ['a11yr', 18:14:02 INFO - 'ts_paint', 18:14:02 INFO - 'tpaint', 18:14:02 INFO - 'sessionrestore', 18:14:02 INFO - 'sessionrestore_no_auto_restore', 18:14:02 INFO - 'tabpaint']}, 18:14:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:14:02 INFO - 'tests': ['tsvgx', 18:14:02 INFO - 'tsvgr_opacity', 18:14:02 INFO - 'tart', 18:14:02 INFO - 'tscrollx', 18:14:02 INFO - 'cart']}, 18:14:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:14:02 INFO - 'tsvgr_opacity', 18:14:02 INFO - 'tart', 18:14:02 INFO - 'tscrollx', 18:14:02 INFO - 'cart']}, 18:14:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:14:02 INFO - 'talos_options': ['--disable-e10s'], 18:14:02 INFO - 'tests': ['tp5o']}, 18:14:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:14:02 INFO - 'tests': ['tp5o']}, 18:14:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:14:02 INFO - 'talos_options': ['--disable-e10s', 18:14:02 INFO - '--xperf_path', 18:14:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:14:02 INFO - 'tests': ['tp5n']}, 18:14:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:14:02 INFO - 'talos_options': ['--xperf_path', 18:14:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:14:02 INFO - 'tests': ['tp5n']}}, 18:14:02 INFO - 'talos.zip': {'path': '', 18:14:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:14:02 INFO - Running post-action listener: _resource_record_post_action 18:14:02 INFO - [mozharness: 2016-10-20 01:14:02.657677Z] Finished populate-webroot step (success) 18:14:02 INFO - [mozharness: 2016-10-20 01:14:02.657765Z] Running create-virtualenv step. 18:14:02 INFO - Running pre-action listener: _resource_record_pre_action 18:14:02 INFO - Running main action method: create_virtualenv 18:14:02 INFO - Creating virtualenv /builds/slave/test/build/venv 18:14:02 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 18:14:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:14:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:14:02 INFO - Using real prefix '/usr' 18:14:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:14:03 INFO - Installing distribute.............................................................................................................................................................................................done. 18:14:05 INFO - Installing pip.................done. 18:14:05 INFO - Return code: 0 18:14:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:14:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:14:05 INFO - Reading from file tmpfile_stdout 18:14:05 INFO - Output received: 18:14:05 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) 18:14:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:14:05 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')]} 18:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:05 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')]} 18:14:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:05 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 0x7f474c1f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16087b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1697790>, '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 0x1698690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1698b20>, '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': '923d835db2ba3686ebe126b700000192-1476925311.829349-1161084094', '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 18:14:05 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 18:14:05 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 18:14:05 INFO - Using env: {'DISPLAY': ':0', 18:14:05 INFO - 'HOME': '/home/cltbld', 18:14:05 INFO - 'LANG': 'en_US.UTF-8', 18:14:05 INFO - 'LANGUAGE': 'en_US:en', 18:14:05 INFO - 'LOGNAME': 'cltbld', 18:14:05 INFO - 'MAIL': '/var/mail/cltbld', 18:14:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:05 INFO - 'MOZ_NO_REMOTE': '1', 18:14:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:14:05 INFO - 'NO_EM_RESTART': '1', 18:14:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:14:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:05 INFO - 'PWD': '/builds/slave/test', 18:14:05 INFO - 'SHELL': '/bin/bash', 18:14:05 INFO - 'SHLVL': '1', 18:14:05 INFO - 'TERM': 'linux', 18:14:05 INFO - 'TMOUT': '86400', 18:14:05 INFO - 'USER': 'cltbld', 18:14:05 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1476925311.829349-1161084094', 18:14:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:05 INFO - '_': '/tools/buildbot/bin/python'} 18:14:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:05 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 18:14:05 INFO - Cleaning up... 18:14:05 INFO - Return code: 0 18:14:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:14:05 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')]} 18:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:05 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')]} 18:14:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:05 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 0x7f474c1f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16087b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1697790>, '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 0x1698690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1698b20>, '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': '923d835db2ba3686ebe126b700000192-1476925311.829349-1161084094', '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 18:14:05 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 18:14:05 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 18:14:05 INFO - Using env: {'DISPLAY': ':0', 18:14:05 INFO - 'HOME': '/home/cltbld', 18:14:05 INFO - 'LANG': 'en_US.UTF-8', 18:14:05 INFO - 'LANGUAGE': 'en_US:en', 18:14:05 INFO - 'LOGNAME': 'cltbld', 18:14:05 INFO - 'MAIL': '/var/mail/cltbld', 18:14:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:05 INFO - 'MOZ_NO_REMOTE': '1', 18:14:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:14:05 INFO - 'NO_EM_RESTART': '1', 18:14:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:14:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:05 INFO - 'PWD': '/builds/slave/test', 18:14:05 INFO - 'SHELL': '/bin/bash', 18:14:05 INFO - 'SHLVL': '1', 18:14:05 INFO - 'TERM': 'linux', 18:14:05 INFO - 'TMOUT': '86400', 18:14:05 INFO - 'USER': 'cltbld', 18:14:05 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1476925311.829349-1161084094', 18:14:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:05 INFO - '_': '/tools/buildbot/bin/python'} 18:14:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:05 INFO - Downloading/unpacking psutil>=3.1.1 18:14:05 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 18:14:05 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 18:14:05 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 18:14:05 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 18:14:05 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 18:14:05 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 18:14:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:14:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:14:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:14:07 INFO - Installing collected packages: psutil 18:14:07 INFO - Running setup.py install for psutil 18:14:07 INFO - building 'psutil._psutil_linux' extension 18:14:07 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 18:14:08 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 18:14:08 INFO - building 'psutil._psutil_posix' extension 18:14:08 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 18:14:08 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 18:14:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:14:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:14:08 INFO - Successfully installed psutil 18:14:08 INFO - Cleaning up... 18:14:08 INFO - Return code: 0 18:14:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:14:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:14:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:08 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 0x7f474c1f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16087b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1697790>, '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 0x1698690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1698b20>, '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': '923d835db2ba3686ebe126b700000192-1476925311.829349-1161084094', '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 18:14:08 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 18:14:08 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 18:14:08 INFO - Using env: {'DISPLAY': ':0', 18:14:08 INFO - 'HOME': '/home/cltbld', 18:14:08 INFO - 'LANG': 'en_US.UTF-8', 18:14:08 INFO - 'LANGUAGE': 'en_US:en', 18:14:08 INFO - 'LOGNAME': 'cltbld', 18:14:08 INFO - 'MAIL': '/var/mail/cltbld', 18:14:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:08 INFO - 'MOZ_NO_REMOTE': '1', 18:14:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:14:08 INFO - 'NO_EM_RESTART': '1', 18:14:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:14:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:08 INFO - 'PWD': '/builds/slave/test', 18:14:08 INFO - 'SHELL': '/bin/bash', 18:14:08 INFO - 'SHLVL': '1', 18:14:08 INFO - 'TERM': 'linux', 18:14:08 INFO - 'TMOUT': '86400', 18:14:08 INFO - 'USER': 'cltbld', 18:14:08 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1476925311.829349-1161084094', 18:14:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:08 INFO - '_': '/tools/buildbot/bin/python'} 18:14:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:14:08 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 18:14:08 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 18:14:08 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 18:14:08 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 18:14:08 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 18:14:08 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 18:14:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:14:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:14:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:14:10 INFO - Installing collected packages: mozsystemmonitor 18:14:10 INFO - Running setup.py install for mozsystemmonitor 18:14:10 INFO - Successfully installed mozsystemmonitor 18:14:10 INFO - Cleaning up... 18:14:10 INFO - Return code: 0 18:14:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:14: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')]} 18:14:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14: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')]} 18:14:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14: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', '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 0x7f474c1f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16087b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1697790>, '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 0x1698690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1698b20>, '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': '923d835db2ba3686ebe126b700000192-1476925311.829349-1161084094', '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 18:14: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:14: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 jsonschema==2.5.1 18:14:10 INFO - Using env: {'DISPLAY': ':0', 18:14:10 INFO - 'HOME': '/home/cltbld', 18:14:10 INFO - 'LANG': 'en_US.UTF-8', 18:14:10 INFO - 'LANGUAGE': 'en_US:en', 18:14:10 INFO - 'LOGNAME': 'cltbld', 18:14:10 INFO - 'MAIL': '/var/mail/cltbld', 18:14:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:10 INFO - 'MOZ_NO_REMOTE': '1', 18:14:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:14:10 INFO - 'NO_EM_RESTART': '1', 18:14:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:14:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:10 INFO - 'PWD': '/builds/slave/test', 18:14:10 INFO - 'SHELL': '/bin/bash', 18:14:10 INFO - 'SHLVL': '1', 18:14:10 INFO - 'TERM': 'linux', 18:14:10 INFO - 'TMOUT': '86400', 18:14:10 INFO - 'USER': 'cltbld', 18:14:10 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1476925311.829349-1161084094', 18:14:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:10 INFO - '_': '/tools/buildbot/bin/python'} 18:14:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:11 INFO - Downloading/unpacking jsonschema==2.5.1 18:14:11 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 18:14:11 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 18:14:11 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 18:14:11 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 18:14:11 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 18:14:11 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 18:14:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:14:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:14:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:14:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:14:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:14:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:14:13 INFO - Downloading functools32-3.2.3-2.tar.gz 18:14:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:14:13 INFO - warning: no files found matching '*.txt' 18:14:13 INFO - no previously-included directories found matching 'build' 18:14:13 INFO - no previously-included directories found matching 'dist' 18:14:13 INFO - no previously-included directories found matching '.git*' 18:14:13 INFO - Installing collected packages: jsonschema, functools32 18:14:13 INFO - Running setup.py install for functools32 18:14:13 INFO - warning: no files found matching '*.txt' 18:14:13 INFO - no previously-included directories found matching 'build' 18:14:13 INFO - no previously-included directories found matching 'dist' 18:14:13 INFO - no previously-included directories found matching '.git*' 18:14:13 INFO - Successfully installed jsonschema functools32 18:14:13 INFO - Cleaning up... 18:14:13 INFO - Return code: 0 18:14:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:14: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')]} 18:14:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14: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')]} 18:14:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14: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', '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 0x7f474c1f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16087b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1697790>, '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 0x1698690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1698b20>, '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': '923d835db2ba3686ebe126b700000192-1476925311.829349-1161084094', '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 18:14: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:14: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 functools32==3.2.3-2 18:14:13 INFO - Using env: {'DISPLAY': ':0', 18:14:13 INFO - 'HOME': '/home/cltbld', 18:14:13 INFO - 'LANG': 'en_US.UTF-8', 18:14:13 INFO - 'LANGUAGE': 'en_US:en', 18:14:13 INFO - 'LOGNAME': 'cltbld', 18:14:13 INFO - 'MAIL': '/var/mail/cltbld', 18:14:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:13 INFO - 'MOZ_NO_REMOTE': '1', 18:14:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:14:13 INFO - 'NO_EM_RESTART': '1', 18:14:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:14:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:13 INFO - 'PWD': '/builds/slave/test', 18:14:13 INFO - 'SHELL': '/bin/bash', 18:14:13 INFO - 'SHLVL': '1', 18:14:13 INFO - 'TERM': 'linux', 18:14:13 INFO - 'TMOUT': '86400', 18:14:13 INFO - 'USER': 'cltbld', 18:14:13 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1476925311.829349-1161084094', 18:14:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:13 INFO - '_': '/tools/buildbot/bin/python'} 18:14:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:14:13 INFO - Cleaning up... 18:14:13 INFO - Return code: 0 18:14:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:14: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')]} 18:14:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14: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')]} 18:14:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14: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', '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 0x7f474c1f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16087b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1697790>, '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 0x1698690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1698b20>, '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': '923d835db2ba3686ebe126b700000192-1476925311.829349-1161084094', '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 18:14: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:14: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 blobuploader==1.2.4 18:14:13 INFO - Using env: {'DISPLAY': ':0', 18:14:13 INFO - 'HOME': '/home/cltbld', 18:14:13 INFO - 'LANG': 'en_US.UTF-8', 18:14:13 INFO - 'LANGUAGE': 'en_US:en', 18:14:13 INFO - 'LOGNAME': 'cltbld', 18:14:13 INFO - 'MAIL': '/var/mail/cltbld', 18:14:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:13 INFO - 'MOZ_NO_REMOTE': '1', 18:14:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:14:13 INFO - 'NO_EM_RESTART': '1', 18:14:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:14:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:13 INFO - 'PWD': '/builds/slave/test', 18:14:13 INFO - 'SHELL': '/bin/bash', 18:14:13 INFO - 'SHLVL': '1', 18:14:13 INFO - 'TERM': 'linux', 18:14:13 INFO - 'TMOUT': '86400', 18:14:13 INFO - 'USER': 'cltbld', 18:14:13 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1476925311.829349-1161084094', 18:14:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:13 INFO - '_': '/tools/buildbot/bin/python'} 18:14:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:13 INFO - Downloading/unpacking blobuploader==1.2.4 18:14: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 18:14: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 18:14: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 18:14: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 18:14: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 18:14: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 18:14:15 INFO - Downloading blobuploader-1.2.4.tar.gz 18:14:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:14:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:14: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 18:14: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 18:14: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 18:14: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 18:14: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 18:14: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 18:14:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:14:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:14:16 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 18:14:16 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 18:14:16 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 18:14:16 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 18:14:16 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 18:14:16 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 18:14:16 INFO - Downloading docopt-0.6.1.tar.gz 18:14:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:14:16 INFO - Installing collected packages: blobuploader, requests, docopt 18:14:16 INFO - Running setup.py install for blobuploader 18:14:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:14:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:14:16 INFO - Running setup.py install for requests 18:14:16 INFO - Running setup.py install for docopt 18:14:17 INFO - Successfully installed blobuploader requests docopt 18:14:17 INFO - Cleaning up... 18:14:17 INFO - Return code: 0 18:14:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:14: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')]} 18:14:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14: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')]} 18:14:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:17 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 0x7f474c1f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16087b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1697790>, '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 0x1698690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1698b20>, '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': '923d835db2ba3686ebe126b700000192-1476925311.829349-1161084094', '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 18:14:17 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 18:14:17 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 18:14:17 INFO - Using env: {'DISPLAY': ':0', 18:14:17 INFO - 'HOME': '/home/cltbld', 18:14:17 INFO - 'LANG': 'en_US.UTF-8', 18:14:17 INFO - 'LANGUAGE': 'en_US:en', 18:14:17 INFO - 'LOGNAME': 'cltbld', 18:14:17 INFO - 'MAIL': '/var/mail/cltbld', 18:14:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:17 INFO - 'MOZ_NO_REMOTE': '1', 18:14:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:14:17 INFO - 'NO_EM_RESTART': '1', 18:14:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:14:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:17 INFO - 'PWD': '/builds/slave/test', 18:14:17 INFO - 'SHELL': '/bin/bash', 18:14:17 INFO - 'SHLVL': '1', 18:14:17 INFO - 'TERM': 'linux', 18:14:17 INFO - 'TMOUT': '86400', 18:14:17 INFO - 'USER': 'cltbld', 18:14:17 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1476925311.829349-1161084094', 18:14:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:17 INFO - '_': '/tools/buildbot/bin/python'} 18:14:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:14:17 INFO - Running setup.py (path:/tmp/pip-lDgkkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:14:17 INFO - Running setup.py (path:/tmp/pip-WuMJxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:14:17 INFO - Running setup.py (path:/tmp/pip-RHJoS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:14:17 INFO - Running setup.py (path:/tmp/pip-ahXTWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:14:17 INFO - Running setup.py (path:/tmp/pip-CSh0To-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:14:17 INFO - Running setup.py (path:/tmp/pip-_h2TaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:14:17 INFO - Running setup.py (path:/tmp/pip-SZb2ic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:14:17 INFO - Running setup.py (path:/tmp/pip-RP5xwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:14:17 INFO - Running setup.py (path:/tmp/pip-rqdInW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:14:18 INFO - Running setup.py (path:/tmp/pip-KeuRFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:14:18 INFO - Running setup.py (path:/tmp/pip-QqxCJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:14:18 INFO - Running setup.py (path:/tmp/pip-J2ZSli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:14:18 INFO - Running setup.py (path:/tmp/pip-6Y06oL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:14:18 INFO - Running setup.py (path:/tmp/pip-a9JOF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:14:18 INFO - Running setup.py (path:/tmp/pip-MDVTaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:14:18 INFO - Running setup.py (path:/tmp/pip-b40c2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:14:18 INFO - Running setup.py (path:/tmp/pip-C2dl0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:14:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:14:18 INFO - Running setup.py install for manifestparser 18:14:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:14:18 INFO - Running setup.py install for mozcrash 18:14:18 INFO - Running setup.py install for mozdebug 18:14:18 INFO - Running setup.py install for mozdevice 18:14:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:14:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:14:19 INFO - Running setup.py install for mozfile 18:14:19 INFO - Running setup.py install for mozhttpd 18:14:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:14:19 INFO - Running setup.py install for mozinfo 18:14:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:14:19 INFO - Running setup.py install for mozInstall 18:14:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:14:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:14:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:14:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:14:19 INFO - Running setup.py install for mozleak 18:14:19 INFO - Running setup.py install for mozlog 18:14:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:14:19 INFO - Running setup.py install for moznetwork 18:14:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:14:19 INFO - Running setup.py install for mozprocess 18:14:19 INFO - Running setup.py install for mozprofile 18:14:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:14:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:14:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:14:19 INFO - Running setup.py install for mozrunner 18:14:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:14:20 INFO - Running setup.py install for mozscreenshot 18:14:20 INFO - Running setup.py install for moztest 18:14:20 INFO - Running setup.py install for mozversion 18:14:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:14:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:14:20 INFO - Cleaning up... 18:14:20 INFO - Return code: 0 18:14:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:14:20 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')]} 18:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:20 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')]} 18:14:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:20 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 0x7f474c1f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16087b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1697790>, '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 0x1698690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1698b20>, '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': '923d835db2ba3686ebe126b700000192-1476925311.829349-1161084094', '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 18:14:20 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 18:14:20 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 18:14:20 INFO - Using env: {'DISPLAY': ':0', 18:14:20 INFO - 'HOME': '/home/cltbld', 18:14:20 INFO - 'LANG': 'en_US.UTF-8', 18:14:20 INFO - 'LANGUAGE': 'en_US:en', 18:14:20 INFO - 'LOGNAME': 'cltbld', 18:14:20 INFO - 'MAIL': '/var/mail/cltbld', 18:14:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:20 INFO - 'MOZ_NO_REMOTE': '1', 18:14:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:14:20 INFO - 'NO_EM_RESTART': '1', 18:14:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:14:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:20 INFO - 'PWD': '/builds/slave/test', 18:14:20 INFO - 'SHELL': '/bin/bash', 18:14:20 INFO - 'SHLVL': '1', 18:14:20 INFO - 'TERM': 'linux', 18:14:20 INFO - 'TMOUT': '86400', 18:14:20 INFO - 'USER': 'cltbld', 18:14:20 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1476925311.829349-1161084094', 18:14:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:20 INFO - '_': '/tools/buildbot/bin/python'} 18:14:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:14:20 INFO - Running setup.py (path:/tmp/pip-jy6Co3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:14:20 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)) 18:14:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:14:20 INFO - Running setup.py (path:/tmp/pip-ogh8Ok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:14:20 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)) 18:14:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:14:20 INFO - Running setup.py (path:/tmp/pip-i1PENG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:14:20 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)) 18:14:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:14:20 INFO - Running setup.py (path:/tmp/pip-0pQtdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:14:20 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)) 18:14:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:14:20 INFO - Running setup.py (path:/tmp/pip-_TlktO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:14:21 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)) 18:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:14:21 INFO - Running setup.py (path:/tmp/pip-bY3wWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:14:21 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)) 18:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:14:21 INFO - Running setup.py (path:/tmp/pip-qvM4bj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:14:21 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)) 18:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:14:21 INFO - Running setup.py (path:/tmp/pip-6gPFSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:14:21 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)) 18:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:14:21 INFO - Running setup.py (path:/tmp/pip-3Mzfp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:14:21 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)) 18:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:14:21 INFO - Running setup.py (path:/tmp/pip-GP4iFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:14:21 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)) 18:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:14:21 INFO - Running setup.py (path:/tmp/pip-WgFtJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:14:21 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)) 18:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:14:21 INFO - Running setup.py (path:/tmp/pip-TBLMUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:14:21 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)) 18:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:14:21 INFO - Running setup.py (path:/tmp/pip-GGm94U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:14:21 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)) 18:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:14:21 INFO - Running setup.py (path:/tmp/pip-kEXb7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:14:21 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)) 18:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:14:21 INFO - Running setup.py (path:/tmp/pip-bCqvs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:14:21 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)) 18:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:14:21 INFO - Running setup.py (path:/tmp/pip-13hPtH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:14:21 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)) 18:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:14:21 INFO - Running setup.py (path:/tmp/pip-vt5bN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:14:21 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)) 18:14:21 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)) 18:14:21 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)) 18:14:21 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)) 18:14:21 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)) 18:14:21 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)) 18:14:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:14:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:14:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:14:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:14:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:14:23 INFO - Downloading blessings-1.6.tar.gz 18:14:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:14:23 INFO - Installing collected packages: blessings 18:14:23 INFO - Running setup.py install for blessings 18:14:24 INFO - Successfully installed blessings 18:14:24 INFO - Cleaning up... 18:14:24 INFO - Return code: 0 18:14:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:14:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:14:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:14:24 INFO - Reading from file tmpfile_stdout 18:14:24 INFO - Current package versions: 18:14:24 INFO - argparse == 1.2.1 18:14:24 INFO - blessings == 1.6 18:14:24 INFO - blobuploader == 1.2.4 18:14:24 INFO - docopt == 0.6.1 18:14:24 INFO - functools32 == 3.2.3-2 18:14:24 INFO - jsonschema == 2.5.1 18:14:24 INFO - manifestparser == 1.1 18:14:24 INFO - mozInstall == 1.12 18:14:24 INFO - mozcrash == 0.17 18:14:24 INFO - mozdebug == 0.1 18:14:24 INFO - mozdevice == 0.48 18:14:24 INFO - mozfile == 1.2 18:14:24 INFO - mozhttpd == 0.7 18:14:24 INFO - mozinfo == 0.9 18:14:24 INFO - mozleak == 0.1 18:14:24 INFO - mozlog == 3.4 18:14:24 INFO - moznetwork == 0.27 18:14:24 INFO - mozprocess == 0.23 18:14:24 INFO - mozprofile == 0.28 18:14:24 INFO - mozrunner == 6.12 18:14:24 INFO - mozscreenshot == 0.1 18:14:24 INFO - mozsystemmonitor == 0.3 18:14:24 INFO - moztest == 0.7 18:14:24 INFO - mozversion == 1.4 18:14:24 INFO - psutil == 3.1.1 18:14:24 INFO - requests == 1.2.3 18:14:24 INFO - wsgiref == 0.1.2 18:14:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:14:24 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')]} 18:14:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:24 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')]} 18:14:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:24 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 0x7f474c1f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16087b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1697790>, '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 0x1698690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1698b20>, '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': '923d835db2ba3686ebe126b700000192-1476925311.829349-1161084094', '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 18:14:24 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 18:14:24 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 18:14:24 INFO - Using env: {'DISPLAY': ':0', 18:14:24 INFO - 'HOME': '/home/cltbld', 18:14:24 INFO - 'LANG': 'en_US.UTF-8', 18:14:24 INFO - 'LANGUAGE': 'en_US:en', 18:14:24 INFO - 'LOGNAME': 'cltbld', 18:14:24 INFO - 'MAIL': '/var/mail/cltbld', 18:14:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:24 INFO - 'MOZ_NO_REMOTE': '1', 18:14:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:14:24 INFO - 'NO_EM_RESTART': '1', 18:14:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:14:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:24 INFO - 'PWD': '/builds/slave/test', 18:14:24 INFO - 'SHELL': '/bin/bash', 18:14:24 INFO - 'SHLVL': '1', 18:14:24 INFO - 'TERM': 'linux', 18:14:24 INFO - 'TMOUT': '86400', 18:14:24 INFO - 'USER': 'cltbld', 18:14:24 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1476925311.829349-1161084094', 18:14:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:24 INFO - '_': '/tools/buildbot/bin/python'} 18:14:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:24 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)) 18:14:24 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)) 18:14:24 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)) 18:14:24 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)) 18:14:24 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)) 18:14:24 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)) 18:14:24 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)) 18:14:24 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)) 18:14:24 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)) 18:14:24 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)) 18:14:24 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)) 18:14:24 INFO - Cleaning up... 18:14:24 INFO - Return code: 0 18:14:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:14:24 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')]} 18:14:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:24 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')]} 18:14:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:24 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 0x7f474c1f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16087b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1697790>, '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 0x1698690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1698b20>, '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': '923d835db2ba3686ebe126b700000192-1476925311.829349-1161084094', '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 18:14:24 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 18:14:24 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 18:14:24 INFO - Using env: {'DISPLAY': ':0', 18:14:24 INFO - 'HOME': '/home/cltbld', 18:14:24 INFO - 'LANG': 'en_US.UTF-8', 18:14:24 INFO - 'LANGUAGE': 'en_US:en', 18:14:24 INFO - 'LOGNAME': 'cltbld', 18:14:24 INFO - 'MAIL': '/var/mail/cltbld', 18:14:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:24 INFO - 'MOZ_NO_REMOTE': '1', 18:14:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:14:24 INFO - 'NO_EM_RESTART': '1', 18:14:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:14:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:24 INFO - 'PWD': '/builds/slave/test', 18:14:24 INFO - 'SHELL': '/bin/bash', 18:14:24 INFO - 'SHLVL': '1', 18:14:24 INFO - 'TERM': 'linux', 18:14:24 INFO - 'TMOUT': '86400', 18:14:24 INFO - 'USER': 'cltbld', 18:14:24 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1476925311.829349-1161084094', 18:14:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:24 INFO - '_': '/tools/buildbot/bin/python'} 18:14:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:14:24 INFO - Cleaning up... 18:14:24 INFO - Return code: 0 18:14:24 INFO - Running post-action listener: _resource_record_post_action 18:14:24 INFO - Running post-action listener: _start_resource_monitoring 18:14:24 INFO - Starting resource monitoring. 18:14:24 INFO - [mozharness: 2016-10-20 01:14:24.813894Z] Finished create-virtualenv step (success) 18:14:24 INFO - [mozharness: 2016-10-20 01:14:24.814408Z] Running install step. 18:14:24 INFO - Running pre-action listener: _resource_record_pre_action 18:14:24 INFO - Running main action method: install 18:14:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:14:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:14:25 INFO - Reading from file tmpfile_stdout 18:14:25 INFO - Detecting whether we're running mozinstall >=1.0... 18:14:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:14:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:14:25 INFO - Reading from file tmpfile_stdout 18:14:25 INFO - Output received: 18:14:25 INFO - Usage: mozinstall [options] installer 18:14:25 INFO - Options: 18:14:25 INFO - -h, --help show this help message and exit 18:14:25 INFO - -d DEST, --destination=DEST 18:14:25 INFO - Directory to install application into. [default: 18:14:25 INFO - "/builds/slave/test"] 18:14:25 INFO - --app=APP Application being installed. [default: firefox] 18:14:25 INFO - mkdir: /builds/slave/test/build/application 18:14:25 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'] 18:14:25 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 18:14:42 INFO - Reading from file tmpfile_stdout 18:14:42 INFO - Output received: 18:14:42 INFO - /builds/slave/test/build/application/firefox/firefox 18:14:42 INFO - Running post-action listener: _resource_record_post_action 18:14:42 INFO - [mozharness: 2016-10-20 01:14:42.050471Z] Finished install step (success) 18:14:42 INFO - [mozharness: 2016-10-20 01:14:42.050771Z] Running run-tests step. 18:14:42 INFO - Running pre-action listener: _resource_record_pre_action 18:14:42 INFO - Running main action method: run_tests 18:14:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:14:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:14:42 INFO - Python 2.7.3 18:14:42 INFO - Return code: 0 18:14:42 INFO - grabbing minidump binary from tooltool 18:14:42 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')]} 18:14:42 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 0x1697790>, '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 0x1698690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1698b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:14:42 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 18:14:42 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 18:14:42 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 18:14:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:14:42 INFO - Return code: 0 18:14:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:14:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:14:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:14:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:14:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:14:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S6NhpWKkRN-9JuRmZ0MnPQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:14:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/S6NhpWKkRN-9JuRmZ0MnPQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:14:42 INFO - Using env: {'DISPLAY': ':0', 18:14:42 INFO - 'HOME': '/home/cltbld', 18:14:42 INFO - 'LANG': 'en_US.UTF-8', 18:14:42 INFO - 'LANGUAGE': 'en_US:en', 18:14:42 INFO - 'LOGNAME': 'cltbld', 18:14:42 INFO - 'MAIL': '/var/mail/cltbld', 18:14:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:14:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:14:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:42 INFO - 'MOZ_NO_REMOTE': '1', 18:14:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:14:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:14:42 INFO - 'NO_EM_RESTART': '1', 18:14:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:14:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:42 INFO - 'PWD': '/builds/slave/test', 18:14:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:14:42 INFO - 'SHELL': '/bin/bash', 18:14:42 INFO - 'SHLVL': '1', 18:14:42 INFO - 'TERM': 'linux', 18:14:42 INFO - 'TMOUT': '86400', 18:14:42 INFO - 'USER': 'cltbld', 18:14:42 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1476925311.829349-1161084094', 18:14:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:42 INFO - '_': '/tools/buildbot/bin/python'} 18:14:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S6NhpWKkRN-9JuRmZ0MnPQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:14:42 INFO - mozversion application_buildid: 20161019153225 18:14:42 INFO - mozversion application_changeset: 83a03cc29bb7674645a46b805cafdc75502f2afe 18:14:42 INFO - mozversion application_display_name: Nightly 18:14:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:14:42 INFO - mozversion application_name: Firefox 18:14:42 INFO - mozversion application_remotingname: firefox 18:14:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 18:14:42 INFO - mozversion application_vendor: Mozilla 18:14:42 INFO - mozversion application_version: 52.0a1 18:14:42 INFO - mozversion platform_buildid: 20161019153225 18:14:42 INFO - mozversion platform_changeset: 83a03cc29bb7674645a46b805cafdc75502f2afe 18:14:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 18:14:42 INFO - mozversion platform_version: 52.0a1 18:14:42 INFO - using testdate: 1476926082 18:14:42 INFO - actual date: 1476926082 18:14:42 INFO - starting webserver on 'localhost:50934' 18:14:42 INFO - SUITE-START | Running 2 tests 18:14:42 INFO - TEST-START | dromaeo_css 18:14:42 INFO - operating with platform_type : linux_ 18:14:42 INFO - Initialising browser for dromaeo_css test... 18:14:42 INFO - TEST-INFO | started process 17477 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyoZRf1/profile http://localhost:50934/getInfo.html) 18:14:46 INFO - PROCESS | 17477 | __metrics Screen width/height:1600/1200 18:14:46 INFO - PROCESS | 17477 | colorDepth:24 18:14:46 INFO - PROCESS | 17477 | Browser inner width/height: 1024/697 18:14:46 INFO - PROCESS | 17477 | __metrics 18:14:47 ERROR - PROCESS | 17477 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3087: TypeError: this.tabs is undefined 18:14:48 INFO - TEST-INFO | 17477: exit 0 18:14:48 INFO - Browser initialized. 18:14:48 INFO - Running cycle 1/1 for dromaeo_css test... 18:14:48 INFO - TEST-INFO | started process 17600 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyoZRf1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:15:00 INFO - PROCESS | 17600 | RSS: Main: 182562816 18:15:00 INFO - PROCESS | 17600 | 18:15:49 INFO - PROCESS | 17600 | 1476926149902 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] 18:18:01 INFO - PROCESS | 17600 | Cycle 1(1): loaded http://localhost:50934/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50934/tests/dromaeo/cssquery-ext.html) 18:18:02 INFO - PROCESS | 17600 | RSS: Main: 195813376 18:18:02 INFO - PROCESS | 17600 | 18:21:05 INFO - PROCESS | 17600 | Cycle 1(1): loaded http://localhost:50934/tests/dromaeo/cssquery-ext.html (next: http://localhost:50934/tests/dromaeo/cssquery-jquery.html) 18:21:05 INFO - PROCESS | 17600 | RSS: Main: 194797568 18:21:05 INFO - PROCESS | 17600 | 18:24:07 INFO - PROCESS | 17600 | Cycle 1(1): loaded http://localhost:50934/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50934/tests/dromaeo/cssquery-mootools.html) 18:24:08 INFO - PROCESS | 17600 | RSS: Main: 197124096 18:24:08 INFO - PROCESS | 17600 | 18:27:10 INFO - PROCESS | 17600 | Cycle 1(1): loaded http://localhost:50934/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50934/tests/dromaeo/cssquery-prototype.html) 18:27:10 INFO - PROCESS | 17600 | RSS: Main: 193748992 18:27:10 INFO - PROCESS | 17600 | 18:30:13 INFO - PROCESS | 17600 | Cycle 1(1): loaded http://localhost:50934/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50934/tests/dromaeo/cssquery-yui.html) 18:30:13 INFO - PROCESS | 17600 | RSS: Main: 197201920 18:30:13 INFO - PROCESS | 17600 | 18:33:17 INFO - PROCESS | 17600 | Cycle 1(1): loaded http://localhost:50934/tests/dromaeo/cssquery-yui.html (next: http://localhost:50934/tests/dromaeo/cssquery-dojo.html) 18:33:17 INFO - PROCESS | 17600 | RSS: Main: 196341760 18:33:17 INFO - PROCESS | 17600 | 18:33:17 INFO - PROCESS | 17600 | __start_tp_report 18:33:17 INFO - PROCESS | 17600 | _x_x_mozilla_page_load 18:33:17 INFO - PROCESS | 17600 | _x_x_mozilla_page_load_details 18:33:17 INFO - PROCESS | 17600 | |i|pagename|runs| 18:33:17 INFO - PROCESS | 17600 | |0;dojo.html;3039.544068389742;3069.7237248647616;3080.645725741539;3091.1190310761435;3101.209191656127;5156.381234251886;5366.490183432577;5385.515303622673;5387.4343193964605;5491.313585801775;5260.079486089938;5263.894722105565;5280.1815718563585;5280.735963201834;5283.207518872171;4818.662693611449;4857.247126695368;4897.657163998521;4915.852524424273;4917.139500587401;4858.441279252896;4897.216445368742;4898.681585696936;4916;4921.704697718131;4913.26301054841;4915.434725006617;4917.262410638397;4919.532644398776;4919.532644398794;4887.169181239198;4899.951000489985;4900.411950565919;4902.117618828609;4915.483874193212;4837.105135549935;4888.951110488921;4892.730899800509;4898.461169271413;4991.176455884774;5354.544863686591;5390.811321603765;5451.945480545183;5461.208124821878;5466.34403871538;5691.9146212806845;5723.998300297473;5724.513416359614;5731.197632331436;5732.5987180897355;5651.802186923479;5738.196652468658;5779.682117483537;5785.595008349417;5791.507721843606;5405.27028851104;5407.999999999961;5408.486193811582;5420.891582168413;5437.619366644337;5838.5329173666005;5851.122331650201;5870.354261031283;5873.383294754075;5874.089516124922;5405.324334458192;5509.531689806331;5607.018771715015;5628.352739435018;5631.915521267184;5659.603827732101;5667.744951477193;5672.290963629546;5740.39725828782;5843.3864444233595;5615.382307946123;5651.632643878217;5695.772169113272;5702.059160238514;5712.314522257356;5667.489925906688;5714.7428365723645;5725.456081672234;5730.08318669011;5748.511376533042;4390.209762242827;4395.077033822933;4396.648268138541;4399.5380485049245;4430.4683437987005;3902.3366027774778;3919.5296564411883;3920.6079392060565;3958.426028225949;3987.6610488108836;5330.440303768126;5374.838754837361;5397.784088636489;5452.40023597404;5464.18037294409;5599.496045355938;5605.80379686709;5618.185363122325;5620.91568626471;5622.493975542221;5293.655912365684;5306.177542480922;5353.437889021597;5356.839294821161;5368.9731551342775;4891;4934.827281045218;5000.424951130593;5002.649814513022;5007.499250074963;5920.526357891358;5955.91066134017;5966.522678185735;5975.820725378333;5984.042553191555;5558.916616250679;5720.799772007959;5756.42435756421;5761.711914404179;5779.075347944308;5795.710214489343;5879.265091863517;5899.941000590111;5909.438603332676;6002.129691194665;5632.070708333079;5637.661740295432;5640.32316122068;5642.210090587403;5688.8577785554035;5702.714864256687;5707.058335374617;5716.742746576331;5721.427857214412;5785.681787501728;5417.322834645669;5482.369527504388;5579.525740311957;5635.295588051494;5652.745626446737;5665.66006039639;5673.461021202979;5679.488846003879;5684.261046063985;5713.771449141987;5613.242212301287;5619.409961954099;5629.352624448241;5636.239107720406;5640.830775076754;5408.45915408456;5447.291852059207;5493.972530137484;5562.054450743302;5688.829335119953;5446.537044351275;5495.890082198413;5503.697296648723;5511.448855114617;5524.447555244444 18:33:17 INFO - PROCESS | 17600 | |1;ext.html;571.9476163858501;577.644748479685;582.5572564850712;585.3911931591143;585.5110982329754;42073.57926420735;43684;43732.781336093314;47418;47600.285995710095;44642.776786116105;45160;45169.77415112928;45215.77392113043;45362.54637453624;8831.807705959709;8908.599113039896;8972.416792908472;8978.820423591524;8995.775105622346;8840.38117331787;8842.76201331814;8854;8866.911330886673;8897.154770296811;8874.42316249445;8911.108889111101;8914.33142514314;8948.776280592972;8949.77625559363;8845.20393164615;8865.689700860472;8865.955670221607;8938;8950.86573701395;8767.123287671246;8827.426217295855;8862.55687215643;8871.112888711143;8938.1508756668;41200;41699.37450938238;41706.37440438396;41871.79064104691;41938.37092443616;3396.9830150849334;3455.879044233465;3582.6059133495296;4012.979935100335;4036.8385264589383;31898.681013189802;32084;32149.1962700932;32267;33976.83011584926;4081.5918408159246;4176.331786914109;4322.783860806947;4330.242207613686;4385.605295523386;328950;328954;330008;330474;331726.34136829403;57048.71475642595;57215.427845721846;57316.426835731945;57437.42562574404;57449.712751435974;59243.11135332973;59530.70234648799;59676;59768.70115649394;60149.699251503465;15365.6158596036;15577.376904923676;15583.454579089677;15704.764428533352;15723.292451839467;12355.6911077222;12430.254184748945;12449.502019919282;12469;12502.187357821713;15858.920705396398;16774.58063548421;17271.481855544353;17443;17448.65102697939;5859.44335288147;5912.615679980788;5969.432903874125;6025.969870150621;6080.270367555833;940.8776859008285;1014.1937159957852;1044.2690116918188;1097.1880808201872;1131.5700033987032;30731.38537229243;30802.845985770375;31031.379372412426;31181.8440907794;31184.064478065695;1040.328987802863;1059.1209296284067;1091.252492042953;1094.2777766674117;1170.303669316755;15614.531564053097;16526.504204873632;16726.58183545421;17107.828921710625;17134.657306854042;513496;518298;519660;519891;521894;55256.44743552594;56499.71750141223;56526;56747;57212.42787572154;1293.1594463598735;1294.6245588779148;1321.0752473268751;1351.175782772508;1364.0724307471014;29205.41589168247;30951.535726964565;31146.844265778527;31286.53070203994;31520.84239578879;50183.24725129199;50642.74678626583;50679;50761;50803.74598126986;424109;424987;425927;426626;428335;26183.869080654476;26868;27100.1869943902;27323.72676273212;27399.589006165323;43502.34746478742;43530.56469435392;44410.55589444193;45035;45079.54920450885;35269.1182720434;36376.09059773527;37610.435843461826;38100.237995240495;38803.417948730224;36568.26863462663;36640.26719465649;36734.081647959014;36901.63098368982;37077.258454831295;34611;35601;35933.64066359407;38887;42542.78728606337;33920.66079339175;36158.84173320102;36493.27013459769;36751;36806.815965919996;26658.733412665624;26734.732652674003;27155.72844271532;27318.453630927666;27762.722372776014 18:33:17 INFO - PROCESS | 17600 | |2;jquery.html;352.7565979474164;362.63555127097266;368.2910397484842;369.8354232366597;376.29069204549415;17727.202275897584;18864.151113199903;19078.141483633237;19626.803731962675;19729.11218995145;18512.44462666122;18551.72172417415;18950.431487055375;19050.33323833666;19103.331383401583;5308.177232528964;5569.387367389584;5571.498565129137;5573.41479144688;5575;4973.1297023020825;5490.231367608538;5495.725213739317;5502.642328248671;5516.641418307817;5395.163749618815;5425.050616142179;5445.210444485548;5468.453154684539;5475.479829416199;5322.733863306838;5498.340199176085;5508.669479831223;5525.972370138124;5543.667379957215;4854.708717476963;4919.21292593187;4921.778519966574;4953.331300274453;4964.528369804862;21936.670949935764;22004.929088118748;22276.554468910694;22335.10659573615;22396.328110156723;2190.3100523335097;2382.6664267002634;2458.942654658496;2572.961405578918;2973.3607274435885;13589.62142417566;14239.288035598178;14579.343929523196;14597.343119559539;14927.850721492754;1837.255911355903;1890.5935223926783;1895.772507299119;1904.9333273335367;1940.0493758058449;75027;77158.99278433406;77924.61037694832;78194;79775.60112199518;9200.90799092014;9418.246540276761;9475.536360546308;9947.253955953332;9967.451790151612;12600.4329805159;12652.240865548096;12707.555235566711;12738;12789.616311510483;7424.665890034961;7559.848803023909;7625.1231108422135;7815.6482958267015;7834;7589.620518974029;7635.160132385433;7662.885056724153;7828.530288182727;7888.368930485547;5998.580099393001;6058.697065146725;6087.6956152192215;6189.597676151036;6204.751809927642;1710.1192885663893;1712.700277451466;1722.9310827567008;1723.2073246306588;1740.9651806963789;911.5943405184629;912.6349460215833;1005.6178652112151;1011.4487604255698;1018.1498448795339;18451.07744612764;18940.621187576446;19050;19375.90312048431;19609;963.1091240602415;963.8698775665335;990.9058639429243;1022.5858527296457;1050.3172937590627;10314.535845886952;10922.781544369227;11046.281991670516;11094.722631934104;11154.442277886235;462136;462341;469151;479855;480644;47927.76036119867;78882.6055869717;79828;80304.59847700724;80448;1007.4811472091878;1013.5033833421718;1017.704865588971;1021.1983592879554;1023.2325755683238;16511.256993435083;16571.834281657513;17171.828281717022;17181.742273865653;17268.568285792455;38663.226735465694;39067.6093239064;39163.804180978914;39723.80138099291;39804.40293395543;49956.750216248685;51364.22953655773;51530.742346288025;51553.22670160026;52213.47786522086;7425.693098003253;7795.922040779519;7890.171531989288;7919.287264146024;8227.465214761021;11255.212135150461;12061;12071;12332.938335308267;12616.873831261937;5517.751701173537;5556.99974004683;9782;10555.366677999345;10844.891551084389;10476.842847357448;10960.780784384107;10998.230123891251;11040.668779936615;11345.602903898654;9571.760705982406;9955.20358371314;10658.573657053632;10763;10850.67447976562;7388;7584.5070070445245;7625.580593067434;7630.504017238862;7793.571353575608;9404.38871473352;10358.378497290187;10632.202584806326;10674;10841.620543280947 18:33:17 INFO - PROCESS | 17600 | |3;mootools.html;1412.4209074279547;1447.5223176351801;1596.9517273711144;1779.7597324361207;1798.8560915126784;8439;8630.611622476988;8946.955265223682;9143.817123657524;9186.54067296635;9095.408798428114;9249.213816825579;9267.675631352904;9267.860982085274;9272.397294175891;2268.671042698812;2295.127851416468;2306;2309.937428782762;2310.1567927706433;2164.3290579920194;2224.5328481019005;2237.7538470768204;2245.764194759551;2248.651459023854;2211.612967730649;2223.5775202711516;2225.5103877147003;2239.899204535792;2240.350298413458;2200.6698995150696;2202.41635966469;2206.7793220677886;2214.8560343577615;2222.944426389337;2194.846360754748;2198.208644887839;2200.7359116905914;2204.7905448982483;2207;9017;9037.819243615157;9087;9090.454572725657;9096.090390960917;5147.510986456281;5255.237990491396;5320.574354051667;5325.0148722486465;5340.092184328634;3159.510275907238;3229.3218424130728;3405.931881362359;3410.658934106594;3433.4163192257374;1050.1808589300358;1064.1380481809758;1064.9307794993301;1088.434014312561;1098.203802243375;12431.62705118848;12473.688157796038;12628.242305461701;12637.115401921868;12676.302803345812;4156.355764856452;4283.678724095706;4341.6526677865695;4369.077605853415;4398.626116780046;9710.271729620306;9723.902760972442;9736.610535578497;9752.26857985654;9754.268429867789;5096.159133742891;5108.438071812097;5136.948630513722;5159.406668233126;5162.225666150108;4591.058832939239;4663;4754.595859351924;4821.180399332122;4836.685615434985;3621.4567814827988;3673.81630918453;3718.721095917817;3739.85040598373;3780.716446266541;1083.7344850511674;1088.2219213262556;1088.2382332367374;1088.8257878739364;1089.1069323155095;716.6524235745659;868.8783570300037;872.4459967920416;874.908134645853;887.0198430734075;5306.46935306474;5306.52241298285;5362.839114826562;5392.865178370572;5412.83761487156;417.7493503897637;423.60181429456213;424.3613361890335;427.72198071253314;436.65286097552524;3726.347889119393;3773.584905660375;3795.6394142556414;3834.750741201813;3891.7664940103687;10770.515326810313;11088.33469991803;11184.217104802749;11197.888021119847;11222.943885280685;11139.220254582264;11152.498137583829;11160.665180044612;11164.776704465865;11170.329780213213;8145.69371434273;8173.34613230952;8277.337812974947;8313.916860831436;8372.28835548985;5392;5433.864153396196;5458.4541545845095;5490.505854473116;5676.403977582459;10040.146587539848;10069.194464442973;10189.082982531607;10258.025487578669;10325.380477171393;9582.377145485521;9947.701568952943;10021.248406369406;10283.94858025735;10311.484425778832;6967.686454109678;7168.53404528704;7648.273414025659;7773.067231932205;7995.320397766022;8291.170882911661;8684.522351270742;8692.739217823475;8713.564321784012;8722.345824063093;7729.613519323899;7821.217878212134;7959.243871832166;8075.798105047421;8086.353091752763;7665.386769058574;7777.455578109478;7796.883046754417;7831.060272767304;7853.1361550228285;6293.276273228637;6314.431701146918;6367.649779261999;6372.330905254881;6385.201849768779;4629.051044535795;4657.976710116428;4668.906621867612;4693.483716791218;4726.480087190475;4583.770811459481;4631.745254011062;4683.555062269079;4692.061587682409;4884.023195360871 18:33:17 INFO - PROCESS | 17600 | |4;prototype.html;315.7537121045584;321.37544711483457;323.4210762734706;327.616688474485;328.4105031468514;5402.864928376793;5479.835604931854;5505.807296744615;5508.732991411977;5512.4211957744365;5370.43610420905;5390.1375779875225;5395.379531353896;5415.350157981038;5424.376196737377;3989.16227592206;4064.309067458524;4102.159057393227;4182.602652747984;4223.282042052859;4111.7944102794745;4181.937270940924;4197.538270790211;4220.345846393814;4242.130363275521;4189.988805373423;4211.642010429117;4224.281872081738;4224.281872081753;4229.894252643693;4092.8130842055766;4163.875083747493;4199.118185181115;4201.747895126302;4219.767912764797;3706.721995850295;3708.313961917054;3708.9258214835822;3713.702903767692;3716.684081853046;5273.709945952971;5276.92084618731;5294.311739473844;5298.145649022849;5307.177387504943;4598.770061496912;4735.526447355272;4797.56821886032;4833.275008748681;4849.187471266657;5561.246158842765;5581.888362232733;5587.8603034924045;5589.608727389084;5592.189132575753;4077.633013028812;4083.3262511685534;4085.20338533986;4114.115465175002;4140.23405669952;5730.455606717355;5846.503047240947;5855.2973643163095;5899.32157801854;5937.940620593782;4177.540470548237;4188.078622703;4191.622753952159;4198.202341555095;4202.2646036943415;4220.324748040299;4250.213710463574;4254.723442976197;4262.232798096373;4287;4644.930326045112;4741.2651039089;4790.401199850019;4806.567408933212;4844.854654360304;5633.521150702154;5634.352049514358;5641.633293835887;5651.660900345993;5675.347335056439;1442.725882082401;1448.3627204030404;1457.884718190585;1460.890433217513;1462.5831637983124;871.7515508080166;925.5834874306589;929.8930622978309;950.4059962523423;951.7763325618474;5402.972985135049;5423.18652202165;5443.918341224806;5444.611624035925;5449.3460784706085;5773.740181691834;5776.6713655859385;5780.393058728857;5784.772862447988;5793.333766616809;5320.547753441001;5346.465353464622;5430.294061771944;5438.972805135949;5492.972535137299;3032.7118923702214;3052.6184226971627;3055.341852588218;3071.508558630608;3073.262417019899;5808.361080281165;5948.553858460633;6006.609570377911;6038.33578306386;6040.610659548329;5787.131930210502;5811.680357580373;5833.404135159898;5838.941610583925;5845.678487683218;5961.731722072517;5966.224390829165;5978.1929439525975;5980.641161530322;5996.820095397233;5524.364698059614;5710.057840456278;5757.712114394348;5759.996802222415;5774.1338799178775;5654.465958775765;5671.461211184931;5678.403767604342;5684.886302274014;5703.830714703393;5836.445537673914;5959.612625179349;6015.819525414245;6024.7288872001745;6026.306974697965;4034;4063.593640636031;4066.739310813657;4066.8039258799918;4086.81609327575;5766.5675074368755;5767.365589785037;5775.451332123442;5785.566082543742;5832.650040997553;5516.61383703153;5668.178114173505;5685.374608793112;5692.430756924275;5707.828765137053;5602.2717046783655;5614.803481878114;5614.887702246014;5624;5641.856094683993;5595.580331475075;5615.410381909841;5628.296462942132;5636.802711905064;5652.484644333233;5537.833864984057;5735.5087677205065;5754.741036653444;5789.594728368974;5802.390748971466;5602.663840169603;5610.4670056344585;5642.379338272704;5660.235868157746;5675.772969081356 18:33:17 INFO - PROCESS | 17600 | |5;yui.html;720.049534614309;723.5333210079499;773.8374941262334;813.4996976859226;820.5117954816884;15959.601009974742;17011.149442527887;17090.829091709078;17131.314747410102;17156.22796974136;14653.120812751216;14692.559223223294;14770.261486925665;14808.851911480882;14849.851501484982;797.3939805747644;808.6563210635456;811.5293129984624;812.3622955979557;812.8699408094706;774.8643987302228;782.030282449761;782.7299581644323;782.7338704840353;785.6150486261748;817.3910436724649;822.7408366364606;824.171707434031;826.9131741167181;827.4414770030205;815.6003558256441;817.1868990354635;822.005373498068;822.5188264865061;822.6421506644599;608.1728848765675;608.3095686395928;608.8143116349512;609.2414943395456;610.1579819848625;13701.246431446267;13710.588682339545;13719.45122195111;13856.168629882239;13860.514881979183;12367.888912131815;12615.621531354074;12728.363581820964;13106.80339794904;13333.666658333523;10262.948685256526;10339.327943683636;10480.790384192274;10603.734906627396;10752.462376881125;3562.982185089084;3588.766730162557;3684.613115622848;3726.366517691999;3932;68569.65715171442;69357.30642693609;69935;70650.29349706488;70775.29224707739;10894.782104357868;10965.890341096487;11002.724931876766;11106;11171.776564468664;19549;19591.706124408145;19597.51006224856;19786.307479238447;19791.208351665773;7318.780436586911;7523.586202758901;7725.188855170126;7857.764267071997;7920.366370690331;4139.8965025874595;4260.360945858084;4419.469663640384;4562.201614717411;4657.091867085954;3533.09905973975;3670.541182352206;3682.779033258013;3686.2811751708696;3687.557493100845;592.6885147923049;608.3095686395884;612.5620181570199;613.141601757543;617.8331850400457;700.0947011954082;725.8802297620939;726.0425733955902;733.8922535246053;760.1410406240913;8544.786380340416;8904.465732056098;9299.488528130882;9309.534523273946;9324.813503729887;577.4427677291434;653.3662347522895;657.2310396835713;759.1725019728523;764.7782143178528;4340.869773906725;4604.240300350405;4621.145088158702;4626.1210370029585;4661.347411362412;112198;115749.4212528932;116200;122840;122965;75718;97501.51249243709;100546;100882.4955875216;101053.49473252587;88957.55521222352;90205;90932.5453372729;91971.54014229887;92694;8461.746147615582;8593.871091933752;8721.520316382406;8832.91167088321;8896.911030889609;52090;52441.21338179854;53119.46880531145;53792;54106.18840717471;70041;72488;75825;78582;78830.6058469704;11699.88300117022;11876.406179691154;11916.320329689534;11933.224340417844;12207.38963051826;12514.43685034194;12677.556285529961;12731.93634031824;13051.738965220453;13330.86669133335;12204.633860984184;12304.569340073054;13230.867691323348;13256.403461844433;13338.799918001043;12404.62786116418;12456.750864982469;12456.75086498283;12470.750584988431;13180.209187448783;11712.238704484182;12043.638690839289;12462.813057804322;12482.94167928827;12484.687882803002;9188.448693078437;9223.148254492944;9297.256219502558;9328.580213890256;9421.246300295823;9912.89363461139;10350.637727679496;10388.37669739818;10473.162147028372;10517.737056573647 18:33:17 INFO - PROCESS | 17600 | __end_tp_report 18:33:17 INFO - PROCESS | 17600 | __start_cc_report 18:33:17 INFO - PROCESS | 17600 | _x_x_mozilla_cycle_collect,330 18:33:17 INFO - PROCESS | 17600 | __end_cc_report 18:33:17 INFO - PROCESS | 17600 | __startTimestamp1476927197358__endTimestamp 18:33:17 INFO - PROCESS | 17600 | 18:33:17 INFO - PROCESS | 17600 | ------- Summary: start ------- 18:33:17 INFO - PROCESS | 17600 | Number of tests: 6 18:33:17 INFO - PROCESS | 17600 | 18:33:17 INFO - PROCESS | 17600 | [#0] dojo.html Cycles:165 Average:5319.25 Median:5495.89 stddev:595.91 (10.8%) stddev-sans-first:570.27 18:33:17 INFO - PROCESS | 17600 | Values: 3039.5 3069.7 3080.6 3091.1 3101.2 5156.4 5366.5 5385.5 5387.4 5491.3 5260.1 5263.9 5280.2 5280.7 5283.2 4818.7 4857.2 4897.7 4915.9 4917.1 4858.4 4897.2 4898.7 4916.0 4921.7 4913.3 4915.4 4917.3 4919.5 4919.5 4887.2 4900.0 4900.4 4902.1 4915.5 4837.1 4889.0 4892.7 4898.5 4991.2 5354.5 5390.8 5451.9 5461.2 5466.3 5691.9 5724.0 5724.5 5731.2 5732.6 5651.8 5738.2 5779.7 5785.6 5791.5 5405.3 5408.0 5408.5 5420.9 5437.6 5838.5 5851.1 5870.4 5873.4 5874.1 5405.3 5509.5 5607.0 5628.4 5631.9 5659.6 5667.7 5672.3 5740.4 5843.4 5615.4 5651.6 5695.8 5702.1 5712.3 5667.5 5714.7 5725.5 5730.1 5748.5 4390.2 4395.1 4396.6 4399.5 4430.5 3902.3 3919.5 3920.6 3958.4 3987.7 5330.4 5374.8 5397.8 5452.4 5464.2 5599.5 5605.8 5618.2 5620.9 5622.5 5293.7 5306.2 5353.4 5356.8 5369.0 4891.0 4934.8 5000.4 5002.6 5007.5 5920.5 5955.9 5966.5 5975.8 5984.0 5558.9 5720.8 5756.4 5761.7 5779.1 5795.7 5879.3 5899.9 5909.4 6002.1 5632.1 5637.7 5640.3 5642.2 5688.9 5702.7 5707.1 5716.7 5721.4 5785.7 5417.3 5482.4 5579.5 5635.3 5652.7 5665.7 5673.5 5679.5 5684.3 5713.8 5613.2 5619.4 5629.4 5636.2 5640.8 5408.5 5447.3 5494.0 5562.1 5688.8 5446.5 5495.9 5503.7 5511.4 5524.4 18:33:17 INFO - PROCESS | 17600 | 18:33:17 INFO - PROCESS | 17600 | [#1] ext.html Cycles:180 Average:58185.86 Median:41702.87 stddev:114479.47 (274.5%) stddev-sans-first:114718.89 18:33:17 INFO - PROCESS | 17600 | Values: 571.9 577.6 582.6 585.4 585.5 42073.6 43684.0 43732.8 47418.0 47600.3 44642.8 45160.0 45169.8 45215.8 45362.5 8831.8 8908.6 8972.4 8978.8 8995.8 8840.4 8842.8 8854.0 8866.9 8897.2 8874.4 8911.1 8914.3 8948.8 8949.8 8845.2 8865.7 8866.0 8938.0 8950.9 8767.1 8827.4 8862.6 8871.1 8938.2 41200.0 41699.4 41706.4 41871.8 41938.4 3397.0 3455.9 3582.6 4013.0 4036.8 31898.7 32084.0 32149.2 32267.0 33976.8 4081.6 4176.3 4322.8 4330.2 4385.6 328950.0 328954.0 330008.0 330474.0 331726.3 57048.7 57215.4 57316.4 57437.4 57449.7 59243.1 59530.7 59676.0 59768.7 60149.7 15365.6 15577.4 15583.5 15704.8 15723.3 12355.7 12430.3 12449.5 12469.0 12502.2 15858.9 16774.6 17271.5 17443.0 17448.7 5859.4 5912.6 5969.4 6026.0 6080.3 940.9 1014.2 1044.3 1097.2 1131.6 30731.4 30802.8 31031.4 31181.8 31184.1 1040.3 1059.1 1091.3 1094.3 1170.3 15614.5 16526.5 16726.6 17107.8 17134.7 513496.0 518298.0 519660.0 519891.0 521894.0 55256.4 56499.7 56526.0 56747.0 57212.4 1293.2 1294.6 1321.1 1351.2 1364.1 29205.4 30951.5 31146.8 31286.5 31520.8 50183.2 50642.7 50679.0 50761.0 50803.7 424109.0 424987.0 425927.0 426626.0 428335.0 26183.9 26868.0 27100.2 27323.7 27399.6 43502.3 43530.6 44410.6 45035.0 45079.5 35269.1 36376.1 37610.4 38100.2 38803.4 36568.3 36640.3 36734.1 36901.6 37077.3 34611.0 35601.0 35933.6 38887.0 42542.8 33920.7 36158.8 36493.3 36751.0 36806.8 26658.7 26734.7 27155.7 27318.5 27762.7 18:33:17 INFO - PROCESS | 17600 | 18:33:17 INFO - PROCESS | 17600 | [#2] jquery.html Cycles:180 Average:27266.14 Median:39115.71 stddev:77347.69 (197.7%) stddev-sans-first:77538.27 18:33:17 INFO - PROCESS | 17600 | Values: 352.8 362.6 368.3 369.8 376.3 17727.2 18864.2 19078.1 19626.8 19729.1 18512.4 18551.7 18950.4 19050.3 19103.3 5308.2 5569.4 5571.5 5573.4 5575.0 4973.1 5490.2 5495.7 5502.6 5516.6 5395.2 5425.1 5445.2 5468.5 5475.5 5322.7 5498.3 5508.7 5526.0 5543.7 4854.7 4919.2 4921.8 4953.3 4964.5 21936.7 22004.9 22276.6 22335.1 22396.3 2190.3 2382.7 2458.9 2573.0 2973.4 13589.6 14239.3 14579.3 14597.3 14927.9 1837.3 1890.6 1895.8 1904.9 1940.0 75027.0 77159.0 77924.6 78194.0 79775.6 9200.9 9418.2 9475.5 9947.3 9967.5 12600.4 12652.2 12707.6 12738.0 12789.6 7424.7 7559.8 7625.1 7815.6 7834.0 7589.6 7635.2 7662.9 7828.5 7888.4 5998.6 6058.7 6087.7 6189.6 6204.8 1710.1 1712.7 1722.9 1723.2 1741.0 911.6 912.6 1005.6 1011.4 1018.1 18451.1 18940.6 19050.0 19375.9 19609.0 963.1 963.9 990.9 1022.6 1050.3 10314.5 10922.8 11046.3 11094.7 11154.4 462136.0 462341.0 469151.0 479855.0 480644.0 47927.8 78882.6 79828.0 80304.6 80448.0 1007.5 1013.5 1017.7 1021.2 1023.2 16511.3 16571.8 17171.8 17181.7 17268.6 38663.2 39067.6 39163.8 39723.8 39804.4 49956.8 51364.2 51530.7 51553.2 52213.5 7425.7 7795.9 7890.2 7919.3 8227.5 11255.2 12061.0 12071.0 12332.9 12616.9 5517.8 5557.0 9782.0 10555.4 10844.9 10476.8 10960.8 10998.2 11040.7 11345.6 9571.8 9955.2 10658.6 10763.0 10850.7 7388.0 7584.5 7625.6 7630.5 7793.6 9404.4 10358.4 10632.2 10674.0 10841.6 18:33:17 INFO - PROCESS | 17600 | 18:33:17 INFO - PROCESS | 17600 | [#3] mootools.html Cycles:180 Average:5696.90 Median:4630.40 stddev:3397.83 (73.4%) stddev-sans-first:3392.11 18:33:17 INFO - PROCESS | 17600 | Values: 1412.4 1447.5 1597.0 1779.8 1798.9 8439.0 8630.6 8947.0 9143.8 9186.5 9095.4 9249.2 9267.7 9267.9 9272.4 2268.7 2295.1 2306.0 2309.9 2310.2 2164.3 2224.5 2237.8 2245.8 2248.7 2211.6 2223.6 2225.5 2239.9 2240.4 2200.7 2202.4 2206.8 2214.9 2222.9 2194.8 2198.2 2200.7 2204.8 2207.0 9017.0 9037.8 9087.0 9090.5 9096.1 5147.5 5255.2 5320.6 5325.0 5340.1 3159.5 3229.3 3405.9 3410.7 3433.4 1050.2 1064.1 1064.9 1088.4 1098.2 12431.6 12473.7 12628.2 12637.1 12676.3 4156.4 4283.7 4341.7 4369.1 4398.6 9710.3 9723.9 9736.6 9752.3 9754.3 5096.2 5108.4 5136.9 5159.4 5162.2 4591.1 4663.0 4754.6 4821.2 4836.7 3621.5 3673.8 3718.7 3739.9 3780.7 1083.7 1088.2 1088.2 1088.8 1089.1 716.7 868.9 872.4 874.9 887.0 5306.5 5306.5 5362.8 5392.9 5412.8 417.7 423.6 424.4 427.7 436.7 3726.3 3773.6 3795.6 3834.8 3891.8 10770.5 11088.3 11184.2 11197.9 11222.9 11139.2 11152.5 11160.7 11164.8 11170.3 8145.7 8173.3 8277.3 8313.9 8372.3 5392.0 5433.9 5458.5 5490.5 5676.4 10040.1 10069.2 10189.1 10258.0 10325.4 9582.4 9947.7 10021.2 10283.9 10311.5 6967.7 7168.5 7648.3 7773.1 7995.3 8291.2 8684.5 8692.7 8713.6 8722.3 7729.6 7821.2 7959.2 8075.8 8086.4 7665.4 7777.5 7796.9 7831.1 7853.1 6293.3 6314.4 6367.6 6372.3 6385.2 4629.1 4658.0 4668.9 4693.5 4726.5 4583.8 4631.7 4683.6 4692.1 4884.0 18:33:17 INFO - PROCESS | 17600 | 18:33:17 INFO - PROCESS | 17600 | [#4] prototype.html Cycles:180 Average:4759.79 Median:5486.40 stddev:1402.04 (25.6%) stddev-sans-first:1365.72 18:33:17 INFO - PROCESS | 17600 | Values: 315.8 321.4 323.4 327.6 328.4 5402.9 5479.8 5505.8 5508.7 5512.4 5370.4 5390.1 5395.4 5415.4 5424.4 3989.2 4064.3 4102.2 4182.6 4223.3 4111.8 4181.9 4197.5 4220.3 4242.1 4190.0 4211.6 4224.3 4224.3 4229.9 4092.8 4163.9 4199.1 4201.7 4219.8 3706.7 3708.3 3708.9 3713.7 3716.7 5273.7 5276.9 5294.3 5298.1 5307.2 4598.8 4735.5 4797.6 4833.3 4849.2 5561.2 5581.9 5587.9 5589.6 5592.2 4077.6 4083.3 4085.2 4114.1 4140.2 5730.5 5846.5 5855.3 5899.3 5937.9 4177.5 4188.1 4191.6 4198.2 4202.3 4220.3 4250.2 4254.7 4262.2 4287.0 4644.9 4741.3 4790.4 4806.6 4844.9 5633.5 5634.4 5641.6 5651.7 5675.3 1442.7 1448.4 1457.9 1460.9 1462.6 871.8 925.6 929.9 950.4 951.8 5403.0 5423.2 5443.9 5444.6 5449.3 5773.7 5776.7 5780.4 5784.8 5793.3 5320.5 5346.5 5430.3 5439.0 5493.0 3032.7 3052.6 3055.3 3071.5 3073.3 5808.4 5948.6 6006.6 6038.3 6040.6 5787.1 5811.7 5833.4 5838.9 5845.7 5961.7 5966.2 5978.2 5980.6 5996.8 5524.4 5710.1 5757.7 5760.0 5774.1 5654.5 5671.5 5678.4 5684.9 5703.8 5836.4 5959.6 6015.8 6024.7 6026.3 4034.0 4063.6 4066.7 4066.8 4086.8 5766.6 5767.4 5775.5 5785.6 5832.7 5516.6 5668.2 5685.4 5692.4 5707.8 5602.3 5614.8 5614.9 5624.0 5641.9 5595.6 5615.4 5628.3 5636.8 5652.5 5537.8 5735.5 5754.7 5789.6 5802.4 5602.7 5610.5 5642.4 5660.2 5675.8 18:33:17 INFO - PROCESS | 17600 | 18:33:17 INFO - PROCESS | 17600 | [#5] yui.html Cycles:180 Average:20336.79 Median:4659.22 stddev:30164.36 (647.4%) stddev-sans-first:30213.01 18:33:17 INFO - PROCESS | 17600 | Values: 720.0 723.5 773.8 813.5 820.5 15959.6 17011.1 17090.8 17131.3 17156.2 14653.1 14692.6 14770.3 14808.9 14849.9 797.4 808.7 811.5 812.4 812.9 774.9 782.0 782.7 782.7 785.6 817.4 822.7 824.2 826.9 827.4 815.6 817.2 822.0 822.5 822.6 608.2 608.3 608.8 609.2 610.2 13701.2 13710.6 13719.5 13856.2 13860.5 12367.9 12615.6 12728.4 13106.8 13333.7 10262.9 10339.3 10480.8 10603.7 10752.5 3563.0 3588.8 3684.6 3726.4 3932.0 68569.7 69357.3 69935.0 70650.3 70775.3 10894.8 10965.9 11002.7 11106.0 11171.8 19549.0 19591.7 19597.5 19786.3 19791.2 7318.8 7523.6 7725.2 7857.8 7920.4 4139.9 4260.4 4419.5 4562.2 4657.1 3533.1 3670.5 3682.8 3686.3 3687.6 592.7 608.3 612.6 613.1 617.8 700.1 725.9 726.0 733.9 760.1 8544.8 8904.5 9299.5 9309.5 9324.8 577.4 653.4 657.2 759.2 764.8 4340.9 4604.2 4621.1 4626.1 4661.3 112198.0 115749.4 116200.0 122840.0 122965.0 75718.0 97501.5 100546.0 100882.5 101053.5 88957.6 90205.0 90932.5 91971.5 92694.0 8461.7 8593.9 8721.5 8832.9 8896.9 52090.0 52441.2 53119.5 53792.0 54106.2 70041.0 72488.0 75825.0 78582.0 78830.6 11699.9 11876.4 11916.3 11933.2 12207.4 12514.4 12677.6 12731.9 13051.7 13330.9 12204.6 12304.6 13230.9 13256.4 13338.8 12404.6 12456.8 12456.8 12470.8 13180.2 11712.2 12043.6 12462.8 12482.9 12484.7 9188.4 9223.1 9297.3 9328.6 9421.2 9912.9 10350.6 10388.4 10473.2 10517.7 18:33:17 INFO - PROCESS | 17600 | -------- Summary: end -------- 18:33:17 INFO - PROCESS | 17600 | 18:33:18 INFO - TEST-INFO | 17600: exit 0 18:33:18 INFO - TEST-OK | dromaeo_css | took 1116081ms 18:33:18 INFO - TEST-START | kraken 18:33:18 INFO - operating with platform_type : linux_ 18:33:18 INFO - Initialising browser for kraken test... 18:33:18 INFO - TEST-INFO | started process 17955 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBNmNNE/profile http://localhost:50934/getInfo.html) 18:33:22 INFO - PROCESS | 17955 | __metrics Screen width/height:1600/1200 18:33:22 INFO - PROCESS | 17955 | colorDepth:24 18:33:22 INFO - PROCESS | 17955 | Browser inner width/height: 1024/697 18:33:22 INFO - PROCESS | 17955 | __metrics 18:33:23 ERROR - PROCESS | 17955 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3087: TypeError: this.tabs is undefined 18:33:24 INFO - TEST-INFO | 17955: exit 0 18:33:24 INFO - Browser initialized. 18:33:24 INFO - Running cycle 1/1 for kraken test... 18:33:24 INFO - TEST-INFO | started process 18078 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBNmNNE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:33:36 INFO - PROCESS | 18078 | RSS: Main: 182849536 18:33:36 INFO - PROCESS | 18078 | 18:33:39 INFO - PROCESS | 18078 | Cycle 1(1): loaded http://localhost:50934/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50934/tests/kraken/driver.html?testName=audio-beat-detection) 18:33:40 INFO - PROCESS | 18078 | RSS: Main: 192217088 18:33:40 INFO - PROCESS | 18078 | 18:33:42 INFO - PROCESS | 18078 | Cycle 1(1): loaded http://localhost:50934/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50934/tests/kraken/driver.html?testName=audio-dft) 18:33:43 INFO - PROCESS | 18078 | RSS: Main: 194277376 18:33:43 INFO - PROCESS | 18078 | 18:33:46 INFO - PROCESS | 18078 | Cycle 1(1): loaded http://localhost:50934/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50934/tests/kraken/driver.html?testName=audio-fft) 18:33:46 INFO - PROCESS | 18078 | RSS: Main: 190644224 18:33:46 INFO - PROCESS | 18078 | 18:33:49 INFO - PROCESS | 18078 | Cycle 1(1): loaded http://localhost:50934/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50934/tests/kraken/driver.html?testName=audio-oscillator) 18:33:49 INFO - PROCESS | 18078 | RSS: Main: 191410176 18:33:49 INFO - PROCESS | 18078 | 18:33:51 INFO - PROCESS | 18078 | Cycle 1(1): loaded http://localhost:50934/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50934/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:33:52 INFO - PROCESS | 18078 | RSS: Main: 191406080 18:33:52 INFO - PROCESS | 18078 | 18:33:55 INFO - PROCESS | 18078 | Cycle 1(1): loaded http://localhost:50934/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50934/tests/kraken/driver.html?testName=imaging-darkroom) 18:33:56 INFO - PROCESS | 18078 | RSS: Main: 191356928 18:33:56 INFO - PROCESS | 18078 | 18:33:59 INFO - PROCESS | 18078 | Cycle 1(1): loaded http://localhost:50934/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50934/tests/kraken/driver.html?testName=imaging-desaturate) 18:34:00 INFO - PROCESS | 18078 | RSS: Main: 191717376 18:34:00 INFO - PROCESS | 18078 | 18:34:02 INFO - PROCESS | 18078 | Cycle 1(1): loaded http://localhost:50934/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50934/tests/kraken/driver.html?testName=json-parse-financial) 18:34:03 INFO - PROCESS | 18078 | RSS: Main: 192040960 18:34:03 INFO - PROCESS | 18078 | 18:34:05 INFO - PROCESS | 18078 | Cycle 1(1): loaded http://localhost:50934/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50934/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:34:05 INFO - PROCESS | 18078 | RSS: Main: 191680512 18:34:05 INFO - PROCESS | 18078 | 18:34:07 INFO - PROCESS | 18078 | Cycle 1(1): loaded http://localhost:50934/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50934/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:34:08 INFO - PROCESS | 18078 | RSS: Main: 191762432 18:34:08 INFO - PROCESS | 18078 | 18:34:10 INFO - PROCESS | 18078 | Cycle 1(1): loaded http://localhost:50934/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50934/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:34:10 INFO - PROCESS | 18078 | RSS: Main: 192008192 18:34:10 INFO - PROCESS | 18078 | 18:34:13 INFO - PROCESS | 18078 | Cycle 1(1): loaded http://localhost:50934/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50934/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:34:14 INFO - PROCESS | 18078 | RSS: Main: 191733760 18:34:14 INFO - PROCESS | 18078 | 18:34:17 INFO - PROCESS | 18078 | Cycle 1(1): loaded http://localhost:50934/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50934/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:34:17 INFO - PROCESS | 18078 | RSS: Main: 192192512 18:34:17 INFO - PROCESS | 18078 | 18:34:19 INFO - PROCESS | 18078 | Cycle 1(1): loaded http://localhost:50934/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50934/tests/kraken/driver.html?testName=ai-astar) 18:34:19 INFO - PROCESS | 18078 | RSS: Main: 193503232 18:34:19 INFO - PROCESS | 18078 | 18:34:19 INFO - PROCESS | 18078 | __start_tp_report 18:34:19 INFO - PROCESS | 18078 | _x_x_mozilla_page_load 18:34:19 INFO - PROCESS | 18078 | _x_x_mozilla_page_load_details 18:34:19 INFO - PROCESS | 18078 | |i|pagename|runs| 18:34:19 INFO - PROCESS | 18078 | |0;ai-astar;105;113;113;112;111;111;111;115;115;111 18:34:19 INFO - PROCESS | 18078 | |1;audio-beat-detection;156;127;125;171;126;129;122;123;172;126 18:34:19 INFO - PROCESS | 18078 | |2;audio-dft;164;164;165;191;165;161;163;165;162;167 18:34:19 INFO - PROCESS | 18078 | |3;audio-fft;75;77;77;130;77;76;78;76;119;77 18:34:19 INFO - PROCESS | 18078 | |4;audio-oscillator;83;83;123;83;82;82;105;82;82;124 18:34:19 INFO - PROCESS | 18078 | |5;imaging-gaussian-blur;118;118;117;117;117;117;117;118;117;118 18:34:19 INFO - PROCESS | 18078 | |6;imaging-darkroom;149;148;147;147;146;146;149;147;147;148 18:34:19 INFO - PROCESS | 18078 | |7;imaging-desaturate;86;85;85;85;86;86;85;86;87;86 18:34:19 INFO - PROCESS | 18078 | |8;json-parse-financial;56;54;54;57;55;57;54;59;55;55 18:34:19 INFO - PROCESS | 18078 | |9;json-stringify-tinderbox;61;61;61;61;62;61;62;62;62;62 18:34:19 INFO - PROCESS | 18078 | |10;stanford-crypto-aes;81;81;81;82;81;80;80;81;82;91 18:34:19 INFO - PROCESS | 18078 | |11;stanford-crypto-ccm;150;146;134;139;136;143;146;144;180;141 18:34:19 INFO - PROCESS | 18078 | |12;stanford-crypto-pbkdf2;170;171;171;175;172;172;169;169;170;175 18:34:19 INFO - PROCESS | 18078 | |13;stanford-crypto-sha256-iterative;67;67;67;66;75;73;66;66;65;64 18:34:19 INFO - PROCESS | 18078 | __end_tp_report 18:34:19 INFO - PROCESS | 18078 | __start_cc_report 18:34:19 INFO - PROCESS | 18078 | _x_x_mozilla_cycle_collect,802 18:34:19 INFO - PROCESS | 18078 | __end_cc_report 18:34:19 INFO - PROCESS | 18078 | __startTimestamp1476927259826__endTimestamp 18:34:19 INFO - PROCESS | 18078 | 18:34:19 INFO - PROCESS | 18078 | ------- Summary: start ------- 18:34:19 INFO - PROCESS | 18078 | Number of tests: 14 18:34:19 INFO - PROCESS | 18078 | 18:34:19 INFO - PROCESS | 18078 | [#0] ai-astar Cycles:10 Average:111.70 Median:112.50 stddev:2.83 (2.5%) stddev-sans-first:1.67 18:34:19 INFO - PROCESS | 18078 | Values: 105.0 113.0 113.0 112.0 111.0 111.0 111.0 115.0 115.0 111.0 18:34:19 INFO - PROCESS | 18078 | 18:34:19 INFO - PROCESS | 18078 | [#1] audio-beat-detection Cycles:10 Average:137.70 Median:128.00 stddev:20.30 (15.9%) stddev-sans-first:20.42 18:34:19 INFO - PROCESS | 18078 | Values: 156.0 127.0 125.0 171.0 126.0 129.0 122.0 123.0 172.0 126.0 18:34:19 INFO - PROCESS | 18078 | 18:34:19 INFO - PROCESS | 18078 | [#2] audio-dft Cycles:10 Average:166.70 Median:165.00 stddev:8.71 (5.3%) stddev-sans-first:9.18 18:34:19 INFO - PROCESS | 18078 | Values: 164.0 164.0 165.0 191.0 165.0 161.0 163.0 165.0 162.0 167.0 18:34:19 INFO - PROCESS | 18078 | 18:34:19 INFO - PROCESS | 18078 | [#3] audio-fft Cycles:10 Average:86.20 Median:77.00 stddev:20.37 (26.5%) stddev-sans-first:21.20 18:34:19 INFO - PROCESS | 18078 | Values: 75.0 77.0 77.0 130.0 77.0 76.0 78.0 76.0 119.0 77.0 18:34:19 INFO - PROCESS | 18078 | 18:34:19 INFO - PROCESS | 18078 | [#4] audio-oscillator Cycles:10 Average:92.90 Median:82.00 stddev:17.60 (21.5%) stddev-sans-first:18.30 18:34:19 INFO - PROCESS | 18078 | Values: 83.0 83.0 123.0 83.0 82.0 82.0 105.0 82.0 82.0 124.0 18:34:19 INFO - PROCESS | 18078 | 18:34:19 INFO - PROCESS | 18078 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 18:34:19 INFO - PROCESS | 18078 | Values: 118.0 118.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 118.0 18:34:19 INFO - PROCESS | 18078 | 18:34:19 INFO - PROCESS | 18078 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:1.07 (0.7%) stddev-sans-first:0.97 18:34:19 INFO - PROCESS | 18078 | Values: 149.0 148.0 147.0 147.0 146.0 146.0 149.0 147.0 147.0 148.0 18:34:19 INFO - PROCESS | 18078 | 18:34:19 INFO - PROCESS | 18078 | [#7] imaging-desaturate Cycles:10 Average:85.70 Median:86.00 stddev:0.67 (0.8%) stddev-sans-first:0.71 18:34:19 INFO - PROCESS | 18078 | Values: 86.0 85.0 85.0 85.0 86.0 86.0 85.0 86.0 87.0 86.0 18:34:19 INFO - PROCESS | 18078 | 18:34:19 INFO - PROCESS | 18078 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:55.50 stddev:1.65 (3.0%) stddev-sans-first:1.74 18:34:19 INFO - PROCESS | 18078 | Values: 56.0 54.0 54.0 57.0 55.0 57.0 54.0 59.0 55.0 55.0 18:34:19 INFO - PROCESS | 18078 | 18:34:19 INFO - PROCESS | 18078 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:62.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 18:34:19 INFO - PROCESS | 18078 | Values: 61.0 61.0 61.0 61.0 62.0 61.0 62.0 62.0 62.0 62.0 18:34:19 INFO - PROCESS | 18078 | 18:34:19 INFO - PROCESS | 18078 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:81.00 stddev:3.23 (4.0%) stddev-sans-first:3.41 18:34:19 INFO - PROCESS | 18078 | Values: 81.0 81.0 81.0 82.0 81.0 80.0 80.0 81.0 82.0 91.0 18:34:19 INFO - PROCESS | 18078 | 18:34:19 INFO - PROCESS | 18078 | [#11] stanford-crypto-ccm Cycles:10 Average:145.90 Median:145.00 stddev:12.92 (8.9%) stddev-sans-first:13.62 18:34:19 INFO - PROCESS | 18078 | Values: 150.0 146.0 134.0 139.0 136.0 143.0 146.0 144.0 180.0 141.0 18:34:19 INFO - PROCESS | 18078 | 18:34:19 INFO - PROCESS | 18078 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.40 Median:171.50 stddev:2.17 (1.3%) stddev-sans-first:2.24 18:34:19 INFO - PROCESS | 18078 | Values: 170.0 171.0 171.0 175.0 172.0 172.0 169.0 169.0 170.0 175.0 18:34:19 INFO - PROCESS | 18078 | 18:34:19 INFO - PROCESS | 18078 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.00 stddev:3.53 (5.3%) stddev-sans-first:3.74 18:34:19 INFO - PROCESS | 18078 | Values: 67.0 67.0 67.0 66.0 75.0 73.0 66.0 66.0 65.0 64.0 18:34:19 INFO - PROCESS | 18078 | -------- Summary: end -------- 18:34:19 INFO - PROCESS | 18078 | 18:34:20 INFO - TEST-INFO | 18078: exit 0 18:34:20 INFO - TEST-OK | kraken | took 62578ms 18:34:20 INFO - SUITE-END | took 1178s 18:34:20 INFO - Completed test suite (00:19:38) 18:34:20 INFO - javascript benchmark 18:34:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7060.230391263963, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3039.544068389742, 3069.7237248647616, 3080.645725741539, 3091.1190310761435, 3101.209191656127, 5156.381234251886, 5366.490183432577, 5385.515303622673, 5387.4343193964605, 5491.313585801775, 5260.079486089938, 5263.894722105565, 5280.1815718563585, 5280.735963201834, 5283.207518872171, 4818.662693611449, 4857.247126695368, 4897.657163998521, 4915.852524424273, 4917.139500587401, 4858.441279252896, 4897.216445368742, 4898.681585696936, 4916.0, 4921.704697718131, 4913.26301054841, 4915.434725006617, 4917.262410638397, 4919.532644398776, 4919.532644398794, 4887.169181239198, 4899.951000489985, 4900.411950565919, 4902.117618828609, 4915.483874193212, 4837.105135549935, 4888.951110488921, 4892.730899800509, 4898.461169271413, 4991.176455884774, 5354.544863686591, 5390.811321603765, 5451.945480545183, 5461.208124821878, 5466.34403871538, 5691.9146212806845, 5723.998300297473, 5724.513416359614, 5731.197632331436, 5732.5987180897355, 5651.802186923479, 5738.196652468658, 5779.682117483537, 5785.595008349417, 5791.507721843606, 5405.27028851104, 5407.999999999961, 5408.486193811582, 5420.891582168413, 5437.619366644337, 5838.5329173666005, 5851.122331650201, 5870.354261031283, 5873.383294754075, 5874.089516124922, 5405.324334458192, 5509.531689806331, 5607.018771715015, 5628.352739435018, 5631.915521267184, 5659.603827732101, 5667.744951477193, 5672.290963629546, 5740.39725828782, 5843.3864444233595, 5615.382307946123, 5651.632643878217, 5695.772169113272, 5702.059160238514, 5712.314522257356, 5667.489925906688, 5714.7428365723645, 5725.456081672234, 5730.08318669011, 5748.511376533042, 4390.209762242827, 4395.077033822933, 4396.648268138541, 4399.5380485049245, 4430.4683437987005, 3902.3366027774778, 3919.5296564411883, 3920.6079392060565, 3958.426028225949, 3987.6610488108836, 5330.440303768126, 5374.838754837361, 5397.784088636489, 5452.40023597404, 5464.18037294409, 5599.496045355938, 5605.80379686709, 5618.185363122325, 5620.91568626471, 5622.493975542221, 5293.655912365684, 5306.177542480922, 5353.437889021597, 5356.839294821161, 5368.9731551342775, 4891.0, 4934.827281045218, 5000.424951130593, 5002.649814513022, 5007.499250074963, 5920.526357891358, 5955.91066134017, 5966.522678185735, 5975.820725378333, 5984.042553191555, 5558.916616250679, 5720.799772007959, 5756.42435756421, 5761.711914404179, 5779.075347944308, 5795.710214489343, 5879.265091863517, 5899.941000590111, 5909.438603332676, 6002.129691194665, 5632.070708333079, 5637.661740295432, 5640.32316122068, 5642.210090587403, 5688.8577785554035, 5702.714864256687, 5707.058335374617, 5716.742746576331, 5721.427857214412, 5785.681787501728, 5417.322834645669, 5482.369527504388, 5579.525740311957, 5635.295588051494, 5652.745626446737, 5665.66006039639, 5673.461021202979, 5679.488846003879, 5684.261046063985, 5713.771449141987, 5613.242212301287, 5619.409961954099, 5629.352624448241, 5636.239107720406, 5640.830775076754, 5408.45915408456, 5447.291852059207, 5493.972530137484, 5562.054450743302, 5688.829335119953, 5446.537044351275, 5495.890082198413, 5503.697296648723, 5511.448855114617, 5524.447555244444], "value": 5279.249744957377, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.9476163858501, 577.644748479685, 582.5572564850712, 585.3911931591143, 585.5110982329754, 42073.57926420735, 43684.0, 43732.781336093314, 47418.0, 47600.285995710095, 44642.776786116105, 45160.0, 45169.77415112928, 45215.77392113043, 45362.54637453624, 8831.807705959709, 8908.599113039896, 8972.416792908472, 8978.820423591524, 8995.775105622346, 8840.38117331787, 8842.76201331814, 8854.0, 8866.911330886673, 8897.154770296811, 8874.42316249445, 8911.108889111101, 8914.33142514314, 8948.776280592972, 8949.77625559363, 8845.20393164615, 8865.689700860472, 8865.955670221607, 8938.0, 8950.86573701395, 8767.123287671246, 8827.426217295855, 8862.55687215643, 8871.112888711143, 8938.1508756668, 41200.0, 41699.37450938238, 41706.37440438396, 41871.79064104691, 41938.37092443616, 3396.9830150849334, 3455.879044233465, 3582.6059133495296, 4012.979935100335, 4036.8385264589383, 31898.681013189802, 32084.0, 32149.1962700932, 32267.0, 33976.83011584926, 4081.5918408159246, 4176.331786914109, 4322.783860806947, 4330.242207613686, 4385.605295523386, 328950.0, 328954.0, 330008.0, 330474.0, 331726.34136829403, 57048.71475642595, 57215.427845721846, 57316.426835731945, 57437.42562574404, 57449.712751435974, 59243.11135332973, 59530.70234648799, 59676.0, 59768.70115649394, 60149.699251503465, 15365.6158596036, 15577.376904923676, 15583.454579089677, 15704.764428533352, 15723.292451839467, 12355.6911077222, 12430.254184748945, 12449.502019919282, 12469.0, 12502.187357821713, 15858.920705396398, 16774.58063548421, 17271.481855544353, 17443.0, 17448.65102697939, 5859.44335288147, 5912.615679980788, 5969.432903874125, 6025.969870150621, 6080.270367555833, 940.8776859008285, 1014.1937159957852, 1044.2690116918188, 1097.1880808201872, 1131.5700033987032, 30731.38537229243, 30802.845985770375, 31031.379372412426, 31181.8440907794, 31184.064478065695, 1040.328987802863, 1059.1209296284067, 1091.252492042953, 1094.2777766674117, 1170.303669316755, 15614.531564053097, 16526.504204873632, 16726.58183545421, 17107.828921710625, 17134.657306854042, 513496.0, 518298.0, 519660.0, 519891.0, 521894.0, 55256.44743552594, 56499.71750141223, 56526.0, 56747.0, 57212.42787572154, 1293.1594463598735, 1294.6245588779148, 1321.0752473268751, 1351.175782772508, 1364.0724307471014, 29205.41589168247, 30951.535726964565, 31146.844265778527, 31286.53070203994, 31520.84239578879, 50183.24725129199, 50642.74678626583, 50679.0, 50761.0, 50803.74598126986, 424109.0, 424987.0, 425927.0, 426626.0, 428335.0, 26183.869080654476, 26868.0, 27100.1869943902, 27323.72676273212, 27399.589006165323, 43502.34746478742, 43530.56469435392, 44410.55589444193, 45035.0, 45079.54920450885, 35269.1182720434, 36376.09059773527, 37610.435843461826, 38100.237995240495, 38803.417948730224, 36568.26863462663, 36640.26719465649, 36734.081647959014, 36901.63098368982, 37077.258454831295, 34611.0, 35601.0, 35933.64066359407, 38887.0, 42542.78728606337, 33920.66079339175, 36158.84173320102, 36493.27013459769, 36751.0, 36806.815965919996, 26658.733412665624, 26734.732652674003, 27155.72844271532, 27318.453630927666, 27762.722372776014], "value": 19511.314376466846, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.7565979474164, 362.63555127097266, 368.2910397484842, 369.8354232366597, 376.29069204549415, 17727.202275897584, 18864.151113199903, 19078.141483633237, 19626.803731962675, 19729.11218995145, 18512.44462666122, 18551.72172417415, 18950.431487055375, 19050.33323833666, 19103.331383401583, 5308.177232528964, 5569.387367389584, 5571.498565129137, 5573.41479144688, 5575.0, 4973.1297023020825, 5490.231367608538, 5495.725213739317, 5502.642328248671, 5516.641418307817, 5395.163749618815, 5425.050616142179, 5445.210444485548, 5468.453154684539, 5475.479829416199, 5322.733863306838, 5498.340199176085, 5508.669479831223, 5525.972370138124, 5543.667379957215, 4854.708717476963, 4919.21292593187, 4921.778519966574, 4953.331300274453, 4964.528369804862, 21936.670949935764, 22004.929088118748, 22276.554468910694, 22335.10659573615, 22396.328110156723, 2190.3100523335097, 2382.6664267002634, 2458.942654658496, 2572.961405578918, 2973.3607274435885, 13589.62142417566, 14239.288035598178, 14579.343929523196, 14597.343119559539, 14927.850721492754, 1837.255911355903, 1890.5935223926783, 1895.772507299119, 1904.9333273335367, 1940.0493758058449, 75027.0, 77158.99278433406, 77924.61037694832, 78194.0, 79775.60112199518, 9200.90799092014, 9418.246540276761, 9475.536360546308, 9947.253955953332, 9967.451790151612, 12600.4329805159, 12652.240865548096, 12707.555235566711, 12738.0, 12789.616311510483, 7424.665890034961, 7559.848803023909, 7625.1231108422135, 7815.6482958267015, 7834.0, 7589.620518974029, 7635.160132385433, 7662.885056724153, 7828.530288182727, 7888.368930485547, 5998.580099393001, 6058.697065146725, 6087.6956152192215, 6189.597676151036, 6204.751809927642, 1710.1192885663893, 1712.700277451466, 1722.9310827567008, 1723.2073246306588, 1740.9651806963789, 911.5943405184629, 912.6349460215833, 1005.6178652112151, 1011.4487604255698, 1018.1498448795339, 18451.07744612764, 18940.621187576446, 19050.0, 19375.90312048431, 19609.0, 963.1091240602415, 963.8698775665335, 990.9058639429243, 1022.5858527296457, 1050.3172937590627, 10314.535845886952, 10922.781544369227, 11046.281991670516, 11094.722631934104, 11154.442277886235, 462136.0, 462341.0, 469151.0, 479855.0, 480644.0, 47927.76036119867, 78882.6055869717, 79828.0, 80304.59847700724, 80448.0, 1007.4811472091878, 1013.5033833421718, 1017.704865588971, 1021.1983592879554, 1023.2325755683238, 16511.256993435083, 16571.834281657513, 17171.828281717022, 17181.742273865653, 17268.568285792455, 38663.226735465694, 39067.6093239064, 39163.804180978914, 39723.80138099291, 39804.40293395543, 49956.750216248685, 51364.22953655773, 51530.742346288025, 51553.22670160026, 52213.47786522086, 7425.693098003253, 7795.922040779519, 7890.171531989288, 7919.287264146024, 8227.465214761021, 11255.212135150461, 12061.0, 12071.0, 12332.938335308267, 12616.873831261937, 5517.751701173537, 5556.99974004683, 9782.0, 10555.366677999345, 10844.891551084389, 10476.842847357448, 10960.780784384107, 10998.230123891251, 11040.668779936615, 11345.602903898654, 9571.760705982406, 9955.20358371314, 10658.573657053632, 10763.0, 10850.67447976562, 7388.0, 7584.5070070445245, 7625.580593067434, 7630.504017238862, 7793.571353575608, 9404.38871473352, 10358.378497290187, 10632.202584806326, 10674.0, 10841.620543280947], "value": 8772.81798413946, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1412.4209074279547, 1447.5223176351801, 1596.9517273711144, 1779.7597324361207, 1798.8560915126784, 8439.0, 8630.611622476988, 8946.955265223682, 9143.817123657524, 9186.54067296635, 9095.408798428114, 9249.213816825579, 9267.675631352904, 9267.860982085274, 9272.397294175891, 2268.671042698812, 2295.127851416468, 2306.0, 2309.937428782762, 2310.1567927706433, 2164.3290579920194, 2224.5328481019005, 2237.7538470768204, 2245.764194759551, 2248.651459023854, 2211.612967730649, 2223.5775202711516, 2225.5103877147003, 2239.899204535792, 2240.350298413458, 2200.6698995150696, 2202.41635966469, 2206.7793220677886, 2214.8560343577615, 2222.944426389337, 2194.846360754748, 2198.208644887839, 2200.7359116905914, 2204.7905448982483, 2207.0, 9017.0, 9037.819243615157, 9087.0, 9090.454572725657, 9096.090390960917, 5147.510986456281, 5255.237990491396, 5320.574354051667, 5325.0148722486465, 5340.092184328634, 3159.510275907238, 3229.3218424130728, 3405.931881362359, 3410.658934106594, 3433.4163192257374, 1050.1808589300358, 1064.1380481809758, 1064.9307794993301, 1088.434014312561, 1098.203802243375, 12431.62705118848, 12473.688157796038, 12628.242305461701, 12637.115401921868, 12676.302803345812, 4156.355764856452, 4283.678724095706, 4341.6526677865695, 4369.077605853415, 4398.626116780046, 9710.271729620306, 9723.902760972442, 9736.610535578497, 9752.26857985654, 9754.268429867789, 5096.159133742891, 5108.438071812097, 5136.948630513722, 5159.406668233126, 5162.225666150108, 4591.058832939239, 4663.0, 4754.595859351924, 4821.180399332122, 4836.685615434985, 3621.4567814827988, 3673.81630918453, 3718.721095917817, 3739.85040598373, 3780.716446266541, 1083.7344850511674, 1088.2219213262556, 1088.2382332367374, 1088.8257878739364, 1089.1069323155095, 716.6524235745659, 868.8783570300037, 872.4459967920416, 874.908134645853, 887.0198430734075, 5306.46935306474, 5306.52241298285, 5362.839114826562, 5392.865178370572, 5412.83761487156, 417.7493503897637, 423.60181429456213, 424.3613361890335, 427.72198071253314, 436.65286097552524, 3726.347889119393, 3773.584905660375, 3795.6394142556414, 3834.750741201813, 3891.7664940103687, 10770.515326810313, 11088.33469991803, 11184.217104802749, 11197.888021119847, 11222.943885280685, 11139.220254582264, 11152.498137583829, 11160.665180044612, 11164.776704465865, 11170.329780213213, 8145.69371434273, 8173.34613230952, 8277.337812974947, 8313.916860831436, 8372.28835548985, 5392.0, 5433.864153396196, 5458.4541545845095, 5490.505854473116, 5676.403977582459, 10040.146587539848, 10069.194464442973, 10189.082982531607, 10258.025487578669, 10325.380477171393, 9582.377145485521, 9947.701568952943, 10021.248406369406, 10283.94858025735, 10311.484425778832, 6967.686454109678, 7168.53404528704, 7648.273414025659, 7773.067231932205, 7995.320397766022, 8291.170882911661, 8684.522351270742, 8692.739217823475, 8713.564321784012, 8722.345824063093, 7729.613519323899, 7821.217878212134, 7959.243871832166, 8075.798105047421, 8086.353091752763, 7665.386769058574, 7777.455578109478, 7796.883046754417, 7831.060272767304, 7853.1361550228285, 6293.276273228637, 6314.431701146918, 6367.649779261999, 6372.330905254881, 6385.201849768779, 4629.051044535795, 4657.976710116428, 4668.906621867612, 4693.483716791218, 4726.480087190475, 4583.770811459481, 4631.745254011062, 4683.555062269079, 4692.061587682409, 4884.023195360871], "value": 4404.123702796678, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.7537121045584, 321.37544711483457, 323.4210762734706, 327.616688474485, 328.4105031468514, 5402.864928376793, 5479.835604931854, 5505.807296744615, 5508.732991411977, 5512.4211957744365, 5370.43610420905, 5390.1375779875225, 5395.379531353896, 5415.350157981038, 5424.376196737377, 3989.16227592206, 4064.309067458524, 4102.159057393227, 4182.602652747984, 4223.282042052859, 4111.7944102794745, 4181.937270940924, 4197.538270790211, 4220.345846393814, 4242.130363275521, 4189.988805373423, 4211.642010429117, 4224.281872081738, 4224.281872081753, 4229.894252643693, 4092.8130842055766, 4163.875083747493, 4199.118185181115, 4201.747895126302, 4219.767912764797, 3706.721995850295, 3708.313961917054, 3708.9258214835822, 3713.702903767692, 3716.684081853046, 5273.709945952971, 5276.92084618731, 5294.311739473844, 5298.145649022849, 5307.177387504943, 4598.770061496912, 4735.526447355272, 4797.56821886032, 4833.275008748681, 4849.187471266657, 5561.246158842765, 5581.888362232733, 5587.8603034924045, 5589.608727389084, 5592.189132575753, 4077.633013028812, 4083.3262511685534, 4085.20338533986, 4114.115465175002, 4140.23405669952, 5730.455606717355, 5846.503047240947, 5855.2973643163095, 5899.32157801854, 5937.940620593782, 4177.540470548237, 4188.078622703, 4191.622753952159, 4198.202341555095, 4202.2646036943415, 4220.324748040299, 4250.213710463574, 4254.723442976197, 4262.232798096373, 4287.0, 4644.930326045112, 4741.2651039089, 4790.401199850019, 4806.567408933212, 4844.854654360304, 5633.521150702154, 5634.352049514358, 5641.633293835887, 5651.660900345993, 5675.347335056439, 1442.725882082401, 1448.3627204030404, 1457.884718190585, 1460.890433217513, 1462.5831637983124, 871.7515508080166, 925.5834874306589, 929.8930622978309, 950.4059962523423, 951.7763325618474, 5402.972985135049, 5423.18652202165, 5443.918341224806, 5444.611624035925, 5449.3460784706085, 5773.740181691834, 5776.6713655859385, 5780.393058728857, 5784.772862447988, 5793.333766616809, 5320.547753441001, 5346.465353464622, 5430.294061771944, 5438.972805135949, 5492.972535137299, 3032.7118923702214, 3052.6184226971627, 3055.341852588218, 3071.508558630608, 3073.262417019899, 5808.361080281165, 5948.553858460633, 6006.609570377911, 6038.33578306386, 6040.610659548329, 5787.131930210502, 5811.680357580373, 5833.404135159898, 5838.941610583925, 5845.678487683218, 5961.731722072517, 5966.224390829165, 5978.1929439525975, 5980.641161530322, 5996.820095397233, 5524.364698059614, 5710.057840456278, 5757.712114394348, 5759.996802222415, 5774.1338799178775, 5654.465958775765, 5671.461211184931, 5678.403767604342, 5684.886302274014, 5703.830714703393, 5836.445537673914, 5959.612625179349, 6015.819525414245, 6024.7288872001745, 6026.306974697965, 4034.0, 4063.593640636031, 4066.739310813657, 4066.8039258799918, 4086.81609327575, 5766.5675074368755, 5767.365589785037, 5775.451332123442, 5785.566082543742, 5832.650040997553, 5516.61383703153, 5668.178114173505, 5685.374608793112, 5692.430756924275, 5707.828765137053, 5602.2717046783655, 5614.803481878114, 5614.887702246014, 5624.0, 5641.856094683993, 5595.580331475075, 5615.410381909841, 5628.296462942132, 5636.802711905064, 5652.484644333233, 5537.833864984057, 5735.5087677205065, 5754.741036653444, 5789.594728368974, 5802.390748971466, 5602.663840169603, 5610.4670056344585, 5642.379338272704, 5660.235868157746, 5675.772969081356], "value": 4305.3712062295235, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [720.049534614309, 723.5333210079499, 773.8374941262334, 813.4996976859226, 820.5117954816884, 15959.601009974742, 17011.149442527887, 17090.829091709078, 17131.314747410102, 17156.22796974136, 14653.120812751216, 14692.559223223294, 14770.261486925665, 14808.851911480882, 14849.851501484982, 797.3939805747644, 808.6563210635456, 811.5293129984624, 812.3622955979557, 812.8699408094706, 774.8643987302228, 782.030282449761, 782.7299581644323, 782.7338704840353, 785.6150486261748, 817.3910436724649, 822.7408366364606, 824.171707434031, 826.9131741167181, 827.4414770030205, 815.6003558256441, 817.1868990354635, 822.005373498068, 822.5188264865061, 822.6421506644599, 608.1728848765675, 608.3095686395928, 608.8143116349512, 609.2414943395456, 610.1579819848625, 13701.246431446267, 13710.588682339545, 13719.45122195111, 13856.168629882239, 13860.514881979183, 12367.888912131815, 12615.621531354074, 12728.363581820964, 13106.80339794904, 13333.666658333523, 10262.948685256526, 10339.327943683636, 10480.790384192274, 10603.734906627396, 10752.462376881125, 3562.982185089084, 3588.766730162557, 3684.613115622848, 3726.366517691999, 3932.0, 68569.65715171442, 69357.30642693609, 69935.0, 70650.29349706488, 70775.29224707739, 10894.782104357868, 10965.890341096487, 11002.724931876766, 11106.0, 11171.776564468664, 19549.0, 19591.706124408145, 19597.51006224856, 19786.307479238447, 19791.208351665773, 7318.780436586911, 7523.586202758901, 7725.188855170126, 7857.764267071997, 7920.366370690331, 4139.8965025874595, 4260.360945858084, 4419.469663640384, 4562.201614717411, 4657.091867085954, 3533.09905973975, 3670.541182352206, 3682.779033258013, 3686.2811751708696, 3687.557493100845, 592.6885147923049, 608.3095686395884, 612.5620181570199, 613.141601757543, 617.8331850400457, 700.0947011954082, 725.8802297620939, 726.0425733955902, 733.8922535246053, 760.1410406240913, 8544.786380340416, 8904.465732056098, 9299.488528130882, 9309.534523273946, 9324.813503729887, 577.4427677291434, 653.3662347522895, 657.2310396835713, 759.1725019728523, 764.7782143178528, 4340.869773906725, 4604.240300350405, 4621.145088158702, 4626.1210370029585, 4661.347411362412, 112198.0, 115749.4212528932, 116200.0, 122840.0, 122965.0, 75718.0, 97501.51249243709, 100546.0, 100882.4955875216, 101053.49473252587, 88957.55521222352, 90205.0, 90932.5453372729, 91971.54014229887, 92694.0, 8461.746147615582, 8593.871091933752, 8721.520316382406, 8832.91167088321, 8896.911030889609, 52090.0, 52441.21338179854, 53119.46880531145, 53792.0, 54106.18840717471, 70041.0, 72488.0, 75825.0, 78582.0, 78830.6058469704, 11699.88300117022, 11876.406179691154, 11916.320329689534, 11933.224340417844, 12207.38963051826, 12514.43685034194, 12677.556285529961, 12731.93634031824, 13051.738965220453, 13330.86669133335, 12204.633860984184, 12304.569340073054, 13230.867691323348, 13256.403461844433, 13338.799918001043, 12404.62786116418, 12456.750864982469, 12456.75086498283, 12470.750584988431, 13180.209187448783, 11712.238704484182, 12043.638690839289, 12462.813057804322, 12482.94167928827, 12484.687882803002, 9188.448693078437, 9223.148254492944, 9297.256219502558, 9328.580213890256, 9421.246300295823, 9912.89363461139, 10350.637727679496, 10388.37669739818, 10473.162147028372, 10517.737056573647], "value": 7227.710786117284, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1529.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 113.0, 112.0, 111.0, 111.0, 111.0, 115.0, 115.0, 111.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 127.0, 125.0, 171.0, 126.0, 129.0, 122.0, 123.0, 172.0, 126.0], "value": 137.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 165.0, 191.0, 165.0, 161.0, 163.0, 165.0, 162.0, 167.0], "value": 166.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 77.0, 130.0, 77.0, 76.0, 78.0, 76.0, 119.0, 77.0], "value": 86.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 123.0, 83.0, 82.0, 82.0, 105.0, 82.0, 82.0, 124.0], "value": 92.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 147.0, 147.0, 146.0, 146.0, 149.0, 147.0, 147.0, 148.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 85.0, 86.0, 86.0, 85.0, 86.0, 87.0, 86.0], "value": 85.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 54.0, 57.0, 55.0, 57.0, 54.0, 59.0, 55.0, 55.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 62.0, 61.0, 62.0, 62.0, 62.0, 62.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 81.0, 82.0, 81.0, 80.0, 80.0, 81.0, 82.0, 91.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 146.0, 134.0, 139.0, 136.0, 143.0, 146.0, 144.0, 180.0, 141.0], "value": 145.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 171.0, 171.0, 175.0, 172.0, 172.0, 169.0, 169.0, 170.0, 175.0], "value": 171.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 66.0, 75.0, 73.0, 66.0, 66.0, 65.0, 64.0], "value": 67.6, "unit": "score"}]}]} 18:34:21 INFO - Return code: 0 18:34:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:34:21 ERROR - # TBPL SUCCESS # 18:34:21 INFO - Running post-action listener: _resource_record_post_action 18:34:21 INFO - [mozharness: 2016-10-20 01:34:21.155567Z] Finished run-tests step (success) 18:34:21 INFO - Running post-run listener: _resource_record_post_run 18:34:21 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392245248; Read time: 160; Write time: 288128 18:34:21 INFO - TinderboxPrint: CPU usage
13.4% 18:34:21 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 160 18:34:21 INFO - TinderboxPrint: I/O write bytes / time
392,245,248 / 288,128 18:34:21 INFO - TinderboxPrint: CPU idle
8,258.6 (86.6%) 18:34:21 INFO - TinderboxPrint: CPU user
1,218.7 (12.8%) 18:34:21 INFO - TinderboxPrint: Swap in / out
0 / 0 18:34:21 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103682048; Read time: 0; Write time: 104364 18:34:21 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288231424; Read time: 160; Write time: 183760 18:34:21 INFO - Running post-run listener: _upload_blobber_files 18:34:21 INFO - Blob upload gear active. 18:34:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:34:21 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 18:34:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:34:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:34:22 INFO - (blobuploader) - INFO - Open directory for files ... 18:34:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:34:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:34:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:34:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:34:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:34:22 INFO - (blobuploader) - INFO - Done attempting. 18:34:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:34:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:34:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:34:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:34:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:34:26 INFO - (blobuploader) - INFO - Done attempting. 18:34:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:34:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:34:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:34:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:34:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:34:27 INFO - (blobuploader) - INFO - Done attempting. 18:34:27 INFO - (blobuploader) - INFO - Iteration through files over. 18:34:27 INFO - Return code: 0 18:34:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:34:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:34:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1e851680ebb7e8e4df0a325f9d5a9f27a0d2003e84bdb3f785f210644df3793016905a7f339d5331753d9d4fdd8b283cca4d451cf6ac7ae3a080ab94edc9aa34", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4d79f10236871034325ed5342fa3151cc9a0a299f65759346dfe4d726a69f99b82cd16c68beeeea460cfa980e23a0b63442fa2f2063447152eff8ffd43c604cb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/46b1975531a43d44f51de36e41275f32275d14ae9c8edb2d6626bd52e4303541b0fd0019e4db2a9f7b1ff3d6b568c759a4a783a1b54c7f9420c46db538c1e1f5"} 18:34:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:34:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:34:27 INFO - Contents: 18:34:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1e851680ebb7e8e4df0a325f9d5a9f27a0d2003e84bdb3f785f210644df3793016905a7f339d5331753d9d4fdd8b283cca4d451cf6ac7ae3a080ab94edc9aa34", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4d79f10236871034325ed5342fa3151cc9a0a299f65759346dfe4d726a69f99b82cd16c68beeeea460cfa980e23a0b63442fa2f2063447152eff8ffd43c604cb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/46b1975531a43d44f51de36e41275f32275d14ae9c8edb2d6626bd52e4303541b0fd0019e4db2a9f7b1ff3d6b568c759a4a783a1b54c7f9420c46db538c1e1f5"} 18:34:27 INFO - Running post-run listener: copy_logs_to_upload_dir 18:34:27 INFO - Copying logs to upload dir... 18:34:27 INFO - mkdir: /builds/slave/test/build/upload/logs 18:34:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.007434 ========= master_lag: 0.51 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-10-19 18:34:27.170819) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 18:34:27.174226) ========= 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=923d835db2ba3686ebe126b700000192-1476925311.829349-1161084094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1e851680ebb7e8e4df0a325f9d5a9f27a0d2003e84bdb3f785f210644df3793016905a7f339d5331753d9d4fdd8b283cca4d451cf6ac7ae3a080ab94edc9aa34", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4d79f10236871034325ed5342fa3151cc9a0a299f65759346dfe4d726a69f99b82cd16c68beeeea460cfa980e23a0b63442fa2f2063447152eff8ffd43c604cb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/46b1975531a43d44f51de36e41275f32275d14ae9c8edb2d6626bd52e4303541b0fd0019e4db2a9f7b1ff3d6b568c759a4a783a1b54c7f9420c46db538c1e1f5"} build_url:https://queue.taskcluster.net/v1/task/S6NhpWKkRN-9JuRmZ0MnPQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011303 build_url: 'https://queue.taskcluster.net/v1/task/S6NhpWKkRN-9JuRmZ0MnPQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1e851680ebb7e8e4df0a325f9d5a9f27a0d2003e84bdb3f785f210644df3793016905a7f339d5331753d9d4fdd8b283cca4d451cf6ac7ae3a080ab94edc9aa34", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4d79f10236871034325ed5342fa3151cc9a0a299f65759346dfe4d726a69f99b82cd16c68beeeea460cfa980e23a0b63442fa2f2063447152eff8ffd43c604cb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/46b1975531a43d44f51de36e41275f32275d14ae9c8edb2d6626bd52e4303541b0fd0019e4db2a9f7b1ff3d6b568c759a4a783a1b54c7f9420c46db538c1e1f5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 18:34:27.199894) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 18:34:27.200265) ========= 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=923d835db2ba3686ebe126b700000192-1476925311.829349-1161084094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 18:34:27.250659) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 18:34:27.251005) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 18:34:27.251297) ========= ========= Total master_lag: 0.63 =========