builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-061 starttime: 1476043003.51 results: success (0) buildid: 20161009121217 builduid: 2b12aab6a0564609b3ac207483f364ed revision: d72cf6ecebaf707c159f6697d9f5f6f6a6feb7e1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-09 12:56:43.512708) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-09 12:56:43.513353) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-09 12:56:43.513803) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-09 12:56:43.569488) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-09 12:56:43.570244) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1476042686.211614-1908415340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-09 12:56:45-- 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% 46.6M=0s 2016-10-09 12:56:45 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104145 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-09 12:56:43.690281) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-09 12:56:43.690574) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1476042686.211614-1908415340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017847 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-09 12:56:43.743017) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-09 12:56:43.743357) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d72cf6ecebaf707c159f6697d9f5f6f6a6feb7e1 --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 d72cf6ecebaf707c159f6697d9f5f6f6a6feb7e1 --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=516f8d7ca085b4d087ab0a71000001a4-1476042686.211614-1908415340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-09 12:56:45,770 truncating revision to first 12 chars 2016-10-09 12:56:45,770 Setting DEBUG logging. 2016-10-09 12:56:45,770 attempt 1/10 2016-10-09 12:56:45,770 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d72cf6ecebaf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-09 12:56:46,229 unpacking tar archive at: fx-team-d72cf6ecebaf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.836180 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-09 12:56:44.593934) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-09 12:56:44.594228) ========= script_repo_revision: d72cf6ecebaf707c159f6697d9f5f6f6a6feb7e1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-09 12:56:44.594645) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-09 12:56:44.594905) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-09 12:56:44.605391) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-10-09 12:56:44.605783) ========= /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=516f8d7ca085b4d087ab0a71000001a4-1476042686.211614-1908415340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:56:46 INFO - MultiFileLogger online at 20161009 12:56:46 in /builds/slave/test 12:56:46 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 12:56:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:56:46 INFO - {'append_to_log': False, 12:56:46 INFO - 'base_work_dir': '/builds/slave/test', 12:56:46 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:56:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:56:46 INFO - 'branch': 'Fx-Team-Non-PGO', 12:56:46 INFO - 'buildbot_json_path': 'buildprops.json', 12:56:46 INFO - 'config_files': ('talos/linux_config.py',), 12:56:46 INFO - 'default_actions': ('clobber', 12:56:46 INFO - 'read-buildbot-config', 12:56:46 INFO - 'download-and-extract', 12:56:46 INFO - 'populate-webroot', 12:56:46 INFO - 'create-virtualenv', 12:56:46 INFO - 'install', 12:56:46 INFO - 'run-tests'), 12:56:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:56:46 INFO - 'download_minidump_stackwalk': True, 12:56:46 INFO - 'download_symbols': 'ondemand', 12:56:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:56:46 INFO - 'tooltool.py': '/tools/tooltool.py', 12:56:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:56:46 INFO - '/tools/misc-python/virtualenv.py')}, 12:56:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:56:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:56:46 INFO - 'installer_path': 'installer.exe', 12:56:46 INFO - 'log_level': 'info', 12:56:46 INFO - 'log_name': 'talos', 12:56:46 INFO - 'log_to_console': True, 12:56:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:56:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:56:46 INFO - 'opt_config_files': (), 12:56:46 INFO - 'pip_index': False, 12:56:46 INFO - 'sps_profile': False, 12:56:46 INFO - 'sps_profile_interval': 0, 12:56:46 INFO - 'suite': 'dromaeojs', 12:56:46 INFO - 'system_bits': '32', 12:56:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:56:46 INFO - 'title': 'talos-linux64-ix-061', 12:56:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:56:46 INFO - 'use_talos_json': True, 12:56:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:56:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:56:46 INFO - 'work_dir': 'build'} 12:56:46 INFO - [mozharness: 2016-10-09 19:56:46.732502Z] Running clobber step. 12:56:46 INFO - Running pre-action listener: _resource_record_pre_action 12:56:46 INFO - Running main action method: clobber 12:56:46 INFO - rmtree: /builds/slave/test/build 12:56:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:56:47 INFO - Running post-action listener: _resource_record_post_action 12:56:47 INFO - [mozharness: 2016-10-09 19:56:47.199022Z] Finished clobber step (success) 12:56:47 INFO - [mozharness: 2016-10-09 19:56:47.199123Z] Running read-buildbot-config step. 12:56:47 INFO - Running pre-action listener: _resource_record_pre_action 12:56:47 INFO - Running main action method: read_buildbot_config 12:56:47 INFO - Using buildbot properties: 12:56:47 INFO - { 12:56:47 INFO - "project": "", 12:56:47 INFO - "product": "firefox", 12:56:47 INFO - "script_repo_revision": "production", 12:56:47 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:56:47 INFO - "repository": "", 12:56:47 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 12:56:47 INFO - "buildid": "20161009121217", 12:56:47 INFO - "pgo_build": "False", 12:56:47 INFO - "basedir": "/builds/slave/test", 12:56:47 INFO - "buildnumber": 3376, 12:56:47 INFO - "slavename": "talos-linux64-ix-061", 12:56:47 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:56:47 INFO - "platform": "ubuntu64_hw", 12:56:47 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:56:47 INFO - "branch": "fx-team", 12:56:47 INFO - "repo_path": "integration/fx-team", 12:56:47 INFO - "revision": "d72cf6ecebaf707c159f6697d9f5f6f6a6feb7e1", 12:56:47 INFO - "stage_platform": "linux64", 12:56:47 INFO - "builduid": "2b12aab6a0564609b3ac207483f364ed", 12:56:47 INFO - "slavebuilddir": "test" 12:56:47 INFO - } 12:56:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/S9Uz76SgQEack33oXFvg3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 12:56:47 INFO - Running post-action listener: _resource_record_post_action 12:56:47 INFO - [mozharness: 2016-10-09 19:56:47.201572Z] Finished read-buildbot-config step (success) 12:56:47 INFO - [mozharness: 2016-10-09 19:56:47.201661Z] Running download-and-extract step. 12:56:47 INFO - Running pre-action listener: _resource_record_pre_action 12:56:47 INFO - Running main action method: download_and_extract 12:56:47 INFO - mkdir: /builds/slave/test/build/tests 12:56:47 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')]} 12:56:47 INFO - trying https://queue.taskcluster.net/v1/task/S9Uz76SgQEack33oXFvg3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:56:47 INFO - Downloading https://queue.taskcluster.net/v1/task/S9Uz76SgQEack33oXFvg3g/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 12:56:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S9Uz76SgQEack33oXFvg3g/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 12:56:47 INFO - Downloaded 1361 bytes. 12:56:47 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:56:47 INFO - Using the following test package requirements: 12:56:47 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:56:47 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:56:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:56:47 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:56:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:56:47 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:56:47 INFO - u'jsshell-linux-x86_64.zip'], 12:56:47 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:56:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:56:47 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:56:47 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:56:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:56:47 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:56:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:56:47 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:56:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:56:47 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:56:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:56:47 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:56:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S9Uz76SgQEack33oXFvg3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:56:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S9Uz76SgQEack33oXFvg3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:56:47 INFO - Fetch https://queue.taskcluster.net/v1/task/S9Uz76SgQEack33oXFvg3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:56:48 INFO - Http code: 200 12:56:48 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 12:56:48 INFO - x-amz-cf-id: YpxGdY7oIzj1_dSTCyBEH2W_YUt6Y9RKfUTnkI047zzqOqDI5JPjrg== 12:56:48 INFO - x-amz-version-id: U.xHzuE20q3Q9.slioEVVlY5MTs697Tc 12:56:49 INFO - Expected file size: 20516868 12:56:49 INFO - Obtained file size: 20516868 12:56:53 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 12:56:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S9Uz76SgQEack33oXFvg3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:56:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S9Uz76SgQEack33oXFvg3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:56:53 INFO - Fetch https://queue.taskcluster.net/v1/task/S9Uz76SgQEack33oXFvg3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:56:54 INFO - Http code: 200 12:56:54 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 12:56:54 INFO - x-amz-cf-id: M6kJ24Tsia5ajZEpmw751q5kbuUZfgTZY7vCSWbCORCf9NWGYyeV9Q== 12:56:54 INFO - x-amz-version-id: U.xHzuE20q3Q9.slioEVVlY5MTs697Tc 12:56:54 INFO - Expected file size: 20516868 12:56:54 INFO - Obtained file size: 20516868 12:56:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S9Uz76SgQEack33oXFvg3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 12:56:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S9Uz76SgQEack33oXFvg3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:56:58 INFO - Fetch https://queue.taskcluster.net/v1/task/S9Uz76SgQEack33oXFvg3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 12:56:59 INFO - Http code: 200 12:56:59 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 12:56:59 INFO - x-amz-cf-id: CbG77vNh-XT8DOYYkg9715qEJqyiMpp7_eObHcaJb7GIpLfy8gkczA== 12:56:59 INFO - x-amz-version-id: aSRVxx4fkHBex878IHpnDtgNFn3bQOFL 12:57:00 INFO - Expected file size: 14409006 12:57:00 INFO - Obtained file size: 14409006 12:57:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:57:00 INFO - trying https://queue.taskcluster.net/v1/task/S9Uz76SgQEack33oXFvg3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:57:00 INFO - Downloading https://queue.taskcluster.net/v1/task/S9Uz76SgQEack33oXFvg3g/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 12:57:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S9Uz76SgQEack33oXFvg3g/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 12:57:02 INFO - Downloaded 55825797 bytes. 12:57:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S9Uz76SgQEack33oXFvg3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:57:02 INFO - mkdir: /builds/slave/test/properties 12:57:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:57:02 INFO - Writing to file /builds/slave/test/properties/build_url 12:57:02 INFO - Contents: 12:57:02 INFO - build_url:https://queue.taskcluster.net/v1/task/S9Uz76SgQEack33oXFvg3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:57:03 INFO - Running post-action listener: _resource_record_post_action 12:57:03 INFO - Running post-action listener: set_extra_try_arguments 12:57:03 INFO - [mozharness: 2016-10-09 19:57:03.286098Z] Finished download-and-extract step (success) 12:57:03 INFO - [mozharness: 2016-10-09 19:57:03.286325Z] Running populate-webroot step. 12:57:03 INFO - Running pre-action listener: _resource_record_pre_action 12:57:03 INFO - Running main action method: populate_webroot 12:57:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:57:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:57:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:57:03 INFO - '--tppagecycles', 12:57:03 INFO - '7'], 12:57:03 INFO - 'tests': ['tsvgm']}}, 12:57:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:57:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:57:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:57:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:57:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:57:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:57:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:03 INFO - 'talos_options': ['--disable-e10s'], 12:57:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:57:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:57:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:03 INFO - 'talos_options': ['--disable-e10s'], 12:57:03 INFO - 'tests': ['damp', 'tps']}, 12:57:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:03 INFO - 'tests': ['damp', 'tps']}, 12:57:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:57:03 INFO - 'tests': ['dromaeo_dom']}, 12:57:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:57:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:57:03 INFO - 'tests': ['basic_compositor_video']}, 12:57:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:57:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:57:03 INFO - 'tests': ['a11yr', 12:57:03 INFO - 'ts_paint', 12:57:03 INFO - 'tpaint', 12:57:03 INFO - 'sessionrestore', 12:57:03 INFO - 'sessionrestore_no_auto_restore', 12:57:03 INFO - 'tabpaint']}, 12:57:03 INFO - 'other-e10s': {'tests': ['a11yr', 12:57:03 INFO - 'ts_paint', 12:57:03 INFO - 'tpaint', 12:57:03 INFO - 'sessionrestore', 12:57:03 INFO - 'sessionrestore_no_auto_restore', 12:57:03 INFO - 'tabpaint']}, 12:57:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:57:03 INFO - 'ts_paint', 12:57:03 INFO - 'tpaint', 12:57:03 INFO - 'sessionrestore', 12:57:03 INFO - 'sessionrestore_no_auto_restore', 12:57:03 INFO - 'tabpaint']}, 12:57:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:57:03 INFO - 'ts_paint', 12:57:03 INFO - 'tpaint', 12:57:03 INFO - 'sessionrestore', 12:57:03 INFO - 'sessionrestore_no_auto_restore', 12:57:03 INFO - 'tabpaint']}, 12:57:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:57:03 INFO - 'tests': ['a11yr', 12:57:03 INFO - 'ts_paint', 12:57:03 INFO - 'tpaint', 12:57:03 INFO - 'sessionrestore', 12:57:03 INFO - 'sessionrestore_no_auto_restore', 12:57:03 INFO - 'tabpaint']}, 12:57:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:57:03 INFO - 'tests': ['a11yr', 12:57:03 INFO - 'ts_paint', 12:57:03 INFO - 'tpaint', 12:57:03 INFO - 'sessionrestore', 12:57:03 INFO - 'sessionrestore_no_auto_restore', 12:57:03 INFO - 'tabpaint']}, 12:57:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:57:03 INFO - 'tests': ['tsvgx', 12:57:03 INFO - 'tsvgr_opacity', 12:57:03 INFO - 'tart', 12:57:03 INFO - 'tscrollx', 12:57:03 INFO - 'cart']}, 12:57:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:57:03 INFO - 'tsvgr_opacity', 12:57:03 INFO - 'tart', 12:57:03 INFO - 'tscrollx', 12:57:03 INFO - 'cart']}, 12:57:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:03 INFO - 'talos_options': ['--disable-e10s'], 12:57:03 INFO - 'tests': ['tp5o']}, 12:57:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:03 INFO - 'tests': ['tp5o']}, 12:57:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:03 INFO - 'talos_options': ['--disable-e10s', 12:57:03 INFO - '--xperf_path', 12:57:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:57:03 INFO - 'tests': ['tp5n']}, 12:57:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:03 INFO - 'talos_options': ['--xperf_path', 12:57:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:57:03 INFO - 'tests': ['tp5n']}}, 12:57:03 INFO - 'talos.zip': {'path': '', 12:57:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:57:03 INFO - Running post-action listener: _resource_record_post_action 12:57:03 INFO - [mozharness: 2016-10-09 19:57:03.303894Z] Finished populate-webroot step (success) 12:57:03 INFO - [mozharness: 2016-10-09 19:57:03.303981Z] Running create-virtualenv step. 12:57:03 INFO - Running pre-action listener: _resource_record_pre_action 12:57:03 INFO - Running main action method: create_virtualenv 12:57:03 INFO - Creating virtualenv /builds/slave/test/build/venv 12:57:03 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 12:57:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:57:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:57:03 INFO - Using real prefix '/usr' 12:57:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:57:03 INFO - Installing distribute.............................................................................................................................................................................................done. 12:57:05 INFO - Installing pip.................done. 12:57:05 INFO - Return code: 0 12:57:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:57:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:57:06 INFO - Reading from file tmpfile_stdout 12:57:06 INFO - Output received: 12:57:06 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) 12:57:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:57: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')]} 12:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57: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')]} 12:57:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9760fcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1377f60>, '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 0x1378d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13791d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1476042686.211614-1908415340', '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 12:57: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', 'pip>=1.5'] in /builds/slave/test/build 12:57: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 pip>=1.5 12:57:06 INFO - Using env: {'DISPLAY': ':0', 12:57:06 INFO - 'HOME': '/home/cltbld', 12:57:06 INFO - 'LANG': 'en_US.UTF-8', 12:57:06 INFO - 'LANGUAGE': 'en_US:en', 12:57:06 INFO - 'LOGNAME': 'cltbld', 12:57:06 INFO - 'MAIL': '/var/mail/cltbld', 12:57:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:06 INFO - 'MOZ_NO_REMOTE': '1', 12:57:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:06 INFO - 'NO_EM_RESTART': '1', 12:57:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:06 INFO - 'PWD': '/builds/slave/test', 12:57:06 INFO - 'SHELL': '/bin/bash', 12:57:06 INFO - 'SHLVL': '1', 12:57:06 INFO - 'TERM': 'linux', 12:57:06 INFO - 'TMOUT': '86400', 12:57:06 INFO - 'USER': 'cltbld', 12:57:06 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1476042686.211614-1908415340', 12:57:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:06 INFO - '_': '/tools/buildbot/bin/python'} 12:57:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:06 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 12:57:06 INFO - Cleaning up... 12:57:06 INFO - Return code: 0 12:57:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:57: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')]} 12:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57: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')]} 12:57:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57: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', '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 0x7f9760fcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1377f60>, '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 0x1378d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13791d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1476042686.211614-1908415340', '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 12:57: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', 'psutil>=3.1.1'] in /builds/slave/test/build 12:57: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 psutil>=3.1.1 12:57:06 INFO - Using env: {'DISPLAY': ':0', 12:57:06 INFO - 'HOME': '/home/cltbld', 12:57:06 INFO - 'LANG': 'en_US.UTF-8', 12:57:06 INFO - 'LANGUAGE': 'en_US:en', 12:57:06 INFO - 'LOGNAME': 'cltbld', 12:57:06 INFO - 'MAIL': '/var/mail/cltbld', 12:57:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:06 INFO - 'MOZ_NO_REMOTE': '1', 12:57:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:06 INFO - 'NO_EM_RESTART': '1', 12:57:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:06 INFO - 'PWD': '/builds/slave/test', 12:57:06 INFO - 'SHELL': '/bin/bash', 12:57:06 INFO - 'SHLVL': '1', 12:57:06 INFO - 'TERM': 'linux', 12:57:06 INFO - 'TMOUT': '86400', 12:57:06 INFO - 'USER': 'cltbld', 12:57:06 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1476042686.211614-1908415340', 12:57:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:06 INFO - '_': '/tools/buildbot/bin/python'} 12:57:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:06 INFO - Downloading/unpacking psutil>=3.1.1 12:57: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 12:57: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 12:57: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 12:57: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 12:57: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 12:57: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 12:57:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:57:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:57:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:57:08 INFO - Installing collected packages: psutil 12:57:08 INFO - Running setup.py install for psutil 12:57:08 INFO - building 'psutil._psutil_linux' extension 12:57:08 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 12:57:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:57:08 INFO - building 'psutil._psutil_posix' extension 12:57:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 12:57:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 12:57:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:57:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:57:09 INFO - Successfully installed psutil 12:57:09 INFO - Cleaning up... 12:57:09 INFO - Return code: 0 12:57:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:57:09 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')]} 12:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:09 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')]} 12:57:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:09 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 0x7f9760fcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1377f60>, '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 0x1378d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13791d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1476042686.211614-1908415340', '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 12:57:09 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 12:57:09 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 12:57:09 INFO - Using env: {'DISPLAY': ':0', 12:57:09 INFO - 'HOME': '/home/cltbld', 12:57:09 INFO - 'LANG': 'en_US.UTF-8', 12:57:09 INFO - 'LANGUAGE': 'en_US:en', 12:57:09 INFO - 'LOGNAME': 'cltbld', 12:57:09 INFO - 'MAIL': '/var/mail/cltbld', 12:57:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:09 INFO - 'MOZ_NO_REMOTE': '1', 12:57:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:09 INFO - 'NO_EM_RESTART': '1', 12:57:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:09 INFO - 'PWD': '/builds/slave/test', 12:57:09 INFO - 'SHELL': '/bin/bash', 12:57:09 INFO - 'SHLVL': '1', 12:57:09 INFO - 'TERM': 'linux', 12:57:09 INFO - 'TMOUT': '86400', 12:57:09 INFO - 'USER': 'cltbld', 12:57:09 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1476042686.211614-1908415340', 12:57:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:09 INFO - '_': '/tools/buildbot/bin/python'} 12:57:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:57: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 12:57: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 12:57: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 12:57: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 12:57: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 12:57: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 12:57:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:57:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:57:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:57:11 INFO - Installing collected packages: mozsystemmonitor 12:57:11 INFO - Running setup.py install for mozsystemmonitor 12:57:11 INFO - Successfully installed mozsystemmonitor 12:57:11 INFO - Cleaning up... 12:57:11 INFO - Return code: 0 12:57:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:57: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')]} 12:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57: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')]} 12:57:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57: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', '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 0x7f9760fcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1377f60>, '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 0x1378d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13791d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1476042686.211614-1908415340', '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 12:57: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:57: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 jsonschema==2.5.1 12:57:11 INFO - Using env: {'DISPLAY': ':0', 12:57:11 INFO - 'HOME': '/home/cltbld', 12:57:11 INFO - 'LANG': 'en_US.UTF-8', 12:57:11 INFO - 'LANGUAGE': 'en_US:en', 12:57:11 INFO - 'LOGNAME': 'cltbld', 12:57:11 INFO - 'MAIL': '/var/mail/cltbld', 12:57:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:11 INFO - 'MOZ_NO_REMOTE': '1', 12:57:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:11 INFO - 'NO_EM_RESTART': '1', 12:57:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:11 INFO - 'PWD': '/builds/slave/test', 12:57:11 INFO - 'SHELL': '/bin/bash', 12:57:11 INFO - 'SHLVL': '1', 12:57:11 INFO - 'TERM': 'linux', 12:57:11 INFO - 'TMOUT': '86400', 12:57:11 INFO - 'USER': 'cltbld', 12:57:11 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1476042686.211614-1908415340', 12:57:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:11 INFO - '_': '/tools/buildbot/bin/python'} 12:57:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:11 INFO - Downloading/unpacking jsonschema==2.5.1 12:57: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 12:57: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 12:57: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 12:57: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 12:57: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 12:57: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 12:57:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:57:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:57: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 12:57: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 12:57: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 12:57: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 12:57: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 12:57: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 12:57:13 INFO - Downloading functools32-3.2.3-2.tar.gz 12:57:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:57:13 INFO - warning: no files found matching '*.txt' 12:57:13 INFO - no previously-included directories found matching 'build' 12:57:13 INFO - no previously-included directories found matching 'dist' 12:57:13 INFO - no previously-included directories found matching '.git*' 12:57:13 INFO - Installing collected packages: jsonschema, functools32 12:57:13 INFO - Running setup.py install for functools32 12:57:13 INFO - warning: no files found matching '*.txt' 12:57:13 INFO - no previously-included directories found matching 'build' 12:57:13 INFO - no previously-included directories found matching 'dist' 12:57:13 INFO - no previously-included directories found matching '.git*' 12:57:13 INFO - Successfully installed jsonschema functools32 12:57:13 INFO - Cleaning up... 12:57:13 INFO - Return code: 0 12:57:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:57:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:14 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')]} 12:57:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:14 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 0x7f9760fcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1377f60>, '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 0x1378d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13791d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1476042686.211614-1908415340', '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 12:57:14 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 12:57:14 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 12:57:14 INFO - Using env: {'DISPLAY': ':0', 12:57:14 INFO - 'HOME': '/home/cltbld', 12:57:14 INFO - 'LANG': 'en_US.UTF-8', 12:57:14 INFO - 'LANGUAGE': 'en_US:en', 12:57:14 INFO - 'LOGNAME': 'cltbld', 12:57:14 INFO - 'MAIL': '/var/mail/cltbld', 12:57:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:14 INFO - 'MOZ_NO_REMOTE': '1', 12:57:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:14 INFO - 'NO_EM_RESTART': '1', 12:57:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:14 INFO - 'PWD': '/builds/slave/test', 12:57:14 INFO - 'SHELL': '/bin/bash', 12:57:14 INFO - 'SHLVL': '1', 12:57:14 INFO - 'TERM': 'linux', 12:57:14 INFO - 'TMOUT': '86400', 12:57:14 INFO - 'USER': 'cltbld', 12:57:14 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1476042686.211614-1908415340', 12:57:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:14 INFO - '_': '/tools/buildbot/bin/python'} 12:57:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:57:14 INFO - Cleaning up... 12:57:14 INFO - Return code: 0 12:57:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:57:14 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')]} 12:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:14 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')]} 12:57:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:14 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 0x7f9760fcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1377f60>, '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 0x1378d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13791d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1476042686.211614-1908415340', '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 12:57:14 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 12:57:14 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 12:57:14 INFO - Using env: {'DISPLAY': ':0', 12:57:14 INFO - 'HOME': '/home/cltbld', 12:57:14 INFO - 'LANG': 'en_US.UTF-8', 12:57:14 INFO - 'LANGUAGE': 'en_US:en', 12:57:14 INFO - 'LOGNAME': 'cltbld', 12:57:14 INFO - 'MAIL': '/var/mail/cltbld', 12:57:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:14 INFO - 'MOZ_NO_REMOTE': '1', 12:57:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:14 INFO - 'NO_EM_RESTART': '1', 12:57:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:14 INFO - 'PWD': '/builds/slave/test', 12:57:14 INFO - 'SHELL': '/bin/bash', 12:57:14 INFO - 'SHLVL': '1', 12:57:14 INFO - 'TERM': 'linux', 12:57:14 INFO - 'TMOUT': '86400', 12:57:14 INFO - 'USER': 'cltbld', 12:57:14 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1476042686.211614-1908415340', 12:57:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:14 INFO - '_': '/tools/buildbot/bin/python'} 12:57:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:14 INFO - Downloading/unpacking blobuploader==1.2.4 12:57: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 12:57: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 12:57: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 12:57: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 12:57: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 12:57: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 12:57:16 INFO - Downloading blobuploader-1.2.4.tar.gz 12:57:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:57:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:57:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:57:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:57:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:17 INFO - Downloading docopt-0.6.1.tar.gz 12:57:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:57:17 INFO - Installing collected packages: blobuploader, requests, docopt 12:57:17 INFO - Running setup.py install for blobuploader 12:57:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:57:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:57:17 INFO - Running setup.py install for requests 12:57:17 INFO - Running setup.py install for docopt 12:57:17 INFO - Successfully installed blobuploader requests docopt 12:57:17 INFO - Cleaning up... 12:57:17 INFO - Return code: 0 12:57:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:57:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:57:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9760fcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1377f60>, '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 0x1378d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13791d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1476042686.211614-1908415340', '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 12:57:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:57:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:57:17 INFO - Using env: {'DISPLAY': ':0', 12:57:17 INFO - 'HOME': '/home/cltbld', 12:57:17 INFO - 'LANG': 'en_US.UTF-8', 12:57:17 INFO - 'LANGUAGE': 'en_US:en', 12:57:17 INFO - 'LOGNAME': 'cltbld', 12:57:17 INFO - 'MAIL': '/var/mail/cltbld', 12:57:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:17 INFO - 'MOZ_NO_REMOTE': '1', 12:57:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:17 INFO - 'NO_EM_RESTART': '1', 12:57:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:17 INFO - 'PWD': '/builds/slave/test', 12:57:17 INFO - 'SHELL': '/bin/bash', 12:57:17 INFO - 'SHLVL': '1', 12:57:17 INFO - 'TERM': 'linux', 12:57:17 INFO - 'TMOUT': '86400', 12:57:17 INFO - 'USER': 'cltbld', 12:57:17 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1476042686.211614-1908415340', 12:57:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:17 INFO - '_': '/tools/buildbot/bin/python'} 12:57:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:57:17 INFO - Running setup.py (path:/tmp/pip-AsFdL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:57:18 INFO - Running setup.py (path:/tmp/pip-t6sj8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:57:18 INFO - Running setup.py (path:/tmp/pip-2Xbi1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:57:18 INFO - Running setup.py (path:/tmp/pip-2FbB6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:57:18 INFO - Running setup.py (path:/tmp/pip-adBboI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:57:18 INFO - Running setup.py (path:/tmp/pip-e_9hBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:57:18 INFO - Running setup.py (path:/tmp/pip-gmDrVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:57:18 INFO - Running setup.py (path:/tmp/pip-ndB147-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:57:18 INFO - Running setup.py (path:/tmp/pip-A1MPy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:57:18 INFO - Running setup.py (path:/tmp/pip-2tZJCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:57:18 INFO - Running setup.py (path:/tmp/pip-5tPu_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:57:18 INFO - Running setup.py (path:/tmp/pip-Xi5ecV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:57:18 INFO - Running setup.py (path:/tmp/pip-RaxCqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:57:18 INFO - Running setup.py (path:/tmp/pip-ES2HIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:57:18 INFO - Running setup.py (path:/tmp/pip-UGtV4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:57:19 INFO - Running setup.py (path:/tmp/pip-c91tCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:57:19 INFO - Running setup.py (path:/tmp/pip-XrOvrp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:57:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:57:19 INFO - Running setup.py install for manifestparser 12:57:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:57:19 INFO - Running setup.py install for mozcrash 12:57:19 INFO - Running setup.py install for mozdebug 12:57:19 INFO - Running setup.py install for mozdevice 12:57:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:57:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:57:19 INFO - Running setup.py install for mozfile 12:57:19 INFO - Running setup.py install for mozhttpd 12:57:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:57:19 INFO - Running setup.py install for mozinfo 12:57:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:57:19 INFO - Running setup.py install for mozInstall 12:57:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:57:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:57:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:57:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:57:20 INFO - Running setup.py install for mozleak 12:57:20 INFO - Running setup.py install for mozlog 12:57:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:57:20 INFO - Running setup.py install for moznetwork 12:57:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:57:20 INFO - Running setup.py install for mozprocess 12:57:20 INFO - Running setup.py install for mozprofile 12:57:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:57:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:57:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:57:20 INFO - Running setup.py install for mozrunner 12:57:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:57:20 INFO - Running setup.py install for mozscreenshot 12:57:20 INFO - Running setup.py install for moztest 12:57:20 INFO - Running setup.py install for mozversion 12:57:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:57:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:57:20 INFO - Cleaning up... 12:57:21 INFO - Return code: 0 12:57:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:57:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:57:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:21 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 0x7f9760fcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1377f60>, '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 0x1378d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13791d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1476042686.211614-1908415340', '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 12:57:21 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 12:57:21 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 12:57:21 INFO - Using env: {'DISPLAY': ':0', 12:57:21 INFO - 'HOME': '/home/cltbld', 12:57:21 INFO - 'LANG': 'en_US.UTF-8', 12:57:21 INFO - 'LANGUAGE': 'en_US:en', 12:57:21 INFO - 'LOGNAME': 'cltbld', 12:57:21 INFO - 'MAIL': '/var/mail/cltbld', 12:57:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:21 INFO - 'MOZ_NO_REMOTE': '1', 12:57:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:21 INFO - 'NO_EM_RESTART': '1', 12:57:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:21 INFO - 'PWD': '/builds/slave/test', 12:57:21 INFO - 'SHELL': '/bin/bash', 12:57:21 INFO - 'SHLVL': '1', 12:57:21 INFO - 'TERM': 'linux', 12:57:21 INFO - 'TMOUT': '86400', 12:57:21 INFO - 'USER': 'cltbld', 12:57:21 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1476042686.211614-1908415340', 12:57:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:21 INFO - '_': '/tools/buildbot/bin/python'} 12:57:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:57:21 INFO - Running setup.py (path:/tmp/pip-fCuqIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:57:21 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)) 12:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:57:21 INFO - Running setup.py (path:/tmp/pip-wTqUOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:57:21 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)) 12:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:57:21 INFO - Running setup.py (path:/tmp/pip-xkfnEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:57:21 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)) 12:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:57:21 INFO - Running setup.py (path:/tmp/pip-m_WAim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:57:21 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)) 12:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:57:21 INFO - Running setup.py (path:/tmp/pip-5_5hNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:57:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:57:21 INFO - Running setup.py (path:/tmp/pip-4Nf6fs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:57:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:57:21 INFO - Running setup.py (path:/tmp/pip-Qo87So-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:57:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:57:21 INFO - Running setup.py (path:/tmp/pip-cWBwm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:57:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:57:21 INFO - Running setup.py (path:/tmp/pip-yoy6vH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:57:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:57:21 INFO - Running setup.py (path:/tmp/pip-aYk7wf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:57:22 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)) 12:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:57:22 INFO - Running setup.py (path:/tmp/pip-UL7Tgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:57:22 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)) 12:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:57:22 INFO - Running setup.py (path:/tmp/pip-LgzBaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:57:22 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)) 12:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:57:22 INFO - Running setup.py (path:/tmp/pip-CV0Dwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:57:22 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)) 12:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:57:22 INFO - Running setup.py (path:/tmp/pip-nxxAxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:57:22 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)) 12:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:57:22 INFO - Running setup.py (path:/tmp/pip-0nWys3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:57:22 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)) 12:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:57:22 INFO - Running setup.py (path:/tmp/pip-nYHYTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:57:22 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)) 12:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:57:22 INFO - Running setup.py (path:/tmp/pip-jF6FWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:57:22 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)) 12:57:22 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)) 12:57:22 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)) 12:57:22 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)) 12:57:22 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)) 12:57:22 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)) 12:57:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:57:22 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 12:57:22 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 12:57:22 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 12:57:22 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 12:57:22 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 12:57:22 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 12:57:24 INFO - Downloading blessings-1.6.tar.gz 12:57:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:57:24 INFO - Installing collected packages: blessings 12:57:24 INFO - Running setup.py install for blessings 12:57:24 INFO - Successfully installed blessings 12:57:24 INFO - Cleaning up... 12:57:24 INFO - Return code: 0 12:57:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:57:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:57:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:57:24 INFO - Reading from file tmpfile_stdout 12:57:24 INFO - Current package versions: 12:57:24 INFO - argparse == 1.2.1 12:57:24 INFO - blessings == 1.6 12:57:24 INFO - blobuploader == 1.2.4 12:57:24 INFO - docopt == 0.6.1 12:57:24 INFO - functools32 == 3.2.3-2 12:57:24 INFO - jsonschema == 2.5.1 12:57:24 INFO - manifestparser == 1.1 12:57:24 INFO - mozInstall == 1.12 12:57:24 INFO - mozcrash == 0.17 12:57:24 INFO - mozdebug == 0.1 12:57:24 INFO - mozdevice == 0.48 12:57:24 INFO - mozfile == 1.2 12:57:24 INFO - mozhttpd == 0.7 12:57:24 INFO - mozinfo == 0.9 12:57:24 INFO - mozleak == 0.1 12:57:24 INFO - mozlog == 3.4 12:57:24 INFO - moznetwork == 0.27 12:57:24 INFO - mozprocess == 0.23 12:57:24 INFO - mozprofile == 0.28 12:57:24 INFO - mozrunner == 6.12 12:57:24 INFO - mozscreenshot == 0.1 12:57:24 INFO - mozsystemmonitor == 0.3 12:57:24 INFO - moztest == 0.7 12:57:24 INFO - mozversion == 1.4 12:57:24 INFO - psutil == 3.1.1 12:57:24 INFO - requests == 1.2.3 12:57:24 INFO - wsgiref == 0.1.2 12:57:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:57:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:57:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:57:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9760fcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1377f60>, '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 0x1378d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13791d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1476042686.211614-1908415340', '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 12:57:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:57:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:57:24 INFO - Using env: {'DISPLAY': ':0', 12:57:24 INFO - 'HOME': '/home/cltbld', 12:57:24 INFO - 'LANG': 'en_US.UTF-8', 12:57:24 INFO - 'LANGUAGE': 'en_US:en', 12:57:24 INFO - 'LOGNAME': 'cltbld', 12:57:24 INFO - 'MAIL': '/var/mail/cltbld', 12:57:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:24 INFO - 'MOZ_NO_REMOTE': '1', 12:57:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:24 INFO - 'NO_EM_RESTART': '1', 12:57:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:24 INFO - 'PWD': '/builds/slave/test', 12:57:24 INFO - 'SHELL': '/bin/bash', 12:57:24 INFO - 'SHLVL': '1', 12:57:24 INFO - 'TERM': 'linux', 12:57:24 INFO - 'TMOUT': '86400', 12:57:24 INFO - 'USER': 'cltbld', 12:57:24 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1476042686.211614-1908415340', 12:57:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:24 INFO - '_': '/tools/buildbot/bin/python'} 12:57:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:25 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)) 12:57:25 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)) 12:57:25 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)) 12:57:25 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)) 12:57:25 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)) 12:57:25 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)) 12:57:25 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)) 12:57:25 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)) 12:57:25 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)) 12:57:25 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)) 12:57:25 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)) 12:57:25 INFO - Cleaning up... 12:57:25 INFO - Return code: 0 12:57:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:57:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:57:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:57:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:25 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 0x7f9760fcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1377f60>, '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 0x1378d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13791d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1476042686.211614-1908415340', '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 12:57:25 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 12:57:25 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 12:57:25 INFO - Using env: {'DISPLAY': ':0', 12:57:25 INFO - 'HOME': '/home/cltbld', 12:57:25 INFO - 'LANG': 'en_US.UTF-8', 12:57:25 INFO - 'LANGUAGE': 'en_US:en', 12:57:25 INFO - 'LOGNAME': 'cltbld', 12:57:25 INFO - 'MAIL': '/var/mail/cltbld', 12:57:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:25 INFO - 'MOZ_NO_REMOTE': '1', 12:57:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:25 INFO - 'NO_EM_RESTART': '1', 12:57:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:25 INFO - 'PWD': '/builds/slave/test', 12:57:25 INFO - 'SHELL': '/bin/bash', 12:57:25 INFO - 'SHLVL': '1', 12:57:25 INFO - 'TERM': 'linux', 12:57:25 INFO - 'TMOUT': '86400', 12:57:25 INFO - 'USER': 'cltbld', 12:57:25 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1476042686.211614-1908415340', 12:57:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:25 INFO - '_': '/tools/buildbot/bin/python'} 12:57:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:57:25 INFO - Cleaning up... 12:57:25 INFO - Return code: 0 12:57:25 INFO - Running post-action listener: _resource_record_post_action 12:57:25 INFO - Running post-action listener: _start_resource_monitoring 12:57:25 INFO - Starting resource monitoring. 12:57:25 INFO - [mozharness: 2016-10-09 19:57:25.401363Z] Finished create-virtualenv step (success) 12:57:25 INFO - [mozharness: 2016-10-09 19:57:25.401873Z] Running install step. 12:57:25 INFO - Running pre-action listener: _resource_record_pre_action 12:57:25 INFO - Running main action method: install 12:57:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:57:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:57:25 INFO - Reading from file tmpfile_stdout 12:57:25 INFO - Detecting whether we're running mozinstall >=1.0... 12:57:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:57:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:57:25 INFO - Reading from file tmpfile_stdout 12:57:25 INFO - Output received: 12:57:25 INFO - Usage: mozinstall [options] installer 12:57:25 INFO - Options: 12:57:25 INFO - -h, --help show this help message and exit 12:57:25 INFO - -d DEST, --destination=DEST 12:57:25 INFO - Directory to install application into. [default: 12:57:25 INFO - "/builds/slave/test"] 12:57:25 INFO - --app=APP Application being installed. [default: firefox] 12:57:25 INFO - mkdir: /builds/slave/test/build/application 12:57:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:57:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:57:41 INFO - Reading from file tmpfile_stdout 12:57:41 INFO - Output received: 12:57:41 INFO - /builds/slave/test/build/application/firefox/firefox 12:57:41 INFO - Running post-action listener: _resource_record_post_action 12:57:41 INFO - [mozharness: 2016-10-09 19:57:41.846386Z] Finished install step (success) 12:57:41 INFO - [mozharness: 2016-10-09 19:57:41.846629Z] Running run-tests step. 12:57:41 INFO - Running pre-action listener: _resource_record_pre_action 12:57:41 INFO - Running main action method: run_tests 12:57:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:57:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:57:41 INFO - Python 2.7.3 12:57:41 INFO - Return code: 0 12:57:41 INFO - grabbing minidump binary from tooltool 12:57:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:57:41 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 0x1377f60>, '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 0x1378d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13791d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:57:41 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 12:57:41 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 12:57:41 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 12:57:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:57:41 INFO - Return code: 0 12:57:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:57:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:57:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:57:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:57:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:57:41 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/S9Uz76SgQEack33oXFvg3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 12:57:41 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/S9Uz76SgQEack33oXFvg3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 12:57:41 INFO - Using env: {'DISPLAY': ':0', 12:57:41 INFO - 'HOME': '/home/cltbld', 12:57:41 INFO - 'LANG': 'en_US.UTF-8', 12:57:41 INFO - 'LANGUAGE': 'en_US:en', 12:57:41 INFO - 'LOGNAME': 'cltbld', 12:57:41 INFO - 'MAIL': '/var/mail/cltbld', 12:57:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:57:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:57:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:41 INFO - 'MOZ_NO_REMOTE': '1', 12:57:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:57:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:41 INFO - 'NO_EM_RESTART': '1', 12:57:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:41 INFO - 'PWD': '/builds/slave/test', 12:57:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:57:41 INFO - 'SHELL': '/bin/bash', 12:57:41 INFO - 'SHLVL': '1', 12:57:41 INFO - 'TERM': 'linux', 12:57:41 INFO - 'TMOUT': '86400', 12:57:41 INFO - 'USER': 'cltbld', 12:57:41 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1476042686.211614-1908415340', 12:57:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:41 INFO - '_': '/tools/buildbot/bin/python'} 12:57:41 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/S9Uz76SgQEack33oXFvg3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 12:57:42 INFO - mozversion application_buildid: 20161009121217 12:57:42 INFO - mozversion application_changeset: d72cf6ecebaf707c159f6697d9f5f6f6a6feb7e1 12:57:42 INFO - mozversion application_display_name: Nightly 12:57:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:57:42 INFO - mozversion application_name: Firefox 12:57:42 INFO - mozversion application_remotingname: firefox 12:57:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:57:42 INFO - mozversion application_vendor: Mozilla 12:57:42 INFO - mozversion application_version: 52.0a1 12:57:42 INFO - mozversion platform_buildid: 20161009121217 12:57:42 INFO - mozversion platform_changeset: d72cf6ecebaf707c159f6697d9f5f6f6a6feb7e1 12:57:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:57:42 INFO - mozversion platform_version: 52.0a1 12:57:42 INFO - using testdate: 1476043062 12:57:42 INFO - actual date: 1476043062 12:57:42 INFO - starting webserver on 'localhost:48624' 12:57:42 INFO - SUITE-START | Running 2 tests 12:57:42 INFO - TEST-START | dromaeo_css 12:57:42 INFO - operating with platform_type : linux_ 12:57:42 INFO - Initialising browser for dromaeo_css test... 12:57:42 INFO - TEST-INFO | started process 12544 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUats81/profile http://localhost:48624/getInfo.html) 12:57:47 INFO - PROCESS | 12544 | __metrics Screen width/height:1600/1200 12:57:47 INFO - PROCESS | 12544 | colorDepth:24 12:57:47 INFO - PROCESS | 12544 | Browser inner width/height: 1024/697 12:57:47 INFO - PROCESS | 12544 | __metrics 12:57:47 INFO - PROCESS | 12544 | 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" 12:57:47 INFO - PROCESS | 12544 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:57:48 INFO - PROCESS | 12544 | console.error: PushService: 12:57:48 INFO - PROCESS | 12544 | stateChangeProcessEnqueue: Error transitioning state 12:57:48 INFO - PROCESS | 12544 | UnknownError 12:57:49 INFO - TEST-INFO | 12544: exit 0 12:57:49 INFO - Browser initialized. 12:57:49 INFO - Running cycle 1/1 for dromaeo_css test... 12:57:49 INFO - TEST-INFO | started process 12628 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUats81/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:58:01 INFO - PROCESS | 12628 | RSS: Main: 174907392 12:58:01 INFO - PROCESS | 12628 | 12:58:52 INFO - PROCESS | 12628 | 1476043132048 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 13:01:06 INFO - PROCESS | 12628 | Cycle 1(1): loaded http://localhost:48624/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48624/tests/dromaeo/cssquery-ext.html) 13:01:07 INFO - PROCESS | 12628 | RSS: Main: 303910912 13:01:07 INFO - PROCESS | 12628 | 13:04:10 INFO - PROCESS | 12628 | Cycle 1(1): loaded http://localhost:48624/tests/dromaeo/cssquery-ext.html (next: http://localhost:48624/tests/dromaeo/cssquery-jquery.html) 13:04:11 INFO - PROCESS | 12628 | RSS: Main: 273592320 13:04:11 INFO - PROCESS | 12628 | 13:07:13 INFO - PROCESS | 12628 | Cycle 1(1): loaded http://localhost:48624/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48624/tests/dromaeo/cssquery-mootools.html) 13:07:14 INFO - PROCESS | 12628 | RSS: Main: 220393472 13:07:14 INFO - PROCESS | 12628 | 13:10:16 INFO - PROCESS | 12628 | Cycle 1(1): loaded http://localhost:48624/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48624/tests/dromaeo/cssquery-prototype.html) 13:10:17 INFO - PROCESS | 12628 | RSS: Main: 219357184 13:10:17 INFO - PROCESS | 12628 | 13:13:20 INFO - PROCESS | 12628 | Cycle 1(1): loaded http://localhost:48624/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48624/tests/dromaeo/cssquery-yui.html) 13:13:20 INFO - PROCESS | 12628 | RSS: Main: 220786688 13:13:20 INFO - PROCESS | 12628 | 13:16:23 INFO - PROCESS | 12628 | Cycle 1(1): loaded http://localhost:48624/tests/dromaeo/cssquery-yui.html (next: http://localhost:48624/tests/dromaeo/cssquery-dojo.html) 13:16:24 INFO - PROCESS | 12628 | RSS: Main: 314109952 13:16:24 INFO - PROCESS | 12628 | 13:16:24 INFO - PROCESS | 12628 | __start_tp_report 13:16:24 INFO - PROCESS | 12628 | _x_x_mozilla_page_load 13:16:24 INFO - PROCESS | 12628 | _x_x_mozilla_page_load_details 13:16:24 INFO - PROCESS | 12628 | |i|pagename|runs| 13:16:24 INFO - PROCESS | 12628 | |0;dojo.html;2587.6247944048114;2613.16378758797;2628.8159828811986;2663.5338815707246;2664.4138289576285;4569.840055598055;4673.813047478106;4744.833930812422;4773.498782627822;4822.300766388871;4758.310045043467;4764.047190561884;4792.6165906727465;4841.588464980472;4892.853214403564;4217.430646862665;4226.682998775089;4276.807543660543;4293.2701440755145;4306.590873866978;4061.472008638873;4363.694541382105;4379.0366119453665;4389.582989615981;4451.5993560579545;4286.035641980529;4338.414314067592;4426.579474949875;4510.345999830039;4530.026044400453;4329.610335069828;4346.869593912188;4360.149770794696;4365.934510982338;4377.365282034088;4359.106383191438;4370.868873933787;4407.1846708358735;4426.933595996063;4435.112977404532;4721.598664113554;4732.408448943882;4758.643101767381;4775.331453596499;4838.564529192389;4945.7774400152075;5015.949840501585;5024;5070.264811602297;5083.79664813407;5092.465291144451;5111.693298402108;5112.744362781883;5154.4072431670465;5168.3281173447585;4746.620270378361;4746.95253047472;4753.524647535288;4758.286257061469;4816.927746083811;4976.427710813303;5044.243363495505;5213.2701421800975;5225.242339860699;5289.127293996447;4859.975700121548;4885.8289959851945;4902.926456103161;4914.434839993375;4921.532454416824;4985.675931064469;5001.649884508122;5067.721275329893;5069.949300507022;5138.434772175057;4912.361393018885;4977.477364876709;5010.3737032870895;5026.1204289249235;5089.491050894881;4907.5828554572545;4947.703137811743;4961.03259864323;5004.724740139254;5073.974630126826;4264.1471705659;4275.978620106879;4276.508201556799;4283.378910058024;4315.438992930899;3686.705063594906;3746.269477451925;3750.981245093757;3786.450964610116;3812.066043819282;4351.412559304516;4381.123775244963;4410.029793445437;4443.33349997503;4446.377507148937;5114.053900028507;5114.769835357418;5125.564327032244;5140.537351638371;5176.534111929869;4429.490608580055;4439.1121775645;4440.089781594766;4484.192845287879;4498.370228168059;4425.690201685851;4454.554544545585;4479.059397526556;4514.593686568224;4579.977100114478;4770.570648641639;4772.856814295576;4790.95209047919;4803.327534145293;4849.127157111754;5068.163752980717;5069.442361340176;5071.949280507148;5076.796928122982;5108.770105345194;4660.580547750718;4715.033418149203;4745.572898439157;4767.713937163781;4829.299751536078;5009.398872135222;5034.421041580119;5047.924281135859;5102.668326558762;5110.1568241239775;5085.46602606721;5116.232565115262;5127.282180494808;5128.076946149579;5190.325257716473;4802.543758342952;4903.632227582874;4979.800807967786;4986.426560945392;4991;4870.415550133865;4914.680545764514;4924.236743304794;4934.333864928189;4987.9002419950675;4850.257682292316;4850.95149048505;4851.95148048515;4856.028794241095;4914.8771280718265;4824.734639594715;4878.78045487961;4961.776720047535;4965.702057876539;4974.228994505857;4778.928316075192;4796.376471058879;4816.362436771515;4847.491013443538;4881.707097574157 13:16:24 INFO - PROCESS | 12628 | |1;ext.html;555.6610467614754;558.6033915919696;564.9096144616863;569.2457493820689;573.6070791507817;26415.735842641567;36690.76257036303;37645.24709505812;37667;41880.581194188046;38836.80581597088;39108.41337379941;39151.21697566047;39224;39226.607733922654;7522.2101679323705;7662.425318101137;7662.931008627667;7664.770056898302;7677.539347639159;7051.506394552383;7157.821054473654;9574.329796914219;9847.212223022141;9852.605895764196;9936.503174841266;10019.749506262366;10021.248406369552;10025.548850301717;10031.448270345129;9838.458884761336;9907.157891579225;9918.553665085088;9929;9937.15534179592;9597.856032159523;9665.323427360088;9667.854982175273;9671.564779584865;9671.90328096717;36677.26645467076;36842.263154737026;36854.815725921464;36961.44557831635;37007.444888326696;2868.6557613086356;2937.2656835791054;3035.5901953236253;3087.428825667236;3268.0359294008326;27770.444591108066;28146.296342591395;28337.433251334856;28732.13803585875;29480.8525957371;3444.448888177905;3485.146139195888;3504.8948531544092;3516.1736991806906;3648;246312;246330;247790;249506.7919226868;249806;30678.69321306803;49005.26492102621;49280.318369754816;49283.50716492861;49710.50289497131;29814.701852981627;31786.36427271488;31855.681443185735;31864.522032169534;31900.68099318977;11093.278936869077;11137.220394572301;11144.164187685956;11152.66542003725;11156.442177891073;9189.40268882534;10960;11056;11057.778844423228;11062.889371106347;7071.929280707127;7671.654775535114;7862.764117076496;7953.363730901514;7977.282044616012;3109.720125188744;3126.1715645353997;3141.1361875483967;3146.4808306629607;3187.5218717192142;867.2541614211773;875.1729615513278;876.54419701756;907.3195103672246;920.8342498350361;26012.739872601032;27166.72833271642;27507.724922750516;27702.722972770014;27726.73192093496;928.7724507495707;929.6839074714629;936.6019441737235;939.4738946190155;976.097110173087;14429.134251944706;14545.563633091024;14651.633709157357;14720.791881217903;14754.40982360715;350571;353494;354844;354946;355561;47481.10075597007;47559.286610700176;47649.52350476451;47989;48084.5191548087;1025.6102680981328;1077.3428208792473;1145.7536629624672;1156.9768604627861;1182.568362547681;24502;27378.726212737616;28618.57072143878;29094.27264318409;29114.126576202747;39833.80083099566;40354.1929161421;40363;40381.394279086424;40395.79802100971;238434;239254;239564;239923;241425;24053.759462405153;24471.51056978886;24742.752572474044;24778.628320574844;25848.836802343565;39613.207735845695;39869.10798591232;39885.60114398935;40339.798301008304;40558;33832;33910;33983.49024764581;34219.4867076989;34419.827900860335;33207;34293.48559771555;34416.65583344134;34487.4826877592;34783.82608086943;33712.15719606931;33984.320313594086;34093;34298;34428.82785586056;30106.69893301039;30306.939257125894;31214.37571248517;31491.212719682193;31717;23567.52864942726;25749.3562660935;25965.350866228495;26007.47985040251;26215.344616384744 13:16:24 INFO - PROCESS | 12628 | |2;jquery.html;335.6894872243174;348.4424920127796;356.93218288525185;359.0950803973985;383.7659027992926;11942.999999999989;12972.156809807368;15386.076835389871;15948.76076858848;17115.144242787843;16453;16522.173891305418;16749.91625041873;16753.07858067806;16821.15894205291;4418.315161150027;4808.735519546423;5034.1945288753805;5039.420466646346;5040.647154699154;5673.773049078032;5820.214271073414;5857.7364018619055;5858.238429004224;5865.618734782225;4893.584045356149;5162.741862906859;5809.6804675742815;5816.709164541756;5820.767169313222;5357.919631205535;5376.381716102659;5380.2736630555155;5389.245505629215;5396.082665946778;5040.747962601892;5174.404943431516;5212.4266330703595;5214.035403450373;5222.503862133091;11641.301521908712;11737.53049878004;11840.88159118415;11849.822252666218;11861.52553897843;1865.1699993502896;1915.3009151659544;1960.696092105726;2197.966955530898;2225.721784776903;8956.306219050024;9032.412893161923;9062;9536.952315238448;9542.666006689802;1654.1811803157393;1668.6996340658677;1687.738400547917;1723.5432610358266;1738.7478815571799;63477;69652.651736741;69788.3021169787;70328;72696.27303726948;9695.70912872615;9806.803863922682;9991.650292239738;10074.244431667654;10106.595736170619;10671.73320666974;13719.794203086962;13751.518696845762;13762.105463144864;13762.518311859038;6468.223813142453;6833.350831670983;6903.965480172667;6910.619915904573;7058.858822823618;6829.829254268584;6835.179778426521;6905.240423553405;7050.330218629222;7056.788296351015;3591.856325746941;3651.214988777426;3734.738568300193;3759.266942946154;3791.374423220138;1806.2413786209822;1815.2376002079159;1821.426250731042;1822.9453116406528;1858.1173942377263;774.9341305989054;775.4533054196778;806.6168569929237;834.0783434305126;876.5836227791875;15905.363785448453;16452.341906323614;16748.665026699397;16917;17436.738448923275;805.3315747929205;834.2450082675189;837.3092198935781;864.4251572704208;866.1554983890782;9141.954290228507;9684.612615495442;9723.562439690231;9726.221902247804;9911.15755160805;348223;359915;360158;360951;361009;70393.29606703867;70895.64552177206;73116;74017;75521;415.5117736659413;427.39310179545123;432.13788491958746;434.71960585422227;434.795646046364;9530.094641009093;9643.807123857623;9952.950235248778;10095.646652367132;10234.692959211236;24085;34973.300533988666;35939.101522462144;36082.45876311805;36906.63093369139;45524.77237613791;48658.942548959465;49737.50262497473;50343.49656503388;50393.74803125961;6723.899141512783;6860;7006.439484841098;7041.929580704127;7165.605891676008;8138.389620778584;10216.284860059724;10599.523021464207;10733.785324293627;10762.192835537522;9169.220616247694;9236.720964057931;9238.861417078884;9243.121903419433;9541.666041688508;9339.20616747557;9502.23982081418;9690.12788849007;9713.805723885624;9953.153981911619;9508.809823803624;9574.186194173573;9605;9792.127157581026;9907.504624768877;7197.676104575411;7260.2739726026975;7341.70633174667;7525.24747525265;7611.581363025087;8485.703000395204;9691.612335506501;9694.321397502106;9712.902870971482;10066.899331006596 13:16:24 INFO - PROCESS | 12628 | |3;mootools.html;1197.1560050164635;1324.4304948871984;1369.5343583181718;1399.6570840144166;1653.6444664397152;6344.080108384282;7293.307135822095;7504.1745408005145;7534.0582427196605;7681.270279323456;7501.5874126923;7572.772816815491;7586.4689471737;7673.846523069536;7684.385249180066;2096.821770149539;2119.671450925109;2124.320217530391;2125.798049185325;2129.957400851982;2079.979200208001;2118.0998075817793;2137.1237792505076;2145.3885642591863;2153.06341741343;2103.295396042328;2115.3548167808813;2129.872207667537;2132.626790311697;2155.644318687415;2034.6744520876662;2035.7557093148769;2038.0624912540175;2041.8979051047536;2048.8463365247667;2009.859309848311;2014.909329080195;2044.3458093410115;2045.7136000959877;2047.7235573197577;7597.772066838003;7637.885431718529;7693;7702.460827742004;7741.303282704527;4283.357496375537;4411.139827733593;4413.315936029889;4415.315626077963;4492.07912377965;2715.2804506805714;2795.8741856616502;2867.985660071686;2879.6832348441653;2881.4669286181916;880.8150288439435;887.041994645781;887.40987243483;889.2263730554395;905.5200743605899;10137.290389672726;10366.118879895217;10391.84412233817;10414;10444.738881527946;3706.3513885070006;3844.115853353744;4017.1563971565715;4019.1760689058674;4022.2960981828064;8961.865572016424;8962.103789620985;8967.506787126771;8976.147266009719;8977.32670049749;4389.056352884081;4392.07766369066;4397.714148580332;4398.318260669601;4401.933970990438;3486.9128271793406;3628.4738712886483;3797.6392242736897;3970.563238043813;3972.1658451724884;3482.460218666111;3581.3374525712825;3656.780593164419;3668.449732540087;3671.155634204148;1115.7322242661864;1167.8656954450178;1173.4602083041725;1183.8579370475427;1187.9524819007142;757.4016526943652;809.2635701511596;809.8542262392826;811.2090711556185;823.4688625836421;4816.662833601685;4826.927596086061;4831.4685384607665;4993.6766756809475;5099.566536844335;362.1905042230612;367.5277268709695;379.88793305974804;381.99045023874623;384.2257850431383;3373.224158443572;3392.2537041850755;3451.8101504416995;3456.6197718250974;3558.6619271169197;9200.125988031126;9379.577918993662;9556.66551670702;9600.087991640783;9608.66369677058;9498.905010949802;9505.619775209052;9506.382085164441;9506.714798556055;9511.286653501014;7119.110111236096;7151.177614574391;7159.176694680178;7169.784906452711;7188;4717.811287548459;4903.210328230241;4996.925046124384;5183.3261675981885;5188.936268064962;8453.619587118472;8699.347548933982;8706.608202631023;8715.041345452122;8736.78158046054;8527.147285271423;8728.607212675317;8729.738107856774;8896.466212027299;8977.820443591223;5994.340622531431;6172.166757487682;6669.366410191024;6794.082798822294;6809.216940051958;7231.783046508614;7430.7399241026305;7460.813479663052;7680.500767450098;7697.65360558765;6456.257530384066;6469.223693156851;6494.123293355526;6575.2767195607485;6641.236257830218;6549.836254093686;6559.114519539801;6581.967090164519;6619.470442364695;6700.865982680221;5973.910391344047;6052.727627256872;6062.42406971337;6064.211652485149;6071.726772295169;4225.492940846995;4312.05134870328;4323.718958267703;4451;4513.255312873339;4354.390385346117;4427.77861106937;4467.843625473093;4543.79552920126;4570.223062079521 13:16:24 INFO - PROCESS | 12628 | |4;prototype.html;271.9034742666353;276.17423902531425;277.4174234108372;277.60857191360185;281.56779343707416;4625.514320996297;4803.423589169304;4809.711417314964;4843.515648435155;4892.975535122324;4658.627309815207;4793.233082706767;4810.5189481051875;4814.013127308902;4845.709257444556;3537.9563028906405;3661.418699816623;3779.168582911755;3788.1287303920117;3790.4314352847086;3696.556413230416;3774.4527043578664;3778.790786948178;3782.9432558511508;3790.564085130218;3754.6620804127624;3757.906052348686;3758.4362345648233;3760.398336266198;3770.5852356240794;3774.981125094371;3779.281936432069;3779.4708740776314;3781.6596506314563;3784.3377408953324;3072.1244445333195;3192.138122706856;3215.742740580748;3220.2754380264487;3304.306095719902;4668.976655116737;4675.036484676444;4679;4679.60223381013;4691.18528882671;4017.738846974937;4187.476565429321;4195.958040419618;4198.391233271189;4203.066589368894;4997.775100120503;5003.524665156804;5016.3980322361185;5029.547340739315;5039.47085556015;3454.101933497284;3458.602260740022;3464.5842498900292;3465.462853257724;3474.2183008823067;5280.656757310762;5287.762050707727;5295.576353891679;5295.867603309909;5297.576193904479;3412.4540073588605;3540.2034542227793;3549.343371476285;3573.1245844767677;3590.838412271454;3618.2944325856206;3620.2940426616556;3621.27574485104;3625.3111908737255;3627.3289441453417;4164.833846522978;4174.77038762871;4185.707000509996;4187.434696315959;4192.496900371914;4755.785989630475;4888.853334399973;4890.144224760653;4926.926096108561;5021.623378246646;1219.1405059433077;1238.7089034076985;1240.34881687115;1241.6337180531764;1247.9064070194772;753.898223739799;772.7790091655171;778.6068035641964;789.3685051958411;794.8410317936435;4039.7374170678813;4045.7255964371716;4056.8640780581486;4071.97964010184;4074.30736774749;4536.6163320187;4576.244919588297;4596.448426188878;4609.677322587387;4615.676902616851;4051.0682543015273;4053.932494427863;4063.6793042261384;4064.504526107545;4072.979635101865;2293.4037150340696;2434.8782560871887;2438.219769673723;2445.963310550343;2470.6905340169737;4376.956230437655;4381.868543943687;4382.006187184823;4385.671074669349;4398.846040388571;4669.766511674471;4671.640821385246;4694.43666759991;4700.835470758507;4706.647001474903;4056.675465962716;4327.740335579875;4360.803763830635;4363.650907927295;4374.047517925387;4576.176288268143;4583.2666773316105;4596.218642830794;4629.749967508821;4641.466231383434;4507.954920450754;4518.774061296987;4529.456465224194;4559.92841682211;4566.70316429431;4100.897477563085;4372.846950356722;4373.781310934504;4384.539623339503;4408.0245834062525;3233.127055694902;3233.5149727541057;3258.820764857861;3292.760922572578;3312.9834350829055;4505.234110201208;4588.292907184777;4620.699654522446;4624.699394539344;4906.484819093944;4879.4388645304825;4892.65751397413;5025.673331233605;5054.620903432184;5057.393112826484;5044.293798868088;5046.697198167974;5052.621053420935;5066.290719299374;5066.36670416198;4858.465568787501;5004.374453193351;5019.322391477104;5023.648344615842;5033.748312584283;5090.847274581768;5124.359455068116;5124.461931497139;5124.718140502308;5128.230765385222;4987.401511818605;5004.77478513475;5009.273655320031;5018.84943451697;5036.29491871131 13:16:24 INFO - PROCESS | 12628 | |5;yui.html;656.9474442044635;683.6615875141806;694.2883544367027;716.4841314253739;738.2654259012284;13337.866621333784;14512.782308265385;14538.636534086652;14544.563663090124;14549.272536373192;13688.931555342235;13856.168629882213;13874.514391996283;13894.652633684163;13907.304634768247;598.2163365990544;613.6256883301182;743.271593838039;753.1903204055635;765.2691679446116;771.0631582627107;774.7327172125607;774.740461945249;775.90689117306;780.169119887321;811.8376324735048;812.191869090256;813;813.633864760857;813.8494378539959;626.8119564130742;642.633698791689;780.0639232920462;795.8527672380628;808.2604416958505;586.6069733278714;587.1838144978483;587.3539106982328;587.4184557288254;588.4086493074476;12119.091068169835;12138.878611213951;12151.696207594792;12160.452779624939;12163.331016794073;12636.925861301801;12881.613551593467;13161.86838131616;13430.395632196574;13553.796693049611;12127.846759842505;12190.695232619168;12230.694232644166;12254.448549815279;12528.373581320897;4045.1302969861326;4047.4535937648334;4047.959520404788;4061.614146656063;4095.1809638072505;65593;65871;66160.6691966537;66834;67310.66344668245;10001.749956251151;10140.29017968735;10486.37081775096;10673.83989240162;10869.076128529163;16841.915790420968;17592.648147036987;17595.64808703819;18484.260629574936;18526.536836579195;6650.401463868275;6706.966465167643;6743.865122697617;6774.627395493295;7085.185203701641;3589.9282014359565;3783.4703141560203;3792.60177681345;3806.448065030555;3817.751846129993;2767;2877.223149749556;2885.7258560436726;2889.5954566360724;2891.898783542566;478.6027597094403;484.8787803049238;485.9757012149378;487.1669445248594;488.14087206516075;525.6714553404122;537.6182910133849;553.8421549858351;553.941836107211;568.3123420660963;8158.3065439438315;8288.751337459886;8364.121767214476;8435.83128337442;8765.474071555727;484.3582253514108;523.6203752279642;530.7213712800733;548.8518100113027;582.8216298190523;3948.170884114368;3952.427077820317;4073.165001174752;4196.349565817303;4269.87190384289;98923.50538247406;103041.48479257556;103286;103292;106271.4686426563;70039;84487;87621.56189219013;89234;92462.53768731248;80154;80746;81759.59120204361;82654.99999999879;82722.58638706768;8047.195280471906;8160.224778646019;8228.958855205685;8273.420860539945;8405.753670962138;30701.23246918845;38607.6139238604;38918.6108138915;42896.2117462364;48773.512264878314;58407.37166827588;58952.70523647354;60177.69911150416;61698.69150654218;62917.685411572646;11154.16343774204;11339.41819162839;11430.599929002445;11762.882371176178;11863.881361186277;12106.878931210927;12867.742645147231;13504.054716169774;13833.79249311241;14062.789058163931;12010.63968080959;12468.5012599495;12570.1200915935;12620.305883176514;12705.301208433624;10944.452777361259;11393;11727.88272117302;12354.876451235372;12373.75252494963;11952.402379881145;12208.45061972231;12224.083193760325;13012.739745205232;13036.608901732963;9958.950205248928;10365.689029329133;10457.633982810565;10525.684229473129;10643.733906652396;9753.268504862022;10284;10354;10443.425611591436;10616 13:16:24 INFO - PROCESS | 12628 | __end_tp_report 13:16:24 INFO - PROCESS | 12628 | __start_cc_report 13:16:24 INFO - PROCESS | 12628 | _x_x_mozilla_cycle_collect,1306 13:16:24 INFO - PROCESS | 12628 | __end_cc_report 13:16:24 INFO - PROCESS | 12628 | __startTimestamp1476044184230__endTimestamp 13:16:24 INFO - PROCESS | 12628 | 13:16:24 INFO - PROCESS | 12628 | ------- Summary: start ------- 13:16:24 INFO - PROCESS | 12628 | Number of tests: 6 13:16:24 INFO - PROCESS | 12628 | 13:16:24 INFO - PROCESS | 12628 | [#0] dojo.html Cycles:165 Average:4681.86 Median:4816.93 stddev:491.86 (10.2%) stddev-sans-first:465.12 13:16:24 INFO - PROCESS | 12628 | Values: 2587.6 2613.2 2628.8 2663.5 2664.4 4569.8 4673.8 4744.8 4773.5 4822.3 4758.3 4764.0 4792.6 4841.6 4892.9 4217.4 4226.7 4276.8 4293.3 4306.6 4061.5 4363.7 4379.0 4389.6 4451.6 4286.0 4338.4 4426.6 4510.3 4530.0 4329.6 4346.9 4360.1 4365.9 4377.4 4359.1 4370.9 4407.2 4426.9 4435.1 4721.6 4732.4 4758.6 4775.3 4838.6 4945.8 5015.9 5024.0 5070.3 5083.8 5092.5 5111.7 5112.7 5154.4 5168.3 4746.6 4747.0 4753.5 4758.3 4816.9 4976.4 5044.2 5213.3 5225.2 5289.1 4860.0 4885.8 4902.9 4914.4 4921.5 4985.7 5001.6 5067.7 5069.9 5138.4 4912.4 4977.5 5010.4 5026.1 5089.5 4907.6 4947.7 4961.0 5004.7 5074.0 4264.1 4276.0 4276.5 4283.4 4315.4 3686.7 3746.3 3751.0 3786.5 3812.1 4351.4 4381.1 4410.0 4443.3 4446.4 5114.1 5114.8 5125.6 5140.5 5176.5 4429.5 4439.1 4440.1 4484.2 4498.4 4425.7 4454.6 4479.1 4514.6 4580.0 4770.6 4772.9 4791.0 4803.3 4849.1 5068.2 5069.4 5071.9 5076.8 5108.8 4660.6 4715.0 4745.6 4767.7 4829.3 5009.4 5034.4 5047.9 5102.7 5110.2 5085.5 5116.2 5127.3 5128.1 5190.3 4802.5 4903.6 4979.8 4986.4 4991.0 4870.4 4914.7 4924.2 4934.3 4987.9 4850.3 4851.0 4852.0 4856.0 4914.9 4824.7 4878.8 4961.8 4965.7 4974.2 4778.9 4796.4 4816.4 4847.5 4881.7 13:16:24 INFO - PROCESS | 12628 | 13:16:24 INFO - PROCESS | 12628 | [#1] ext.html Cycles:180 Average:42474.01 Median:34418.24 stddev:74949.81 (217.8%) stddev-sans-first:75093.98 13:16:24 INFO - PROCESS | 12628 | Values: 555.7 558.6 564.9 569.2 573.6 26415.7 36690.8 37645.2 37667.0 41880.6 38836.8 39108.4 39151.2 39224.0 39226.6 7522.2 7662.4 7662.9 7664.8 7677.5 7051.5 7157.8 9574.3 9847.2 9852.6 9936.5 10019.7 10021.2 10025.5 10031.4 9838.5 9907.2 9918.6 9929.0 9937.2 9597.9 9665.3 9667.9 9671.6 9671.9 36677.3 36842.3 36854.8 36961.4 37007.4 2868.7 2937.3 3035.6 3087.4 3268.0 27770.4 28146.3 28337.4 28732.1 29480.9 3444.4 3485.1 3504.9 3516.2 3648.0 246312.0 246330.0 247790.0 249506.8 249806.0 30678.7 49005.3 49280.3 49283.5 49710.5 29814.7 31786.4 31855.7 31864.5 31900.7 11093.3 11137.2 11144.2 11152.7 11156.4 9189.4 10960.0 11056.0 11057.8 11062.9 7071.9 7671.7 7862.8 7953.4 7977.3 3109.7 3126.2 3141.1 3146.5 3187.5 867.3 875.2 876.5 907.3 920.8 26012.7 27166.7 27507.7 27702.7 27726.7 928.8 929.7 936.6 939.5 976.1 14429.1 14545.6 14651.6 14720.8 14754.4 350571.0 353494.0 354844.0 354946.0 355561.0 47481.1 47559.3 47649.5 47989.0 48084.5 1025.6 1077.3 1145.8 1157.0 1182.6 24502.0 27378.7 28618.6 29094.3 29114.1 39833.8 40354.2 40363.0 40381.4 40395.8 238434.0 239254.0 239564.0 239923.0 241425.0 24053.8 24471.5 24742.8 24778.6 25848.8 39613.2 39869.1 39885.6 40339.8 40558.0 33832.0 33910.0 33983.5 34219.5 34419.8 33207.0 34293.5 34416.7 34487.5 34783.8 33712.2 33984.3 34093.0 34298.0 34428.8 30106.7 30306.9 31214.4 31491.2 31717.0 23567.5 25749.4 25965.4 26007.5 26215.3 13:16:24 INFO - PROCESS | 12628 | 13:16:24 INFO - PROCESS | 12628 | [#2] jquery.html Cycles:180 Average:22471.34 Median:5290.21 stddev:59323.79 (1121.4%) stddev-sans-first:59466.93 13:16:24 INFO - PROCESS | 12628 | Values: 335.7 348.4 356.9 359.1 383.8 11943.0 12972.2 15386.1 15948.8 17115.1 16453.0 16522.2 16749.9 16753.1 16821.2 4418.3 4808.7 5034.2 5039.4 5040.6 5673.8 5820.2 5857.7 5858.2 5865.6 4893.6 5162.7 5809.7 5816.7 5820.8 5357.9 5376.4 5380.3 5389.2 5396.1 5040.7 5174.4 5212.4 5214.0 5222.5 11641.3 11737.5 11840.9 11849.8 11861.5 1865.2 1915.3 1960.7 2198.0 2225.7 8956.3 9032.4 9062.0 9537.0 9542.7 1654.2 1668.7 1687.7 1723.5 1738.7 63477.0 69652.7 69788.3 70328.0 72696.3 9695.7 9806.8 9991.7 10074.2 10106.6 10671.7 13719.8 13751.5 13762.1 13762.5 6468.2 6833.4 6904.0 6910.6 7058.9 6829.8 6835.2 6905.2 7050.3 7056.8 3591.9 3651.2 3734.7 3759.3 3791.4 1806.2 1815.2 1821.4 1822.9 1858.1 774.9 775.5 806.6 834.1 876.6 15905.4 16452.3 16748.7 16917.0 17436.7 805.3 834.2 837.3 864.4 866.2 9142.0 9684.6 9723.6 9726.2 9911.2 348223.0 359915.0 360158.0 360951.0 361009.0 70393.3 70895.6 73116.0 74017.0 75521.0 415.5 427.4 432.1 434.7 434.8 9530.1 9643.8 9953.0 10095.6 10234.7 24085.0 34973.3 35939.1 36082.5 36906.6 45524.8 48658.9 49737.5 50343.5 50393.7 6723.9 6860.0 7006.4 7041.9 7165.6 8138.4 10216.3 10599.5 10733.8 10762.2 9169.2 9236.7 9238.9 9243.1 9541.7 9339.2 9502.2 9690.1 9713.8 9953.2 9508.8 9574.2 9605.0 9792.1 9907.5 7197.7 7260.3 7341.7 7525.2 7611.6 8485.7 9691.6 9694.3 9712.9 10066.9 13:16:24 INFO - PROCESS | 12628 | 13:16:24 INFO - PROCESS | 12628 | [#3] mootools.html Cycles:180 Average:4966.51 Median:4767.24 stddev:2847.33 (59.7%) stddev-sans-first:2841.22 13:16:24 INFO - PROCESS | 12628 | Values: 1197.2 1324.4 1369.5 1399.7 1653.6 6344.1 7293.3 7504.2 7534.1 7681.3 7501.6 7572.8 7586.5 7673.8 7684.4 2096.8 2119.7 2124.3 2125.8 2130.0 2080.0 2118.1 2137.1 2145.4 2153.1 2103.3 2115.4 2129.9 2132.6 2155.6 2034.7 2035.8 2038.1 2041.9 2048.8 2009.9 2014.9 2044.3 2045.7 2047.7 7597.8 7637.9 7693.0 7702.5 7741.3 4283.4 4411.1 4413.3 4415.3 4492.1 2715.3 2795.9 2868.0 2879.7 2881.5 880.8 887.0 887.4 889.2 905.5 10137.3 10366.1 10391.8 10414.0 10444.7 3706.4 3844.1 4017.2 4019.2 4022.3 8961.9 8962.1 8967.5 8976.1 8977.3 4389.1 4392.1 4397.7 4398.3 4401.9 3486.9 3628.5 3797.6 3970.6 3972.2 3482.5 3581.3 3656.8 3668.4 3671.2 1115.7 1167.9 1173.5 1183.9 1188.0 757.4 809.3 809.9 811.2 823.5 4816.7 4826.9 4831.5 4993.7 5099.6 362.2 367.5 379.9 382.0 384.2 3373.2 3392.3 3451.8 3456.6 3558.7 9200.1 9379.6 9556.7 9600.1 9608.7 9498.9 9505.6 9506.4 9506.7 9511.3 7119.1 7151.2 7159.2 7169.8 7188.0 4717.8 4903.2 4996.9 5183.3 5188.9 8453.6 8699.3 8706.6 8715.0 8736.8 8527.1 8728.6 8729.7 8896.5 8977.8 5994.3 6172.2 6669.4 6794.1 6809.2 7231.8 7430.7 7460.8 7680.5 7697.7 6456.3 6469.2 6494.1 6575.3 6641.2 6549.8 6559.1 6582.0 6619.5 6700.9 5973.9 6052.7 6062.4 6064.2 6071.7 4225.5 4312.1 4323.7 4451.0 4513.3 4354.4 4427.8 4467.8 4543.8 4570.2 13:16:24 INFO - PROCESS | 12628 | 13:16:24 INFO - PROCESS | 12628 | [#4] prototype.html Cycles:180 Average:3999.09 Median:4383.27 stddev:1174.79 (26.8%) stddev-sans-first:1144.29 13:16:24 INFO - PROCESS | 12628 | Values: 271.9 276.2 277.4 277.6 281.6 4625.5 4803.4 4809.7 4843.5 4893.0 4658.6 4793.2 4810.5 4814.0 4845.7 3538.0 3661.4 3779.2 3788.1 3790.4 3696.6 3774.5 3778.8 3782.9 3790.6 3754.7 3757.9 3758.4 3760.4 3770.6 3775.0 3779.3 3779.5 3781.7 3784.3 3072.1 3192.1 3215.7 3220.3 3304.3 4669.0 4675.0 4679.0 4679.6 4691.2 4017.7 4187.5 4196.0 4198.4 4203.1 4997.8 5003.5 5016.4 5029.5 5039.5 3454.1 3458.6 3464.6 3465.5 3474.2 5280.7 5287.8 5295.6 5295.9 5297.6 3412.5 3540.2 3549.3 3573.1 3590.8 3618.3 3620.3 3621.3 3625.3 3627.3 4164.8 4174.8 4185.7 4187.4 4192.5 4755.8 4888.9 4890.1 4926.9 5021.6 1219.1 1238.7 1240.3 1241.6 1247.9 753.9 772.8 778.6 789.4 794.8 4039.7 4045.7 4056.9 4072.0 4074.3 4536.6 4576.2 4596.4 4609.7 4615.7 4051.1 4053.9 4063.7 4064.5 4073.0 2293.4 2434.9 2438.2 2446.0 2470.7 4377.0 4381.9 4382.0 4385.7 4398.8 4669.8 4671.6 4694.4 4700.8 4706.6 4056.7 4327.7 4360.8 4363.7 4374.0 4576.2 4583.3 4596.2 4629.7 4641.5 4508.0 4518.8 4529.5 4559.9 4566.7 4100.9 4372.8 4373.8 4384.5 4408.0 3233.1 3233.5 3258.8 3292.8 3313.0 4505.2 4588.3 4620.7 4624.7 4906.5 4879.4 4892.7 5025.7 5054.6 5057.4 5044.3 5046.7 5052.6 5066.3 5066.4 4858.5 5004.4 5019.3 5023.6 5033.7 5090.8 5124.4 5124.5 5124.7 5128.2 4987.4 5004.8 5009.3 5018.8 5036.3 13:16:24 INFO - PROCESS | 12628 | 13:16:24 INFO - PROCESS | 12628 | [#5] yui.html Cycles:180 Average:18229.74 Median:4067.39 stddev:26294.91 (646.5%) stddev-sans-first:26335.57 13:16:24 INFO - PROCESS | 12628 | Values: 656.9 683.7 694.3 716.5 738.3 13337.9 14512.8 14538.6 14544.6 14549.3 13688.9 13856.2 13874.5 13894.7 13907.3 598.2 613.6 743.3 753.2 765.3 771.1 774.7 774.7 775.9 780.2 811.8 812.2 813.0 813.6 813.8 626.8 642.6 780.1 795.9 808.3 586.6 587.2 587.4 587.4 588.4 12119.1 12138.9 12151.7 12160.5 12163.3 12636.9 12881.6 13161.9 13430.4 13553.8 12127.8 12190.7 12230.7 12254.4 12528.4 4045.1 4047.5 4048.0 4061.6 4095.2 65593.0 65871.0 66160.7 66834.0 67310.7 10001.7 10140.3 10486.4 10673.8 10869.1 16841.9 17592.6 17595.6 18484.3 18526.5 6650.4 6707.0 6743.9 6774.6 7085.2 3589.9 3783.5 3792.6 3806.4 3817.8 2767.0 2877.2 2885.7 2889.6 2891.9 478.6 484.9 486.0 487.2 488.1 525.7 537.6 553.8 553.9 568.3 8158.3 8288.8 8364.1 8435.8 8765.5 484.4 523.6 530.7 548.9 582.8 3948.2 3952.4 4073.2 4196.3 4269.9 98923.5 103041.5 103286.0 103292.0 106271.5 70039.0 84487.0 87621.6 89234.0 92462.5 80154.0 80746.0 81759.6 82655.0 82722.6 8047.2 8160.2 8229.0 8273.4 8405.8 30701.2 38607.6 38918.6 42896.2 48773.5 58407.4 58952.7 60177.7 61698.7 62917.7 11154.2 11339.4 11430.6 11762.9 11863.9 12106.9 12867.7 13504.1 13833.8 14062.8 12010.6 12468.5 12570.1 12620.3 12705.3 10944.5 11393.0 11727.9 12354.9 12373.8 11952.4 12208.5 12224.1 13012.7 13036.6 9959.0 10365.7 10457.6 10525.7 10643.7 9753.3 10284.0 10354.0 10443.4 10616.0 13:16:24 INFO - PROCESS | 12628 | -------- Summary: end -------- 13:16:24 INFO - PROCESS | 12628 | 13:16:25 INFO - TEST-INFO | 12628: exit 0 13:16:25 INFO - TEST-OK | dromaeo_css | took 1123175ms 13:16:25 INFO - TEST-START | kraken 13:16:25 INFO - operating with platform_type : linux_ 13:16:25 INFO - Initialising browser for kraken test... 13:16:25 INFO - TEST-INFO | started process 12935 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzrGV89/profile http://localhost:48624/getInfo.html) 13:16:30 INFO - PROCESS | 12935 | __metrics Screen width/height:1600/1200 13:16:30 INFO - PROCESS | 12935 | colorDepth:24 13:16:30 INFO - PROCESS | 12935 | Browser inner width/height: 1024/697 13:16:30 INFO - PROCESS | 12935 | __metrics 13:16:30 INFO - PROCESS | 12935 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:16:30 INFO - PROCESS | 12935 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:16:31 INFO - PROCESS | 12935 | console.error: PushService: 13:16:31 INFO - PROCESS | 12935 | stateChangeProcessEnqueue: Error transitioning state 13:16:31 INFO - PROCESS | 12935 | UnknownError 13:16:32 INFO - TEST-INFO | 12935: exit 0 13:16:32 INFO - Browser initialized. 13:16:32 INFO - Running cycle 1/1 for kraken test... 13:16:32 INFO - TEST-INFO | started process 13015 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzrGV89/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:16:44 INFO - PROCESS | 13015 | RSS: Main: 174497792 13:16:44 INFO - PROCESS | 13015 | 13:16:47 INFO - PROCESS | 13015 | Cycle 1(1): loaded http://localhost:48624/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48624/tests/kraken/driver.html?testName=audio-beat-detection) 13:16:48 INFO - PROCESS | 13015 | RSS: Main: 233332736 13:16:48 INFO - PROCESS | 13015 | 13:16:50 INFO - PROCESS | 13015 | Cycle 1(1): loaded http://localhost:48624/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48624/tests/kraken/driver.html?testName=audio-dft) 13:16:51 INFO - PROCESS | 13015 | RSS: Main: 218247168 13:16:51 INFO - PROCESS | 13015 | 13:16:54 INFO - PROCESS | 13015 | Cycle 1(1): loaded http://localhost:48624/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48624/tests/kraken/driver.html?testName=audio-fft) 13:16:55 INFO - PROCESS | 13015 | RSS: Main: 299593728 13:16:55 INFO - PROCESS | 13015 | 13:16:57 INFO - PROCESS | 13015 | Cycle 1(1): loaded http://localhost:48624/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48624/tests/kraken/driver.html?testName=audio-oscillator) 13:16:58 INFO - PROCESS | 13015 | RSS: Main: 210849792 13:16:58 INFO - PROCESS | 13015 | 13:17:00 INFO - PROCESS | 13015 | Cycle 1(1): loaded http://localhost:48624/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48624/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:17:01 INFO - PROCESS | 13015 | RSS: Main: 214069248 13:17:01 INFO - PROCESS | 13015 | 13:17:04 INFO - PROCESS | 13015 | Cycle 1(1): loaded http://localhost:48624/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48624/tests/kraken/driver.html?testName=imaging-darkroom) 13:17:04 INFO - PROCESS | 13015 | RSS: Main: 249126912 13:17:04 INFO - PROCESS | 13015 | 13:17:08 INFO - PROCESS | 13015 | Cycle 1(1): loaded http://localhost:48624/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48624/tests/kraken/driver.html?testName=imaging-desaturate) 13:17:08 INFO - PROCESS | 13015 | RSS: Main: 243691520 13:17:08 INFO - PROCESS | 13015 | 13:17:11 INFO - PROCESS | 13015 | Cycle 1(1): loaded http://localhost:48624/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48624/tests/kraken/driver.html?testName=json-parse-financial) 13:17:12 INFO - PROCESS | 13015 | RSS: Main: 246259712 13:17:12 INFO - PROCESS | 13015 | 13:17:14 INFO - PROCESS | 13015 | Cycle 1(1): loaded http://localhost:48624/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48624/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:17:14 INFO - PROCESS | 13015 | RSS: Main: 210034688 13:17:14 INFO - PROCESS | 13015 | 13:17:16 INFO - PROCESS | 13015 | Cycle 1(1): loaded http://localhost:48624/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48624/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:17:17 INFO - PROCESS | 13015 | RSS: Main: 217268224 13:17:17 INFO - PROCESS | 13015 | 13:17:19 INFO - PROCESS | 13015 | Cycle 1(1): loaded http://localhost:48624/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48624/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:17:20 INFO - PROCESS | 13015 | RSS: Main: 226406400 13:17:20 INFO - PROCESS | 13015 | 13:17:22 INFO - PROCESS | 13015 | Cycle 1(1): loaded http://localhost:48624/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48624/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:17:23 INFO - PROCESS | 13015 | RSS: Main: 234917888 13:17:23 INFO - PROCESS | 13015 | 13:17:26 INFO - PROCESS | 13015 | Cycle 1(1): loaded http://localhost:48624/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48624/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:17:27 INFO - PROCESS | 13015 | RSS: Main: 232353792 13:17:27 INFO - PROCESS | 13015 | 13:17:29 INFO - PROCESS | 13015 | Cycle 1(1): loaded http://localhost:48624/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48624/tests/kraken/driver.html?testName=ai-astar) 13:17:29 INFO - PROCESS | 13015 | RSS: Main: 283226112 13:17:29 INFO - PROCESS | 13015 | 13:17:29 INFO - PROCESS | 13015 | __start_tp_report 13:17:29 INFO - PROCESS | 13015 | _x_x_mozilla_page_load 13:17:29 INFO - PROCESS | 13015 | _x_x_mozilla_page_load_details 13:17:29 INFO - PROCESS | 13015 | |i|pagename|runs| 13:17:29 INFO - PROCESS | 13015 | |0;ai-astar;113;116;116;114;114;116;115;115;115;115 13:17:29 INFO - PROCESS | 13015 | |1;audio-beat-detection;155;128;128;180;134;129;127;132;177;131 13:17:29 INFO - PROCESS | 13015 | |2;audio-dft;163;162;163;163;163;160;162;162;161;161 13:17:29 INFO - PROCESS | 13015 | |3;audio-fft;76;75;76;106;76;77;77;76;103;76 13:17:29 INFO - PROCESS | 13015 | |4;audio-oscillator;85;83;115;84;84;83;111;83;83;118 13:17:29 INFO - PROCESS | 13015 | |5;imaging-gaussian-blur;117;117;117;117;119;117;117;117;117;117 13:17:29 INFO - PROCESS | 13015 | |6;imaging-darkroom;148;147;147;149;149;147;147;150;148;148 13:17:29 INFO - PROCESS | 13015 | |7;imaging-desaturate;96;96;95;95;96;95;96;96;96;96 13:17:29 INFO - PROCESS | 13015 | |8;json-parse-financial;65;63;63;64;65;64;64;66;64;65 13:17:29 INFO - PROCESS | 13015 | |9;json-stringify-tinderbox;66;66;66;67;65;67;66;66;67;66 13:17:29 INFO - PROCESS | 13015 | |10;stanford-crypto-aes;84;84;84;84;91;86;90;83;83;84 13:17:29 INFO - PROCESS | 13015 | |11;stanford-crypto-ccm;144;138;140;148;144;137;138;136;176;147 13:17:29 INFO - PROCESS | 13015 | |12;stanford-crypto-pbkdf2;179;176;175;178;181;173;173;173;176;173 13:17:29 INFO - PROCESS | 13015 | |13;stanford-crypto-sha256-iterative;69;69;69;69;70;70;71;69;68;67 13:17:29 INFO - PROCESS | 13015 | __end_tp_report 13:17:29 INFO - PROCESS | 13015 | __start_cc_report 13:17:29 INFO - PROCESS | 13015 | _x_x_mozilla_cycle_collect,1947 13:17:29 INFO - PROCESS | 13015 | __end_cc_report 13:17:29 INFO - PROCESS | 13015 | __startTimestamp1476044249289__endTimestamp 13:17:29 INFO - PROCESS | 13015 | 13:17:29 INFO - PROCESS | 13015 | ------- Summary: start ------- 13:17:29 INFO - PROCESS | 13015 | Number of tests: 14 13:17:29 INFO - PROCESS | 13015 | 13:17:29 INFO - PROCESS | 13015 | [#0] ai-astar Cycles:10 Average:114.90 Median:115.00 stddev:0.99 (0.9%) stddev-sans-first:0.78 13:17:29 INFO - PROCESS | 13015 | Values: 113.0 116.0 116.0 114.0 114.0 116.0 115.0 115.0 115.0 115.0 13:17:29 INFO - PROCESS | 13015 | 13:17:29 INFO - PROCESS | 13015 | [#1] audio-beat-detection Cycles:10 Average:142.10 Median:133.00 stddev:20.84 (15.7%) stddev-sans-first:21.58 13:17:29 INFO - PROCESS | 13015 | Values: 155.0 128.0 128.0 180.0 134.0 129.0 127.0 132.0 177.0 131.0 13:17:29 INFO - PROCESS | 13015 | 13:17:29 INFO - PROCESS | 13015 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.50 stddev:1.05 (0.6%) stddev-sans-first:1.05 13:17:29 INFO - PROCESS | 13015 | Values: 163.0 162.0 163.0 163.0 163.0 160.0 162.0 162.0 161.0 161.0 13:17:29 INFO - PROCESS | 13015 | 13:17:29 INFO - PROCESS | 13015 | [#3] audio-fft Cycles:10 Average:81.80 Median:76.00 stddev:12.00 (15.8%) stddev-sans-first:12.54 13:17:29 INFO - PROCESS | 13015 | Values: 76.0 75.0 76.0 106.0 76.0 77.0 77.0 76.0 103.0 76.0 13:17:29 INFO - PROCESS | 13015 | 13:17:29 INFO - PROCESS | 13015 | [#4] audio-oscillator Cycles:10 Average:92.90 Median:83.00 stddev:15.13 (18.2%) stddev-sans-first:15.77 13:17:29 INFO - PROCESS | 13015 | Values: 85.0 83.0 115.0 84.0 84.0 83.0 111.0 83.0 83.0 118.0 13:17:29 INFO - PROCESS | 13015 | 13:17:29 INFO - PROCESS | 13015 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 13:17:29 INFO - PROCESS | 13015 | Values: 117.0 117.0 117.0 117.0 119.0 117.0 117.0 117.0 117.0 117.0 13:17:29 INFO - PROCESS | 13015 | 13:17:29 INFO - PROCESS | 13015 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:1.05 (0.7%) stddev-sans-first:1.12 13:17:29 INFO - PROCESS | 13015 | Values: 148.0 147.0 147.0 149.0 149.0 147.0 147.0 150.0 148.0 148.0 13:17:29 INFO - PROCESS | 13015 | 13:17:29 INFO - PROCESS | 13015 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 13:17:29 INFO - PROCESS | 13015 | Values: 96.0 96.0 95.0 95.0 96.0 95.0 96.0 96.0 96.0 96.0 13:17:29 INFO - PROCESS | 13015 | 13:17:29 INFO - PROCESS | 13015 | [#8] json-parse-financial Cycles:10 Average:64.30 Median:64.50 stddev:0.95 (1.5%) stddev-sans-first:0.97 13:17:29 INFO - PROCESS | 13015 | Values: 65.0 63.0 63.0 64.0 65.0 64.0 64.0 66.0 64.0 65.0 13:17:29 INFO - PROCESS | 13015 | 13:17:29 INFO - PROCESS | 13015 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 13:17:29 INFO - PROCESS | 13015 | Values: 66.0 66.0 66.0 67.0 65.0 67.0 66.0 66.0 67.0 66.0 13:17:29 INFO - PROCESS | 13015 | 13:17:29 INFO - PROCESS | 13015 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:84.00 stddev:2.87 (3.4%) stddev-sans-first:3.00 13:17:29 INFO - PROCESS | 13015 | Values: 84.0 84.0 84.0 84.0 91.0 86.0 90.0 83.0 83.0 84.0 13:17:29 INFO - PROCESS | 13015 | 13:17:29 INFO - PROCESS | 13015 | [#11] stanford-crypto-ccm Cycles:10 Average:144.80 Median:144.00 stddev:11.75 (8.2%) stddev-sans-first:12.46 13:17:29 INFO - PROCESS | 13015 | Values: 144.0 138.0 140.0 148.0 144.0 137.0 138.0 136.0 176.0 147.0 13:17:29 INFO - PROCESS | 13015 | 13:17:29 INFO - PROCESS | 13015 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.70 Median:176.00 stddev:2.87 (1.6%) stddev-sans-first:2.78 13:17:29 INFO - PROCESS | 13015 | Values: 179.0 176.0 175.0 178.0 181.0 173.0 173.0 173.0 176.0 173.0 13:17:29 INFO - PROCESS | 13015 | 13:17:29 INFO - PROCESS | 13015 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.00 stddev:1.10 (1.6%) stddev-sans-first:1.17 13:17:29 INFO - PROCESS | 13015 | Values: 69.0 69.0 69.0 69.0 70.0 70.0 71.0 69.0 68.0 67.0 13:17:29 INFO - PROCESS | 13015 | -------- Summary: end -------- 13:17:29 INFO - PROCESS | 13015 | 13:17:30 INFO - TEST-INFO | 13015: exit 0 13:17:30 INFO - TEST-OK | kraken | took 65361ms 13:17:30 INFO - SUITE-END | took 1188s 13:17:30 INFO - Completed test suite (00:19:48) 13:17:30 INFO - javascript benchmark 13:17:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2587.6247944048114, 2613.16378758797, 2628.8159828811986, 2663.5338815707246, 2664.4138289576285, 4569.840055598055, 4673.813047478106, 4744.833930812422, 4773.498782627822, 4822.300766388871, 4758.310045043467, 4764.047190561884, 4792.6165906727465, 4841.588464980472, 4892.853214403564, 4217.430646862665, 4226.682998775089, 4276.807543660543, 4293.2701440755145, 4306.590873866978, 4061.472008638873, 4363.694541382105, 4379.0366119453665, 4389.582989615981, 4451.5993560579545, 4286.035641980529, 4338.414314067592, 4426.579474949875, 4510.345999830039, 4530.026044400453, 4329.610335069828, 4346.869593912188, 4360.149770794696, 4365.934510982338, 4377.365282034088, 4359.106383191438, 4370.868873933787, 4407.1846708358735, 4426.933595996063, 4435.112977404532, 4721.598664113554, 4732.408448943882, 4758.643101767381, 4775.331453596499, 4838.564529192389, 4945.7774400152075, 5015.949840501585, 5024.0, 5070.264811602297, 5083.79664813407, 5092.465291144451, 5111.693298402108, 5112.744362781883, 5154.4072431670465, 5168.3281173447585, 4746.620270378361, 4746.95253047472, 4753.524647535288, 4758.286257061469, 4816.927746083811, 4976.427710813303, 5044.243363495505, 5213.2701421800975, 5225.242339860699, 5289.127293996447, 4859.975700121548, 4885.8289959851945, 4902.926456103161, 4914.434839993375, 4921.532454416824, 4985.675931064469, 5001.649884508122, 5067.721275329893, 5069.949300507022, 5138.434772175057, 4912.361393018885, 4977.477364876709, 5010.3737032870895, 5026.1204289249235, 5089.491050894881, 4907.5828554572545, 4947.703137811743, 4961.03259864323, 5004.724740139254, 5073.974630126826, 4264.1471705659, 4275.978620106879, 4276.508201556799, 4283.378910058024, 4315.438992930899, 3686.705063594906, 3746.269477451925, 3750.981245093757, 3786.450964610116, 3812.066043819282, 4351.412559304516, 4381.123775244963, 4410.029793445437, 4443.33349997503, 4446.377507148937, 5114.053900028507, 5114.769835357418, 5125.564327032244, 5140.537351638371, 5176.534111929869, 4429.490608580055, 4439.1121775645, 4440.089781594766, 4484.192845287879, 4498.370228168059, 4425.690201685851, 4454.554544545585, 4479.059397526556, 4514.593686568224, 4579.977100114478, 4770.570648641639, 4772.856814295576, 4790.95209047919, 4803.327534145293, 4849.127157111754, 5068.163752980717, 5069.442361340176, 5071.949280507148, 5076.796928122982, 5108.770105345194, 4660.580547750718, 4715.033418149203, 4745.572898439157, 4767.713937163781, 4829.299751536078, 5009.398872135222, 5034.421041580119, 5047.924281135859, 5102.668326558762, 5110.1568241239775, 5085.46602606721, 5116.232565115262, 5127.282180494808, 5128.076946149579, 5190.325257716473, 4802.543758342952, 4903.632227582874, 4979.800807967786, 4986.426560945392, 4991.0, 4870.415550133865, 4914.680545764514, 4924.236743304794, 4934.333864928189, 4987.9002419950675, 4850.257682292316, 4850.95149048505, 4851.95148048515, 4856.028794241095, 4914.8771280718265, 4824.734639594715, 4878.78045487961, 4961.776720047535, 4965.702057876539, 4974.228994505857, 4778.928316075192, 4796.376471058879, 4816.362436771515, 4847.491013443538, 4881.707097574157], "value": 4650.348041046352, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.6610467614754, 558.6033915919696, 564.9096144616863, 569.2457493820689, 573.6070791507817, 26415.735842641567, 36690.76257036303, 37645.24709505812, 37667.0, 41880.581194188046, 38836.80581597088, 39108.41337379941, 39151.21697566047, 39224.0, 39226.607733922654, 7522.2101679323705, 7662.425318101137, 7662.931008627667, 7664.770056898302, 7677.539347639159, 7051.506394552383, 7157.821054473654, 9574.329796914219, 9847.212223022141, 9852.605895764196, 9936.503174841266, 10019.749506262366, 10021.248406369552, 10025.548850301717, 10031.448270345129, 9838.458884761336, 9907.157891579225, 9918.553665085088, 9929.0, 9937.15534179592, 9597.856032159523, 9665.323427360088, 9667.854982175273, 9671.564779584865, 9671.90328096717, 36677.26645467076, 36842.263154737026, 36854.815725921464, 36961.44557831635, 37007.444888326696, 2868.6557613086356, 2937.2656835791054, 3035.5901953236253, 3087.428825667236, 3268.0359294008326, 27770.444591108066, 28146.296342591395, 28337.433251334856, 28732.13803585875, 29480.8525957371, 3444.448888177905, 3485.146139195888, 3504.8948531544092, 3516.1736991806906, 3648.0, 246312.0, 246330.0, 247790.0, 249506.7919226868, 249806.0, 30678.69321306803, 49005.26492102621, 49280.318369754816, 49283.50716492861, 49710.50289497131, 29814.701852981627, 31786.36427271488, 31855.681443185735, 31864.522032169534, 31900.68099318977, 11093.278936869077, 11137.220394572301, 11144.164187685956, 11152.66542003725, 11156.442177891073, 9189.40268882534, 10960.0, 11056.0, 11057.778844423228, 11062.889371106347, 7071.929280707127, 7671.654775535114, 7862.764117076496, 7953.363730901514, 7977.282044616012, 3109.720125188744, 3126.1715645353997, 3141.1361875483967, 3146.4808306629607, 3187.5218717192142, 867.2541614211773, 875.1729615513278, 876.54419701756, 907.3195103672246, 920.8342498350361, 26012.739872601032, 27166.72833271642, 27507.724922750516, 27702.722972770014, 27726.73192093496, 928.7724507495707, 929.6839074714629, 936.6019441737235, 939.4738946190155, 976.097110173087, 14429.134251944706, 14545.563633091024, 14651.633709157357, 14720.791881217903, 14754.40982360715, 350571.0, 353494.0, 354844.0, 354946.0, 355561.0, 47481.10075597007, 47559.286610700176, 47649.52350476451, 47989.0, 48084.5191548087, 1025.6102680981328, 1077.3428208792473, 1145.7536629624672, 1156.9768604627861, 1182.568362547681, 24502.0, 27378.726212737616, 28618.57072143878, 29094.27264318409, 29114.126576202747, 39833.80083099566, 40354.1929161421, 40363.0, 40381.394279086424, 40395.79802100971, 238434.0, 239254.0, 239564.0, 239923.0, 241425.0, 24053.759462405153, 24471.51056978886, 24742.752572474044, 24778.628320574844, 25848.836802343565, 39613.207735845695, 39869.10798591232, 39885.60114398935, 40339.798301008304, 40558.0, 33832.0, 33910.0, 33983.49024764581, 34219.4867076989, 34419.827900860335, 33207.0, 34293.48559771555, 34416.65583344134, 34487.4826877592, 34783.82608086943, 33712.15719606931, 33984.320313594086, 34093.0, 34298.0, 34428.82785586056, 30106.69893301039, 30306.939257125894, 31214.37571248517, 31491.212719682193, 31717.0, 23567.52864942726, 25749.3562660935, 25965.350866228495, 26007.47985040251, 26215.344616384744], "value": 16143.227680142529, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.6894872243174, 348.4424920127796, 356.93218288525185, 359.0950803973985, 383.7659027992926, 11942.999999999989, 12972.156809807368, 15386.076835389871, 15948.76076858848, 17115.144242787843, 16453.0, 16522.173891305418, 16749.91625041873, 16753.07858067806, 16821.15894205291, 4418.315161150027, 4808.735519546423, 5034.1945288753805, 5039.420466646346, 5040.647154699154, 5673.773049078032, 5820.214271073414, 5857.7364018619055, 5858.238429004224, 5865.618734782225, 4893.584045356149, 5162.741862906859, 5809.6804675742815, 5816.709164541756, 5820.767169313222, 5357.919631205535, 5376.381716102659, 5380.2736630555155, 5389.245505629215, 5396.082665946778, 5040.747962601892, 5174.404943431516, 5212.4266330703595, 5214.035403450373, 5222.503862133091, 11641.301521908712, 11737.53049878004, 11840.88159118415, 11849.822252666218, 11861.52553897843, 1865.1699993502896, 1915.3009151659544, 1960.696092105726, 2197.966955530898, 2225.721784776903, 8956.306219050024, 9032.412893161923, 9062.0, 9536.952315238448, 9542.666006689802, 1654.1811803157393, 1668.6996340658677, 1687.738400547917, 1723.5432610358266, 1738.7478815571799, 63477.0, 69652.651736741, 69788.3021169787, 70328.0, 72696.27303726948, 9695.70912872615, 9806.803863922682, 9991.650292239738, 10074.244431667654, 10106.595736170619, 10671.73320666974, 13719.794203086962, 13751.518696845762, 13762.105463144864, 13762.518311859038, 6468.223813142453, 6833.350831670983, 6903.965480172667, 6910.619915904573, 7058.858822823618, 6829.829254268584, 6835.179778426521, 6905.240423553405, 7050.330218629222, 7056.788296351015, 3591.856325746941, 3651.214988777426, 3734.738568300193, 3759.266942946154, 3791.374423220138, 1806.2413786209822, 1815.2376002079159, 1821.426250731042, 1822.9453116406528, 1858.1173942377263, 774.9341305989054, 775.4533054196778, 806.6168569929237, 834.0783434305126, 876.5836227791875, 15905.363785448453, 16452.341906323614, 16748.665026699397, 16917.0, 17436.738448923275, 805.3315747929205, 834.2450082675189, 837.3092198935781, 864.4251572704208, 866.1554983890782, 9141.954290228507, 9684.612615495442, 9723.562439690231, 9726.221902247804, 9911.15755160805, 348223.0, 359915.0, 360158.0, 360951.0, 361009.0, 70393.29606703867, 70895.64552177206, 73116.0, 74017.0, 75521.0, 415.5117736659413, 427.39310179545123, 432.13788491958746, 434.71960585422227, 434.795646046364, 9530.094641009093, 9643.807123857623, 9952.950235248778, 10095.646652367132, 10234.692959211236, 24085.0, 34973.300533988666, 35939.101522462144, 36082.45876311805, 36906.63093369139, 45524.77237613791, 48658.942548959465, 49737.50262497473, 50343.49656503388, 50393.74803125961, 6723.899141512783, 6860.0, 7006.439484841098, 7041.929580704127, 7165.605891676008, 8138.389620778584, 10216.284860059724, 10599.523021464207, 10733.785324293627, 10762.192835537522, 9169.220616247694, 9236.720964057931, 9238.861417078884, 9243.121903419433, 9541.666041688508, 9339.20616747557, 9502.23982081418, 9690.12788849007, 9713.805723885624, 9953.153981911619, 9508.809823803624, 9574.186194173573, 9605.0, 9792.127157581026, 9907.504624768877, 7197.676104575411, 7260.2739726026975, 7341.70633174667, 7525.24747525265, 7611.581363025087, 8485.703000395204, 9691.612335506501, 9694.321397502106, 9712.902870971482, 10066.899331006596], "value": 7522.4528319262, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1197.1560050164635, 1324.4304948871984, 1369.5343583181718, 1399.6570840144166, 1653.6444664397152, 6344.080108384282, 7293.307135822095, 7504.1745408005145, 7534.0582427196605, 7681.270279323456, 7501.5874126923, 7572.772816815491, 7586.4689471737, 7673.846523069536, 7684.385249180066, 2096.821770149539, 2119.671450925109, 2124.320217530391, 2125.798049185325, 2129.957400851982, 2079.979200208001, 2118.0998075817793, 2137.1237792505076, 2145.3885642591863, 2153.06341741343, 2103.295396042328, 2115.3548167808813, 2129.872207667537, 2132.626790311697, 2155.644318687415, 2034.6744520876662, 2035.7557093148769, 2038.0624912540175, 2041.8979051047536, 2048.8463365247667, 2009.859309848311, 2014.909329080195, 2044.3458093410115, 2045.7136000959877, 2047.7235573197577, 7597.772066838003, 7637.885431718529, 7693.0, 7702.460827742004, 7741.303282704527, 4283.357496375537, 4411.139827733593, 4413.315936029889, 4415.315626077963, 4492.07912377965, 2715.2804506805714, 2795.8741856616502, 2867.985660071686, 2879.6832348441653, 2881.4669286181916, 880.8150288439435, 887.041994645781, 887.40987243483, 889.2263730554395, 905.5200743605899, 10137.290389672726, 10366.118879895217, 10391.84412233817, 10414.0, 10444.738881527946, 3706.3513885070006, 3844.115853353744, 4017.1563971565715, 4019.1760689058674, 4022.2960981828064, 8961.865572016424, 8962.103789620985, 8967.506787126771, 8976.147266009719, 8977.32670049749, 4389.056352884081, 4392.07766369066, 4397.714148580332, 4398.318260669601, 4401.933970990438, 3486.9128271793406, 3628.4738712886483, 3797.6392242736897, 3970.563238043813, 3972.1658451724884, 3482.460218666111, 3581.3374525712825, 3656.780593164419, 3668.449732540087, 3671.155634204148, 1115.7322242661864, 1167.8656954450178, 1173.4602083041725, 1183.8579370475427, 1187.9524819007142, 757.4016526943652, 809.2635701511596, 809.8542262392826, 811.2090711556185, 823.4688625836421, 4816.662833601685, 4826.927596086061, 4831.4685384607665, 4993.6766756809475, 5099.566536844335, 362.1905042230612, 367.5277268709695, 379.88793305974804, 381.99045023874623, 384.2257850431383, 3373.224158443572, 3392.2537041850755, 3451.8101504416995, 3456.6197718250974, 3558.6619271169197, 9200.125988031126, 9379.577918993662, 9556.66551670702, 9600.087991640783, 9608.66369677058, 9498.905010949802, 9505.619775209052, 9506.382085164441, 9506.714798556055, 9511.286653501014, 7119.110111236096, 7151.177614574391, 7159.176694680178, 7169.784906452711, 7188.0, 4717.811287548459, 4903.210328230241, 4996.925046124384, 5183.3261675981885, 5188.936268064962, 8453.619587118472, 8699.347548933982, 8706.608202631023, 8715.041345452122, 8736.78158046054, 8527.147285271423, 8728.607212675317, 8729.738107856774, 8896.466212027299, 8977.820443591223, 5994.340622531431, 6172.166757487682, 6669.366410191024, 6794.082798822294, 6809.216940051958, 7231.783046508614, 7430.7399241026305, 7460.813479663052, 7680.500767450098, 7697.65360558765, 6456.257530384066, 6469.223693156851, 6494.123293355526, 6575.2767195607485, 6641.236257830218, 6549.836254093686, 6559.114519539801, 6581.967090164519, 6619.470442364695, 6700.865982680221, 5973.910391344047, 6052.727627256872, 6062.42406971337, 6064.211652485149, 6071.726772295169, 4225.492940846995, 4312.05134870328, 4323.718958267703, 4451.0, 4513.255312873339, 4354.390385346117, 4427.77861106937, 4467.843625473093, 4543.79552920126, 4570.223062079521], "value": 3908.126347164728, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [271.9034742666353, 276.17423902531425, 277.4174234108372, 277.60857191360185, 281.56779343707416, 4625.514320996297, 4803.423589169304, 4809.711417314964, 4843.515648435155, 4892.975535122324, 4658.627309815207, 4793.233082706767, 4810.5189481051875, 4814.013127308902, 4845.709257444556, 3537.9563028906405, 3661.418699816623, 3779.168582911755, 3788.1287303920117, 3790.4314352847086, 3696.556413230416, 3774.4527043578664, 3778.790786948178, 3782.9432558511508, 3790.564085130218, 3754.6620804127624, 3757.906052348686, 3758.4362345648233, 3760.398336266198, 3770.5852356240794, 3774.981125094371, 3779.281936432069, 3779.4708740776314, 3781.6596506314563, 3784.3377408953324, 3072.1244445333195, 3192.138122706856, 3215.742740580748, 3220.2754380264487, 3304.306095719902, 4668.976655116737, 4675.036484676444, 4679.0, 4679.60223381013, 4691.18528882671, 4017.738846974937, 4187.476565429321, 4195.958040419618, 4198.391233271189, 4203.066589368894, 4997.775100120503, 5003.524665156804, 5016.3980322361185, 5029.547340739315, 5039.47085556015, 3454.101933497284, 3458.602260740022, 3464.5842498900292, 3465.462853257724, 3474.2183008823067, 5280.656757310762, 5287.762050707727, 5295.576353891679, 5295.867603309909, 5297.576193904479, 3412.4540073588605, 3540.2034542227793, 3549.343371476285, 3573.1245844767677, 3590.838412271454, 3618.2944325856206, 3620.2940426616556, 3621.27574485104, 3625.3111908737255, 3627.3289441453417, 4164.833846522978, 4174.77038762871, 4185.707000509996, 4187.434696315959, 4192.496900371914, 4755.785989630475, 4888.853334399973, 4890.144224760653, 4926.926096108561, 5021.623378246646, 1219.1405059433077, 1238.7089034076985, 1240.34881687115, 1241.6337180531764, 1247.9064070194772, 753.898223739799, 772.7790091655171, 778.6068035641964, 789.3685051958411, 794.8410317936435, 4039.7374170678813, 4045.7255964371716, 4056.8640780581486, 4071.97964010184, 4074.30736774749, 4536.6163320187, 4576.244919588297, 4596.448426188878, 4609.677322587387, 4615.676902616851, 4051.0682543015273, 4053.932494427863, 4063.6793042261384, 4064.504526107545, 4072.979635101865, 2293.4037150340696, 2434.8782560871887, 2438.219769673723, 2445.963310550343, 2470.6905340169737, 4376.956230437655, 4381.868543943687, 4382.006187184823, 4385.671074669349, 4398.846040388571, 4669.766511674471, 4671.640821385246, 4694.43666759991, 4700.835470758507, 4706.647001474903, 4056.675465962716, 4327.740335579875, 4360.803763830635, 4363.650907927295, 4374.047517925387, 4576.176288268143, 4583.2666773316105, 4596.218642830794, 4629.749967508821, 4641.466231383434, 4507.954920450754, 4518.774061296987, 4529.456465224194, 4559.92841682211, 4566.70316429431, 4100.897477563085, 4372.846950356722, 4373.781310934504, 4384.539623339503, 4408.0245834062525, 3233.127055694902, 3233.5149727541057, 3258.820764857861, 3292.760922572578, 3312.9834350829055, 4505.234110201208, 4588.292907184777, 4620.699654522446, 4624.699394539344, 4906.484819093944, 4879.4388645304825, 4892.65751397413, 5025.673331233605, 5054.620903432184, 5057.393112826484, 5044.293798868088, 5046.697198167974, 5052.621053420935, 5066.290719299374, 5066.36670416198, 4858.465568787501, 5004.374453193351, 5019.322391477104, 5023.648344615842, 5033.748312584283, 5090.847274581768, 5124.359455068116, 5124.461931497139, 5124.718140502308, 5128.230765385222, 4987.401511818605, 5004.77478513475, 5009.273655320031, 5018.84943451697, 5036.29491871131], "value": 3620.6244671077206, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [656.9474442044635, 683.6615875141806, 694.2883544367027, 716.4841314253739, 738.2654259012284, 13337.866621333784, 14512.782308265385, 14538.636534086652, 14544.563663090124, 14549.272536373192, 13688.931555342235, 13856.168629882213, 13874.514391996283, 13894.652633684163, 13907.304634768247, 598.2163365990544, 613.6256883301182, 743.271593838039, 753.1903204055635, 765.2691679446116, 771.0631582627107, 774.7327172125607, 774.740461945249, 775.90689117306, 780.169119887321, 811.8376324735048, 812.191869090256, 813.0, 813.633864760857, 813.8494378539959, 626.8119564130742, 642.633698791689, 780.0639232920462, 795.8527672380628, 808.2604416958505, 586.6069733278714, 587.1838144978483, 587.3539106982328, 587.4184557288254, 588.4086493074476, 12119.091068169835, 12138.878611213951, 12151.696207594792, 12160.452779624939, 12163.331016794073, 12636.925861301801, 12881.613551593467, 13161.86838131616, 13430.395632196574, 13553.796693049611, 12127.846759842505, 12190.695232619168, 12230.694232644166, 12254.448549815279, 12528.373581320897, 4045.1302969861326, 4047.4535937648334, 4047.959520404788, 4061.614146656063, 4095.1809638072505, 65593.0, 65871.0, 66160.6691966537, 66834.0, 67310.66344668245, 10001.749956251151, 10140.29017968735, 10486.37081775096, 10673.83989240162, 10869.076128529163, 16841.915790420968, 17592.648147036987, 17595.64808703819, 18484.260629574936, 18526.536836579195, 6650.401463868275, 6706.966465167643, 6743.865122697617, 6774.627395493295, 7085.185203701641, 3589.9282014359565, 3783.4703141560203, 3792.60177681345, 3806.448065030555, 3817.751846129993, 2767.0, 2877.223149749556, 2885.7258560436726, 2889.5954566360724, 2891.898783542566, 478.6027597094403, 484.8787803049238, 485.9757012149378, 487.1669445248594, 488.14087206516075, 525.6714553404122, 537.6182910133849, 553.8421549858351, 553.941836107211, 568.3123420660963, 8158.3065439438315, 8288.751337459886, 8364.121767214476, 8435.83128337442, 8765.474071555727, 484.3582253514108, 523.6203752279642, 530.7213712800733, 548.8518100113027, 582.8216298190523, 3948.170884114368, 3952.427077820317, 4073.165001174752, 4196.349565817303, 4269.87190384289, 98923.50538247406, 103041.48479257556, 103286.0, 103292.0, 106271.4686426563, 70039.0, 84487.0, 87621.56189219013, 89234.0, 92462.53768731248, 80154.0, 80746.0, 81759.59120204361, 82654.99999999879, 82722.58638706768, 8047.195280471906, 8160.224778646019, 8228.958855205685, 8273.420860539945, 8405.753670962138, 30701.23246918845, 38607.6139238604, 38918.6108138915, 42896.2117462364, 48773.512264878314, 58407.37166827588, 58952.70523647354, 60177.69911150416, 61698.69150654218, 62917.685411572646, 11154.16343774204, 11339.41819162839, 11430.599929002445, 11762.882371176178, 11863.881361186277, 12106.878931210927, 12867.742645147231, 13504.054716169774, 13833.79249311241, 14062.789058163931, 12010.63968080959, 12468.5012599495, 12570.1200915935, 12620.305883176514, 12705.301208433624, 10944.452777361259, 11393.0, 11727.88272117302, 12354.876451235372, 12373.75252494963, 11952.402379881145, 12208.45061972231, 12224.083193760325, 13012.739745205232, 13036.608901732963, 9958.950205248928, 10365.689029329133, 10457.633982810565, 10525.684229473129, 10643.733906652396, 9753.268504862022, 10284.0, 10354.0, 10443.425611591436, 10616.0], "value": 6636.017637964016, "unit": "score"}], "name": "dromaeo_css", "value": 6129.485949105563, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 116.0, 116.0, 114.0, 114.0, 116.0, 115.0, 115.0, 115.0, 115.0], "value": 114.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 128.0, 128.0, 180.0, 134.0, 129.0, 127.0, 132.0, 177.0, 131.0], "value": 142.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 163.0, 163.0, 160.0, 162.0, 162.0, 161.0, 161.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 106.0, 76.0, 77.0, 77.0, 76.0, 103.0, 76.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 115.0, 84.0, 84.0, 83.0, 111.0, 83.0, 83.0, 118.0], "value": 92.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 119.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 149.0, 149.0, 147.0, 147.0, 150.0, 148.0, 148.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 63.0, 64.0, 65.0, 64.0, 64.0, 66.0, 64.0, 65.0], "value": 64.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 67.0, 65.0, 67.0, 66.0, 66.0, 67.0, 66.0], "value": 66.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 84.0, 91.0, 86.0, 90.0, 83.0, 83.0, 84.0], "value": 85.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 138.0, 140.0, 148.0, 144.0, 137.0, 138.0, 136.0, 176.0, 147.0], "value": 144.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 176.0, 175.0, 178.0, 181.0, 173.0, 173.0, 173.0, 176.0, 173.0], "value": 175.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 69.0, 69.0, 70.0, 70.0, 71.0, 69.0, 68.0, 67.0], "value": 69.1, "unit": "score"}], "name": "kraken", "value": 1560.0, "alertThreshold": 2.0}]} 13:17:31 INFO - Return code: 0 13:17:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:17:31 INFO - # TBPL SUCCESS # 13:17:31 INFO - Running post-action listener: _resource_record_post_action 13:17:31 INFO - [mozharness: 2016-10-09 20:17:31.102794Z] Finished run-tests step (success) 13:17:31 INFO - Running post-run listener: _resource_record_post_run 13:17:31 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 4096; Write bytes: 401883136; Read time: 12; Write time: 312872 13:17:31 INFO - TinderboxPrint: CPU usage
13.1% 13:17:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 13:17:31 INFO - TinderboxPrint: I/O write bytes / time
401,883,136 / 312,872 13:17:31 INFO - TinderboxPrint: CPU idle
8,351.5 (86.9%) 13:17:31 INFO - TinderboxPrint: CPU user
1,210.8 (12.6%) 13:17:31 INFO - TinderboxPrint: Swap in / out
0 / 0 13:17:31 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99991552; Read time: 0; Write time: 92172 13:17:31 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 290467840; Read time: 0; Write time: 218076 13:17:31 INFO - Running post-run listener: _upload_blobber_files 13:17:31 INFO - Blob upload gear active. 13:17:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:17:31 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:17:31 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'] 13:17:31 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 13:17:32 INFO - (blobuploader) - INFO - Open directory for files ... 13:17:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:17:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:17:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:17:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:17:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:17:32 INFO - (blobuploader) - INFO - Done attempting. 13:17:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:17:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:17:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:17:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:17:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:17:36 INFO - (blobuploader) - INFO - Done attempting. 13:17:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:17:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:17:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:17:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:17:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:17:36 INFO - (blobuploader) - INFO - Done attempting. 13:17:36 INFO - (blobuploader) - INFO - Iteration through files over. 13:17:36 INFO - Return code: 0 13:17:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:17:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:17:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/226e61bd7800bef93b9b025e50e0fea67f2e3f453038c6ed991f97e89a1d7b140ca1b792ccb89ab91fccb804bf4a2272e9e56929152f9f390d90792b65532209", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f563555b527f56a0cfef7100a83bb9936d6cb73ddf6d4b982242d7a12c7ade559d9d6cdf069eaa43de8e76b4648cc6bea4c9b28bba1fb501b6f29dd7407b8661", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b4501e89025ddf49e6d357801499277fc3e7ec426c44c18ee4798997c0ae6dd3ac0476ca00d0585bae5796d3ce3f379436b9e0be2046a334f8f466f72f94f9ad"} 13:17:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:17:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:17:36 INFO - Contents: 13:17:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/226e61bd7800bef93b9b025e50e0fea67f2e3f453038c6ed991f97e89a1d7b140ca1b792ccb89ab91fccb804bf4a2272e9e56929152f9f390d90792b65532209", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f563555b527f56a0cfef7100a83bb9936d6cb73ddf6d4b982242d7a12c7ade559d9d6cdf069eaa43de8e76b4648cc6bea4c9b28bba1fb501b6f29dd7407b8661", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b4501e89025ddf49e6d357801499277fc3e7ec426c44c18ee4798997c0ae6dd3ac0476ca00d0585bae5796d3ce3f379436b9e0be2046a334f8f466f72f94f9ad"} 13:17:36 INFO - Running post-run listener: copy_logs_to_upload_dir 13:17:36 INFO - Copying logs to upload dir... 13:17:36 INFO - mkdir: /builds/slave/test/build/upload/logs 13:17:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.247940 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-10-09 13:17:34.857003) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-09 13:17:34.860176) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1476042686.211614-1908415340 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/226e61bd7800bef93b9b025e50e0fea67f2e3f453038c6ed991f97e89a1d7b140ca1b792ccb89ab91fccb804bf4a2272e9e56929152f9f390d90792b65532209", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f563555b527f56a0cfef7100a83bb9936d6cb73ddf6d4b982242d7a12c7ade559d9d6cdf069eaa43de8e76b4648cc6bea4c9b28bba1fb501b6f29dd7407b8661", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b4501e89025ddf49e6d357801499277fc3e7ec426c44c18ee4798997c0ae6dd3ac0476ca00d0585bae5796d3ce3f379436b9e0be2046a334f8f466f72f94f9ad"} build_url:https://queue.taskcluster.net/v1/task/S9Uz76SgQEack33oXFvg3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011395 build_url: 'https://queue.taskcluster.net/v1/task/S9Uz76SgQEack33oXFvg3g/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/226e61bd7800bef93b9b025e50e0fea67f2e3f453038c6ed991f97e89a1d7b140ca1b792ccb89ab91fccb804bf4a2272e9e56929152f9f390d90792b65532209", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f563555b527f56a0cfef7100a83bb9936d6cb73ddf6d4b982242d7a12c7ade559d9d6cdf069eaa43de8e76b4648cc6bea4c9b28bba1fb501b6f29dd7407b8661", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b4501e89025ddf49e6d357801499277fc3e7ec426c44c18ee4798997c0ae6dd3ac0476ca00d0585bae5796d3ce3f379436b9e0be2046a334f8f466f72f94f9ad"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-09 13:17:34.885468) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-09 13:17:34.885786) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1476042686.211614-1908415340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004506 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-09 13:17:34.968920) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-09 13:17:34.969282) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-09 13:17:34.969647) ========= ========= Total master_lag: 0.16 =========