builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-009 starttime: 1475813020.78 results: success (0) buildid: 20161006202401 builduid: ee2a3d12a1b746e0b7d546968ad16c8a revision: 0e67f06bcfcc83f4317a968914232bb6c82965ac ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 21:03:40.782377) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 21:03:40.782768) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 21:03:40.783034) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 21:03:40.805947) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:03:40.806204) ========= 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=17051fcd5208b27b50bedfeb000001dd-1475813020.494721-488689387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-06 21:03:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 39.0M=0s 2016-10-06 21:03:41 (39.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.090152 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:03:40.910094) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:03:40.910398) ========= 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=17051fcd5208b27b50bedfeb000001dd-1475813020.494721-488689387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016267 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:03:40.959775) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:03:40.960083) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0e67f06bcfcc83f4317a968914232bb6c82965ac --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 0e67f06bcfcc83f4317a968914232bb6c82965ac --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=17051fcd5208b27b50bedfeb000001dd-1475813020.494721-488689387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-06 21:03:41,466 truncating revision to first 12 chars 2016-10-06 21:03:41,466 Setting DEBUG logging. 2016-10-06 21:03:41,466 attempt 1/10 2016-10-06 21:03:41,466 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0e67f06bcfcc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-06 21:03:41,761 unpacking tar archive at: fx-team-0e67f06bcfcc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.613073 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:03:41.586480) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 21:03:41.586844) ========= script_repo_revision: 0e67f06bcfcc83f4317a968914232bb6c82965ac ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 21:03:41.587261) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 21:03:41.587527) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 21:03:41.596533) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-10-06 21:03:41.597151) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=17051fcd5208b27b50bedfeb000001dd-1475813020.494721-488689387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:03:42 INFO - MultiFileLogger online at 20161006 21:03:42 in /builds/slave/test 21:03:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 21:03:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:03:42 INFO - {'append_to_log': False, 21:03:42 INFO - 'base_work_dir': '/builds/slave/test', 21:03:42 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 21:03:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:03:42 INFO - 'branch': 'Fx-Team-Non-PGO', 21:03:42 INFO - 'buildbot_json_path': 'buildprops.json', 21:03:42 INFO - 'config_files': ('talos/linux_config.py',), 21:03:42 INFO - 'default_actions': ('clobber', 21:03:42 INFO - 'read-buildbot-config', 21:03:42 INFO - 'download-and-extract', 21:03:42 INFO - 'populate-webroot', 21:03:42 INFO - 'create-virtualenv', 21:03:42 INFO - 'install', 21:03:42 INFO - 'run-tests'), 21:03:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:03:42 INFO - 'download_minidump_stackwalk': True, 21:03:42 INFO - 'download_symbols': 'ondemand', 21:03:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:03:42 INFO - 'tooltool.py': '/tools/tooltool.py', 21:03:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:03:42 INFO - '/tools/misc-python/virtualenv.py')}, 21:03:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:03:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:03:42 INFO - 'installer_path': 'installer.exe', 21:03:42 INFO - 'log_level': 'info', 21:03:42 INFO - 'log_name': 'talos', 21:03:42 INFO - 'log_to_console': True, 21:03:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:03:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:03:42 INFO - 'opt_config_files': (), 21:03:42 INFO - 'pip_index': False, 21:03:42 INFO - 'sps_profile': False, 21:03:42 INFO - 'sps_profile_interval': 0, 21:03:42 INFO - 'suite': 'dromaeojs', 21:03:42 INFO - 'system_bits': '32', 21:03:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:03:42 INFO - 'title': 'talos-linux64-ix-009', 21:03:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:03:42 INFO - 'use_talos_json': True, 21:03:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:03:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:03:42 INFO - 'work_dir': 'build'} 21:03:42 INFO - [mozharness: 2016-10-07 04:03:42.203880Z] Running clobber step. 21:03:42 INFO - Running pre-action listener: _resource_record_pre_action 21:03:42 INFO - Running main action method: clobber 21:03:42 INFO - rmtree: /builds/slave/test/build 21:03:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:03:42 INFO - Running post-action listener: _resource_record_post_action 21:03:42 INFO - [mozharness: 2016-10-07 04:03:42.706117Z] Finished clobber step (success) 21:03:42 INFO - [mozharness: 2016-10-07 04:03:42.706218Z] Running read-buildbot-config step. 21:03:42 INFO - Running pre-action listener: _resource_record_pre_action 21:03:42 INFO - Running main action method: read_buildbot_config 21:03:42 INFO - Using buildbot properties: 21:03:42 INFO - { 21:03:42 INFO - "project": "", 21:03:42 INFO - "product": "firefox", 21:03:42 INFO - "script_repo_revision": "production", 21:03:42 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 21:03:42 INFO - "repository": "", 21:03:42 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 21:03:42 INFO - "buildid": "20161006202401", 21:03:42 INFO - "pgo_build": "False", 21:03:42 INFO - "basedir": "/builds/slave/test", 21:03:42 INFO - "buildnumber": 3370, 21:03:42 INFO - "slavename": "talos-linux64-ix-009", 21:03:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:03:42 INFO - "platform": "ubuntu64_hw", 21:03:42 INFO - "scheduler": "tests-fx-team-linux64-talos", 21:03:42 INFO - "branch": "fx-team", 21:03:42 INFO - "repo_path": "integration/fx-team", 21:03:42 INFO - "revision": "0e67f06bcfcc83f4317a968914232bb6c82965ac", 21:03:42 INFO - "stage_platform": "linux64", 21:03:42 INFO - "builduid": "ee2a3d12a1b746e0b7d546968ad16c8a", 21:03:42 INFO - "slavebuilddir": "test" 21:03:42 INFO - } 21:03:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/CI7_Og0tR5K3Of0nnUOu3w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 21:03:42 INFO - Running post-action listener: _resource_record_post_action 21:03:42 INFO - [mozharness: 2016-10-07 04:03:42.708635Z] Finished read-buildbot-config step (success) 21:03:42 INFO - [mozharness: 2016-10-07 04:03:42.708723Z] Running download-and-extract step. 21:03:42 INFO - Running pre-action listener: _resource_record_pre_action 21:03:42 INFO - Running main action method: download_and_extract 21:03:42 INFO - mkdir: /builds/slave/test/build/tests 21:03: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')]} 21:03:42 INFO - trying https://queue.taskcluster.net/v1/task/CI7_Og0tR5K3Of0nnUOu3w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:03:42 INFO - Downloading https://queue.taskcluster.net/v1/task/CI7_Og0tR5K3Of0nnUOu3w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:03:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CI7_Og0tR5K3Of0nnUOu3w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:03:43 INFO - Downloaded 1361 bytes. 21:03:43 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:03:43 INFO - Using the following test package requirements: 21:03:43 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:03:43 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:03:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:03:43 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:03:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:03:43 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:03:43 INFO - u'jsshell-linux-x86_64.zip'], 21:03:43 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:03:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:03:43 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:03:43 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:03:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:03:43 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:03:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:03:43 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:03:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:03:43 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:03:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:03:43 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:03:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CI7_Og0tR5K3Of0nnUOu3w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:03:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CI7_Og0tR5K3Of0nnUOu3w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:03:43 INFO - Fetch https://queue.taskcluster.net/v1/task/CI7_Og0tR5K3Of0nnUOu3w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:03:44 INFO - Http code: 200 21:03:44 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 21:03:44 INFO - x-amz-cf-id: xNY8XAwN4-T6pbDWI0XCuXRxL35hO-q0XV6kCb8EhlYGsqvZNOFeqQ== 21:03:44 INFO - x-amz-version-id: WTmPmkYg9wQp8OJ9fAOMvoTCKesckZlt 21:03:44 INFO - Expected file size: 20450570 21:03:44 INFO - Obtained file size: 20450570 21:03:48 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:03:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CI7_Og0tR5K3Of0nnUOu3w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:03:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CI7_Og0tR5K3Of0nnUOu3w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:03:48 INFO - Fetch https://queue.taskcluster.net/v1/task/CI7_Og0tR5K3Of0nnUOu3w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:03:49 INFO - Http code: 200 21:03:49 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 21:03:49 INFO - x-amz-cf-id: NgVlBoaDZBEJKgThS2iADqNK-pNkrZHnaU1qax-WMNVRvISAIuEf3w== 21:03:49 INFO - x-amz-version-id: WTmPmkYg9wQp8OJ9fAOMvoTCKesckZlt 21:03:49 INFO - Expected file size: 20450570 21:03:49 INFO - Obtained file size: 20450570 21:03:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CI7_Og0tR5K3Of0nnUOu3w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 21:03:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CI7_Og0tR5K3Of0nnUOu3w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:03:54 INFO - Fetch https://queue.taskcluster.net/v1/task/CI7_Og0tR5K3Of0nnUOu3w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 21:03:54 INFO - Http code: 200 21:03:54 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 21:03:54 INFO - x-amz-cf-id: AJNQVUgrYrmgn-tKS5Z_oxg0ursEza8My2XORuhPpGGyE9ihKL4wyA== 21:03:54 INFO - x-amz-version-id: gQ.zCJedEdEOkQ72nA599VYIci_Faz_3 21:03:56 INFO - Expected file size: 14409006 21:03:56 INFO - Obtained file size: 14409006 21:03:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:56 INFO - trying https://queue.taskcluster.net/v1/task/CI7_Og0tR5K3Of0nnUOu3w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:03:56 INFO - Downloading https://queue.taskcluster.net/v1/task/CI7_Og0tR5K3Of0nnUOu3w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:03:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CI7_Og0tR5K3Of0nnUOu3w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:03:59 INFO - Downloaded 55861766 bytes. 21:03:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CI7_Og0tR5K3Of0nnUOu3w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:03:59 INFO - mkdir: /builds/slave/test/properties 21:03:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:03:59 INFO - Writing to file /builds/slave/test/properties/build_url 21:03:59 INFO - Contents: 21:03:59 INFO - build_url:https://queue.taskcluster.net/v1/task/CI7_Og0tR5K3Of0nnUOu3w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:04:00 INFO - Running post-action listener: _resource_record_post_action 21:04:00 INFO - Running post-action listener: set_extra_try_arguments 21:04:00 INFO - [mozharness: 2016-10-07 04:04:00.684806Z] Finished download-and-extract step (success) 21:04:00 INFO - [mozharness: 2016-10-07 04:04:00.685068Z] Running populate-webroot step. 21:04:00 INFO - Running pre-action listener: _resource_record_pre_action 21:04:00 INFO - Running main action method: populate_webroot 21:04:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:04:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:04:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:04:00 INFO - '--tppagecycles', 21:04:00 INFO - '7'], 21:04:00 INFO - 'tests': ['tsvgm']}}, 21:04:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:04:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:04:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:04:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:04:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:04:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:04:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:04:00 INFO - 'talos_options': ['--disable-e10s'], 21:04:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:04:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:04:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:04:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:04:00 INFO - 'talos_options': ['--disable-e10s'], 21:04:00 INFO - 'tests': ['damp', 'tps']}, 21:04:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:04:00 INFO - 'tests': ['damp', 'tps']}, 21:04:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:04:00 INFO - 'tests': ['dromaeo_dom']}, 21:04:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:04:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:04:00 INFO - 'tests': ['basic_compositor_video']}, 21:04:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:04:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:04:00 INFO - 'tests': ['a11yr', 21:04:00 INFO - 'ts_paint', 21:04:00 INFO - 'tpaint', 21:04:00 INFO - 'sessionrestore', 21:04:00 INFO - 'sessionrestore_no_auto_restore', 21:04:00 INFO - 'tabpaint']}, 21:04:00 INFO - 'other-e10s': {'tests': ['a11yr', 21:04:00 INFO - 'ts_paint', 21:04:00 INFO - 'tpaint', 21:04:00 INFO - 'sessionrestore', 21:04:00 INFO - 'sessionrestore_no_auto_restore', 21:04:00 INFO - 'tabpaint']}, 21:04:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:04:00 INFO - 'ts_paint', 21:04:00 INFO - 'tpaint', 21:04:00 INFO - 'sessionrestore', 21:04:00 INFO - 'sessionrestore_no_auto_restore', 21:04:00 INFO - 'tabpaint']}, 21:04:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:04:00 INFO - 'ts_paint', 21:04:00 INFO - 'tpaint', 21:04:00 INFO - 'sessionrestore', 21:04:00 INFO - 'sessionrestore_no_auto_restore', 21:04:00 INFO - 'tabpaint']}, 21:04:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:04:00 INFO - 'tests': ['a11yr', 21:04:00 INFO - 'ts_paint', 21:04:00 INFO - 'tpaint', 21:04:00 INFO - 'sessionrestore', 21:04:00 INFO - 'sessionrestore_no_auto_restore', 21:04:00 INFO - 'tabpaint']}, 21:04:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:04:00 INFO - 'tests': ['a11yr', 21:04:00 INFO - 'ts_paint', 21:04:00 INFO - 'tpaint', 21:04:00 INFO - 'sessionrestore', 21:04:00 INFO - 'sessionrestore_no_auto_restore', 21:04:00 INFO - 'tabpaint']}, 21:04:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:04:00 INFO - 'tests': ['tsvgx', 21:04:00 INFO - 'tsvgr_opacity', 21:04:00 INFO - 'tart', 21:04:00 INFO - 'tscrollx', 21:04:00 INFO - 'cart']}, 21:04:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:04:00 INFO - 'tsvgr_opacity', 21:04:00 INFO - 'tart', 21:04:00 INFO - 'tscrollx', 21:04:00 INFO - 'cart']}, 21:04:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:04:00 INFO - 'talos_options': ['--disable-e10s'], 21:04:00 INFO - 'tests': ['tp5o']}, 21:04:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:04:00 INFO - 'tests': ['tp5o']}, 21:04:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:04:00 INFO - 'talos_options': ['--disable-e10s', 21:04:00 INFO - '--xperf_path', 21:04:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:04:00 INFO - 'tests': ['tp5n']}, 21:04:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:04:00 INFO - 'talos_options': ['--xperf_path', 21:04:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:04:00 INFO - 'tests': ['tp5n']}}, 21:04:00 INFO - 'talos.zip': {'path': '', 21:04:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:04:00 INFO - Running post-action listener: _resource_record_post_action 21:04:00 INFO - [mozharness: 2016-10-07 04:04:00.703492Z] Finished populate-webroot step (success) 21:04:00 INFO - [mozharness: 2016-10-07 04:04:00.703581Z] Running create-virtualenv step. 21:04:00 INFO - Running pre-action listener: _resource_record_pre_action 21:04:00 INFO - Running main action method: create_virtualenv 21:04:00 INFO - Creating virtualenv /builds/slave/test/build/venv 21:04:00 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:04:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:04:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:04:00 INFO - Using real prefix '/usr' 21:04:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:04:01 INFO - Installing distribute.............................................................................................................................................................................................done. 21:04:03 INFO - Installing pip.................done. 21:04:03 INFO - Return code: 0 21:04:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:04:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:04:03 INFO - Reading from file tmpfile_stdout 21:04:03 INFO - Output received: 21:04:03 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 21:04:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:04:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:04:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:04:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:03 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 0x7f227fa60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1cf60>, '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 0x1f1dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f1e1d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1475813020.494721-488689387', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:04:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:04:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:04:03 INFO - Using env: {'DISPLAY': ':0', 21:04:03 INFO - 'HOME': '/home/cltbld', 21:04:03 INFO - 'LANG': 'en_US.UTF-8', 21:04:03 INFO - 'LANGUAGE': 'en_US:en', 21:04:03 INFO - 'LOGNAME': 'cltbld', 21:04:03 INFO - 'MAIL': '/var/mail/cltbld', 21:04:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:04:03 INFO - 'MOZ_NO_REMOTE': '1', 21:04:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:04:03 INFO - 'NO_EM_RESTART': '1', 21:04:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:04:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:04:03 INFO - 'PWD': '/builds/slave/test', 21:04:03 INFO - 'SHELL': '/bin/bash', 21:04:03 INFO - 'SHLVL': '1', 21:04:03 INFO - 'TERM': 'linux', 21:04:03 INFO - 'TMOUT': '86400', 21:04:03 INFO - 'USER': 'cltbld', 21:04:03 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1475813020.494721-488689387', 21:04:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:04:03 INFO - '_': '/tools/buildbot/bin/python'} 21:04:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:04:03 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:04:03 INFO - Cleaning up... 21:04:03 INFO - Return code: 0 21:04:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:04:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:04:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:04:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:03 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 0x7f227fa60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1cf60>, '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 0x1f1dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f1e1d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1475813020.494721-488689387', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:04:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:04:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:04:03 INFO - Using env: {'DISPLAY': ':0', 21:04:03 INFO - 'HOME': '/home/cltbld', 21:04:03 INFO - 'LANG': 'en_US.UTF-8', 21:04:03 INFO - 'LANGUAGE': 'en_US:en', 21:04:03 INFO - 'LOGNAME': 'cltbld', 21:04:03 INFO - 'MAIL': '/var/mail/cltbld', 21:04:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:04:03 INFO - 'MOZ_NO_REMOTE': '1', 21:04:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:04:03 INFO - 'NO_EM_RESTART': '1', 21:04:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:04:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:04:03 INFO - 'PWD': '/builds/slave/test', 21:04:03 INFO - 'SHELL': '/bin/bash', 21:04:03 INFO - 'SHLVL': '1', 21:04:03 INFO - 'TERM': 'linux', 21:04:03 INFO - 'TMOUT': '86400', 21:04:03 INFO - 'USER': 'cltbld', 21:04:03 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1475813020.494721-488689387', 21:04:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:04:03 INFO - '_': '/tools/buildbot/bin/python'} 21:04:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:04:03 INFO - Downloading/unpacking psutil>=3.1.1 21:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:04:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:04:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:04:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:04:05 INFO - Installing collected packages: psutil 21:04:05 INFO - Running setup.py install for psutil 21:04:06 INFO - building 'psutil._psutil_linux' extension 21:04:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 21:04:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 21:04:06 INFO - building 'psutil._psutil_posix' extension 21:04:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 21:04:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 21:04:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:04:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:04:06 INFO - Successfully installed psutil 21:04:06 INFO - Cleaning up... 21:04:06 INFO - Return code: 0 21:04:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:04:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:04:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:04:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:06 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 0x7f227fa60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1cf60>, '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 0x1f1dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f1e1d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1475813020.494721-488689387', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:04:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:04:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:04:06 INFO - Using env: {'DISPLAY': ':0', 21:04:06 INFO - 'HOME': '/home/cltbld', 21:04:06 INFO - 'LANG': 'en_US.UTF-8', 21:04:06 INFO - 'LANGUAGE': 'en_US:en', 21:04:06 INFO - 'LOGNAME': 'cltbld', 21:04:06 INFO - 'MAIL': '/var/mail/cltbld', 21:04:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:04:06 INFO - 'MOZ_NO_REMOTE': '1', 21:04:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:04:06 INFO - 'NO_EM_RESTART': '1', 21:04:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:04:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:04:06 INFO - 'PWD': '/builds/slave/test', 21:04:06 INFO - 'SHELL': '/bin/bash', 21:04:06 INFO - 'SHLVL': '1', 21:04:06 INFO - 'TERM': 'linux', 21:04:06 INFO - 'TMOUT': '86400', 21:04:06 INFO - 'USER': 'cltbld', 21:04:06 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1475813020.494721-488689387', 21:04:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:04:06 INFO - '_': '/tools/buildbot/bin/python'} 21:04:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:04:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:04:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:04:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:04:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:04:08 INFO - Installing collected packages: mozsystemmonitor 21:04:08 INFO - Running setup.py install for mozsystemmonitor 21:04:08 INFO - Successfully installed mozsystemmonitor 21:04:08 INFO - Cleaning up... 21:04:08 INFO - Return code: 0 21:04:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:04: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')]} 21:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:04:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04: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')]} 21:04:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:04:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04: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', '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 0x7f227fa60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1cf60>, '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 0x1f1dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f1e1d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1475813020.494721-488689387', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:04: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:04: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 jsonschema==2.5.1 21:04:08 INFO - Using env: {'DISPLAY': ':0', 21:04:08 INFO - 'HOME': '/home/cltbld', 21:04:08 INFO - 'LANG': 'en_US.UTF-8', 21:04:08 INFO - 'LANGUAGE': 'en_US:en', 21:04:08 INFO - 'LOGNAME': 'cltbld', 21:04:08 INFO - 'MAIL': '/var/mail/cltbld', 21:04:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:04:08 INFO - 'MOZ_NO_REMOTE': '1', 21:04:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:04:08 INFO - 'NO_EM_RESTART': '1', 21:04:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:04:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:04:08 INFO - 'PWD': '/builds/slave/test', 21:04:08 INFO - 'SHELL': '/bin/bash', 21:04:08 INFO - 'SHLVL': '1', 21:04:08 INFO - 'TERM': 'linux', 21:04:08 INFO - 'TMOUT': '86400', 21:04:08 INFO - 'USER': 'cltbld', 21:04:08 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1475813020.494721-488689387', 21:04:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:04:08 INFO - '_': '/tools/buildbot/bin/python'} 21:04:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:04:09 INFO - Downloading/unpacking jsonschema==2.5.1 21:04:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:04:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:04:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:04:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:04:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:04:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:04:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:11 INFO - Downloading functools32-3.2.3-2.tar.gz 21:04:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:04:11 INFO - warning: no files found matching '*.txt' 21:04:11 INFO - no previously-included directories found matching 'build' 21:04:11 INFO - no previously-included directories found matching 'dist' 21:04:11 INFO - no previously-included directories found matching '.git*' 21:04:11 INFO - Installing collected packages: jsonschema, functools32 21:04:11 INFO - Running setup.py install for functools32 21:04:11 INFO - warning: no files found matching '*.txt' 21:04:11 INFO - no previously-included directories found matching 'build' 21:04:11 INFO - no previously-included directories found matching 'dist' 21:04:11 INFO - no previously-included directories found matching '.git*' 21:04:11 INFO - Successfully installed jsonschema functools32 21:04:11 INFO - Cleaning up... 21:04:11 INFO - Return code: 0 21:04:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:04:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:04:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:04:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:11 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 0x7f227fa60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1cf60>, '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 0x1f1dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f1e1d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1475813020.494721-488689387', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:04:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:04:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:04:11 INFO - Using env: {'DISPLAY': ':0', 21:04:11 INFO - 'HOME': '/home/cltbld', 21:04:11 INFO - 'LANG': 'en_US.UTF-8', 21:04:11 INFO - 'LANGUAGE': 'en_US:en', 21:04:11 INFO - 'LOGNAME': 'cltbld', 21:04:11 INFO - 'MAIL': '/var/mail/cltbld', 21:04:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:04:11 INFO - 'MOZ_NO_REMOTE': '1', 21:04:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:04:11 INFO - 'NO_EM_RESTART': '1', 21:04:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:04:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:04:11 INFO - 'PWD': '/builds/slave/test', 21:04:11 INFO - 'SHELL': '/bin/bash', 21:04:11 INFO - 'SHLVL': '1', 21:04:11 INFO - 'TERM': 'linux', 21:04:11 INFO - 'TMOUT': '86400', 21:04:11 INFO - 'USER': 'cltbld', 21:04:11 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1475813020.494721-488689387', 21:04:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:04:11 INFO - '_': '/tools/buildbot/bin/python'} 21:04:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:04:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:04:11 INFO - Cleaning up... 21:04:11 INFO - Return code: 0 21:04:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:04:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:04:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:04:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:11 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 0x7f227fa60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1cf60>, '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 0x1f1dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f1e1d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1475813020.494721-488689387', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:04:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:04:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:04:11 INFO - Using env: {'DISPLAY': ':0', 21:04:11 INFO - 'HOME': '/home/cltbld', 21:04:11 INFO - 'LANG': 'en_US.UTF-8', 21:04:11 INFO - 'LANGUAGE': 'en_US:en', 21:04:11 INFO - 'LOGNAME': 'cltbld', 21:04:11 INFO - 'MAIL': '/var/mail/cltbld', 21:04:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:04:11 INFO - 'MOZ_NO_REMOTE': '1', 21:04:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:04:11 INFO - 'NO_EM_RESTART': '1', 21:04:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:04:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:04:11 INFO - 'PWD': '/builds/slave/test', 21:04:11 INFO - 'SHELL': '/bin/bash', 21:04:11 INFO - 'SHLVL': '1', 21:04:11 INFO - 'TERM': 'linux', 21:04:11 INFO - 'TMOUT': '86400', 21:04:11 INFO - 'USER': 'cltbld', 21:04:11 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1475813020.494721-488689387', 21:04:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:04:11 INFO - '_': '/tools/buildbot/bin/python'} 21:04:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:04:11 INFO - Downloading/unpacking blobuploader==1.2.4 21:04: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 21:04: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 21:04: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 21:04: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 21:04: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 21:04: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 21:04:13 INFO - Downloading blobuploader-1.2.4.tar.gz 21:04:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:04:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:04:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:04:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:04:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:04:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:04:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:04:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:04:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:14 INFO - Downloading docopt-0.6.1.tar.gz 21:04:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:04:14 INFO - Installing collected packages: blobuploader, requests, docopt 21:04:14 INFO - Running setup.py install for blobuploader 21:04:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:04:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:04:14 INFO - Running setup.py install for requests 21:04:14 INFO - Running setup.py install for docopt 21:04:15 INFO - Successfully installed blobuploader requests docopt 21:04:15 INFO - Cleaning up... 21:04:15 INFO - Return code: 0 21:04:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:04:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:04:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:04:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:15 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 0x7f227fa60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1cf60>, '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 0x1f1dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f1e1d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1475813020.494721-488689387', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:04:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:04:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:04:15 INFO - Using env: {'DISPLAY': ':0', 21:04:15 INFO - 'HOME': '/home/cltbld', 21:04:15 INFO - 'LANG': 'en_US.UTF-8', 21:04:15 INFO - 'LANGUAGE': 'en_US:en', 21:04:15 INFO - 'LOGNAME': 'cltbld', 21:04:15 INFO - 'MAIL': '/var/mail/cltbld', 21:04:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:04:15 INFO - 'MOZ_NO_REMOTE': '1', 21:04:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:04:15 INFO - 'NO_EM_RESTART': '1', 21:04:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:04:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:04:15 INFO - 'PWD': '/builds/slave/test', 21:04:15 INFO - 'SHELL': '/bin/bash', 21:04:15 INFO - 'SHLVL': '1', 21:04:15 INFO - 'TERM': 'linux', 21:04:15 INFO - 'TMOUT': '86400', 21:04:15 INFO - 'USER': 'cltbld', 21:04:15 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1475813020.494721-488689387', 21:04:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:04:15 INFO - '_': '/tools/buildbot/bin/python'} 21:04:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:04:15 INFO - Running setup.py (path:/tmp/pip-jZHs4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:04:15 INFO - Running setup.py (path:/tmp/pip-46o6K8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:04:15 INFO - Running setup.py (path:/tmp/pip-oqRszg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:04:15 INFO - Running setup.py (path:/tmp/pip-6JRQ82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:04:15 INFO - Running setup.py (path:/tmp/pip-3LA_lB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:04:15 INFO - Running setup.py (path:/tmp/pip-mSA0HD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:04:15 INFO - Running setup.py (path:/tmp/pip-zbmkt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:04:15 INFO - Running setup.py (path:/tmp/pip-hGtG4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:04:15 INFO - Running setup.py (path:/tmp/pip-2OTCes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:04:16 INFO - Running setup.py (path:/tmp/pip-1V0_fh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:04:16 INFO - Running setup.py (path:/tmp/pip-c3mVtT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:04:16 INFO - Running setup.py (path:/tmp/pip-fP6MbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:04:16 INFO - Running setup.py (path:/tmp/pip-BrKs99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:04:16 INFO - Running setup.py (path:/tmp/pip-pALxzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:04:16 INFO - Running setup.py (path:/tmp/pip-LFc9GM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:04:16 INFO - Running setup.py (path:/tmp/pip-Mr11hi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:04:16 INFO - Running setup.py (path:/tmp/pip-FPV7YG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:04:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:04:16 INFO - Running setup.py install for manifestparser 21:04:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:04:16 INFO - Running setup.py install for mozcrash 21:04:16 INFO - Running setup.py install for mozdebug 21:04:16 INFO - Running setup.py install for mozdevice 21:04:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:04:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:04:17 INFO - Running setup.py install for mozfile 21:04:17 INFO - Running setup.py install for mozhttpd 21:04:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:04:17 INFO - Running setup.py install for mozinfo 21:04:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:04:17 INFO - Running setup.py install for mozInstall 21:04:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:04:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:04:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:04:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:04:17 INFO - Running setup.py install for mozleak 21:04:17 INFO - Running setup.py install for mozlog 21:04:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:04:17 INFO - Running setup.py install for moznetwork 21:04:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:04:17 INFO - Running setup.py install for mozprocess 21:04:17 INFO - Running setup.py install for mozprofile 21:04:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:04:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:04:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:04:17 INFO - Running setup.py install for mozrunner 21:04:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:04:18 INFO - Running setup.py install for mozscreenshot 21:04:18 INFO - Running setup.py install for moztest 21:04:18 INFO - Running setup.py install for mozversion 21:04:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:04:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:04:18 INFO - Cleaning up... 21:04:18 INFO - Return code: 0 21:04:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:04:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:04:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:04:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:18 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 0x7f227fa60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1cf60>, '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 0x1f1dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f1e1d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1475813020.494721-488689387', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:04:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:04:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:04:18 INFO - Using env: {'DISPLAY': ':0', 21:04:18 INFO - 'HOME': '/home/cltbld', 21:04:18 INFO - 'LANG': 'en_US.UTF-8', 21:04:18 INFO - 'LANGUAGE': 'en_US:en', 21:04:18 INFO - 'LOGNAME': 'cltbld', 21:04:18 INFO - 'MAIL': '/var/mail/cltbld', 21:04:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:04:18 INFO - 'MOZ_NO_REMOTE': '1', 21:04:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:04:18 INFO - 'NO_EM_RESTART': '1', 21:04:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:04:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:04:18 INFO - 'PWD': '/builds/slave/test', 21:04:18 INFO - 'SHELL': '/bin/bash', 21:04:18 INFO - 'SHLVL': '1', 21:04:18 INFO - 'TERM': 'linux', 21:04:18 INFO - 'TMOUT': '86400', 21:04:18 INFO - 'USER': 'cltbld', 21:04:18 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1475813020.494721-488689387', 21:04:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:04:18 INFO - '_': '/tools/buildbot/bin/python'} 21:04:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:04:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:04:18 INFO - Running setup.py (path:/tmp/pip-q4559l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:04:18 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 21:04:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:04:18 INFO - Running setup.py (path:/tmp/pip-0hsfAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:04:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:04:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:04:18 INFO - Running setup.py (path:/tmp/pip-G27ESa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:04:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:04:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:04:18 INFO - Running setup.py (path:/tmp/pip-9fEGpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:04:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:04:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:04:18 INFO - Running setup.py (path:/tmp/pip-qsEK7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:04:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 21:04:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:04:18 INFO - Running setup.py (path:/tmp/pip-DIASmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:04:19 INFO - Running setup.py (path:/tmp/pip-niobP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 21:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:04:19 INFO - Running setup.py (path:/tmp/pip-lowGsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 21:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:04:19 INFO - Running setup.py (path:/tmp/pip-wLcPd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 21:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:04:19 INFO - Running setup.py (path:/tmp/pip-OKjdwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:04:19 INFO - Running setup.py (path:/tmp/pip-DNJtB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 21:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:04:19 INFO - Running setup.py (path:/tmp/pip-5ienar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 21:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:04:19 INFO - Running setup.py (path:/tmp/pip-jaCUl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 21:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:04:19 INFO - Running setup.py (path:/tmp/pip-cySgVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:04:19 INFO - Running setup.py (path:/tmp/pip-aZEbr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 21:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:04:19 INFO - Running setup.py (path:/tmp/pip-tyOqC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:04:19 INFO - Running setup.py (path:/tmp/pip-_xYKMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 21:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:04:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:04:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:21 INFO - Downloading blessings-1.6.tar.gz 21:04:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:04:21 INFO - Installing collected packages: blessings 21:04:21 INFO - Running setup.py install for blessings 21:04:21 INFO - Successfully installed blessings 21:04:21 INFO - Cleaning up... 21:04:22 INFO - Return code: 0 21:04:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:04:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:04:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:04:22 INFO - Reading from file tmpfile_stdout 21:04:22 INFO - Current package versions: 21:04:22 INFO - argparse == 1.2.1 21:04:22 INFO - blessings == 1.6 21:04:22 INFO - blobuploader == 1.2.4 21:04:22 INFO - docopt == 0.6.1 21:04:22 INFO - functools32 == 3.2.3-2 21:04:22 INFO - jsonschema == 2.5.1 21:04:22 INFO - manifestparser == 1.1 21:04:22 INFO - mozInstall == 1.12 21:04:22 INFO - mozcrash == 0.17 21:04:22 INFO - mozdebug == 0.1 21:04:22 INFO - mozdevice == 0.48 21:04:22 INFO - mozfile == 1.2 21:04:22 INFO - mozhttpd == 0.7 21:04:22 INFO - mozinfo == 0.9 21:04:22 INFO - mozleak == 0.1 21:04:22 INFO - mozlog == 3.4 21:04:22 INFO - moznetwork == 0.27 21:04:22 INFO - mozprocess == 0.23 21:04:22 INFO - mozprofile == 0.28 21:04:22 INFO - mozrunner == 6.12 21:04:22 INFO - mozscreenshot == 0.1 21:04:22 INFO - mozsystemmonitor == 0.3 21:04:22 INFO - moztest == 0.7 21:04:22 INFO - mozversion == 1.4 21:04:22 INFO - psutil == 3.1.1 21:04:22 INFO - requests == 1.2.3 21:04:22 INFO - wsgiref == 0.1.2 21:04:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:04:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:04:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:04:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:22 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 0x7f227fa60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1cf60>, '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 0x1f1dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f1e1d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1475813020.494721-488689387', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:04:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 21:04:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:04:22 INFO - Using env: {'DISPLAY': ':0', 21:04:22 INFO - 'HOME': '/home/cltbld', 21:04:22 INFO - 'LANG': 'en_US.UTF-8', 21:04:22 INFO - 'LANGUAGE': 'en_US:en', 21:04:22 INFO - 'LOGNAME': 'cltbld', 21:04:22 INFO - 'MAIL': '/var/mail/cltbld', 21:04:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:04:22 INFO - 'MOZ_NO_REMOTE': '1', 21:04:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:04:22 INFO - 'NO_EM_RESTART': '1', 21:04:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:04:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:04:22 INFO - 'PWD': '/builds/slave/test', 21:04:22 INFO - 'SHELL': '/bin/bash', 21:04:22 INFO - 'SHLVL': '1', 21:04:22 INFO - 'TERM': 'linux', 21:04:22 INFO - 'TMOUT': '86400', 21:04:22 INFO - 'USER': 'cltbld', 21:04:22 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1475813020.494721-488689387', 21:04:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:04:22 INFO - '_': '/tools/buildbot/bin/python'} 21:04:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 21:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 21:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 21:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 21:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 21:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 21:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 21:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:04:22 INFO - Cleaning up... 21:04:22 INFO - Return code: 0 21:04:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:04:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:04:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:04:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:22 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 0x7f227fa60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1cf60>, '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 0x1f1dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f1e1d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1475813020.494721-488689387', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:04:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:04:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:04:22 INFO - Using env: {'DISPLAY': ':0', 21:04:22 INFO - 'HOME': '/home/cltbld', 21:04:22 INFO - 'LANG': 'en_US.UTF-8', 21:04:22 INFO - 'LANGUAGE': 'en_US:en', 21:04:22 INFO - 'LOGNAME': 'cltbld', 21:04:22 INFO - 'MAIL': '/var/mail/cltbld', 21:04:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:04:22 INFO - 'MOZ_NO_REMOTE': '1', 21:04:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:04:22 INFO - 'NO_EM_RESTART': '1', 21:04:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:04:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:04:22 INFO - 'PWD': '/builds/slave/test', 21:04:22 INFO - 'SHELL': '/bin/bash', 21:04:22 INFO - 'SHLVL': '1', 21:04:22 INFO - 'TERM': 'linux', 21:04:22 INFO - 'TMOUT': '86400', 21:04:22 INFO - 'USER': 'cltbld', 21:04:22 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1475813020.494721-488689387', 21:04:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:04:22 INFO - '_': '/tools/buildbot/bin/python'} 21:04:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:04:22 INFO - Cleaning up... 21:04:22 INFO - Return code: 0 21:04:22 INFO - Running post-action listener: _resource_record_post_action 21:04:22 INFO - Running post-action listener: _start_resource_monitoring 21:04:22 INFO - Starting resource monitoring. 21:04:22 INFO - [mozharness: 2016-10-07 04:04:22.717141Z] Finished create-virtualenv step (success) 21:04:22 INFO - [mozharness: 2016-10-07 04:04:22.717607Z] Running install step. 21:04:22 INFO - Running pre-action listener: _resource_record_pre_action 21:04:22 INFO - Running main action method: install 21:04:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:04:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:04:22 INFO - Reading from file tmpfile_stdout 21:04:22 INFO - Detecting whether we're running mozinstall >=1.0... 21:04:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:04:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:04:22 INFO - Reading from file tmpfile_stdout 21:04:22 INFO - Output received: 21:04:22 INFO - Usage: mozinstall [options] installer 21:04:22 INFO - Options: 21:04:22 INFO - -h, --help show this help message and exit 21:04:22 INFO - -d DEST, --destination=DEST 21:04:22 INFO - Directory to install application into. [default: 21:04:22 INFO - "/builds/slave/test"] 21:04:22 INFO - --app=APP Application being installed. [default: firefox] 21:04:22 INFO - mkdir: /builds/slave/test/build/application 21:04:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:04:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:04:39 INFO - Reading from file tmpfile_stdout 21:04:39 INFO - Output received: 21:04:39 INFO - /builds/slave/test/build/application/firefox/firefox 21:04:39 INFO - Running post-action listener: _resource_record_post_action 21:04:39 INFO - [mozharness: 2016-10-07 04:04:39.158110Z] Finished install step (success) 21:04:39 INFO - [mozharness: 2016-10-07 04:04:39.158356Z] Running run-tests step. 21:04:39 INFO - Running pre-action listener: _resource_record_pre_action 21:04:39 INFO - Running main action method: run_tests 21:04:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:04:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:04:39 INFO - Python 2.7.3 21:04:39 INFO - Return code: 0 21:04:39 INFO - grabbing minidump binary from tooltool 21:04:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:39 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 0x1f1cf60>, '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 0x1f1dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f1e1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:04:39 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 21:04:39 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 21:04:39 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 21:04:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:04:39 INFO - Return code: 0 21:04:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:04:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:04:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:04:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:04:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:04:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CI7_Og0tR5K3Of0nnUOu3w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 21:04:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CI7_Og0tR5K3Of0nnUOu3w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 21:04:39 INFO - Using env: {'DISPLAY': ':0', 21:04:39 INFO - 'HOME': '/home/cltbld', 21:04:39 INFO - 'LANG': 'en_US.UTF-8', 21:04:39 INFO - 'LANGUAGE': 'en_US:en', 21:04:39 INFO - 'LOGNAME': 'cltbld', 21:04:39 INFO - 'MAIL': '/var/mail/cltbld', 21:04:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:04:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:04:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:04:39 INFO - 'MOZ_NO_REMOTE': '1', 21:04:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:04:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:04:39 INFO - 'NO_EM_RESTART': '1', 21:04:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:04:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:04:39 INFO - 'PWD': '/builds/slave/test', 21:04:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:04:39 INFO - 'SHELL': '/bin/bash', 21:04:39 INFO - 'SHLVL': '1', 21:04:39 INFO - 'TERM': 'linux', 21:04:39 INFO - 'TMOUT': '86400', 21:04:39 INFO - 'USER': 'cltbld', 21:04:39 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1475813020.494721-488689387', 21:04:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:04:39 INFO - '_': '/tools/buildbot/bin/python'} 21:04:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CI7_Og0tR5K3Of0nnUOu3w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:04:39 INFO - mozversion application_buildid: 20161006202401 21:04:39 INFO - mozversion application_changeset: 0e67f06bcfcc83f4317a968914232bb6c82965ac 21:04:39 INFO - mozversion application_display_name: Nightly 21:04:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:04:39 INFO - mozversion application_name: Firefox 21:04:39 INFO - mozversion application_remotingname: firefox 21:04:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:04:39 INFO - mozversion application_vendor: Mozilla 21:04:39 INFO - mozversion application_version: 52.0a1 21:04:39 INFO - mozversion platform_buildid: 20161006202401 21:04:39 INFO - mozversion platform_changeset: 0e67f06bcfcc83f4317a968914232bb6c82965ac 21:04:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:04:39 INFO - mozversion platform_version: 52.0a1 21:04:39 INFO - using testdate: 1475813079 21:04:39 INFO - actual date: 1475813079 21:04:39 INFO - starting webserver on 'localhost:46023' 21:04:39 INFO - SUITE-START | Running 2 tests 21:04:39 INFO - TEST-START | dromaeo_css 21:04:39 INFO - operating with platform_type : linux_ 21:04:39 INFO - Initialising browser for dromaeo_css test... 21:04:39 INFO - TEST-INFO | started process 14196 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYHvRiv/profile http://localhost:46023/getInfo.html) 21:04:44 INFO - PROCESS | 14196 | __metrics Screen width/height:1600/1200 21:04:44 INFO - PROCESS | 14196 | colorDepth:24 21:04:44 INFO - PROCESS | 14196 | Browser inner width/height: 1024/697 21:04:44 INFO - PROCESS | 14196 | __metrics 21:04:44 INFO - PROCESS | 14196 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:04:44 INFO - PROCESS | 14196 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:04:45 INFO - PROCESS | 14196 | console.error: PushService: 21:04:45 INFO - PROCESS | 14196 | stateChangeProcessEnqueue: Error transitioning state 21:04:45 INFO - PROCESS | 14196 | UnknownError 21:04:45 INFO - TEST-INFO | 14196: exit 0 21:04:45 INFO - Browser initialized. 21:04:45 INFO - Running cycle 1/1 for dromaeo_css test... 21:04:45 INFO - TEST-INFO | started process 14277 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYHvRiv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:04:58 INFO - PROCESS | 14277 | RSS: Main: 176549888 21:04:58 INFO - PROCESS | 14277 | 21:05:48 INFO - PROCESS | 14277 | 1475813148990 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 21:08:03 INFO - PROCESS | 14277 | Cycle 1(1): loaded http://localhost:46023/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46023/tests/dromaeo/cssquery-ext.html) 21:08:04 INFO - PROCESS | 14277 | RSS: Main: 301498368 21:08:04 INFO - PROCESS | 14277 | 21:11:07 INFO - PROCESS | 14277 | Cycle 1(1): loaded http://localhost:46023/tests/dromaeo/cssquery-ext.html (next: http://localhost:46023/tests/dromaeo/cssquery-jquery.html) 21:11:07 INFO - PROCESS | 14277 | RSS: Main: 277643264 21:11:07 INFO - PROCESS | 14277 | 21:14:10 INFO - PROCESS | 14277 | Cycle 1(1): loaded http://localhost:46023/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46023/tests/dromaeo/cssquery-mootools.html) 21:14:10 INFO - PROCESS | 14277 | RSS: Main: 219492352 21:14:10 INFO - PROCESS | 14277 | 21:17:13 INFO - PROCESS | 14277 | Cycle 1(1): loaded http://localhost:46023/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46023/tests/dromaeo/cssquery-prototype.html) 21:17:13 INFO - PROCESS | 14277 | RSS: Main: 218886144 21:17:13 INFO - PROCESS | 14277 | 21:20:16 INFO - PROCESS | 14277 | Cycle 1(1): loaded http://localhost:46023/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46023/tests/dromaeo/cssquery-yui.html) 21:20:17 INFO - PROCESS | 14277 | RSS: Main: 220049408 21:20:17 INFO - PROCESS | 14277 | 21:23:20 INFO - PROCESS | 14277 | Cycle 1(1): loaded http://localhost:46023/tests/dromaeo/cssquery-yui.html (next: http://localhost:46023/tests/dromaeo/cssquery-dojo.html) 21:23:20 INFO - PROCESS | 14277 | RSS: Main: 308150272 21:23:20 INFO - PROCESS | 14277 | 21:23:20 INFO - PROCESS | 14277 | __start_tp_report 21:23:21 INFO - PROCESS | 14277 | _x_x_mozilla_page_load 21:23:21 INFO - PROCESS | 14277 | _x_x_mozilla_page_load_details 21:23:21 INFO - PROCESS | 14277 | |i|pagename|runs| 21:23:21 INFO - PROCESS | 14277 | |0;dojo.html;2544.262163972448;2567.7945764338865;2582.212425210311;2588.935276618084;2596.4287856671526;4600.401947746788;4649.837255696051;4654.325122857188;4660.860174194775;4727.5036121207295;4653.720776753389;4666.953330466695;4685.320628508873;4720.976395118019;4761.928571071437;4272.380504826814;4287.421198138242;4333.60997510224;4334.371516130159;4357.542458041908;4349.847755328564;4363.716358436707;4367;4369.169857727037;4383.408239887623;4252.744835309892;4380.2115619188535;4381.036172042146;4394.890127746816;4491.146682130385;4233.44965154531;4285.378620100099;4358.237308471005;4361.149575832714;4370.038591509863;4268.146370725836;4270.572942705736;4273;4323.848665296731;4348.847790327355;4627.8611641650805;4650.651201159926;4670.743109128996;4713.175194341011;4728.929066064012;4902.436219834729;4943.826966056171;4987.077390682699;4989.750512474398;4996.9500304996845;4952.727599981999;4973.5523802857915;4987.700737955734;4989.052080104769;5070.569001634865;4659.021605462857;4662.673612847136;4665.393498845128;4667.649926255544;4720.858374248778;5026.572741316956;5095.923561146586;5104.157813960729;5109.463506331856;5169.663971841818;4865.148598995162;4879.682820616648;4923.310736496894;4923.975380123076;4925.827596034122;5010.872553675466;5015.899682006339;5017.272495488134;5017.698938063728;5018.548330650186;4928.334674818925;4957.380327459067;4964.776585053682;4978.5270399312;4979.278004689299;4908.042931628298;4949.604031677457;4961.5534601886;5046.1169295373165;5052;4199.391088292181;4203.810828512725;4209.137126888981;4249.3413520904305;4251.893702657397;3641.053326135224;3644.781313121221;3673.9632603674154;3695.6858667013603;3723.1436769543157;4137.296659567881;4171.353440216772;4174.248635245685;4194.874153775391;4246.723962942398;4953.281774142729;4979.377577802775;4990.051890140861;5040.899182016413;5048.268001139814;4237.660987121023;4243.7029407941145;4244.72409293395;4296.634786043159;4297.162053399557;4292.420523229386;4343.652507799368;4364.192624364439;4422.778861056934;4429.402030725811;4669.929951050669;4732.645051621211;4732.692374995752;4772.117158325721;4780.6414518911915;4990.3762029746285;5008.649394542347;5009.599232061353;5010.473900240422;5068.695878247317;4583.083383323416;4637.814487420465;4697.177993850994;4720.740359280135;4799.352087468287;4923.729194894315;4963.181075122564;4965.4289756677;4966.577840883565;5030.3963524377305;5010.5240002199735;5021.096202683552;5025.84922452327;5025.899482010413;5091.949080509147;4786.593139583035;4852.175130227799;4862.367892173995;4867.318575399376;4921.360223170965;4805.519448055166;4844.660873738945;4845.685030473008;4847.151748443937;4912.901741965212;4761.381020467317;4773.785179666854;4785.377900872864;4789.880252993703;4831.057943701085;4841.782119804547;4869.31829543857;4873.9025219496125;4878.780454879468;4943.604511639132;4695.272232803921;4741.620670346433;4762.452317983338;4792.496787837227;4823.469418364048 21:23:21 INFO - PROCESS | 14277 | |1;ext.html;520.3131865936963;532.9253904453376;539.38240714382;541.6831153775041;545.5662748115247;27132.728672713267;37485.43771843421;38415.54260116592;38527.229455410874;42311;39246.80376598113;39532.604673953254;39589.208215835664;39656.20687586247;39669.20661586767;7521.661525231364;7661.23387661235;7668.463207575472;7688.38492920565;7693.615319234043;7560.319571238588;7641.61791910405;7649.464537482379;7649.502782319159;7651.387888968897;7636.694532218732;7735.342495887856;7740.845183096335;7741.961290193569;7747.922520774805;7611.505252158619;7660.578668173248;7666.425018123663;7668.578228197447;7668.846623067563;7518.736844210481;7578.772636820904;7586.544807311524;7591.6583753730665;7593.6582853771715;36597.63402365969;36977.26045479102;36980.44529332062;36996.26007479835;36998.260034799154;2782.8330300182056;2821.887124515017;2879.3521457672064;2884.423115376912;2891.334992951633;24532.386690332885;27224.183274501796;27549.586756198674;27594.227099236792;28099.57850632242;3244.513323001545;3258.462353711635;3290.3748287825474;3291.424000799874;3316.121227874591;244958;245389;245765;246024;246952.76523617445;47865.52134478611;48476.27285590719;48558.5144148554;48590.5140948593;48676.26985595219;31543.36913261722;32355.676443235265;32404.83797580997;34383.31233375319;34437.48343774845;12425.565105221274;12488.687782805502;12508.687282818002;12517.061220408506;12522.74954500923;10685.786284274427;10838.67483975482;10867.83698244527;10869.67390978272;10879.619213327496;16996.57508562271;17143.485695429157;17240.482785516455;17250.223739931735;17360.739588906177;6403.679816009181;6450.4839612830865;6494.870102597922;6635.971424429221;6716.496262780311;712.7576623947882;808.1474044882705;817.554432834095;865.8787769712245;888.1828717579842;25695.87152064265;27546.586801198;27577.724222757515;27940.52715916447;28188.295292617437;893.4683863101444;940.1773448232797;949.5726922884729;978.188103873783;1017.7201269650906;14326.355314010894;14513.709725805636;14549.34527946245;14559.19924404168;14601.92699036498;111672;111828;112493.43753281182;113228;366572;47517;47850.5214947853;47940.280895785894;47961.28058079132;48010.519894801306;1110.1396417776289;1134.8070827959266;1154.4112502623555;1160.5067846165346;1168.59099315239;24032.71999880893;25787.226383208534;27110.864445677646;27204;27249.86375068112;40073.79963100166;45303.32045019393;46738.29892551546;46787;50789.492105078476;333637;336252;337348;338492;339146;36964.63035369612;37413.81293093517;37440.438393423574;37617.43573846449;38183.42724859185;40151.79924100361;40458.39312410257;41175;41199.58800411958;41584.584154158074;34438.31123377568;34515.654843451244;34892.47661285134;34894.476582851785;35024.29951401009;34377;34506.482402763475;34590.308193836485;34753.30493390169;34833.12917177091;33957.49063764095;34408;34694.479582805776;35152.47271290881;35259.47110793392;26279.60580591331;28478.145655630364;28553.571696424155;28626.14121576356;29073.418531628828;24679.62980555329;24775.628365574892;24788.628170577096;24856.875715621307;24945.21457417172 21:23:21 INFO - PROCESS | 14277 | |2;jquery.html;340.64232555816386;348.7645839058636;365.26399305399616;370.8720491430456;387.9631435013674;12245.938770306158;13208.273544955024;15522.146281954489;15581.844181558181;16129.83870161298;14913.552593422215;15046.924765376158;15392.384304627802;15394.769078463803;15742.763858542132;4837.685550439211;4895.192293271606;5134.435212126663;5138.948610513903;5140.691558506483;4646.3495110684535;5077.263796749469;5078.8476345709505;5081.695098294095;5091.516305950929;5065.265536497206;5065.468125846788;5070.366204224472;5070.442251352349;5071.213961835903;4810.97594512027;4896.094222568836;4924.80300787968;4927.926081108786;4932.926006109911;4356.75832387768;4357.36818161368;4359.237133501624;4366.541513141106;4370.519242883281;19595.31416400419;19768.505787355287;19780.70328945067;19907.900460497603;20423.183072677075;1864.8041955594604;1889;1890.1494327552518;1978.5350442645968;2001.35956493922;11661.475233614423;12775;13098.607041788762;13313.86686133136;13388.196708197442;1679.7060514410052;1732.1079643983358;1754.9385771497937;1756.1219390304848;1784.0990299898467;39893.202135957115;54653.726731366485;61839.99999999955;62243;63473;9293.67472138472;9342.392744471588;9584.37701549397;9764.51177441125;9852.211823054138;12194.634160975185;12195.634130975908;12214;12223.755524889453;12226.266424014588;6606.504512161607;6719;6787;6894.620795856276;6902.792916212522;6247.375262473716;6260.780872669526;6501.349865013555;6512.088307636935;6557.180352455943;5859.794907178229;5917.378675239124;5934.376890426443;6028.156058151862;6115.143879856823;1680.2949496360495;1711.7432385142079;1748.4055421156868;1749.7900251969845;1750.6586215687819;772.3319328780676;827.8758186272107;827.8840962265288;833.9583020848934;857.3012994409536;15725.606859828367;16342.754858676892;16542;16810.243539040774;17320.220590073477;803.8392321535716;821.4208982667205;842.8103676672699;855.6021450025768;872.6378552900602;8914;10083.64707235258;10117.392956422638;10205.438700871524;10246.231532634933;357264;362113;365225;370811;371224;44488.43894513186;45858.43635298043;74606;75154.74535763936;77349.22650773532;804.1154729797294;831.4470876866936;833.4124442268308;833.8457385383723;840.7225615546855;14236.501722439665;14493.20287384204;15728;15862.841371586137;15997.920010399874;35931.64068359283;36060.27879442344;36400.453993190655;36788.26423471462;37658.2468350626;46102.769486153695;49585.50414495809;50414;52352.47647523476;53011.469885300656;7325.560466372035;7329.670164842488;7388.445866560137;7420.812669972778;7756.806079848049;9441.716748497556;10664.626738064131;11256.942689676029;11315.496376503845;11344.376059316817;9783.951080244553;9836.3606365586;10107.64623238183;10117.544710487899;10127.797444051224;9660.516974151124;9726.173275271682;9789.412635241908;9792.314537982558;10156.695299141038;9569.3779904306;9618.759531011781;9811.313208075366;9896.257780666334;10034.598616055277;7310.671019804228;7345.706171753283;7451.3666338361845;7589.241075892367;7935.523868567904;8407.95796021016;9729.85405218908;9852.852207217042;9897.455639939584;10309.896901030894 21:23:21 INFO - PROCESS | 14277 | |3;mootools.html;1302.4529697527034;1337.0707358385923;1364.7748121559944;1610.5651474101985;1634.3952737487125;6505;6749.325067493261;6844.5893246405185;7340.889886651697;7343.192248852622;7154.964225178866;7426.443016773736;7452.813679658011;7615.162332143474;7619.085709714842;2076.4289820299464;2095.549456866773;2100.884451355175;2106.3154474795674;2106.6096376391506;1827.7167039108892;1891.4798430431604;2037.449888530096;2088.4152437317575;2117.227212067592;2052.887091209983;2094;2101.8843963582;2102.8422868284865;2108.114591871418;2004.9498762530907;2017.3040301096098;2028.3712049264627;2029.0970518119443;2031.8069783370704;2060.3509894383224;2063.123172651632;2063.226290141197;2065.0500769645982;2072.357569153567;7329.19378868324;7391;7391.113066432009;7395.186529481753;7397.482176247665;4158.771267580282;4291.527931927485;4309.676774241944;4330.39374487572;4333.133373325316;2763.0429584372528;2838.3471801485775;2874.8131371460786;2942.6321709786275;2945.072302224792;945.2626950978248;946.2382781860599;963.1187463470916;963.9759006024835;965.0253244223314;10209.438480883548;10235.334703244265;10245.48772561369;10256.74358141045;10374.429406382646;3931.5085614298214;3968.1071758854027;4038.7980600969836;4077.571854955246;4086.162336720965;8494.83010339802;8518.531480768494;8527.275181609508;8533.573321333908;8533.829323413496;4321.416608757841;4323.0705398339505;4324.718893271927;4328;4339.566043395698;3730.757500762442;3898.064464528493;3916.6083391660604;3917.216556688674;3922.2743792398496;3230.53157292196;3318.0875259303402;3384.1370450534955;3418.7265018798435;3438.793672379665;939.8355287824603;953.880764904387;1025.2976710953021;1043.280136705686;1109.4619109731773;582.8047604052605;683.7333439958321;755;796.5658715999793;799.3884678221049;4662.347271382009;4684.297355396649;4744.4543877454535;4822.228443449031;4928.28539861718;763.8968739220245;769.805307971921;871.4292138649195;881.1628952495155;884.6594061286322;3340.4321265384456;3415.743819213519;3445;3542.2915416916203;3607.296577167427;8990.100989901088;9315.767105822408;9331.673391431268;9331.953340233254;9391.718248452557;9228.8615670765;9300.53497325131;9317.11487408695;9322.25421966241;9324.533773311307;6515.4787616990525;6687.699053542602;6786.219584747817;6976.476764242702;7101.680424380916;4880.072786170616;4929.827456039022;5036.463878517087;5096.0827051131155;5173.92239116406;8210.917890821016;8267;8283.29591984688;8349.666013359398;8384.035835878953;7988.400869934894;8062.7581172564915;8153;8184.099749027483;8403.411761176903;6428.164338636135;6582.539222254588;6583.078369028436;6588.308227636221;6591.571547849375;7103.25415831351;7175.856482870209;7184.425245980414;7187.496875218893;7226.566406015656;6383.616982981036;6446.613203207822;6497.220333560003;6523.543351965507;6641.734330626914;6378.043293506012;6518.348165183444;6543.770968016097;6543.80368588924;6549.672516374067;5476.205950137288;5517.034518959086;5554.555635549227;5571.415001424792;5662.207290979349;4406.074724307931;4418.977905110454;4452.532484089254;4506.256467682927;4518.457785065813;4192.83228670862;4217.7891105445215;4245.808938597832;4381.649468042485;4432.711873728197 21:23:21 INFO - PROCESS | 14277 | |4;prototype.html;274.8694370174167;283.5250954650959;287.04986494702536;288.36415703374075;292.57284364827353;4685;4846.7091974481555;4853.490383509734;4870.902581948359;4886.242632391981;4594.793234304456;4711.363965864607;4712.198926182548;4722.834700785474;4731.692439991398;3546.166650837064;3716.940671908507;3728.962710372902;3733.1227161617;3735.8318875650525;3656.39669454541;3701.925961480769;3739.8691045813403;3753.4182201758636;3757.1170774867883;3709.517762690846;3714.7213958953052;3719.2189640175598;3722.6463485968925;3728.328900797855;3739.6447337502896;3741.27045226181;3754.3992961126087;3758.718096142773;3762.849486020556;3234.3531293741344;3279.311344617633;3286.96713032869;3337.332533493311;3339.714210029132;4623.583877451012;4645.210314246552;4656.930146047812;4668.859934201945;4668.85993420198;4204.957950420488;4220.936685949713;4223.535411104776;4232;4238.279492486285;4851.223804191348;4990.476000020019;4995.500449954975;5017.397912250517;5017.799288028475;3494.2836718472654;3505.6669616386657;3505.8597656093725;3511.877084302063;3521.894343169709;5233.659812112201;5283.55089817366;5302.549283310923;5337.919931201035;5339.786408543692;3484.8954531364097;3555.715542756625;3561;3575.6960658344333;3585.15748799032;3611.2957973194975;3614.3494171049465;3623.221007483404;3633.345997720383;3633.691136253395;4172.561881002451;4180.352045432963;4191.790410479525;4203.159368126387;4220.746755194698;4787.832425865078;4930;5013.5989120870245;5023.648344615842;5025.648204625714;1188.6849984754047;1215.775081609905;1249.375312343828;1263.0779530942464;1267.5436842736608;826.2481142160605;842.2588122452325;860.875173099897;865.8441480533564;868.522312727997;4365.978170109129;4368.4321038264825;4374.956250437519;4395.802188901507;4419.11617676466;5103.770330335144;5118.181091025418;5120.769565369567;5128.512791284897;5138.409082955433;4370.934435983463;4381.298992161239;4387.122575484852;4393.802278897458;4406.9559304407185;2264.682944387787;2415.565198264294;2430.756924307555;2437.927311982722;2440.2313271319476;4347.304431290978;4348.695591308641;4356.390105385185;4358.869233922924;4401.007315025749;4637.582617564435;4648.6745927785405;4650.534946505322;4689.413823272091;4689.60138388234;4353.194658988034;4531.297648864432;4826.597248939489;4939.802407903716;4950;5217.556507696889;5220.269162317354;5231.346081739783;5231.712255825966;5250.18622113573;5143.665661731976;5154.845354639367;5187.351581052369;5190.97404512975;5220.895582088413;4669.929951050805;4881.536254055859;4922.532359425849;4928.359313289249;4942.728149951788;3618.620044895353;3623.2210074832983;3638.235970446236;3644.4351125575577;3668.908277293089;4960.30555722192;5226.764795584132;5250.527452529291;5274.736263186902;5299.6290259681455;4756.928646070381;5043.596512278936;5049.81329387601;5052.823151189691;5134.794608215779;5017.799288028438;5049.84850454487;5052.8989420210655;5059;5068.873278167928;4819.975900120477;4953.306537084739;4992.650514464098;4993.825216117419;5012.5964729875695;5083.822066227664;5094.2867998479505;5105.974470127774;5107.978404319077;5111.4888511150075;4941.950580494149;4951.861071953399;4967.180415231591;4984.700917944935;5031.94329190874 21:23:21 INFO - PROCESS | 14277 | |5;yui.html;614.4101662404092;637.5282291104584;638.9137466442029;647.6502688548185;749.827539665877;12337.321447320393;13838.723225535483;13868.861311386883;13912.373943172557;13916.304184790757;12890.162139460928;12998.350082495861;13004.284764337981;13022.54421095262;13023;621.0932039222718;635.272612858277;736.5764685305944;753.6457864803533;761.1665226576889;747.6822350501016;749.4491548711693;750.5121670913895;751.3087959077634;763.0919206144698;777.2926636760549;777.8288776469168;777.9688812447496;778.6457161991281;780.4185881518276;648.1347401219355;666.3236814633151;776.0454640791829;784.1609477858693;787.1027029186731;580.6312991250544;581.9553900748167;582.2576215325452;582.5019608234983;583.833607421887;12100.334481603508;12116.878831211752;12118;12119.212251203731;12121.878781212163;12262.570810021607;12578.748425031448;12952.417141228667;13016.60950171487;13431.462741490328;11030.558777648885;11231.550737970472;11308.547658093667;11336.773264534746;11507.136964727679;3217.6621454747146;3370.4607262837826;3422.5892892852767;3454.516367708523;4085.20338533986;58061.70969145127;59115;60344.39655603431;60672.69663651698;60927;9666.226701863974;9700.90299097014;9849.310548261554;9874.111329980336;9884.752881178028;17533.123343832758;17616.29534818593;17646.2059207336;17691.823081769016;17880;6331.430171284606;6352.269489008823;6406.839829004219;6434.485241180788;6532.477401807844;3619.49327094207;3664.0656632558525;3687.6865466435115;3700.6114357992024;3708.2583483303447;2797.8321300722023;2885.9855700721364;2893.1754449981654;2897.0294951191167;2902.085842959461;481.14836738972525;482.6959015820081;484.6849547793962;487.36885732975884;490.76443307212026;488.5285699300121;536.769189248619;548.7640314664652;567.5261156933924;579.1341943794055;8481.745547633582;8518.361122915807;8610.4760958156;8778.561071946377;8846.734597962071;493.1197811905803;539.9946000540023;578.5978744772343;579.9072148456227;598.437468779346;3931.8034098295543;4108.157827645326;4121.773302468393;4277.101808620225;4452.799624016927;54289;55439.168412473846;55456.72271638697;55540;56325;83710.58144709238;84350.57824710837;84820.57589712011;86624.56687716521;86945.1305486937;73300.26699733041;74210.25789742141;75301.62349188219;76036;78825.60587197027;7571;7636.770896873103;7752.7674169775;7844.84310313802;8068.919310807051;42555.3616695756;42775.5722442784;44159.55840441683;44195.674129776155;44671.55328446674;47978.520214797405;48059.75970120127;50703.74648126736;57553.71223143858;58703.70648146732;11526.642141895938;11543.249688770204;11671;11682.649520514058;11722;13069.673258168621;13072.084954053505;13210.933945330597;13235;13354.065215435216;12040.518379264731;12127.939360303495;12221.38893055326;12868.935655321664;12891.41988610496;12491.625251242478;12544.121911466475;13053.673658158623;13282.80075798883;13358.86641133615;11631.825522616999;11805.350705711267;11968.940155299168;12456.190347627375;12599.370031498573;10197.975936241412;10204.591816327264;10491.790164196826;10757.193210509087;10797.946010269898;10070.093691567794;10307.94846025765;10530.894691052992;10808;10902.454877255946 21:23:21 INFO - PROCESS | 14277 | __end_tp_report 21:23:21 INFO - PROCESS | 14277 | __start_cc_report 21:23:21 INFO - PROCESS | 14277 | _x_x_mozilla_cycle_collect,1206 21:23:21 INFO - PROCESS | 14277 | __end_cc_report 21:23:21 INFO - PROCESS | 14277 | __startTimestamp1475814200996__endTimestamp 21:23:21 INFO - PROCESS | 14277 | 21:23:21 INFO - PROCESS | 14277 | ------- Summary: start ------- 21:23:21 INFO - PROCESS | 14277 | Number of tests: 6 21:23:21 INFO - PROCESS | 14277 | 21:23:21 INFO - PROCESS | 14277 | [#0] dojo.html Cycles:165 Average:4612.20 Median:4741.62 stddev:490.62 (10.3%) stddev-sans-first:464.53 21:23:21 INFO - PROCESS | 14277 | Values: 2544.3 2567.8 2582.2 2588.9 2596.4 4600.4 4649.8 4654.3 4660.9 4727.5 4653.7 4667.0 4685.3 4721.0 4761.9 4272.4 4287.4 4333.6 4334.4 4357.5 4349.8 4363.7 4367.0 4369.2 4383.4 4252.7 4380.2 4381.0 4394.9 4491.1 4233.4 4285.4 4358.2 4361.1 4370.0 4268.1 4270.6 4273.0 4323.8 4348.8 4627.9 4650.7 4670.7 4713.2 4728.9 4902.4 4943.8 4987.1 4989.8 4997.0 4952.7 4973.6 4987.7 4989.1 5070.6 4659.0 4662.7 4665.4 4667.6 4720.9 5026.6 5095.9 5104.2 5109.5 5169.7 4865.1 4879.7 4923.3 4924.0 4925.8 5010.9 5015.9 5017.3 5017.7 5018.5 4928.3 4957.4 4964.8 4978.5 4979.3 4908.0 4949.6 4961.6 5046.1 5052.0 4199.4 4203.8 4209.1 4249.3 4251.9 3641.1 3644.8 3674.0 3695.7 3723.1 4137.3 4171.4 4174.2 4194.9 4246.7 4953.3 4979.4 4990.1 5040.9 5048.3 4237.7 4243.7 4244.7 4296.6 4297.2 4292.4 4343.7 4364.2 4422.8 4429.4 4669.9 4732.6 4732.7 4772.1 4780.6 4990.4 5008.6 5009.6 5010.5 5068.7 4583.1 4637.8 4697.2 4720.7 4799.4 4923.7 4963.2 4965.4 4966.6 5030.4 5010.5 5021.1 5025.8 5025.9 5091.9 4786.6 4852.2 4862.4 4867.3 4921.4 4805.5 4844.7 4845.7 4847.2 4912.9 4761.4 4773.8 4785.4 4789.9 4831.1 4841.8 4869.3 4873.9 4878.8 4943.6 4695.3 4741.6 4762.5 4792.5 4823.5 21:23:21 INFO - PROCESS | 14277 | 21:23:21 INFO - PROCESS | 14277 | [#1] ext.html Cycles:180 Average:40555.20 Median:34862.80 stddev:69977.43 (200.7%) stddev-sans-first:70109.17 21:23:21 INFO - PROCESS | 14277 | Values: 520.3 532.9 539.4 541.7 545.6 27132.7 37485.4 38415.5 38527.2 42311.0 39246.8 39532.6 39589.2 39656.2 39669.2 7521.7 7661.2 7668.5 7688.4 7693.6 7560.3 7641.6 7649.5 7649.5 7651.4 7636.7 7735.3 7740.8 7742.0 7747.9 7611.5 7660.6 7666.4 7668.6 7668.8 7518.7 7578.8 7586.5 7591.7 7593.7 36597.6 36977.3 36980.4 36996.3 36998.3 2782.8 2821.9 2879.4 2884.4 2891.3 24532.4 27224.2 27549.6 27594.2 28099.6 3244.5 3258.5 3290.4 3291.4 3316.1 244958.0 245389.0 245765.0 246024.0 246952.8 47865.5 48476.3 48558.5 48590.5 48676.3 31543.4 32355.7 32404.8 34383.3 34437.5 12425.6 12488.7 12508.7 12517.1 12522.7 10685.8 10838.7 10867.8 10869.7 10879.6 16996.6 17143.5 17240.5 17250.2 17360.7 6403.7 6450.5 6494.9 6636.0 6716.5 712.8 808.1 817.6 865.9 888.2 25695.9 27546.6 27577.7 27940.5 28188.3 893.5 940.2 949.6 978.2 1017.7 14326.4 14513.7 14549.3 14559.2 14601.9 111672.0 111828.0 112493.4 113228.0 366572.0 47517.0 47850.5 47940.3 47961.3 48010.5 1110.1 1134.8 1154.4 1160.5 1168.6 24032.7 25787.2 27110.9 27204.0 27249.9 40073.8 45303.3 46738.3 46787.0 50789.5 333637.0 336252.0 337348.0 338492.0 339146.0 36964.6 37413.8 37440.4 37617.4 38183.4 40151.8 40458.4 41175.0 41199.6 41584.6 34438.3 34515.7 34892.5 34894.5 35024.3 34377.0 34506.5 34590.3 34753.3 34833.1 33957.5 34408.0 34694.5 35152.5 35259.5 26279.6 28478.1 28553.6 28626.1 29073.4 24679.6 24775.6 24788.6 24856.9 24945.2 21:23:21 INFO - PROCESS | 14277 | 21:23:21 INFO - PROCESS | 14277 | [#2] jquery.html Cycles:180 Average:22638.17 Median:4866.44 stddev:60064.54 (1234.3%) stddev-sans-first:60209.70 21:23:21 INFO - PROCESS | 14277 | Values: 340.6 348.8 365.3 370.9 388.0 12245.9 13208.3 15522.1 15581.8 16129.8 14913.6 15046.9 15392.4 15394.8 15742.8 4837.7 4895.2 5134.4 5138.9 5140.7 4646.3 5077.3 5078.8 5081.7 5091.5 5065.3 5065.5 5070.4 5070.4 5071.2 4811.0 4896.1 4924.8 4927.9 4932.9 4356.8 4357.4 4359.2 4366.5 4370.5 19595.3 19768.5 19780.7 19907.9 20423.2 1864.8 1889.0 1890.1 1978.5 2001.4 11661.5 12775.0 13098.6 13313.9 13388.2 1679.7 1732.1 1754.9 1756.1 1784.1 39893.2 54653.7 61840.0 62243.0 63473.0 9293.7 9342.4 9584.4 9764.5 9852.2 12194.6 12195.6 12214.0 12223.8 12226.3 6606.5 6719.0 6787.0 6894.6 6902.8 6247.4 6260.8 6501.3 6512.1 6557.2 5859.8 5917.4 5934.4 6028.2 6115.1 1680.3 1711.7 1748.4 1749.8 1750.7 772.3 827.9 827.9 834.0 857.3 15725.6 16342.8 16542.0 16810.2 17320.2 803.8 821.4 842.8 855.6 872.6 8914.0 10083.6 10117.4 10205.4 10246.2 357264.0 362113.0 365225.0 370811.0 371224.0 44488.4 45858.4 74606.0 75154.7 77349.2 804.1 831.4 833.4 833.8 840.7 14236.5 14493.2 15728.0 15862.8 15997.9 35931.6 36060.3 36400.5 36788.3 37658.2 46102.8 49585.5 50414.0 52352.5 53011.5 7325.6 7329.7 7388.4 7420.8 7756.8 9441.7 10664.6 11256.9 11315.5 11344.4 9784.0 9836.4 10107.6 10117.5 10127.8 9660.5 9726.2 9789.4 9792.3 10156.7 9569.4 9618.8 9811.3 9896.3 10034.6 7310.7 7345.7 7451.4 7589.2 7935.5 8408.0 9729.9 9852.9 9897.5 10309.9 21:23:21 INFO - PROCESS | 14277 | 21:23:21 INFO - PROCESS | 14277 | [#3] mootools.html Cycles:180 Average:4853.18 Median:5066.27 stddev:2723.55 (53.8%) stddev-sans-first:2718.12 21:23:21 INFO - PROCESS | 14277 | Values: 1302.5 1337.1 1364.8 1610.6 1634.4 6505.0 6749.3 6844.6 7340.9 7343.2 7155.0 7426.4 7452.8 7615.2 7619.1 2076.4 2095.5 2100.9 2106.3 2106.6 1827.7 1891.5 2037.4 2088.4 2117.2 2052.9 2094.0 2101.9 2102.8 2108.1 2004.9 2017.3 2028.4 2029.1 2031.8 2060.4 2063.1 2063.2 2065.1 2072.4 7329.2 7391.0 7391.1 7395.2 7397.5 4158.8 4291.5 4309.7 4330.4 4333.1 2763.0 2838.3 2874.8 2942.6 2945.1 945.3 946.2 963.1 964.0 965.0 10209.4 10235.3 10245.5 10256.7 10374.4 3931.5 3968.1 4038.8 4077.6 4086.2 8494.8 8518.5 8527.3 8533.6 8533.8 4321.4 4323.1 4324.7 4328.0 4339.6 3730.8 3898.1 3916.6 3917.2 3922.3 3230.5 3318.1 3384.1 3418.7 3438.8 939.8 953.9 1025.3 1043.3 1109.5 582.8 683.7 755.0 796.6 799.4 4662.3 4684.3 4744.5 4822.2 4928.3 763.9 769.8 871.4 881.2 884.7 3340.4 3415.7 3445.0 3542.3 3607.3 8990.1 9315.8 9331.7 9332.0 9391.7 9228.9 9300.5 9317.1 9322.3 9324.5 6515.5 6687.7 6786.2 6976.5 7101.7 4880.1 4929.8 5036.5 5096.1 5173.9 8210.9 8267.0 8283.3 8349.7 8384.0 7988.4 8062.8 8153.0 8184.1 8403.4 6428.2 6582.5 6583.1 6588.3 6591.6 7103.3 7175.9 7184.4 7187.5 7226.6 6383.6 6446.6 6497.2 6523.5 6641.7 6378.0 6518.3 6543.8 6543.8 6549.7 5476.2 5517.0 5554.6 5571.4 5662.2 4406.1 4419.0 4452.5 4506.3 4518.5 4192.8 4217.8 4245.8 4381.6 4432.7 21:23:21 INFO - PROCESS | 14277 | 21:23:21 INFO - PROCESS | 14277 | [#4] prototype.html Cycles:180 Average:4119.67 Median:4646.94 stddev:1219.49 (26.2%) stddev-sans-first:1188.27 21:23:21 INFO - PROCESS | 14277 | Values: 274.9 283.5 287.0 288.4 292.6 4685.0 4846.7 4853.5 4870.9 4886.2 4594.8 4711.4 4712.2 4722.8 4731.7 3546.2 3716.9 3729.0 3733.1 3735.8 3656.4 3701.9 3739.9 3753.4 3757.1 3709.5 3714.7 3719.2 3722.6 3728.3 3739.6 3741.3 3754.4 3758.7 3762.8 3234.4 3279.3 3287.0 3337.3 3339.7 4623.6 4645.2 4656.9 4668.9 4668.9 4205.0 4220.9 4223.5 4232.0 4238.3 4851.2 4990.5 4995.5 5017.4 5017.8 3494.3 3505.7 3505.9 3511.9 3521.9 5233.7 5283.6 5302.5 5337.9 5339.8 3484.9 3555.7 3561.0 3575.7 3585.2 3611.3 3614.3 3623.2 3633.3 3633.7 4172.6 4180.4 4191.8 4203.2 4220.7 4787.8 4930.0 5013.6 5023.6 5025.6 1188.7 1215.8 1249.4 1263.1 1267.5 826.2 842.3 860.9 865.8 868.5 4366.0 4368.4 4375.0 4395.8 4419.1 5103.8 5118.2 5120.8 5128.5 5138.4 4370.9 4381.3 4387.1 4393.8 4407.0 2264.7 2415.6 2430.8 2437.9 2440.2 4347.3 4348.7 4356.4 4358.9 4401.0 4637.6 4648.7 4650.5 4689.4 4689.6 4353.2 4531.3 4826.6 4939.8 4950.0 5217.6 5220.3 5231.3 5231.7 5250.2 5143.7 5154.8 5187.4 5191.0 5220.9 4669.9 4881.5 4922.5 4928.4 4942.7 3618.6 3623.2 3638.2 3644.4 3668.9 4960.3 5226.8 5250.5 5274.7 5299.6 4756.9 5043.6 5049.8 5052.8 5134.8 5017.8 5049.8 5052.9 5059.0 5068.9 4820.0 4953.3 4992.7 4993.8 5012.6 5083.8 5094.3 5106.0 5108.0 5111.5 4942.0 4951.9 4967.2 4984.7 5031.9 21:23:21 INFO - PROCESS | 14277 | 21:23:21 INFO - PROCESS | 14277 | [#5] yui.html Cycles:180 Average:16354.81 Median:48019.14 stddev:21877.36 (45.6%) stddev-sans-first:21906.80 21:23:21 INFO - PROCESS | 14277 | Values: 614.4 637.5 638.9 647.7 749.8 12337.3 13838.7 13868.9 13912.4 13916.3 12890.2 12998.4 13004.3 13022.5 13023.0 621.1 635.3 736.6 753.6 761.2 747.7 749.4 750.5 751.3 763.1 777.3 777.8 778.0 778.6 780.4 648.1 666.3 776.0 784.2 787.1 580.6 582.0 582.3 582.5 583.8 12100.3 12116.9 12118.0 12119.2 12121.9 12262.6 12578.7 12952.4 13016.6 13431.5 11030.6 11231.6 11308.5 11336.8 11507.1 3217.7 3370.5 3422.6 3454.5 4085.2 58061.7 59115.0 60344.4 60672.7 60927.0 9666.2 9700.9 9849.3 9874.1 9884.8 17533.1 17616.3 17646.2 17691.8 17880.0 6331.4 6352.3 6406.8 6434.5 6532.5 3619.5 3664.1 3687.7 3700.6 3708.3 2797.8 2886.0 2893.2 2897.0 2902.1 481.1 482.7 484.7 487.4 490.8 488.5 536.8 548.8 567.5 579.1 8481.7 8518.4 8610.5 8778.6 8846.7 493.1 540.0 578.6 579.9 598.4 3931.8 4108.2 4121.8 4277.1 4452.8 54289.0 55439.2 55456.7 55540.0 56325.0 83710.6 84350.6 84820.6 86624.6 86945.1 73300.3 74210.3 75301.6 76036.0 78825.6 7571.0 7636.8 7752.8 7844.8 8068.9 42555.4 42775.6 44159.6 44195.7 44671.6 47978.5 48059.8 50703.7 57553.7 58703.7 11526.6 11543.2 11671.0 11682.6 11722.0 13069.7 13072.1 13210.9 13235.0 13354.1 12040.5 12127.9 12221.4 12868.9 12891.4 12491.6 12544.1 13053.7 13282.8 13358.9 11631.8 11805.4 11968.9 12456.2 12599.4 10198.0 10204.6 10491.8 10757.2 10797.9 10070.1 10307.9 10530.9 10808.0 10902.5 21:23:21 INFO - PROCESS | 14277 | -------- Summary: end -------- 21:23:21 INFO - PROCESS | 14277 | 21:23:21 INFO - TEST-INFO | 14277: exit 0 21:23:21 INFO - TEST-OK | dromaeo_css | took 1122523ms 21:23:21 INFO - TEST-START | kraken 21:23:21 INFO - operating with platform_type : linux_ 21:23:21 INFO - Initialising browser for kraken test... 21:23:21 INFO - TEST-INFO | started process 14578 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9kvY75/profile http://localhost:46023/getInfo.html) 21:23:26 INFO - PROCESS | 14578 | __metrics Screen width/height:1600/1200 21:23:26 INFO - PROCESS | 14578 | colorDepth:24 21:23:26 INFO - PROCESS | 14578 | Browser inner width/height: 1024/697 21:23:26 INFO - PROCESS | 14578 | __metrics 21:23:27 INFO - PROCESS | 14578 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:23:27 INFO - PROCESS | 14578 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:23:27 INFO - PROCESS | 14578 | console.error: PushService: 21:23:27 INFO - PROCESS | 14578 | stateChangeProcessEnqueue: Error transitioning state 21:23:27 INFO - PROCESS | 14578 | UnknownError 21:23:28 INFO - TEST-INFO | 14578: exit 0 21:23:28 INFO - Browser initialized. 21:23:28 INFO - Running cycle 1/1 for kraken test... 21:23:28 INFO - TEST-INFO | started process 14661 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9kvY75/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:23:40 INFO - PROCESS | 14661 | RSS: Main: 175489024 21:23:40 INFO - PROCESS | 14661 | 21:23:43 INFO - PROCESS | 14661 | Cycle 1(1): loaded http://localhost:46023/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46023/tests/kraken/driver.html?testName=audio-beat-detection) 21:23:44 INFO - PROCESS | 14661 | RSS: Main: 241664000 21:23:44 INFO - PROCESS | 14661 | 21:23:47 INFO - PROCESS | 14661 | Cycle 1(1): loaded http://localhost:46023/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46023/tests/kraken/driver.html?testName=audio-dft) 21:23:47 INFO - PROCESS | 14661 | RSS: Main: 219058176 21:23:47 INFO - PROCESS | 14661 | 21:23:51 INFO - PROCESS | 14661 | Cycle 1(1): loaded http://localhost:46023/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46023/tests/kraken/driver.html?testName=audio-fft) 21:23:51 INFO - PROCESS | 14661 | RSS: Main: 301682688 21:23:51 INFO - PROCESS | 14661 | 21:23:53 INFO - PROCESS | 14661 | Cycle 1(1): loaded http://localhost:46023/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46023/tests/kraken/driver.html?testName=audio-oscillator) 21:23:54 INFO - PROCESS | 14661 | RSS: Main: 211996672 21:23:54 INFO - PROCESS | 14661 | 21:23:56 INFO - PROCESS | 14661 | Cycle 1(1): loaded http://localhost:46023/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46023/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:23:57 INFO - PROCESS | 14661 | RSS: Main: 214724608 21:23:57 INFO - PROCESS | 14661 | 21:24:00 INFO - PROCESS | 14661 | Cycle 1(1): loaded http://localhost:46023/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46023/tests/kraken/driver.html?testName=imaging-darkroom) 21:24:01 INFO - PROCESS | 14661 | RSS: Main: 250707968 21:24:01 INFO - PROCESS | 14661 | 21:24:04 INFO - PROCESS | 14661 | Cycle 1(1): loaded http://localhost:46023/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46023/tests/kraken/driver.html?testName=imaging-desaturate) 21:24:05 INFO - PROCESS | 14661 | RSS: Main: 250327040 21:24:05 INFO - PROCESS | 14661 | 21:24:08 INFO - PROCESS | 14661 | Cycle 1(1): loaded http://localhost:46023/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46023/tests/kraken/driver.html?testName=json-parse-financial) 21:24:08 INFO - PROCESS | 14661 | RSS: Main: 250015744 21:24:08 INFO - PROCESS | 14661 | 21:24:10 INFO - PROCESS | 14661 | Cycle 1(1): loaded http://localhost:46023/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46023/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:24:11 INFO - PROCESS | 14661 | RSS: Main: 211976192 21:24:11 INFO - PROCESS | 14661 | 21:24:12 INFO - PROCESS | 14661 | Cycle 1(1): loaded http://localhost:46023/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46023/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:24:13 INFO - PROCESS | 14661 | RSS: Main: 219054080 21:24:13 INFO - PROCESS | 14661 | 21:24:15 INFO - PROCESS | 14661 | Cycle 1(1): loaded http://localhost:46023/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46023/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:24:16 INFO - PROCESS | 14661 | RSS: Main: 228360192 21:24:16 INFO - PROCESS | 14661 | 21:24:19 INFO - PROCESS | 14661 | Cycle 1(1): loaded http://localhost:46023/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46023/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:24:19 INFO - PROCESS | 14661 | RSS: Main: 236810240 21:24:19 INFO - PROCESS | 14661 | 21:24:22 INFO - PROCESS | 14661 | Cycle 1(1): loaded http://localhost:46023/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46023/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:24:23 INFO - PROCESS | 14661 | RSS: Main: 233623552 21:24:23 INFO - PROCESS | 14661 | 21:24:25 INFO - PROCESS | 14661 | Cycle 1(1): loaded http://localhost:46023/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46023/tests/kraken/driver.html?testName=ai-astar) 21:24:25 INFO - PROCESS | 14661 | RSS: Main: 285413376 21:24:25 INFO - PROCESS | 14661 | 21:24:25 INFO - PROCESS | 14661 | __start_tp_report 21:24:25 INFO - PROCESS | 14661 | _x_x_mozilla_page_load 21:24:25 INFO - PROCESS | 14661 | _x_x_mozilla_page_load_details 21:24:25 INFO - PROCESS | 14661 | |i|pagename|runs| 21:24:25 INFO - PROCESS | 14661 | |0;ai-astar;115;115;115;117;115;115;114;115;115;114 21:24:25 INFO - PROCESS | 14661 | |1;audio-beat-detection;154;137;126;177;130;126;126;128;161;132 21:24:25 INFO - PROCESS | 14661 | |2;audio-dft;165;163;165;165;164;163;162;162;164;161 21:24:25 INFO - PROCESS | 14661 | |3;audio-fft;75;78;76;103;78;76;77;76;104;76 21:24:25 INFO - PROCESS | 14661 | |4;audio-oscillator;84;83;126;85;83;84;109;83;83;115 21:24:25 INFO - PROCESS | 14661 | |5;imaging-gaussian-blur;117;116;117;117;116;117;118;117;116;117 21:24:25 INFO - PROCESS | 14661 | |6;imaging-darkroom;147;146;147;146;146;147;146;146;145;145 21:24:25 INFO - PROCESS | 14661 | |7;imaging-desaturate;96;95;95;95;95;95;96;95;96;95 21:24:25 INFO - PROCESS | 14661 | |8;json-parse-financial;65;63;63;69;65;65;66;65;66;66 21:24:25 INFO - PROCESS | 14661 | |9;json-stringify-tinderbox;66;66;66;66;69;67;67;66;66;66 21:24:25 INFO - PROCESS | 14661 | |10;stanford-crypto-aes;84;85;84;88;89;83;85;84;83;83 21:24:25 INFO - PROCESS | 14661 | |11;stanford-crypto-ccm;157;149;140;140;137;139;142;139;182;138 21:24:25 INFO - PROCESS | 14661 | |12;stanford-crypto-pbkdf2;176;180;177;180;174;178;174;177;177;177 21:24:25 INFO - PROCESS | 14661 | |13;stanford-crypto-sha256-iterative;70;72;73;70;70;70;71;71;69;69 21:24:25 INFO - PROCESS | 14661 | __end_tp_report 21:24:25 INFO - PROCESS | 14661 | __start_cc_report 21:24:25 INFO - PROCESS | 14661 | _x_x_mozilla_cycle_collect,1941 21:24:25 INFO - PROCESS | 14661 | __end_cc_report 21:24:25 INFO - PROCESS | 14661 | __startTimestamp1475814265581__endTimestamp 21:24:25 INFO - PROCESS | 14661 | 21:24:25 INFO - PROCESS | 14661 | ------- Summary: start ------- 21:24:25 INFO - PROCESS | 14661 | Number of tests: 14 21:24:25 INFO - PROCESS | 14661 | 21:24:25 INFO - PROCESS | 14661 | [#0] ai-astar Cycles:10 Average:115.00 Median:115.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 21:24:25 INFO - PROCESS | 14661 | Values: 115.0 115.0 115.0 117.0 115.0 115.0 114.0 115.0 115.0 114.0 21:24:25 INFO - PROCESS | 14661 | 21:24:25 INFO - PROCESS | 14661 | [#1] audio-beat-detection Cycles:10 Average:139.70 Median:134.50 stddev:17.98 (13.4%) stddev-sans-first:18.31 21:24:25 INFO - PROCESS | 14661 | Values: 154.0 137.0 126.0 177.0 130.0 126.0 126.0 128.0 161.0 132.0 21:24:25 INFO - PROCESS | 14661 | 21:24:25 INFO - PROCESS | 14661 | [#2] audio-dft Cycles:10 Average:163.40 Median:164.00 stddev:1.43 (0.9%) stddev-sans-first:1.39 21:24:25 INFO - PROCESS | 14661 | Values: 165.0 163.0 165.0 165.0 164.0 163.0 162.0 162.0 164.0 161.0 21:24:25 INFO - PROCESS | 14661 | 21:24:25 INFO - PROCESS | 14661 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.00 stddev:11.43 (15.0%) stddev-sans-first:11.84 21:24:25 INFO - PROCESS | 14661 | Values: 75.0 78.0 76.0 103.0 78.0 76.0 77.0 76.0 104.0 76.0 21:24:25 INFO - PROCESS | 14661 | 21:24:25 INFO - PROCESS | 14661 | [#4] audio-oscillator Cycles:10 Average:93.50 Median:83.00 stddev:16.51 (19.9%) stddev-sans-first:17.15 21:24:25 INFO - PROCESS | 14661 | Values: 84.0 83.0 126.0 85.0 83.0 84.0 109.0 83.0 83.0 115.0 21:24:25 INFO - PROCESS | 14661 | 21:24:25 INFO - PROCESS | 14661 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 21:24:25 INFO - PROCESS | 14661 | Values: 117.0 116.0 117.0 117.0 116.0 117.0 118.0 117.0 116.0 117.0 21:24:25 INFO - PROCESS | 14661 | 21:24:25 INFO - PROCESS | 14661 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 21:24:25 INFO - PROCESS | 14661 | Values: 147.0 146.0 147.0 146.0 146.0 147.0 146.0 146.0 145.0 145.0 21:24:25 INFO - PROCESS | 14661 | 21:24:25 INFO - PROCESS | 14661 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 21:24:25 INFO - PROCESS | 14661 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 21:24:25 INFO - PROCESS | 14661 | 21:24:25 INFO - PROCESS | 14661 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:65.50 stddev:1.70 (2.6%) stddev-sans-first:1.80 21:24:25 INFO - PROCESS | 14661 | Values: 65.0 63.0 63.0 69.0 65.0 65.0 66.0 65.0 66.0 66.0 21:24:25 INFO - PROCESS | 14661 | 21:24:25 INFO - PROCESS | 14661 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:66.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 21:24:25 INFO - PROCESS | 14661 | Values: 66.0 66.0 66.0 66.0 69.0 67.0 67.0 66.0 66.0 66.0 21:24:25 INFO - PROCESS | 14661 | 21:24:25 INFO - PROCESS | 14661 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:84.50 stddev:2.10 (2.5%) stddev-sans-first:2.20 21:24:25 INFO - PROCESS | 14661 | Values: 84.0 85.0 84.0 88.0 89.0 83.0 85.0 84.0 83.0 83.0 21:24:25 INFO - PROCESS | 14661 | 21:24:25 INFO - PROCESS | 14661 | [#11] stanford-crypto-ccm Cycles:10 Average:146.30 Median:141.00 stddev:13.97 (9.9%) stddev-sans-first:14.27 21:24:25 INFO - PROCESS | 14661 | Values: 157.0 149.0 140.0 140.0 137.0 139.0 142.0 139.0 182.0 138.0 21:24:25 INFO - PROCESS | 14661 | 21:24:25 INFO - PROCESS | 14661 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.00 Median:177.00 stddev:2.05 (1.2%) stddev-sans-first:2.15 21:24:25 INFO - PROCESS | 14661 | Values: 176.0 180.0 177.0 180.0 174.0 178.0 174.0 177.0 177.0 177.0 21:24:25 INFO - PROCESS | 14661 | 21:24:25 INFO - PROCESS | 14661 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:70.50 stddev:1.27 (1.8%) stddev-sans-first:1.33 21:24:25 INFO - PROCESS | 14661 | Values: 70.0 72.0 73.0 70.0 70.0 70.0 71.0 71.0 69.0 69.0 21:24:25 INFO - PROCESS | 14661 | -------- Summary: end -------- 21:24:25 INFO - PROCESS | 14661 | 21:24:26 INFO - TEST-INFO | 14661: exit 0 21:24:27 INFO - TEST-OK | kraken | took 65038ms 21:24:27 INFO - SUITE-END | took 1187s 21:24:27 INFO - Completed test suite (00:19:47) 21:24:27 INFO - javascript benchmark 21:24:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2544.262163972448, 2567.7945764338865, 2582.212425210311, 2588.935276618084, 2596.4287856671526, 4600.401947746788, 4649.837255696051, 4654.325122857188, 4660.860174194775, 4727.5036121207295, 4653.720776753389, 4666.953330466695, 4685.320628508873, 4720.976395118019, 4761.928571071437, 4272.380504826814, 4287.421198138242, 4333.60997510224, 4334.371516130159, 4357.542458041908, 4349.847755328564, 4363.716358436707, 4367.0, 4369.169857727037, 4383.408239887623, 4252.744835309892, 4380.2115619188535, 4381.036172042146, 4394.890127746816, 4491.146682130385, 4233.44965154531, 4285.378620100099, 4358.237308471005, 4361.149575832714, 4370.038591509863, 4268.146370725836, 4270.572942705736, 4273.0, 4323.848665296731, 4348.847790327355, 4627.8611641650805, 4650.651201159926, 4670.743109128996, 4713.175194341011, 4728.929066064012, 4902.436219834729, 4943.826966056171, 4987.077390682699, 4989.750512474398, 4996.9500304996845, 4952.727599981999, 4973.5523802857915, 4987.700737955734, 4989.052080104769, 5070.569001634865, 4659.021605462857, 4662.673612847136, 4665.393498845128, 4667.649926255544, 4720.858374248778, 5026.572741316956, 5095.923561146586, 5104.157813960729, 5109.463506331856, 5169.663971841818, 4865.148598995162, 4879.682820616648, 4923.310736496894, 4923.975380123076, 4925.827596034122, 5010.872553675466, 5015.899682006339, 5017.272495488134, 5017.698938063728, 5018.548330650186, 4928.334674818925, 4957.380327459067, 4964.776585053682, 4978.5270399312, 4979.278004689299, 4908.042931628298, 4949.604031677457, 4961.5534601886, 5046.1169295373165, 5052.0, 4199.391088292181, 4203.810828512725, 4209.137126888981, 4249.3413520904305, 4251.893702657397, 3641.053326135224, 3644.781313121221, 3673.9632603674154, 3695.6858667013603, 3723.1436769543157, 4137.296659567881, 4171.353440216772, 4174.248635245685, 4194.874153775391, 4246.723962942398, 4953.281774142729, 4979.377577802775, 4990.051890140861, 5040.899182016413, 5048.268001139814, 4237.660987121023, 4243.7029407941145, 4244.72409293395, 4296.634786043159, 4297.162053399557, 4292.420523229386, 4343.652507799368, 4364.192624364439, 4422.778861056934, 4429.402030725811, 4669.929951050669, 4732.645051621211, 4732.692374995752, 4772.117158325721, 4780.6414518911915, 4990.3762029746285, 5008.649394542347, 5009.599232061353, 5010.473900240422, 5068.695878247317, 4583.083383323416, 4637.814487420465, 4697.177993850994, 4720.740359280135, 4799.352087468287, 4923.729194894315, 4963.181075122564, 4965.4289756677, 4966.577840883565, 5030.3963524377305, 5010.5240002199735, 5021.096202683552, 5025.84922452327, 5025.899482010413, 5091.949080509147, 4786.593139583035, 4852.175130227799, 4862.367892173995, 4867.318575399376, 4921.360223170965, 4805.519448055166, 4844.660873738945, 4845.685030473008, 4847.151748443937, 4912.901741965212, 4761.381020467317, 4773.785179666854, 4785.377900872864, 4789.880252993703, 4831.057943701085, 4841.782119804547, 4869.31829543857, 4873.9025219496125, 4878.780454879468, 4943.604511639132, 4695.272232803921, 4741.620670346433, 4762.452317983338, 4792.496787837227, 4823.469418364048], "value": 4580.160319625303, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [520.3131865936963, 532.9253904453376, 539.38240714382, 541.6831153775041, 545.5662748115247, 27132.728672713267, 37485.43771843421, 38415.54260116592, 38527.229455410874, 42311.0, 39246.80376598113, 39532.604673953254, 39589.208215835664, 39656.20687586247, 39669.20661586767, 7521.661525231364, 7661.23387661235, 7668.463207575472, 7688.38492920565, 7693.615319234043, 7560.319571238588, 7641.61791910405, 7649.464537482379, 7649.502782319159, 7651.387888968897, 7636.694532218732, 7735.342495887856, 7740.845183096335, 7741.961290193569, 7747.922520774805, 7611.505252158619, 7660.578668173248, 7666.425018123663, 7668.578228197447, 7668.846623067563, 7518.736844210481, 7578.772636820904, 7586.544807311524, 7591.6583753730665, 7593.6582853771715, 36597.63402365969, 36977.26045479102, 36980.44529332062, 36996.26007479835, 36998.260034799154, 2782.8330300182056, 2821.887124515017, 2879.3521457672064, 2884.423115376912, 2891.334992951633, 24532.386690332885, 27224.183274501796, 27549.586756198674, 27594.227099236792, 28099.57850632242, 3244.513323001545, 3258.462353711635, 3290.3748287825474, 3291.424000799874, 3316.121227874591, 244958.0, 245389.0, 245765.0, 246024.0, 246952.76523617445, 47865.52134478611, 48476.27285590719, 48558.5144148554, 48590.5140948593, 48676.26985595219, 31543.36913261722, 32355.676443235265, 32404.83797580997, 34383.31233375319, 34437.48343774845, 12425.565105221274, 12488.687782805502, 12508.687282818002, 12517.061220408506, 12522.74954500923, 10685.786284274427, 10838.67483975482, 10867.83698244527, 10869.67390978272, 10879.619213327496, 16996.57508562271, 17143.485695429157, 17240.482785516455, 17250.223739931735, 17360.739588906177, 6403.679816009181, 6450.4839612830865, 6494.870102597922, 6635.971424429221, 6716.496262780311, 712.7576623947882, 808.1474044882705, 817.554432834095, 865.8787769712245, 888.1828717579842, 25695.87152064265, 27546.586801198, 27577.724222757515, 27940.52715916447, 28188.295292617437, 893.4683863101444, 940.1773448232797, 949.5726922884729, 978.188103873783, 1017.7201269650906, 14326.355314010894, 14513.709725805636, 14549.34527946245, 14559.19924404168, 14601.92699036498, 111672.0, 111828.0, 112493.43753281182, 113228.0, 366572.0, 47517.0, 47850.5214947853, 47940.280895785894, 47961.28058079132, 48010.519894801306, 1110.1396417776289, 1134.8070827959266, 1154.4112502623555, 1160.5067846165346, 1168.59099315239, 24032.71999880893, 25787.226383208534, 27110.864445677646, 27204.0, 27249.86375068112, 40073.79963100166, 45303.32045019393, 46738.29892551546, 46787.0, 50789.492105078476, 333637.0, 336252.0, 337348.0, 338492.0, 339146.0, 36964.63035369612, 37413.81293093517, 37440.438393423574, 37617.43573846449, 38183.42724859185, 40151.79924100361, 40458.39312410257, 41175.0, 41199.58800411958, 41584.584154158074, 34438.31123377568, 34515.654843451244, 34892.47661285134, 34894.476582851785, 35024.29951401009, 34377.0, 34506.482402763475, 34590.308193836485, 34753.30493390169, 34833.12917177091, 33957.49063764095, 34408.0, 34694.479582805776, 35152.47271290881, 35259.47110793392, 26279.60580591331, 28478.145655630364, 28553.571696424155, 28626.14121576356, 29073.418531628828, 24679.62980555329, 24775.628365574892, 24788.628170577096, 24856.875715621307, 24945.21457417172], "value": 16429.50972536932, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.64232555816386, 348.7645839058636, 365.26399305399616, 370.8720491430456, 387.9631435013674, 12245.938770306158, 13208.273544955024, 15522.146281954489, 15581.844181558181, 16129.83870161298, 14913.552593422215, 15046.924765376158, 15392.384304627802, 15394.769078463803, 15742.763858542132, 4837.685550439211, 4895.192293271606, 5134.435212126663, 5138.948610513903, 5140.691558506483, 4646.3495110684535, 5077.263796749469, 5078.8476345709505, 5081.695098294095, 5091.516305950929, 5065.265536497206, 5065.468125846788, 5070.366204224472, 5070.442251352349, 5071.213961835903, 4810.97594512027, 4896.094222568836, 4924.80300787968, 4927.926081108786, 4932.926006109911, 4356.75832387768, 4357.36818161368, 4359.237133501624, 4366.541513141106, 4370.519242883281, 19595.31416400419, 19768.505787355287, 19780.70328945067, 19907.900460497603, 20423.183072677075, 1864.8041955594604, 1889.0, 1890.1494327552518, 1978.5350442645968, 2001.35956493922, 11661.475233614423, 12775.0, 13098.607041788762, 13313.86686133136, 13388.196708197442, 1679.7060514410052, 1732.1079643983358, 1754.9385771497937, 1756.1219390304848, 1784.0990299898467, 39893.202135957115, 54653.726731366485, 61839.99999999955, 62243.0, 63473.0, 9293.67472138472, 9342.392744471588, 9584.37701549397, 9764.51177441125, 9852.211823054138, 12194.634160975185, 12195.634130975908, 12214.0, 12223.755524889453, 12226.266424014588, 6606.504512161607, 6719.0, 6787.0, 6894.620795856276, 6902.792916212522, 6247.375262473716, 6260.780872669526, 6501.349865013555, 6512.088307636935, 6557.180352455943, 5859.794907178229, 5917.378675239124, 5934.376890426443, 6028.156058151862, 6115.143879856823, 1680.2949496360495, 1711.7432385142079, 1748.4055421156868, 1749.7900251969845, 1750.6586215687819, 772.3319328780676, 827.8758186272107, 827.8840962265288, 833.9583020848934, 857.3012994409536, 15725.606859828367, 16342.754858676892, 16542.0, 16810.243539040774, 17320.220590073477, 803.8392321535716, 821.4208982667205, 842.8103676672699, 855.6021450025768, 872.6378552900602, 8914.0, 10083.64707235258, 10117.392956422638, 10205.438700871524, 10246.231532634933, 357264.0, 362113.0, 365225.0, 370811.0, 371224.0, 44488.43894513186, 45858.43635298043, 74606.0, 75154.74535763936, 77349.22650773532, 804.1154729797294, 831.4470876866936, 833.4124442268308, 833.8457385383723, 840.7225615546855, 14236.501722439665, 14493.20287384204, 15728.0, 15862.841371586137, 15997.920010399874, 35931.64068359283, 36060.27879442344, 36400.453993190655, 36788.26423471462, 37658.2468350626, 46102.769486153695, 49585.50414495809, 50414.0, 52352.47647523476, 53011.469885300656, 7325.560466372035, 7329.670164842488, 7388.445866560137, 7420.812669972778, 7756.806079848049, 9441.716748497556, 10664.626738064131, 11256.942689676029, 11315.496376503845, 11344.376059316817, 9783.951080244553, 9836.3606365586, 10107.64623238183, 10117.544710487899, 10127.797444051224, 9660.516974151124, 9726.173275271682, 9789.412635241908, 9792.314537982558, 10156.695299141038, 9569.3779904306, 9618.759531011781, 9811.313208075366, 9896.257780666334, 10034.598616055277, 7310.671019804228, 7345.706171753283, 7451.3666338361845, 7589.241075892367, 7935.523868567904, 8407.95796021016, 9729.85405218908, 9852.852207217042, 9897.455639939584, 10309.896901030894], "value": 7884.490139659987, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1302.4529697527034, 1337.0707358385923, 1364.7748121559944, 1610.5651474101985, 1634.3952737487125, 6505.0, 6749.325067493261, 6844.5893246405185, 7340.889886651697, 7343.192248852622, 7154.964225178866, 7426.443016773736, 7452.813679658011, 7615.162332143474, 7619.085709714842, 2076.4289820299464, 2095.549456866773, 2100.884451355175, 2106.3154474795674, 2106.6096376391506, 1827.7167039108892, 1891.4798430431604, 2037.449888530096, 2088.4152437317575, 2117.227212067592, 2052.887091209983, 2094.0, 2101.8843963582, 2102.8422868284865, 2108.114591871418, 2004.9498762530907, 2017.3040301096098, 2028.3712049264627, 2029.0970518119443, 2031.8069783370704, 2060.3509894383224, 2063.123172651632, 2063.226290141197, 2065.0500769645982, 2072.357569153567, 7329.19378868324, 7391.0, 7391.113066432009, 7395.186529481753, 7397.482176247665, 4158.771267580282, 4291.527931927485, 4309.676774241944, 4330.39374487572, 4333.133373325316, 2763.0429584372528, 2838.3471801485775, 2874.8131371460786, 2942.6321709786275, 2945.072302224792, 945.2626950978248, 946.2382781860599, 963.1187463470916, 963.9759006024835, 965.0253244223314, 10209.438480883548, 10235.334703244265, 10245.48772561369, 10256.74358141045, 10374.429406382646, 3931.5085614298214, 3968.1071758854027, 4038.7980600969836, 4077.571854955246, 4086.162336720965, 8494.83010339802, 8518.531480768494, 8527.275181609508, 8533.573321333908, 8533.829323413496, 4321.416608757841, 4323.0705398339505, 4324.718893271927, 4328.0, 4339.566043395698, 3730.757500762442, 3898.064464528493, 3916.6083391660604, 3917.216556688674, 3922.2743792398496, 3230.53157292196, 3318.0875259303402, 3384.1370450534955, 3418.7265018798435, 3438.793672379665, 939.8355287824603, 953.880764904387, 1025.2976710953021, 1043.280136705686, 1109.4619109731773, 582.8047604052605, 683.7333439958321, 755.0, 796.5658715999793, 799.3884678221049, 4662.347271382009, 4684.297355396649, 4744.4543877454535, 4822.228443449031, 4928.28539861718, 763.8968739220245, 769.805307971921, 871.4292138649195, 881.1628952495155, 884.6594061286322, 3340.4321265384456, 3415.743819213519, 3445.0, 3542.2915416916203, 3607.296577167427, 8990.100989901088, 9315.767105822408, 9331.673391431268, 9331.953340233254, 9391.718248452557, 9228.8615670765, 9300.53497325131, 9317.11487408695, 9322.25421966241, 9324.533773311307, 6515.4787616990525, 6687.699053542602, 6786.219584747817, 6976.476764242702, 7101.680424380916, 4880.072786170616, 4929.827456039022, 5036.463878517087, 5096.0827051131155, 5173.92239116406, 8210.917890821016, 8267.0, 8283.29591984688, 8349.666013359398, 8384.035835878953, 7988.400869934894, 8062.7581172564915, 8153.0, 8184.099749027483, 8403.411761176903, 6428.164338636135, 6582.539222254588, 6583.078369028436, 6588.308227636221, 6591.571547849375, 7103.25415831351, 7175.856482870209, 7184.425245980414, 7187.496875218893, 7226.566406015656, 6383.616982981036, 6446.613203207822, 6497.220333560003, 6523.543351965507, 6641.734330626914, 6378.043293506012, 6518.348165183444, 6543.770968016097, 6543.80368588924, 6549.672516374067, 5476.205950137288, 5517.034518959086, 5554.555635549227, 5571.415001424792, 5662.207290979349, 4406.074724307931, 4418.977905110454, 4452.532484089254, 4506.256467682927, 4518.457785065813, 4192.83228670862, 4217.7891105445215, 4245.808938597832, 4381.649468042485, 4432.711873728197], "value": 3907.3320909009826, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [274.8694370174167, 283.5250954650959, 287.04986494702536, 288.36415703374075, 292.57284364827353, 4685.0, 4846.7091974481555, 4853.490383509734, 4870.902581948359, 4886.242632391981, 4594.793234304456, 4711.363965864607, 4712.198926182548, 4722.834700785474, 4731.692439991398, 3546.166650837064, 3716.940671908507, 3728.962710372902, 3733.1227161617, 3735.8318875650525, 3656.39669454541, 3701.925961480769, 3739.8691045813403, 3753.4182201758636, 3757.1170774867883, 3709.517762690846, 3714.7213958953052, 3719.2189640175598, 3722.6463485968925, 3728.328900797855, 3739.6447337502896, 3741.27045226181, 3754.3992961126087, 3758.718096142773, 3762.849486020556, 3234.3531293741344, 3279.311344617633, 3286.96713032869, 3337.332533493311, 3339.714210029132, 4623.583877451012, 4645.210314246552, 4656.930146047812, 4668.859934201945, 4668.85993420198, 4204.957950420488, 4220.936685949713, 4223.535411104776, 4232.0, 4238.279492486285, 4851.223804191348, 4990.476000020019, 4995.500449954975, 5017.397912250517, 5017.799288028475, 3494.2836718472654, 3505.6669616386657, 3505.8597656093725, 3511.877084302063, 3521.894343169709, 5233.659812112201, 5283.55089817366, 5302.549283310923, 5337.919931201035, 5339.786408543692, 3484.8954531364097, 3555.715542756625, 3561.0, 3575.6960658344333, 3585.15748799032, 3611.2957973194975, 3614.3494171049465, 3623.221007483404, 3633.345997720383, 3633.691136253395, 4172.561881002451, 4180.352045432963, 4191.790410479525, 4203.159368126387, 4220.746755194698, 4787.832425865078, 4930.0, 5013.5989120870245, 5023.648344615842, 5025.648204625714, 1188.6849984754047, 1215.775081609905, 1249.375312343828, 1263.0779530942464, 1267.5436842736608, 826.2481142160605, 842.2588122452325, 860.875173099897, 865.8441480533564, 868.522312727997, 4365.978170109129, 4368.4321038264825, 4374.956250437519, 4395.802188901507, 4419.11617676466, 5103.770330335144, 5118.181091025418, 5120.769565369567, 5128.512791284897, 5138.409082955433, 4370.934435983463, 4381.298992161239, 4387.122575484852, 4393.802278897458, 4406.9559304407185, 2264.682944387787, 2415.565198264294, 2430.756924307555, 2437.927311982722, 2440.2313271319476, 4347.304431290978, 4348.695591308641, 4356.390105385185, 4358.869233922924, 4401.007315025749, 4637.582617564435, 4648.6745927785405, 4650.534946505322, 4689.413823272091, 4689.60138388234, 4353.194658988034, 4531.297648864432, 4826.597248939489, 4939.802407903716, 4950.0, 5217.556507696889, 5220.269162317354, 5231.346081739783, 5231.712255825966, 5250.18622113573, 5143.665661731976, 5154.845354639367, 5187.351581052369, 5190.97404512975, 5220.895582088413, 4669.929951050805, 4881.536254055859, 4922.532359425849, 4928.359313289249, 4942.728149951788, 3618.620044895353, 3623.2210074832983, 3638.235970446236, 3644.4351125575577, 3668.908277293089, 4960.30555722192, 5226.764795584132, 5250.527452529291, 5274.736263186902, 5299.6290259681455, 4756.928646070381, 5043.596512278936, 5049.81329387601, 5052.823151189691, 5134.794608215779, 5017.799288028438, 5049.84850454487, 5052.8989420210655, 5059.0, 5068.873278167928, 4819.975900120477, 4953.306537084739, 4992.650514464098, 4993.825216117419, 5012.5964729875695, 5083.822066227664, 5094.2867998479505, 5105.974470127774, 5107.978404319077, 5111.4888511150075, 4941.950580494149, 4951.861071953399, 4967.180415231591, 4984.700917944935, 5031.94329190874], "value": 3729.243017773195, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [614.4101662404092, 637.5282291104584, 638.9137466442029, 647.6502688548185, 749.827539665877, 12337.321447320393, 13838.723225535483, 13868.861311386883, 13912.373943172557, 13916.304184790757, 12890.162139460928, 12998.350082495861, 13004.284764337981, 13022.54421095262, 13023.0, 621.0932039222718, 635.272612858277, 736.5764685305944, 753.6457864803533, 761.1665226576889, 747.6822350501016, 749.4491548711693, 750.5121670913895, 751.3087959077634, 763.0919206144698, 777.2926636760549, 777.8288776469168, 777.9688812447496, 778.6457161991281, 780.4185881518276, 648.1347401219355, 666.3236814633151, 776.0454640791829, 784.1609477858693, 787.1027029186731, 580.6312991250544, 581.9553900748167, 582.2576215325452, 582.5019608234983, 583.833607421887, 12100.334481603508, 12116.878831211752, 12118.0, 12119.212251203731, 12121.878781212163, 12262.570810021607, 12578.748425031448, 12952.417141228667, 13016.60950171487, 13431.462741490328, 11030.558777648885, 11231.550737970472, 11308.547658093667, 11336.773264534746, 11507.136964727679, 3217.6621454747146, 3370.4607262837826, 3422.5892892852767, 3454.516367708523, 4085.20338533986, 58061.70969145127, 59115.0, 60344.39655603431, 60672.69663651698, 60927.0, 9666.226701863974, 9700.90299097014, 9849.310548261554, 9874.111329980336, 9884.752881178028, 17533.123343832758, 17616.29534818593, 17646.2059207336, 17691.823081769016, 17880.0, 6331.430171284606, 6352.269489008823, 6406.839829004219, 6434.485241180788, 6532.477401807844, 3619.49327094207, 3664.0656632558525, 3687.6865466435115, 3700.6114357992024, 3708.2583483303447, 2797.8321300722023, 2885.9855700721364, 2893.1754449981654, 2897.0294951191167, 2902.085842959461, 481.14836738972525, 482.6959015820081, 484.6849547793962, 487.36885732975884, 490.76443307212026, 488.5285699300121, 536.769189248619, 548.7640314664652, 567.5261156933924, 579.1341943794055, 8481.745547633582, 8518.361122915807, 8610.4760958156, 8778.561071946377, 8846.734597962071, 493.1197811905803, 539.9946000540023, 578.5978744772343, 579.9072148456227, 598.437468779346, 3931.8034098295543, 4108.157827645326, 4121.773302468393, 4277.101808620225, 4452.799624016927, 54289.0, 55439.168412473846, 55456.72271638697, 55540.0, 56325.0, 83710.58144709238, 84350.57824710837, 84820.57589712011, 86624.56687716521, 86945.1305486937, 73300.26699733041, 74210.25789742141, 75301.62349188219, 76036.0, 78825.60587197027, 7571.0, 7636.770896873103, 7752.7674169775, 7844.84310313802, 8068.919310807051, 42555.3616695756, 42775.5722442784, 44159.55840441683, 44195.674129776155, 44671.55328446674, 47978.520214797405, 48059.75970120127, 50703.74648126736, 57553.71223143858, 58703.70648146732, 11526.642141895938, 11543.249688770204, 11671.0, 11682.649520514058, 11722.0, 13069.673258168621, 13072.084954053505, 13210.933945330597, 13235.0, 13354.065215435216, 12040.518379264731, 12127.939360303495, 12221.38893055326, 12868.935655321664, 12891.41988610496, 12491.625251242478, 12544.121911466475, 13053.673658158623, 13282.80075798883, 13358.86641133615, 11631.825522616999, 11805.350705711267, 11968.940155299168, 12456.190347627375, 12599.370031498573, 10197.975936241412, 10204.591816327264, 10491.790164196826, 10757.193210509087, 10797.946010269898, 10070.093691567794, 10307.94846025765, 10530.894691052992, 10808.0, 10902.454877255946], "value": 6389.797786486992, "unit": "score"}], "name": "dromaeo_css", "value": 6171.434359910411, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 115.0, 117.0, 115.0, 115.0, 114.0, 115.0, 115.0, 114.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 137.0, 126.0, 177.0, 130.0, 126.0, 126.0, 128.0, 161.0, 132.0], "value": 139.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 165.0, 165.0, 164.0, 163.0, 162.0, 162.0, 164.0, 161.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 76.0, 103.0, 78.0, 76.0, 77.0, 76.0, 104.0, 76.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 126.0, 85.0, 83.0, 84.0, 109.0, 83.0, 83.0, 115.0], "value": 93.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 118.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 145.0, 145.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 63.0, 69.0, 65.0, 65.0, 66.0, 65.0, 66.0, 66.0], "value": 65.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 69.0, 67.0, 67.0, 66.0, 66.0, 66.0], "value": 66.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 88.0, 89.0, 83.0, 85.0, 84.0, 83.0, 83.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 149.0, 140.0, 140.0, 137.0, 139.0, 142.0, 139.0, 182.0, 138.0], "value": 146.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 180.0, 177.0, 180.0, 174.0, 178.0, 174.0, 177.0, 177.0, 177.0], "value": 177.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 73.0, 70.0, 70.0, 70.0, 71.0, 71.0, 69.0, 69.0], "value": 70.5, "unit": "score"}], "name": "kraken", "value": 1562.1, "alertThreshold": 2.0}]} 21:24:27 INFO - Return code: 0 21:24:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:24:27 INFO - # TBPL SUCCESS # 21:24:27 INFO - Running post-action listener: _resource_record_post_action 21:24:27 INFO - [mozharness: 2016-10-07 04:24:27.400320Z] Finished run-tests step (success) 21:24:27 INFO - Running post-run listener: _resource_record_post_run 21:24:27 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 398286848; Read time: 12; Write time: 357276 21:24:27 INFO - TinderboxPrint: CPU usage
13.0% 21:24:27 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 21:24:27 INFO - TinderboxPrint: I/O write bytes / time
398,286,848 / 357,276 21:24:27 INFO - TinderboxPrint: CPU idle
8,353.8 (87.0%) 21:24:27 INFO - TinderboxPrint: CPU user
1,203.9 (12.5%) 21:24:27 INFO - TinderboxPrint: Swap in / out
0 / 0 21:24:27 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 106561536; Read time: 0; Write time: 77712 21:24:27 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 291725312; Read time: 0; Write time: 279564 21:24:28 INFO - Running post-run listener: _upload_blobber_files 21:24:28 INFO - Blob upload gear active. 21:24:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:24:28 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 21:24:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:24:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:24:28 INFO - (blobuploader) - INFO - Open directory for files ... 21:24:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:24:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:24:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:24:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:24:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:24:29 INFO - (blobuploader) - INFO - Done attempting. 21:24:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:24:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:24:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:24:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:24:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:24:29 INFO - (blobuploader) - INFO - Done attempting. 21:24:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:24:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:24:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:24:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:24:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:24:33 INFO - (blobuploader) - INFO - Done attempting. 21:24:33 INFO - (blobuploader) - INFO - Iteration through files over. 21:24:33 INFO - Return code: 0 21:24:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:24:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:24:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/07dcf4af8cdc83d170b4f193bc28f3eaf894be4d154cc3468b6e87c680122aec3a3a6756c01496a8e94e12e9d4cdf8275e95f4a2acdce2ff39dbc138800b74a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a97c44c35589f68cc174c0ee9c44cf1ee8e10f96de478a3e61b8dd18301918ba4d450668f08dfca110f66990b6b7bba437521727084ee13d42df0724c566bd7d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/878dc9831f16ea44a909706e93c3abf4ec04627aec27248466b1899f7ac32dcced9bdbd63fdc66db10b9d3dcfa922d7ed156f93c564ae69aafcd5ed4077289d4"} 21:24:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:24:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:24:33 INFO - Contents: 21:24:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/07dcf4af8cdc83d170b4f193bc28f3eaf894be4d154cc3468b6e87c680122aec3a3a6756c01496a8e94e12e9d4cdf8275e95f4a2acdce2ff39dbc138800b74a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a97c44c35589f68cc174c0ee9c44cf1ee8e10f96de478a3e61b8dd18301918ba4d450668f08dfca110f66990b6b7bba437521727084ee13d42df0724c566bd7d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/878dc9831f16ea44a909706e93c3abf4ec04627aec27248466b1899f7ac32dcced9bdbd63fdc66db10b9d3dcfa922d7ed156f93c564ae69aafcd5ed4077289d4"} 21:24:33 INFO - Running post-run listener: copy_logs_to_upload_dir 21:24:33 INFO - Copying logs to upload dir... 21:24:33 INFO - mkdir: /builds/slave/test/build/upload/logs 21:24:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.455500 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-10-06 21:24:33.071391) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 21:24:33.075105) ========= 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=17051fcd5208b27b50bedfeb000001dd-1475813020.494721-488689387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/07dcf4af8cdc83d170b4f193bc28f3eaf894be4d154cc3468b6e87c680122aec3a3a6756c01496a8e94e12e9d4cdf8275e95f4a2acdce2ff39dbc138800b74a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a97c44c35589f68cc174c0ee9c44cf1ee8e10f96de478a3e61b8dd18301918ba4d450668f08dfca110f66990b6b7bba437521727084ee13d42df0724c566bd7d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/878dc9831f16ea44a909706e93c3abf4ec04627aec27248466b1899f7ac32dcced9bdbd63fdc66db10b9d3dcfa922d7ed156f93c564ae69aafcd5ed4077289d4"} build_url:https://queue.taskcluster.net/v1/task/CI7_Og0tR5K3Of0nnUOu3w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011284 build_url: 'https://queue.taskcluster.net/v1/task/CI7_Og0tR5K3Of0nnUOu3w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/07dcf4af8cdc83d170b4f193bc28f3eaf894be4d154cc3468b6e87c680122aec3a3a6756c01496a8e94e12e9d4cdf8275e95f4a2acdce2ff39dbc138800b74a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a97c44c35589f68cc174c0ee9c44cf1ee8e10f96de478a3e61b8dd18301918ba4d450668f08dfca110f66990b6b7bba437521727084ee13d42df0724c566bd7d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/878dc9831f16ea44a909706e93c3abf4ec04627aec27248466b1899f7ac32dcced9bdbd63fdc66db10b9d3dcfa922d7ed156f93c564ae69aafcd5ed4077289d4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 21:24:33.100491) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:24:33.100852) ========= 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=17051fcd5208b27b50bedfeb000001dd-1475813020.494721-488689387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004490 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:24:33.186867) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 21:24:33.187228) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 21:24:33.187577) ========= ========= Total master_lag: 0.17 =========