builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-017 starttime: 1475644479.45 results: success (0) buildid: 20161004195000 builduid: c97035c1b3cb45fe9a32fe92fd8b415a revision: d3366b063f5231867f2cea79ae229ac4b4e2c63b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 22:14:39.448128) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 22:14:39.448564) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 22:14:39.448862) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 22:14:39.521692) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 22:14:39.522044) ========= 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=0333a256a5e4f052382dd180000001b1-1475643662.990995-2126107780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-04 22:14:40-- 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% 112M=0s 2016-10-04 22:14:40 (112 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.144719 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 22:14:39.685301) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 22:14:39.685599) ========= 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=0333a256a5e4f052382dd180000001b1-1475643662.990995-2126107780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018805 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 22:14:39.742427) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-04 22:14:39.742781) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d3366b063f5231867f2cea79ae229ac4b4e2c63b --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 d3366b063f5231867f2cea79ae229ac4b4e2c63b --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=0333a256a5e4f052382dd180000001b1-1475643662.990995-2126107780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-04 22:14:40,280 truncating revision to first 12 chars 2016-10-04 22:14:40,280 Setting DEBUG logging. 2016-10-04 22:14:40,280 attempt 1/10 2016-10-04 22:14:40,280 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d3366b063f52?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-04 22:14:41,069 unpacking tar archive at: fx-team-d3366b063f52/testing/mozharness/ program finished with exit code 0 elapsedTime=1.100751 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-04 22:14:40.861349) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 22:14:40.862020) ========= script_repo_revision: d3366b063f5231867f2cea79ae229ac4b4e2c63b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 22:14:40.862469) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 22:14:40.862772) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 22:14:40.871994) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-10-04 22:14:40.872284) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=0333a256a5e4f052382dd180000001b1-1475643662.990995-2126107780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:14:41 INFO - MultiFileLogger online at 20161004 22:14:41 in /builds/slave/test 22:14:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 22:14:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:14:41 INFO - {'append_to_log': False, 22:14:41 INFO - 'base_work_dir': '/builds/slave/test', 22:14:41 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:14:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:14:41 INFO - 'branch': 'Fx-Team-Non-PGO', 22:14:41 INFO - 'buildbot_json_path': 'buildprops.json', 22:14:41 INFO - 'config_files': ('talos/linux_config.py',), 22:14:41 INFO - 'default_actions': ('clobber', 22:14:41 INFO - 'read-buildbot-config', 22:14:41 INFO - 'download-and-extract', 22:14:41 INFO - 'populate-webroot', 22:14:41 INFO - 'create-virtualenv', 22:14:41 INFO - 'install', 22:14:41 INFO - 'run-tests'), 22:14:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:14:41 INFO - 'download_minidump_stackwalk': True, 22:14:41 INFO - 'download_symbols': 'ondemand', 22:14:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:14:41 INFO - 'tooltool.py': '/tools/tooltool.py', 22:14:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:14:41 INFO - '/tools/misc-python/virtualenv.py')}, 22:14:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:14:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:14:41 INFO - 'installer_path': 'installer.exe', 22:14:41 INFO - 'log_level': 'info', 22:14:41 INFO - 'log_name': 'talos', 22:14:41 INFO - 'log_to_console': True, 22:14:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:14:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:14:41 INFO - 'opt_config_files': (), 22:14:41 INFO - 'pip_index': False, 22:14:41 INFO - 'sps_profile': False, 22:14:41 INFO - 'sps_profile_interval': 0, 22:14:41 INFO - 'suite': 'dromaeojs-e10s', 22:14:41 INFO - 'system_bits': '32', 22:14:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:14:41 INFO - 'title': 'talos-linux64-ix-017', 22:14:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:14:41 INFO - 'use_talos_json': True, 22:14:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:14:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:14:41 INFO - 'work_dir': 'build'} 22:14:41 INFO - [mozharness: 2016-10-05 05:14:41.509685Z] Running clobber step. 22:14:41 INFO - Running pre-action listener: _resource_record_pre_action 22:14:41 INFO - Running main action method: clobber 22:14:41 INFO - rmtree: /builds/slave/test/build 22:14:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:14:42 INFO - Running post-action listener: _resource_record_post_action 22:14:42 INFO - [mozharness: 2016-10-05 05:14:42.495503Z] Finished clobber step (success) 22:14:42 INFO - [mozharness: 2016-10-05 05:14:42.495602Z] Running read-buildbot-config step. 22:14:42 INFO - Running pre-action listener: _resource_record_pre_action 22:14:42 INFO - Running main action method: read_buildbot_config 22:14:42 INFO - Using buildbot properties: 22:14:42 INFO - { 22:14:42 INFO - "project": "", 22:14:42 INFO - "product": "firefox", 22:14:42 INFO - "script_repo_revision": "production", 22:14:42 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 22:14:42 INFO - "repository": "", 22:14:42 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 22:14:42 INFO - "buildid": "20161004195000", 22:14:42 INFO - "pgo_build": "False", 22:14:42 INFO - "basedir": "/builds/slave/test", 22:14:42 INFO - "buildnumber": 1830, 22:14:42 INFO - "slavename": "talos-linux64-ix-017", 22:14:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:14:42 INFO - "platform": "ubuntu64_hw", 22:14:42 INFO - "scheduler": "tests-fx-team-linux64-talos-8-3600", 22:14:42 INFO - "branch": "fx-team", 22:14:42 INFO - "repo_path": "integration/fx-team", 22:14:42 INFO - "revision": "d3366b063f5231867f2cea79ae229ac4b4e2c63b", 22:14:42 INFO - "stage_platform": "linux64", 22:14:42 INFO - "builduid": "c97035c1b3cb45fe9a32fe92fd8b415a", 22:14:42 INFO - "slavebuilddir": "test" 22:14:42 INFO - } 22:14:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/Pg9wISahRH--Kd5U-XBntg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 22:14:42 INFO - Running post-action listener: _resource_record_post_action 22:14:42 INFO - [mozharness: 2016-10-05 05:14:42.498051Z] Finished read-buildbot-config step (success) 22:14:42 INFO - [mozharness: 2016-10-05 05:14:42.498139Z] Running download-and-extract step. 22:14:42 INFO - Running pre-action listener: _resource_record_pre_action 22:14:42 INFO - Running main action method: download_and_extract 22:14:42 INFO - mkdir: /builds/slave/test/build/tests 22:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:14:42 INFO - trying https://queue.taskcluster.net/v1/task/Pg9wISahRH--Kd5U-XBntg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 22:14:42 INFO - Downloading https://queue.taskcluster.net/v1/task/Pg9wISahRH--Kd5U-XBntg/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 22:14:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pg9wISahRH--Kd5U-XBntg/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 22:14:43 INFO - Downloaded 1361 bytes. 22:14:43 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 22:14:43 INFO - Using the following test package requirements: 22:14:43 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 22:14:43 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:14:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:14:43 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:14:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:14:43 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:14:43 INFO - u'jsshell-linux-x86_64.zip'], 22:14:43 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:14:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:14:43 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 22:14:43 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:14:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:14:43 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:14:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:14:43 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:14:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:14:43 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:14:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:14:43 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:14:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Pg9wISahRH--Kd5U-XBntg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 22:14:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pg9wISahRH--Kd5U-XBntg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:14:43 INFO - Fetch https://queue.taskcluster.net/v1/task/Pg9wISahRH--Kd5U-XBntg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:14:43 INFO - Http code: 200 22:14:43 INFO - via: 1.1 5574699f9d8b8aad21acf2edbb25dc62.cloudfront.net (CloudFront) 22:14:43 INFO - x-amz-cf-id: HvopN01-0LB-da2DWMuOzt9gaxEbdMU2SV0fVoVJSyhkv_pYFPTlpA== 22:14:43 INFO - x-amz-version-id: JUByfU3mY0DIVWV9s5xppX69FJaTb2XP 22:14:43 INFO - Expected file size: 20421173 22:14:43 INFO - Obtained file size: 20421173 22:14:47 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 22:14:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Pg9wISahRH--Kd5U-XBntg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 22:14:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pg9wISahRH--Kd5U-XBntg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:14:47 INFO - Fetch https://queue.taskcluster.net/v1/task/Pg9wISahRH--Kd5U-XBntg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:14:48 INFO - Http code: 200 22:14:48 INFO - via: 1.1 296faebadd40feee8b2eb0e10d5786d2.cloudfront.net (CloudFront) 22:14:48 INFO - x-amz-cf-id: 6j0TpN940qfg5_XTh8HP_W6I174eCnd_iUQ0SRIRMthqwzQdQu5f3g== 22:14:48 INFO - x-amz-version-id: JUByfU3mY0DIVWV9s5xppX69FJaTb2XP 22:14:48 INFO - Expected file size: 20421173 22:14:48 INFO - Obtained file size: 20421173 22:14:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Pg9wISahRH--Kd5U-XBntg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 22:14:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pg9wISahRH--Kd5U-XBntg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:14:53 INFO - Fetch https://queue.taskcluster.net/v1/task/Pg9wISahRH--Kd5U-XBntg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 22:14:53 INFO - Http code: 200 22:14:53 INFO - via: 1.1 373880a309382d9266a9313233b86d25.cloudfront.net (CloudFront) 22:14:53 INFO - x-amz-cf-id: -XkeRRsRrHUkag_iciTYw9TvxrX-u41Kp0-XmXQMff5rgNCweh1qww== 22:14:53 INFO - x-amz-version-id: JvpHw27NXvCLwc31uyR3c1ndsn7q4YUC 22:14:53 INFO - Expected file size: 14409006 22:14:53 INFO - Obtained file size: 14409006 22:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:14:54 INFO - trying https://queue.taskcluster.net/v1/task/Pg9wISahRH--Kd5U-XBntg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:14:54 INFO - Downloading https://queue.taskcluster.net/v1/task/Pg9wISahRH--Kd5U-XBntg/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 22:14:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pg9wISahRH--Kd5U-XBntg/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 22:14:55 INFO - Downloaded 55787526 bytes. 22:14:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Pg9wISahRH--Kd5U-XBntg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:14:55 INFO - mkdir: /builds/slave/test/properties 22:14:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:14:55 INFO - Writing to file /builds/slave/test/properties/build_url 22:14:55 INFO - Contents: 22:14:55 INFO - build_url:https://queue.taskcluster.net/v1/task/Pg9wISahRH--Kd5U-XBntg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:14:56 INFO - Running post-action listener: _resource_record_post_action 22:14:56 INFO - Running post-action listener: set_extra_try_arguments 22:14:56 INFO - [mozharness: 2016-10-05 05:14:56.023621Z] Finished download-and-extract step (success) 22:14:56 INFO - [mozharness: 2016-10-05 05:14:56.023849Z] Running populate-webroot step. 22:14:56 INFO - Running pre-action listener: _resource_record_pre_action 22:14:56 INFO - Running main action method: populate_webroot 22:14:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:14:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:14:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:14:56 INFO - '--tppagecycles', 22:14:56 INFO - '7'], 22:14:56 INFO - 'tests': ['tsvgm']}}, 22:14:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:14:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:14:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:14:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:14:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:14:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:14:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:14:56 INFO - 'talos_options': ['--disable-e10s'], 22:14:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:14:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:14:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:14:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:14:56 INFO - 'talos_options': ['--disable-e10s'], 22:14:56 INFO - 'tests': ['damp', 'tps']}, 22:14:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:14:56 INFO - 'tests': ['damp', 'tps']}, 22:14:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:14:56 INFO - 'tests': ['dromaeo_dom']}, 22:14:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:14:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:14:56 INFO - 'tests': ['basic_compositor_video']}, 22:14:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:14:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:14:56 INFO - 'tests': ['a11yr', 22:14:56 INFO - 'ts_paint', 22:14:56 INFO - 'tpaint', 22:14:56 INFO - 'sessionrestore', 22:14:56 INFO - 'sessionrestore_no_auto_restore', 22:14:56 INFO - 'tabpaint']}, 22:14:56 INFO - 'other-e10s': {'tests': ['a11yr', 22:14:56 INFO - 'ts_paint', 22:14:56 INFO - 'tpaint', 22:14:56 INFO - 'sessionrestore', 22:14:56 INFO - 'sessionrestore_no_auto_restore', 22:14:56 INFO - 'tabpaint']}, 22:14:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:14:56 INFO - 'ts_paint', 22:14:56 INFO - 'tpaint', 22:14:56 INFO - 'sessionrestore', 22:14:56 INFO - 'sessionrestore_no_auto_restore', 22:14:56 INFO - 'tabpaint']}, 22:14:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:14:56 INFO - 'ts_paint', 22:14:56 INFO - 'tpaint', 22:14:56 INFO - 'sessionrestore', 22:14:56 INFO - 'sessionrestore_no_auto_restore', 22:14:56 INFO - 'tabpaint']}, 22:14:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:14:56 INFO - 'tests': ['a11yr', 22:14:56 INFO - 'ts_paint', 22:14:56 INFO - 'tpaint', 22:14:56 INFO - 'sessionrestore', 22:14:56 INFO - 'sessionrestore_no_auto_restore', 22:14:56 INFO - 'tabpaint']}, 22:14:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:14:56 INFO - 'tests': ['a11yr', 22:14:56 INFO - 'ts_paint', 22:14:56 INFO - 'tpaint', 22:14:56 INFO - 'sessionrestore', 22:14:56 INFO - 'sessionrestore_no_auto_restore', 22:14:56 INFO - 'tabpaint']}, 22:14:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:14:56 INFO - 'tests': ['tsvgx', 22:14:56 INFO - 'tsvgr_opacity', 22:14:56 INFO - 'tart', 22:14:56 INFO - 'tscrollx', 22:14:56 INFO - 'cart']}, 22:14:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:14:56 INFO - 'tsvgr_opacity', 22:14:56 INFO - 'tart', 22:14:56 INFO - 'tscrollx', 22:14:56 INFO - 'cart']}, 22:14:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:14:56 INFO - 'talos_options': ['--disable-e10s'], 22:14:56 INFO - 'tests': ['tp5o']}, 22:14:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:14:56 INFO - 'tests': ['tp5o']}, 22:14:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:14:56 INFO - 'talos_options': ['--disable-e10s', 22:14:56 INFO - '--xperf_path', 22:14:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:14:56 INFO - 'tests': ['tp5n']}, 22:14:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:14:56 INFO - 'talos_options': ['--xperf_path', 22:14:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:14:56 INFO - 'tests': ['tp5n']}}, 22:14:56 INFO - 'talos.zip': {'path': '', 22:14:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:14:56 INFO - Running post-action listener: _resource_record_post_action 22:14:56 INFO - [mozharness: 2016-10-05 05:14:56.045773Z] Finished populate-webroot step (success) 22:14:56 INFO - [mozharness: 2016-10-05 05:14:56.045861Z] Running create-virtualenv step. 22:14:56 INFO - Running pre-action listener: _resource_record_pre_action 22:14:56 INFO - Running main action method: create_virtualenv 22:14:56 INFO - Creating virtualenv /builds/slave/test/build/venv 22:14:56 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 22:14:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:14:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:14:56 INFO - Using real prefix '/usr' 22:14:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:14:56 INFO - Installing distribute.............................................................................................................................................................................................done. 22:14:58 INFO - Installing pip.................done. 22:14:58 INFO - Return code: 0 22:14:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:14:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:14:58 INFO - Reading from file tmpfile_stdout 22:14:58 INFO - Output received: 22:14:58 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) 22:14:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:14:58 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')]} 22:14:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:14:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:58 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')]} 22:14:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:14:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:58 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 0x7f765d433f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2029f60>, '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 0x202ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202b1d0>, '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': '0333a256a5e4f052382dd180000001b1-1475643662.990995-2126107780', '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 22:14:58 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 22:14:58 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 22:14:58 INFO - Using env: {'DISPLAY': ':0', 22:14:58 INFO - 'HOME': '/home/cltbld', 22:14:58 INFO - 'LANG': 'en_US.UTF-8', 22:14:58 INFO - 'LANGUAGE': 'en_US:en', 22:14:58 INFO - 'LOGNAME': 'cltbld', 22:14:58 INFO - 'MAIL': '/var/mail/cltbld', 22:14:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:14:58 INFO - 'MOZ_NO_REMOTE': '1', 22:14:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:14:58 INFO - 'NO_EM_RESTART': '1', 22:14:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:14:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:14:58 INFO - 'PWD': '/builds/slave/test', 22:14:58 INFO - 'SHELL': '/bin/bash', 22:14:58 INFO - 'SHLVL': '1', 22:14:58 INFO - 'TERM': 'linux', 22:14:58 INFO - 'TMOUT': '86400', 22:14:58 INFO - 'USER': 'cltbld', 22:14:58 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1475643662.990995-2126107780', 22:14:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:14:58 INFO - '_': '/tools/buildbot/bin/python'} 22:14:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:14:59 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 22:14:59 INFO - Cleaning up... 22:14:59 INFO - Return code: 0 22:14:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:14:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:14:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:14:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:14:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:59 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 0x7f765d433f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2029f60>, '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 0x202ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202b1d0>, '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': '0333a256a5e4f052382dd180000001b1-1475643662.990995-2126107780', '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 22:14:59 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 22:14:59 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 22:14:59 INFO - Using env: {'DISPLAY': ':0', 22:14:59 INFO - 'HOME': '/home/cltbld', 22:14:59 INFO - 'LANG': 'en_US.UTF-8', 22:14:59 INFO - 'LANGUAGE': 'en_US:en', 22:14:59 INFO - 'LOGNAME': 'cltbld', 22:14:59 INFO - 'MAIL': '/var/mail/cltbld', 22:14:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:14:59 INFO - 'MOZ_NO_REMOTE': '1', 22:14:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:14:59 INFO - 'NO_EM_RESTART': '1', 22:14:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:14:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:14:59 INFO - 'PWD': '/builds/slave/test', 22:14:59 INFO - 'SHELL': '/bin/bash', 22:14:59 INFO - 'SHLVL': '1', 22:14:59 INFO - 'TERM': 'linux', 22:14:59 INFO - 'TMOUT': '86400', 22:14:59 INFO - 'USER': 'cltbld', 22:14:59 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1475643662.990995-2126107780', 22:14:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:14:59 INFO - '_': '/tools/buildbot/bin/python'} 22:14:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:14:59 INFO - Downloading/unpacking psutil>=3.1.1 22:14:59 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 22:14:59 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 22:14:59 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 22:14:59 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 22:14:59 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 22:14:59 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 22:15:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:15:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:15:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:15:01 INFO - Installing collected packages: psutil 22:15:01 INFO - Running setup.py install for psutil 22:15:01 INFO - building 'psutil._psutil_linux' extension 22:15:01 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 22:15:01 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 22:15:01 INFO - building 'psutil._psutil_posix' extension 22:15:01 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 22:15:01 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 22:15:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:15:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:15:01 INFO - Successfully installed psutil 22:15:01 INFO - Cleaning up... 22:15:01 INFO - Return code: 0 22:15:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:15:01 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')]} 22:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:15:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:01 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')]} 22:15:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:15:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:01 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 0x7f765d433f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2029f60>, '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 0x202ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202b1d0>, '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': '0333a256a5e4f052382dd180000001b1-1475643662.990995-2126107780', '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 22:15:01 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 22:15:01 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 22:15:01 INFO - Using env: {'DISPLAY': ':0', 22:15:01 INFO - 'HOME': '/home/cltbld', 22:15:01 INFO - 'LANG': 'en_US.UTF-8', 22:15:01 INFO - 'LANGUAGE': 'en_US:en', 22:15:01 INFO - 'LOGNAME': 'cltbld', 22:15:01 INFO - 'MAIL': '/var/mail/cltbld', 22:15:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:15:01 INFO - 'MOZ_NO_REMOTE': '1', 22:15:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:15:01 INFO - 'NO_EM_RESTART': '1', 22:15:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:15:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:15:01 INFO - 'PWD': '/builds/slave/test', 22:15:01 INFO - 'SHELL': '/bin/bash', 22:15:01 INFO - 'SHLVL': '1', 22:15:01 INFO - 'TERM': 'linux', 22:15:01 INFO - 'TMOUT': '86400', 22:15:01 INFO - 'USER': 'cltbld', 22:15:01 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1475643662.990995-2126107780', 22:15:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:15:01 INFO - '_': '/tools/buildbot/bin/python'} 22:15:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:15:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:15:02 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 22:15:02 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 22:15:02 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 22:15:02 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 22:15:02 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 22:15:02 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 22:15:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:15:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:15:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:15:04 INFO - Installing collected packages: mozsystemmonitor 22:15:04 INFO - Running setup.py install for mozsystemmonitor 22:15:04 INFO - Successfully installed mozsystemmonitor 22:15:04 INFO - Cleaning up... 22:15:04 INFO - Return code: 0 22:15:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:15:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:15:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:15:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:04 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 0x7f765d433f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2029f60>, '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 0x202ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202b1d0>, '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': '0333a256a5e4f052382dd180000001b1-1475643662.990995-2126107780', '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 22:15:04 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 22:15:04 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 22:15:04 INFO - Using env: {'DISPLAY': ':0', 22:15:04 INFO - 'HOME': '/home/cltbld', 22:15:04 INFO - 'LANG': 'en_US.UTF-8', 22:15:04 INFO - 'LANGUAGE': 'en_US:en', 22:15:04 INFO - 'LOGNAME': 'cltbld', 22:15:04 INFO - 'MAIL': '/var/mail/cltbld', 22:15:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:15:04 INFO - 'MOZ_NO_REMOTE': '1', 22:15:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:15:04 INFO - 'NO_EM_RESTART': '1', 22:15:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:15:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:15:04 INFO - 'PWD': '/builds/slave/test', 22:15:04 INFO - 'SHELL': '/bin/bash', 22:15:04 INFO - 'SHLVL': '1', 22:15:04 INFO - 'TERM': 'linux', 22:15:04 INFO - 'TMOUT': '86400', 22:15:04 INFO - 'USER': 'cltbld', 22:15:04 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1475643662.990995-2126107780', 22:15:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:15:04 INFO - '_': '/tools/buildbot/bin/python'} 22:15:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:15:04 INFO - Downloading/unpacking jsonschema==2.5.1 22:15:04 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 22:15:04 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 22:15:04 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 22:15:04 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 22:15:04 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 22:15:04 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 22:15:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:15:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:15: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 22:15: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 22:15: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 22:15: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 22:15: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 22:15: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 22:15:06 INFO - Downloading functools32-3.2.3-2.tar.gz 22:15:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:15:06 INFO - warning: no files found matching '*.txt' 22:15:06 INFO - no previously-included directories found matching 'build' 22:15:06 INFO - no previously-included directories found matching 'dist' 22:15:06 INFO - no previously-included directories found matching '.git*' 22:15:06 INFO - Installing collected packages: jsonschema, functools32 22:15:06 INFO - Running setup.py install for functools32 22:15:06 INFO - warning: no files found matching '*.txt' 22:15:06 INFO - no previously-included directories found matching 'build' 22:15:06 INFO - no previously-included directories found matching 'dist' 22:15:06 INFO - no previously-included directories found matching '.git*' 22:15:06 INFO - Successfully installed jsonschema functools32 22:15:06 INFO - Cleaning up... 22:15:06 INFO - Return code: 0 22:15:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:15: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')]} 22:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:15:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15: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')]} 22:15:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:15:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15: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', '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 0x7f765d433f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2029f60>, '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 0x202ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202b1d0>, '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': '0333a256a5e4f052382dd180000001b1-1475643662.990995-2126107780', '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 22:15: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 22:15: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 functools32==3.2.3-2 22:15:06 INFO - Using env: {'DISPLAY': ':0', 22:15:06 INFO - 'HOME': '/home/cltbld', 22:15:06 INFO - 'LANG': 'en_US.UTF-8', 22:15:06 INFO - 'LANGUAGE': 'en_US:en', 22:15:06 INFO - 'LOGNAME': 'cltbld', 22:15:06 INFO - 'MAIL': '/var/mail/cltbld', 22:15:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:15:06 INFO - 'MOZ_NO_REMOTE': '1', 22:15:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:15:06 INFO - 'NO_EM_RESTART': '1', 22:15:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:15:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:15:06 INFO - 'PWD': '/builds/slave/test', 22:15:06 INFO - 'SHELL': '/bin/bash', 22:15:06 INFO - 'SHLVL': '1', 22:15:06 INFO - 'TERM': 'linux', 22:15:06 INFO - 'TMOUT': '86400', 22:15:06 INFO - 'USER': 'cltbld', 22:15:06 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1475643662.990995-2126107780', 22:15:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:15:06 INFO - '_': '/tools/buildbot/bin/python'} 22:15:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:15:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:15:06 INFO - Cleaning up... 22:15:06 INFO - Return code: 0 22:15:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:15: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')]} 22:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:15:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15: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')]} 22:15:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:15:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:07 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 0x7f765d433f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2029f60>, '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 0x202ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202b1d0>, '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': '0333a256a5e4f052382dd180000001b1-1475643662.990995-2126107780', '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 22:15:07 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 22:15:07 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 22:15:07 INFO - Using env: {'DISPLAY': ':0', 22:15:07 INFO - 'HOME': '/home/cltbld', 22:15:07 INFO - 'LANG': 'en_US.UTF-8', 22:15:07 INFO - 'LANGUAGE': 'en_US:en', 22:15:07 INFO - 'LOGNAME': 'cltbld', 22:15:07 INFO - 'MAIL': '/var/mail/cltbld', 22:15:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:15:07 INFO - 'MOZ_NO_REMOTE': '1', 22:15:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:15:07 INFO - 'NO_EM_RESTART': '1', 22:15:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:15:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:15:07 INFO - 'PWD': '/builds/slave/test', 22:15:07 INFO - 'SHELL': '/bin/bash', 22:15:07 INFO - 'SHLVL': '1', 22:15:07 INFO - 'TERM': 'linux', 22:15:07 INFO - 'TMOUT': '86400', 22:15:07 INFO - 'USER': 'cltbld', 22:15:07 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1475643662.990995-2126107780', 22:15:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:15:07 INFO - '_': '/tools/buildbot/bin/python'} 22:15:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:15:07 INFO - Downloading/unpacking blobuploader==1.2.4 22:15:07 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 22:15:07 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 22:15:07 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 22:15:07 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 22:15:07 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 22:15:07 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 22:15:09 INFO - Downloading blobuploader-1.2.4.tar.gz 22:15:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:15:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:15: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 22:15: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 22:15: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 22:15: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 22:15: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 22:15: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 22:15:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:15:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:15: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 22:15: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 22:15: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 22:15: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 22:15: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 22:15: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 22:15:09 INFO - Downloading docopt-0.6.1.tar.gz 22:15:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:15:09 INFO - Installing collected packages: blobuploader, requests, docopt 22:15:09 INFO - Running setup.py install for blobuploader 22:15:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:15:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:15:09 INFO - Running setup.py install for requests 22:15:10 INFO - Running setup.py install for docopt 22:15:10 INFO - Successfully installed blobuploader requests docopt 22:15:10 INFO - Cleaning up... 22:15:10 INFO - Return code: 0 22:15:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:15:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:15:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:15:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:15:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:10 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 0x7f765d433f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2029f60>, '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 0x202ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202b1d0>, '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': '0333a256a5e4f052382dd180000001b1-1475643662.990995-2126107780', '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 22:15:10 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 22:15:10 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 22:15:10 INFO - Using env: {'DISPLAY': ':0', 22:15:10 INFO - 'HOME': '/home/cltbld', 22:15:10 INFO - 'LANG': 'en_US.UTF-8', 22:15:10 INFO - 'LANGUAGE': 'en_US:en', 22:15:10 INFO - 'LOGNAME': 'cltbld', 22:15:10 INFO - 'MAIL': '/var/mail/cltbld', 22:15:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:15:10 INFO - 'MOZ_NO_REMOTE': '1', 22:15:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:15:10 INFO - 'NO_EM_RESTART': '1', 22:15:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:15:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:15:10 INFO - 'PWD': '/builds/slave/test', 22:15:10 INFO - 'SHELL': '/bin/bash', 22:15:10 INFO - 'SHLVL': '1', 22:15:10 INFO - 'TERM': 'linux', 22:15:10 INFO - 'TMOUT': '86400', 22:15:10 INFO - 'USER': 'cltbld', 22:15:10 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1475643662.990995-2126107780', 22:15:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:15:10 INFO - '_': '/tools/buildbot/bin/python'} 22:15:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:15:10 INFO - Running setup.py (path:/tmp/pip-ZOGWJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:15:10 INFO - Running setup.py (path:/tmp/pip-LPZJot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:15:10 INFO - Running setup.py (path:/tmp/pip-StGNp5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:15:10 INFO - Running setup.py (path:/tmp/pip-4yBvQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:15:10 INFO - Running setup.py (path:/tmp/pip-NGSw3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:15:11 INFO - Running setup.py (path:/tmp/pip-yG6ZZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:15:11 INFO - Running setup.py (path:/tmp/pip-vGLss5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:15:11 INFO - Running setup.py (path:/tmp/pip-YmZykc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:15:11 INFO - Running setup.py (path:/tmp/pip-__XeqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:15:11 INFO - Running setup.py (path:/tmp/pip-PxHhup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:15:11 INFO - Running setup.py (path:/tmp/pip-Cvwx_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:15:11 INFO - Running setup.py (path:/tmp/pip-0s4Fsv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:15:11 INFO - Running setup.py (path:/tmp/pip-7U02Js-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:15:11 INFO - Running setup.py (path:/tmp/pip-zkD5Gw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:15:11 INFO - Running setup.py (path:/tmp/pip-Xn1eRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:15:11 INFO - Running setup.py (path:/tmp/pip-Ybb0m7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:15:11 INFO - Running setup.py (path:/tmp/pip-ANeVWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:15:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:15:11 INFO - Running setup.py install for manifestparser 22:15:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:15:12 INFO - Running setup.py install for mozcrash 22:15:12 INFO - Running setup.py install for mozdebug 22:15:12 INFO - Running setup.py install for mozdevice 22:15:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:15:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:15:12 INFO - Running setup.py install for mozfile 22:15:12 INFO - Running setup.py install for mozhttpd 22:15:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:15:12 INFO - Running setup.py install for mozinfo 22:15:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:15:12 INFO - Running setup.py install for mozInstall 22:15:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:15:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:15:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:15:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:15:12 INFO - Running setup.py install for mozleak 22:15:12 INFO - Running setup.py install for mozlog 22:15:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:15:12 INFO - Running setup.py install for moznetwork 22:15:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:15:13 INFO - Running setup.py install for mozprocess 22:15:13 INFO - Running setup.py install for mozprofile 22:15:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:15:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:15:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:15:13 INFO - Running setup.py install for mozrunner 22:15:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:15:13 INFO - Running setup.py install for mozscreenshot 22:15:13 INFO - Running setup.py install for moztest 22:15:13 INFO - Running setup.py install for mozversion 22:15:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:15:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:15:13 INFO - Cleaning up... 22:15:13 INFO - Return code: 0 22:15:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:15: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')]} 22:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:15:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15: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')]} 22:15:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:15:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:13 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 0x7f765d433f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2029f60>, '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 0x202ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202b1d0>, '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': '0333a256a5e4f052382dd180000001b1-1475643662.990995-2126107780', '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 22:15:13 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 22:15:13 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 22:15:13 INFO - Using env: {'DISPLAY': ':0', 22:15:13 INFO - 'HOME': '/home/cltbld', 22:15:13 INFO - 'LANG': 'en_US.UTF-8', 22:15:13 INFO - 'LANGUAGE': 'en_US:en', 22:15:13 INFO - 'LOGNAME': 'cltbld', 22:15:13 INFO - 'MAIL': '/var/mail/cltbld', 22:15:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:15:13 INFO - 'MOZ_NO_REMOTE': '1', 22:15:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:15:13 INFO - 'NO_EM_RESTART': '1', 22:15:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:15:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:15:13 INFO - 'PWD': '/builds/slave/test', 22:15:13 INFO - 'SHELL': '/bin/bash', 22:15:13 INFO - 'SHLVL': '1', 22:15:13 INFO - 'TERM': 'linux', 22:15:13 INFO - 'TMOUT': '86400', 22:15:13 INFO - 'USER': 'cltbld', 22:15:13 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1475643662.990995-2126107780', 22:15:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:15:13 INFO - '_': '/tools/buildbot/bin/python'} 22:15:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:15:13 INFO - Running setup.py (path:/tmp/pip-AEih1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:15:14 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)) 22:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:15:14 INFO - Running setup.py (path:/tmp/pip-wFbbKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:15:14 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)) 22:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:15:14 INFO - Running setup.py (path:/tmp/pip-Gntfzz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:15:14 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)) 22:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:15:14 INFO - Running setup.py (path:/tmp/pip-8UHpDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:15:14 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)) 22:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:15:14 INFO - Running setup.py (path:/tmp/pip-kYDtuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:15:14 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)) 22:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:15:14 INFO - Running setup.py (path:/tmp/pip-eFPnf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:15:14 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)) 22:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:15:14 INFO - Running setup.py (path:/tmp/pip-gocxfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:15:14 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)) 22:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:15:14 INFO - Running setup.py (path:/tmp/pip-CefsPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:15:14 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)) 22:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:15:14 INFO - Running setup.py (path:/tmp/pip-14pOMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:15:14 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)) 22:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:15:14 INFO - Running setup.py (path:/tmp/pip-yBGwFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:15:14 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)) 22:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:15:14 INFO - Running setup.py (path:/tmp/pip-1VWhux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:15:14 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)) 22:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:15:14 INFO - Running setup.py (path:/tmp/pip-uPRBmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:15:14 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)) 22:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:15:14 INFO - Running setup.py (path:/tmp/pip-wFW2sI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:15:14 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)) 22:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:15:14 INFO - Running setup.py (path:/tmp/pip-Vym2ez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:15:14 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)) 22:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:15:14 INFO - Running setup.py (path:/tmp/pip-PkOQ8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:15:15 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)) 22:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:15:15 INFO - Running setup.py (path:/tmp/pip-xGnQdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:15:15 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)) 22:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:15:15 INFO - Running setup.py (path:/tmp/pip-EUTGJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:15:15 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)) 22:15:15 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)) 22:15:15 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)) 22:15:15 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)) 22:15:15 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)) 22:15:15 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)) 22:15:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:15:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:15:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:15:17 INFO - Downloading blessings-1.6.tar.gz 22:15:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:15:17 INFO - Installing collected packages: blessings 22:15:17 INFO - Running setup.py install for blessings 22:15:17 INFO - Successfully installed blessings 22:15:17 INFO - Cleaning up... 22:15:17 INFO - Return code: 0 22:15:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:15:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:15:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:15:17 INFO - Reading from file tmpfile_stdout 22:15:17 INFO - Current package versions: 22:15:17 INFO - argparse == 1.2.1 22:15:17 INFO - blessings == 1.6 22:15:17 INFO - blobuploader == 1.2.4 22:15:17 INFO - docopt == 0.6.1 22:15:17 INFO - functools32 == 3.2.3-2 22:15:17 INFO - jsonschema == 2.5.1 22:15:17 INFO - manifestparser == 1.1 22:15:17 INFO - mozInstall == 1.12 22:15:17 INFO - mozcrash == 0.17 22:15:17 INFO - mozdebug == 0.1 22:15:17 INFO - mozdevice == 0.48 22:15:17 INFO - mozfile == 1.2 22:15:17 INFO - mozhttpd == 0.7 22:15:17 INFO - mozinfo == 0.9 22:15:17 INFO - mozleak == 0.1 22:15:17 INFO - mozlog == 3.4 22:15:17 INFO - moznetwork == 0.27 22:15:17 INFO - mozprocess == 0.23 22:15:17 INFO - mozprofile == 0.28 22:15:17 INFO - mozrunner == 6.12 22:15:17 INFO - mozscreenshot == 0.1 22:15:17 INFO - mozsystemmonitor == 0.3 22:15:17 INFO - moztest == 0.7 22:15:17 INFO - mozversion == 1.4 22:15:17 INFO - psutil == 3.1.1 22:15:17 INFO - requests == 1.2.3 22:15:17 INFO - wsgiref == 0.1.2 22:15:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:15: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')]} 22:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:15:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15: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')]} 22:15:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:15:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:17 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 0x7f765d433f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2029f60>, '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 0x202ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202b1d0>, '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': '0333a256a5e4f052382dd180000001b1-1475643662.990995-2126107780', '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 22:15:17 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 22:15:17 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 22:15:17 INFO - Using env: {'DISPLAY': ':0', 22:15:17 INFO - 'HOME': '/home/cltbld', 22:15:17 INFO - 'LANG': 'en_US.UTF-8', 22:15:17 INFO - 'LANGUAGE': 'en_US:en', 22:15:17 INFO - 'LOGNAME': 'cltbld', 22:15:17 INFO - 'MAIL': '/var/mail/cltbld', 22:15:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:15:17 INFO - 'MOZ_NO_REMOTE': '1', 22:15:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:15:17 INFO - 'NO_EM_RESTART': '1', 22:15:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:15:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:15:17 INFO - 'PWD': '/builds/slave/test', 22:15:17 INFO - 'SHELL': '/bin/bash', 22:15:17 INFO - 'SHLVL': '1', 22:15:17 INFO - 'TERM': 'linux', 22:15:17 INFO - 'TMOUT': '86400', 22:15:17 INFO - 'USER': 'cltbld', 22:15:17 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1475643662.990995-2126107780', 22:15:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:15:17 INFO - '_': '/tools/buildbot/bin/python'} 22:15:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:15:17 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)) 22:15:17 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)) 22:15:17 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)) 22:15:17 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)) 22:15:17 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)) 22:15:17 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)) 22:15:17 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)) 22:15:17 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)) 22:15:17 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)) 22:15:17 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)) 22:15:17 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)) 22:15:17 INFO - Cleaning up... 22:15:17 INFO - Return code: 0 22:15:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:15: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')]} 22:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:15:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15: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')]} 22:15:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:15:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f765d433f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2029f60>, '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 0x202ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202b1d0>, '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': '0333a256a5e4f052382dd180000001b1-1475643662.990995-2126107780', '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 22:15:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:15:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:15:17 INFO - Using env: {'DISPLAY': ':0', 22:15:17 INFO - 'HOME': '/home/cltbld', 22:15:17 INFO - 'LANG': 'en_US.UTF-8', 22:15:17 INFO - 'LANGUAGE': 'en_US:en', 22:15:17 INFO - 'LOGNAME': 'cltbld', 22:15:17 INFO - 'MAIL': '/var/mail/cltbld', 22:15:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:15:17 INFO - 'MOZ_NO_REMOTE': '1', 22:15:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:15:17 INFO - 'NO_EM_RESTART': '1', 22:15:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:15:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:15:17 INFO - 'PWD': '/builds/slave/test', 22:15:17 INFO - 'SHELL': '/bin/bash', 22:15:17 INFO - 'SHLVL': '1', 22:15:17 INFO - 'TERM': 'linux', 22:15:17 INFO - 'TMOUT': '86400', 22:15:17 INFO - 'USER': 'cltbld', 22:15:17 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1475643662.990995-2126107780', 22:15:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:15:17 INFO - '_': '/tools/buildbot/bin/python'} 22:15:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:15:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:15:18 INFO - Cleaning up... 22:15:18 INFO - Return code: 0 22:15:18 INFO - Running post-action listener: _resource_record_post_action 22:15:18 INFO - Running post-action listener: _start_resource_monitoring 22:15:18 INFO - Starting resource monitoring. 22:15:18 INFO - [mozharness: 2016-10-05 05:15:18.050367Z] Finished create-virtualenv step (success) 22:15:18 INFO - [mozharness: 2016-10-05 05:15:18.050824Z] Running install step. 22:15:18 INFO - Running pre-action listener: _resource_record_pre_action 22:15:18 INFO - Running main action method: install 22:15:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:15:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:15:18 INFO - Reading from file tmpfile_stdout 22:15:18 INFO - Detecting whether we're running mozinstall >=1.0... 22:15:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:15:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:15:18 INFO - Reading from file tmpfile_stdout 22:15:18 INFO - Output received: 22:15:18 INFO - Usage: mozinstall [options] installer 22:15:18 INFO - Options: 22:15:18 INFO - -h, --help show this help message and exit 22:15:18 INFO - -d DEST, --destination=DEST 22:15:18 INFO - Directory to install application into. [default: 22:15:18 INFO - "/builds/slave/test"] 22:15:18 INFO - --app=APP Application being installed. [default: firefox] 22:15:18 INFO - mkdir: /builds/slave/test/build/application 22:15:18 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'] 22:15:18 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 22:15:34 INFO - Reading from file tmpfile_stdout 22:15:34 INFO - Output received: 22:15:34 INFO - /builds/slave/test/build/application/firefox/firefox 22:15:34 INFO - Running post-action listener: _resource_record_post_action 22:15:34 INFO - [mozharness: 2016-10-05 05:15:34.493321Z] Finished install step (success) 22:15:34 INFO - [mozharness: 2016-10-05 05:15:34.493576Z] Running run-tests step. 22:15:34 INFO - Running pre-action listener: _resource_record_pre_action 22:15:34 INFO - Running main action method: run_tests 22:15:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:15:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:15:34 INFO - Python 2.7.3 22:15:34 INFO - Return code: 0 22:15:34 INFO - grabbing minidump binary from tooltool 22:15:34 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')]} 22:15:34 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 0x2029f60>, '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 0x202ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202b1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:15:34 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 22:15:34 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 22:15:34 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 22:15:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:15:34 INFO - Return code: 0 22:15:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:15:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:15:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:15:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:15:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:15:34 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Pg9wISahRH--Kd5U-XBntg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 22:15:34 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Pg9wISahRH--Kd5U-XBntg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:15:34 INFO - Using env: {'DISPLAY': ':0', 22:15:34 INFO - 'HOME': '/home/cltbld', 22:15:34 INFO - 'LANG': 'en_US.UTF-8', 22:15:34 INFO - 'LANGUAGE': 'en_US:en', 22:15:34 INFO - 'LOGNAME': 'cltbld', 22:15:34 INFO - 'MAIL': '/var/mail/cltbld', 22:15:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:15:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:15:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:15:34 INFO - 'MOZ_NO_REMOTE': '1', 22:15:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:15:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:15:34 INFO - 'NO_EM_RESTART': '1', 22:15:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:15:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:15:34 INFO - 'PWD': '/builds/slave/test', 22:15:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:15:34 INFO - 'SHELL': '/bin/bash', 22:15:34 INFO - 'SHLVL': '1', 22:15:34 INFO - 'TERM': 'linux', 22:15:34 INFO - 'TMOUT': '86400', 22:15:34 INFO - 'USER': 'cltbld', 22:15:34 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1475643662.990995-2126107780', 22:15:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:15:34 INFO - '_': '/tools/buildbot/bin/python'} 22:15:34 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Pg9wISahRH--Kd5U-XBntg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:15:34 INFO - mozversion application_buildid: 20161004195000 22:15:34 INFO - mozversion application_changeset: d3366b063f5231867f2cea79ae229ac4b4e2c63b 22:15:34 INFO - mozversion application_display_name: Nightly 22:15:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:15:34 INFO - mozversion application_name: Firefox 22:15:34 INFO - mozversion application_remotingname: firefox 22:15:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:15:34 INFO - mozversion application_vendor: Mozilla 22:15:34 INFO - mozversion application_version: 52.0a1 22:15:34 INFO - mozversion platform_buildid: 20161004195000 22:15:34 INFO - mozversion platform_changeset: d3366b063f5231867f2cea79ae229ac4b4e2c63b 22:15:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:15:34 INFO - mozversion platform_version: 52.0a1 22:15:34 INFO - using testdate: 1475644534 22:15:34 INFO - actual date: 1475644534 22:15:34 INFO - starting webserver on 'localhost:60546' 22:15:34 INFO - SUITE-START | Running 2 tests 22:15:34 INFO - TEST-START | dromaeo_css 22:15:34 INFO - operating with platform_type : linux_ 22:15:34 INFO - Initialising browser for dromaeo_css test... 22:15:34 INFO - TEST-INFO | started process 20481 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwv8Pyc/profile http://localhost:60546/getInfo.html) 22:15:39 INFO - PROCESS | 20481 | __metrics Screen width/height:1600/1200 22:15:39 INFO - PROCESS | 20481 | colorDepth:24 22:15:39 INFO - PROCESS | 20481 | Browser inner width/height: 1024/697 22:15:39 INFO - PROCESS | 20481 | __metrics 22:15:39 ERROR - PROCESS | 20481 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 22:15:40 INFO - TEST-INFO | 20481: exit 0 22:15:40 INFO - Browser initialized. 22:15:40 INFO - Running cycle 1/1 for dromaeo_css test... 22:15:40 INFO - TEST-INFO | started process 20602 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwv8Pyc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:15:52 INFO - PROCESS | 20602 | RSS: Main: 186638336 22:15:52 INFO - PROCESS | 20602 | 22:16:42 INFO - PROCESS | 20602 | 1475644602657 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] 22:18:56 INFO - PROCESS | 20602 | Cycle 1(1): loaded http://localhost:60546/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60546/tests/dromaeo/cssquery-ext.html) 22:18:57 INFO - PROCESS | 20602 | RSS: Main: 200220672 22:18:57 INFO - PROCESS | 20602 | 22:21:59 INFO - PROCESS | 20602 | Cycle 1(1): loaded http://localhost:60546/tests/dromaeo/cssquery-ext.html (next: http://localhost:60546/tests/dromaeo/cssquery-jquery.html) 22:22:00 INFO - PROCESS | 20602 | RSS: Main: 200306688 22:22:00 INFO - PROCESS | 20602 | 22:25:02 INFO - PROCESS | 20602 | Cycle 1(1): loaded http://localhost:60546/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60546/tests/dromaeo/cssquery-mootools.html) 22:25:03 INFO - PROCESS | 20602 | RSS: Main: 201015296 22:25:03 INFO - PROCESS | 20602 | 22:28:05 INFO - PROCESS | 20602 | Cycle 1(1): loaded http://localhost:60546/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60546/tests/dromaeo/cssquery-prototype.html) 22:28:05 INFO - PROCESS | 20602 | RSS: Main: 195182592 22:28:05 INFO - PROCESS | 20602 | 22:31:08 INFO - PROCESS | 20602 | Cycle 1(1): loaded http://localhost:60546/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60546/tests/dromaeo/cssquery-yui.html) 22:31:09 INFO - PROCESS | 20602 | RSS: Main: 198299648 22:31:09 INFO - PROCESS | 20602 | 22:34:12 INFO - PROCESS | 20602 | Cycle 1(1): loaded http://localhost:60546/tests/dromaeo/cssquery-yui.html (next: http://localhost:60546/tests/dromaeo/cssquery-dojo.html) 22:34:12 INFO - PROCESS | 20602 | RSS: Main: 199229440 22:34:12 INFO - PROCESS | 20602 | 22:34:12 INFO - PROCESS | 20602 | __start_tp_report 22:34:12 INFO - PROCESS | 20602 | _x_x_mozilla_page_load 22:34:12 INFO - PROCESS | 20602 | _x_x_mozilla_page_load_details 22:34:12 INFO - PROCESS | 20602 | |i|pagename|runs| 22:34:12 INFO - PROCESS | 20602 | |0;dojo.html;2616.764491195792;2631.947361052779;2633.631291619173;2637.8549179795104;2654.0578094776365;4634.096351211515;4741.288806679;4773.809047638095;4788.377510923575;4826.565609095181;4691.953080469194;4696.272077827942;4768.856934291968;4771.260454629538;4805.903881922368;4262.829486820523;4339.717918335298;4361.716488428242;4418.82324707013;4468.151051300242;4389.363542286366;4413.470383553962;4435.445569303837;4436.578525040116;4493.865184044484;4259.977605374719;4289.1850548395705;4299.97850010748;4343;4397;4332.393464914914;4345.695801293879;4358.3244597087505;4420.292753159511;4431.313146462304;4316.309390497506;4331.371951067078;4340.565943405666;4356.542563030868;4390.034192477649;4636.652251081148;4645.094206629708;4753.239481682948;4753.47711751707;4768.583450210371;4966.2798894160505;5038.722870242135;5038.79844806211;5058.595312375001;5120.820771273025;5068;5084.313617661605;5097.6941383517105;5105.617078719111;5153.922691159635;4633.814647414133;4704.082703872712;4738.857834264943;4739.526047395302;4793.32893394925;5118.846434606968;5184.222366644958;5198.194279886548;5198.610104242197;5204.193350030751;4945.851624451272;4988.027334669777;4999.475055119233;5000.724960127155;5002.924956125661;4995.100881841231;5034.34553508049;5073.695578265316;5083.974580127149;5164.406093299319;5000.074986127578;5022.59819214462;5039.168537191323;5051.444341122474;5118.155504341817;5034.0686972910125;5039.370078740158;5041.420236672756;5052.898942021139;5054.7472626368535;4154.91690166201;4195.160967806451;4208.326667733209;4240.6395456385935;4246.8725938221905;3706.4069748840056;3707.8331475083687;3712.5730540987593;3749.868754593631;3754.8310326035394;4420.469543654782;4460.464744230713;4467.8212871484775;4502.459704835375;4527.456705195397;4946.901061978812;5005.349304590452;5044.621653376012;5095.796168153306;5123.487651234846;4392.472903251631;4413.293872980308;4463.330500424897;4496.280595104768;4514.954850451519;4542.409486766765;4547.636189104864;4548.090381923628;4561.521040290721;4600.700954437951;4648.953510464852;4707.482176960463;4812.614990800657;4816.470188279286;4823.927641085316;5122.129238029469;5139.049275883974;5144.022635699355;5179.715115668674;5203.297554830049;4729.148753224453;4840.854774356775;4854.490278520846;4857.271409288635;4911.607071434348;4972.204447288416;4995.2507123930245;5034.723090230073;5056.696598204119;5144.254083157846;5150.871228219325;5162.406323272871;5177.119889618699;5180.507851754077;5186.507281808223;5015.774290157025;5016.046951079284;5016.072026675077;5016.849494515171;5072.492750724898;4829.5653391194965;4863.635227357891;4901.926471103007;4925.433575138905;4965.4786247444945;4841.951580484291;4856.053069651384;4868.926966095441;4880.121578115832;4932.580730637936;5004.449510553909;5009.373828271466;5017.949820501748;5022.723750193774;5058.215976523645;4717.268823332389;4719.787609557509;4831.661783675109;4855.320255164209;4929.06347793918 22:34:12 INFO - PROCESS | 20602 | |1;ext.html;522.1541103412472;547.1737676109075;560.081466395112;563.5378989228834;567.1945836911585;38157;40283.59716402835;40347.79826100869;44165.337519937224;44184.11631767363;40782.7960860196;41094;41128.79435602825;41188;41192.79403602985;7663.042119735033;7736.265054819812;7770.106437759645;7810.179931107237;7820.843583128334;7681.9231807682045;7809.804754881145;7810;7813.374930005586;7815.452918295721;7821;7861;7861.449698521106;7863.37093032556;7864.095629002681;7699.923000770033;7737.187595302468;7776.183500732426;7800.804979875492;7806.102298235719;7512.849743005164;7539.434542409341;7625.771226863203;7626.237376262385;7640.770776876702;37473.625263747286;37584.24831503382;37805.432918506245;37873.62126378728;37982.24035519274;2976.880924763007;3190.1865024418858;3246.6104067511815;3427;3552.129728216578;27717;28027.859860700566;28098.438031239464;28123;28570.857145714348;3400.472926696366;3427.2974040321674;3472.2534655049035;3542.734294927891;3548.787072775616;234168;234244;234486.8275658628;235209;235981;51090.48909510932;51292.74353628208;51459;51558.22662660063;51703.673334700026;53832.46167538274;53849;53861.19208211802;53896.19155712589;53935.190972135446;13872.445102196001;13972.790408143886;14115.435382584581;14122.435102595986;14132.434702611987;10195.133413659774;10257.743556411;10290.897091029143;10305.124064454456;10311.22665800068;14605.634859128395;15688.215589220494;15716.214189290718;15737.68524629501;15798.447054353042;5514.310711161105;5542.196381524737;5616.494515493543;5711;5746.827595172152;742.6064185981438;763.522798251093;829.9210477753189;853.1937319233389;895.5119459894373;26812.90554794583;27505.17484475469;27601.86199068992;27604.585931211048;27725.58411623827;869.6086760957594;951.5813042261383;958.3818437108026;969.8157350103457;977.2768151567789;13720.588382348546;14440.638984025483;14514.129152250687;14531.346089426;14827.18450485212;364391;369624;369681;371584;372001;49318.7670308238;49371.50628493669;49384;49526.50473495219;49545;1141.9257748246503;1163.8661553921238;1199.9880001200052;1200.5497938273147;1204.9337286449154;25983.22050338417;26315.473690526465;27107.72892271052;27108.32229194286;27309.726902731512;41571.37642935419;41820.79089604533;41984.370234445894;42051;42101.78949105235;308842;309795;310706;311139;311380;24179.51640967206;24982.875085624455;25003.374915627253;25100.874495627406;25415;39866.60133398745;39959;40508;40951.38572921349;41154.58845411507;34621.65378346184;35603.64396356003;35608.28783424265;36498;37088.6291137096;35581.64418355887;35847.28305433929;35910.28179436344;36518;36677.81661091677;34768.30463390768;35053.39145736772;35255.647443526264;35432.46851297181;35841.28317433585;29723.702762972094;32480.675193247764;32543.18642033968;32567.37163141881;32590.51114233241;24838.50322993566;25022.62466063047;25090.749092508842;25306.36734081589;25372.619410709223 22:34:12 INFO - PROCESS | 20602 | |2;jquery.html;336.12774849266145;342.61113636023106;356.29453681710214;359.6259889714696;376.88505005973184;15428;16610.501684949442;16992.745108823347;17058.061806600632;17305.913470432646;15937.282822272997;16611.41860034899;16886.071266080362;16922.915385423057;16952;4267.893302667427;4500.684952053358;4537.0925814837165;4585.3122031695175;4587.357769912215;3386.2719515304207;3580.104973756561;4544.091181763644;4575.519570445105;4578.473475550304;5052.696838189702;5281.6830990140525;5299.682019078868;5357.49103835137;5358.544523715489;5304.946950530484;5342.465753424646;5345.545628621572;5685.516731077863;5773.884522309572;5118.2578526113875;5123.666961647518;5124.615653825978;5130.743462826844;5131.255967884673;12130.636080917586;15128.697426051527;20165.596688066158;20243.39269821908;20278.188872445233;1714.5542159038614;1814.383109742694;1939.679952807785;1946.912388942501;2017.3342796877141;9055.320850936141;9069.501177435239;9072.319576031758;9157.038510956387;11902.226355286879;1672.540051485839;1754.9824501754947;1769.973450398245;1798.190814133632;1831.8076601956736;63790;64194;67672;69834.65082674604;71206;9678.17735492491;9738.707838764849;9878.259130565237;9919.256055795844;10149.695509134737;13294.268815215062;13407.396667150002;13424.261665608485;13431.522532521414;13439.126456780277;6698.550246622993;7020.92979070213;7044.22513523512;7214.49498535108;7228.927710722825;6655.101561289164;6790.7623233186605;6952.409045231212;6969.54697944632;6991.825204369829;4084.857030003995;4085.1829634073306;4111.814968326433;4154.127633197002;4186.079062606222;1735.6788994035892;1760.5862622283753;1761.1381505054287;1774.1927423022494;1779.430582213705;679.4462513051946;810.4529442626203;845.6490556419141;910.740438974889;923.8383282925461;14879.628009299855;16572.17139143038;16652.16739163037;16768;16993.32026718942;828.4076885027114;829.7884039569992;834.7620928035481;853.3386625365267;883.2977782662798;8930.738482418403;9314.394564353295;9428.905710942803;9486.146246837818;9557.985646028685;312026;312760;313363;315590;318432;72076.63961680263;73143.63428182826;73826;74363.62818185982;77055.61472192603;883.5228976352826;883.6730409748434;885.0883589902411;895.6551727584797;910.0399078971616;14664.340104695528;14785.704285914437;15257.6185595361;15280.694386112438;15409.229538523254;35310.646893530735;35654.821725891205;35657.28685426225;35826.28347433089;35842.64157358393;47792.76103619599;47842.760786197236;48058;48157.27764083471;48307.5169248303;7502.549847009197;7553.509021913558;7654.540727556365;7730;8065.758027259191;8409.411341206056;11631.53473861036;11967.64097077089;12060.15578909503;12504.812427813407;9976.551055202679;10025;10030.949845250727;10138.087572118544;10790.89209107899;9725.367851089657;9902.306838521234;10039.749006274902;10323.690289291333;10517.316374435637;9730.270229732656;9947.682997719607;9951.601935922483;10352.327098738559;10519;7461.962690186514;7490.625468726651;7499.137599176164;7620.618969051415;7690.692372305045;9761.951190244003;9781.85327220078;10122.190224781853;10140.290179687647;10406.73983150397 22:34:12 INFO - PROCESS | 20602 | |3;mootools.html;1349.6895713985782;1386.1890793885577;1401.1593044173496;1617.4985754416139;1620.659661471091;6505.739770409178;6750.594964302145;6853.965730171349;7451.403887688985;7471.663775130119;6918.308169183079;7197.604131772763;7240.565566066027;7429.219931907153;7462.7014919403155;2091.7908209179113;2115.7566879808865;2117.6611742121263;2117.8729276243475;2132.2430537159316;2024.4432780985273;2056.9588608227828;2060.361288000717;2092.246791155183;2094.14140202517;2077.428707105543;2099.4121645939085;2103.558252766913;2106.189117189885;2107.5258066934894;2020.9494762630904;2025.3721346382667;2028.8681235719778;2030.3198428526314;2030.624334498115;2043.3257025181804;2073.782252863458;2082.5938941906334;2087.1964293746864;2091.1426315210692;7433.070866141732;7529.247075292427;7533.096028476563;7536.095668519758;7536.886946695804;4364.454443194601;4498.032922921588;4506.031203291308;4506.098780243931;4512.3682684423875;2785.7910656700624;2854.685984541699;2889.0321742216383;2890.2340879666904;2890.927726806826;870;888.8533391990314;894.9642014319419;903.737916004358;912.4251721415532;9930.80138397228;9968.601255949754;9996.850047249225;10073.748156296078;10074.89925100747;3703.9814800925824;3825.1967086911504;3997.380406037069;4019.2765302245293;4027.496562929634;8510.234078932803;8513.74458766238;8515.19105684959;8519.105493923173;8525.44584601999;4428.047969686533;4432.091421258634;4434.623057040188;4443.178012067778;4458.242098843204;3567.2152126532123;3703.9814800925824;3908.3160446922243;4010.3583426651594;4015.477987861559;3417.743669224818;3442.7934323940644;3536.0629433200224;3540.2211513466996;3586.211033572662;1109.434188563822;1115.3809635652292;1118.4854966715402;1124.4827379405401;1130.5025788652965;763.5571368606195;801.9494462254465;831.9459235149695;848.8472075026555;889.6085722282176;5010.924836127461;5248.6325957182635;5253.317068781034;5279.234510995961;5392.110301800238;806.8144326804868;826.4008593769469;838.8322335532796;858.8368210040072;885.3404213860715;3632.002398680715;3773.566039905446;3823.2735780201674;3859.2474467478573;3906.374980003186;8867.955660221658;9056.547172641342;9105.81788364229;9137.360384773003;9139.314551408672;9033.548322583845;9058.36591438593;9092.408993415407;9134.132257435665;9152.130547597968;6804.591724496546;6856.862862742717;6869;6899.793006209822;6927.134108236471;5042.243663450365;5236.6857988520815;5250.26496290512;5263.7630156913865;5268.998890210848;8056.154103819014;8188.672453101809;8340.708075217339;8384.077751447458;8496.532690701824;8235.629396677285;8258.545779982158;8437.578121094044;8439.535825529654;8449.197326253996;5805.187273781758;6002.759889604367;6138.815835524942;6196.1015652731;6234.657093859882;6687.264400915798;6968.790936271717;6978.581285122706;7139.214686384597;7155.92661100839;6315;6323.36766323364;6389.233292004989;6471.611703297817;6646.069550263063;6263.467605253422;6268.341824108403;6301.0863424804065;6313.526485513513;6327.86098502274;5959.10613407975;6032.607880487754;6059.787907423219;6068;6073.301570319293;4607.193741095228;4701.294805779161;4734.147853386424;4742.881427964328;4746.19314716506;4612.377329060534;4628.328892310664;4679.953200468088;4760.976195119002;4872.171730805842 22:34:12 INFO - PROCESS | 20602 | |4;prototype.html;279.27388789148216;281.9816711913725;289.0720786276053;291.0236157690947;292.5436319341828;4794.640401969848;4907.435644900837;4943.184374578194;5015.398152221734;5041.77312020959;4684.367610372598;4813.253945638423;4841.515848415157;4861.270809378595;4893.853184404474;3820.4842346283313;3831.329517334469;3864.9227015459674;3866.4007078902673;3868.1490072184074;3728.8881333560034;3863.821534431997;3874.4575759393706;3896.6687831534355;3897.59075297094;3805.2602126468896;3810.7141964352786;3820.2550502651993;3830.6743926766258;3864.2851072551666;3812.8474861005525;3819.567662126716;3824.177801772604;3831.252905683393;3840.2703486337505;3382.475716263983;3400.5409269748516;3402.894059430695;3408.7784294021058;3413.2320227948762;4691;4770.833020844254;4810.639721226529;4833.275008748681;4867.515407800619;4333.8699839004885;4343.913121737579;4353.934690979638;4358.36803663467;4376.912461750779;5087.898242035176;5126.410462796789;5134.383873935114;5143.588512918995;5187.429382767892;3595.2989167112423;3687.2994131115;3699.3711069118044;3703.7037037037244;3708.4808126862263;5330.520253177194;5338.27933229013;5349.679019258857;5349.7057661828585;5351.919721204185;3737.9160043587053;3768.717346199046;3771.5474143103;3779.149691319431;3789.4694742736037;3825.1202223488754;3830.80845957701;3836.271108489378;3836.5779764225913;3836.635519625631;4181.853635122756;4304.160688665743;4356.6950313477755;4363.5564084113;4382.452193475816;5103.438621751604;5103.8468845934685;5110;5114.948850511521;5122.282880396748;1223.2721530689403;1256.5162412471082;1288.4910460368103;1310.737852429518;1333.7132516508998;890.3589415620743;918.820829938169;922.6217250927087;928.1971095002909;932.8927173375013;4600.493945665974;4626.398568186181;4629.768511574408;4630.143423466669;4633.62930965522;5142.30578871855;5300.416954135042;5346.518813306821;5362.410134885159;5366.543843773245;4471.329300604935;4579.656525760582;4599.494055653875;4602.366160013214;4622.976885115553;2454.6931633545805;2458.987705061463;2463.1994601754145;2481.4416756229703;2494.9416731196834;4400.359784129497;4429.667774916894;4430.490493593278;4438.822447102079;4454.22051141049;4470.463544374696;4723.6929599575915;4731.313959475857;4744.695208817603;4772.832950846704;4453.955460445354;4469.664775141878;4479.238529450001;4491.910161796811;4508.098380323882;4675.200047981483;4683.882902927454;4729.43246810385;4731.881702957454;4746.833860814855;4356.629686476685;4544.454665440168;4546.9545304547855;4561.49823519406;4595.276771210796;4413.455290648248;4452.821887124479;4455.551945617752;4472.597466228055;4495.21333766583;3428.348613763477;3454.671806178409;3476.210930086218;3485.1984043670604;3485.3726329260976;4532.255081793467;4614.561616646413;4657.767111644472;4730.385049943486;4743.857684269477;4497.740632622871;4504.369388285708;4514.977425112854;4520.6383489320115;4548.909021819479;4505.504394516535;4514.45826500822;4521.909561808679;4547.704399214041;4564.452265728134;4491.236489796677;4496.303073023687;4604.654650901129;4873.585745211555;5143.871403214949;5179.766910488962;5183.481651834786;5184.533391994588;5199.4020687621405;5220.9477905220465;5058.91233384824;5071.290019397214;5074.644774865724;5087;5111.744412779421 22:34:12 INFO - PROCESS | 20602 | |5;yui.html;607.2075940897128;629.6033498895695;650.921889373275;665.9400653941144;717.4619035723208;12805.615831525045;13796.448142074305;13847.861521384782;13895.096818706777;13947.581572552814;12532.248065116099;12781.360931953388;12880.549180778675;12900.1614895032;12908.806367904488;740.3743836458184;755.7241606813528;757.8711619024751;757.9545227286353;758.8140905478137;602.7679343452759;618.3785295777737;738.78205929251;757.0914902117454;770.8728059870115;804.9718259860906;806.0649646410166;806.6370133439946;806.9031716194036;808.2241048593357;794.6980147543954;795.5783434779576;797.2904115337354;798.6126728536655;798.876174193001;587.7913340764053;588.4615576747271;588.9617174883618;589.6638915817986;590.1796502861026;12017;12053;12205.877941220562;12237.632871013884;12243.449044793006;12378.257304561756;12540.74918501634;12823.61529154127;12961;13026.241457403225;10247.38515689061;10283.331583447052;10343.637972670997;10521.15830733547;10717.30337528066;3243.8702451901895;3268.4116858965376;3318.950215746766;3350.5811773528308;3475.930481390358;55005.44994550043;55759.72120139414;56565;59288.40711592915;59848.70075649594;9585.712428627152;9769.706908792748;9792.118709316195;9817.754556136153;9892.406455612687;16902.830971690124;17445.127743612768;17456.12719364052;17482.213300401512;17540.122993850255;6626.304238055031;6635.303293154149;6761.29006454325;6771.695273712695;6901.965490172517;3507.8246087696025;3710.350688629479;3715.8142092895246;3727.7390582658954;3775.414810704345;2862.627858378439;2965.0660042086674;2972.1380799567883;2972.4500967320682;2981.7167369099902;496.5282981167905;507.45955557331325;508.9770960306795;511.50384127396364;538.6050130162897;563.9904570818271;611.6360765344613;616.6824085595922;619.662284055182;634.4163369699887;8258.463199891989;8817.603207855662;8965.417247878868;8991.77520561978;9343.859842102374;588.2088590845307;597.9402059793986;609.442360240384;617.5152505283331;649.1496140056541;4034.9394759078637;4147.212029714345;4169.2703776838935;4213.641840443535;4245.936310955338;81635;101573;104831.66178367441;106352.46823765832;106390;63853.68073159605;83436.58281708675;84309.15690843135;84701.57649211837;86330.56834715787;46404.07191856211;50999.74500127476;56514.434855650914;64921.67539162274;71733.28266717267;7528;8024.197580242163;8132.552709601029;8138.348932085537;8171.713990010321;43392.56607433885;43799;44117.77941110402;44397.33403999007;45137.77431112823;35742.285154297286;47828.76085619689;62468.68765656143;62511;63632;10075.395476271447;10144.479256051554;10222.437765922648;10271.229657775548;10396.844047339144;11907.642770716893;11928.403579821148;12024.639260822189;12285.75428491443;12292.754144917231;11022.063124634175;11237.157213208879;11303.773924521627;11309.491072901903;11424;10305;10409.323393979366;10488.842667360148;11048.337099774039;11640.301581905112;10246.38521688701;10370.014848589371;10879.564817407532;10923.617673381394;11149.386783726648;9077.500737459502;9195.310351723514;9280.396774209656;9429.434233945985;9458.668946586837;8885.555722213734;9483.810323793348;9535.809283814146;9744.512774361396;9815.607375704893 22:34:12 INFO - PROCESS | 20602 | __end_tp_report 22:34:12 INFO - PROCESS | 20602 | __start_cc_report 22:34:12 INFO - PROCESS | 20602 | _x_x_mozilla_cycle_collect,330 22:34:12 INFO - PROCESS | 20602 | __end_cc_report 22:34:12 INFO - PROCESS | 20602 | __startTimestamp1475645652259__endTimestamp 22:34:12 INFO - PROCESS | 20602 | 22:34:12 INFO - PROCESS | 20602 | ------- Summary: start ------- 22:34:12 INFO - PROCESS | 20602 | Number of tests: 6 22:34:12 INFO - PROCESS | 20602 | 22:34:12 INFO - PROCESS | 20602 | [#0] dojo.html Cycles:165 Average:4695.90 Median:4826.57 stddev:498.80 (10.3%) stddev-sans-first:472.91 22:34:12 INFO - PROCESS | 20602 | Values: 2616.8 2631.9 2633.6 2637.9 2654.1 4634.1 4741.3 4773.8 4788.4 4826.6 4692.0 4696.3 4768.9 4771.3 4805.9 4262.8 4339.7 4361.7 4418.8 4468.2 4389.4 4413.5 4435.4 4436.6 4493.9 4260.0 4289.2 4300.0 4343.0 4397.0 4332.4 4345.7 4358.3 4420.3 4431.3 4316.3 4331.4 4340.6 4356.5 4390.0 4636.7 4645.1 4753.2 4753.5 4768.6 4966.3 5038.7 5038.8 5058.6 5120.8 5068.0 5084.3 5097.7 5105.6 5153.9 4633.8 4704.1 4738.9 4739.5 4793.3 5118.8 5184.2 5198.2 5198.6 5204.2 4945.9 4988.0 4999.5 5000.7 5002.9 4995.1 5034.3 5073.7 5084.0 5164.4 5000.1 5022.6 5039.2 5051.4 5118.2 5034.1 5039.4 5041.4 5052.9 5054.7 4154.9 4195.2 4208.3 4240.6 4246.9 3706.4 3707.8 3712.6 3749.9 3754.8 4420.5 4460.5 4467.8 4502.5 4527.5 4946.9 5005.3 5044.6 5095.8 5123.5 4392.5 4413.3 4463.3 4496.3 4515.0 4542.4 4547.6 4548.1 4561.5 4600.7 4649.0 4707.5 4812.6 4816.5 4823.9 5122.1 5139.0 5144.0 5179.7 5203.3 4729.1 4840.9 4854.5 4857.3 4911.6 4972.2 4995.3 5034.7 5056.7 5144.3 5150.9 5162.4 5177.1 5180.5 5186.5 5015.8 5016.0 5016.1 5016.8 5072.5 4829.6 4863.6 4901.9 4925.4 4965.5 4842.0 4856.1 4868.9 4880.1 4932.6 5004.4 5009.4 5017.9 5022.7 5058.2 4717.3 4719.8 4831.7 4855.3 4929.1 22:34:12 INFO - PROCESS | 20602 | 22:34:12 INFO - PROCESS | 20602 | [#1] ext.html Cycles:180 Average:45902.92 Median:369652.50 stddev:81505.60 (22.0%) stddev-sans-first:81663.02 22:34:12 INFO - PROCESS | 20602 | Values: 522.2 547.2 560.1 563.5 567.2 38157.0 40283.6 40347.8 44165.3 44184.1 40782.8 41094.0 41128.8 41188.0 41192.8 7663.0 7736.3 7770.1 7810.2 7820.8 7681.9 7809.8 7810.0 7813.4 7815.5 7821.0 7861.0 7861.4 7863.4 7864.1 7699.9 7737.2 7776.2 7800.8 7806.1 7512.8 7539.4 7625.8 7626.2 7640.8 37473.6 37584.2 37805.4 37873.6 37982.2 2976.9 3190.2 3246.6 3427.0 3552.1 27717.0 28027.9 28098.4 28123.0 28570.9 3400.5 3427.3 3472.3 3542.7 3548.8 234168.0 234244.0 234486.8 235209.0 235981.0 51090.5 51292.7 51459.0 51558.2 51703.7 53832.5 53849.0 53861.2 53896.2 53935.2 13872.4 13972.8 14115.4 14122.4 14132.4 10195.1 10257.7 10290.9 10305.1 10311.2 14605.6 15688.2 15716.2 15737.7 15798.4 5514.3 5542.2 5616.5 5711.0 5746.8 742.6 763.5 829.9 853.2 895.5 26812.9 27505.2 27601.9 27604.6 27725.6 869.6 951.6 958.4 969.8 977.3 13720.6 14440.6 14514.1 14531.3 14827.2 364391.0 369624.0 369681.0 371584.0 372001.0 49318.8 49371.5 49384.0 49526.5 49545.0 1141.9 1163.9 1200.0 1200.5 1204.9 25983.2 26315.5 27107.7 27108.3 27309.7 41571.4 41820.8 41984.4 42051.0 42101.8 308842.0 309795.0 310706.0 311139.0 311380.0 24179.5 24982.9 25003.4 25100.9 25415.0 39866.6 39959.0 40508.0 40951.4 41154.6 34621.7 35603.6 35608.3 36498.0 37088.6 35581.6 35847.3 35910.3 36518.0 36677.8 34768.3 35053.4 35255.6 35432.5 35841.3 29723.7 32480.7 32543.2 32567.4 32590.5 24838.5 25022.6 25090.7 25306.4 25372.6 22:34:12 INFO - PROCESS | 20602 | 22:34:12 INFO - PROCESS | 20602 | [#2] jquery.html Cycles:180 Average:21725.13 Median:4581.89 stddev:52382.65 (1143.3%) stddev-sans-first:52504.98 22:34:12 INFO - PROCESS | 20602 | Values: 336.1 342.6 356.3 359.6 376.9 15428.0 16610.5 16992.7 17058.1 17305.9 15937.3 16611.4 16886.1 16922.9 16952.0 4267.9 4500.7 4537.1 4585.3 4587.4 3386.3 3580.1 4544.1 4575.5 4578.5 5052.7 5281.7 5299.7 5357.5 5358.5 5304.9 5342.5 5345.5 5685.5 5773.9 5118.3 5123.7 5124.6 5130.7 5131.3 12130.6 15128.7 20165.6 20243.4 20278.2 1714.6 1814.4 1939.7 1946.9 2017.3 9055.3 9069.5 9072.3 9157.0 11902.2 1672.5 1755.0 1770.0 1798.2 1831.8 63790.0 64194.0 67672.0 69834.7 71206.0 9678.2 9738.7 9878.3 9919.3 10149.7 13294.3 13407.4 13424.3 13431.5 13439.1 6698.6 7020.9 7044.2 7214.5 7228.9 6655.1 6790.8 6952.4 6969.5 6991.8 4084.9 4085.2 4111.8 4154.1 4186.1 1735.7 1760.6 1761.1 1774.2 1779.4 679.4 810.5 845.6 910.7 923.8 14879.6 16572.2 16652.2 16768.0 16993.3 828.4 829.8 834.8 853.3 883.3 8930.7 9314.4 9428.9 9486.1 9558.0 312026.0 312760.0 313363.0 315590.0 318432.0 72076.6 73143.6 73826.0 74363.6 77055.6 883.5 883.7 885.1 895.7 910.0 14664.3 14785.7 15257.6 15280.7 15409.2 35310.6 35654.8 35657.3 35826.3 35842.6 47792.8 47842.8 48058.0 48157.3 48307.5 7502.5 7553.5 7654.5 7730.0 8065.8 8409.4 11631.5 11967.6 12060.2 12504.8 9976.6 10025.0 10030.9 10138.1 10790.9 9725.4 9902.3 10039.7 10323.7 10517.3 9730.3 9947.7 9951.6 10352.3 10519.0 7462.0 7490.6 7499.1 7620.6 7690.7 9762.0 9781.9 10122.2 10140.3 10406.7 22:34:12 INFO - PROCESS | 20602 | 22:34:12 INFO - PROCESS | 20602 | [#3] mootools.html Cycles:180 Average:4890.27 Median:5335.67 stddev:2669.30 (50.0%) stddev-sans-first:2663.53 22:34:12 INFO - PROCESS | 20602 | Values: 1349.7 1386.2 1401.2 1617.5 1620.7 6505.7 6750.6 6854.0 7451.4 7471.7 6918.3 7197.6 7240.6 7429.2 7462.7 2091.8 2115.8 2117.7 2117.9 2132.2 2024.4 2057.0 2060.4 2092.2 2094.1 2077.4 2099.4 2103.6 2106.2 2107.5 2020.9 2025.4 2028.9 2030.3 2030.6 2043.3 2073.8 2082.6 2087.2 2091.1 7433.1 7529.2 7533.1 7536.1 7536.9 4364.5 4498.0 4506.0 4506.1 4512.4 2785.8 2854.7 2889.0 2890.2 2890.9 870.0 888.9 895.0 903.7 912.4 9930.8 9968.6 9996.9 10073.7 10074.9 3704.0 3825.2 3997.4 4019.3 4027.5 8510.2 8513.7 8515.2 8519.1 8525.4 4428.0 4432.1 4434.6 4443.2 4458.2 3567.2 3704.0 3908.3 4010.4 4015.5 3417.7 3442.8 3536.1 3540.2 3586.2 1109.4 1115.4 1118.5 1124.5 1130.5 763.6 801.9 831.9 848.8 889.6 5010.9 5248.6 5253.3 5279.2 5392.1 806.8 826.4 838.8 858.8 885.3 3632.0 3773.6 3823.3 3859.2 3906.4 8868.0 9056.5 9105.8 9137.4 9139.3 9033.5 9058.4 9092.4 9134.1 9152.1 6804.6 6856.9 6869.0 6899.8 6927.1 5042.2 5236.7 5250.3 5263.8 5269.0 8056.2 8188.7 8340.7 8384.1 8496.5 8235.6 8258.5 8437.6 8439.5 8449.2 5805.2 6002.8 6138.8 6196.1 6234.7 6687.3 6968.8 6978.6 7139.2 7155.9 6315.0 6323.4 6389.2 6471.6 6646.1 6263.5 6268.3 6301.1 6313.5 6327.9 5959.1 6032.6 6059.8 6068.0 6073.3 4607.2 4701.3 4734.1 4742.9 4746.2 4612.4 4628.3 4680.0 4761.0 4872.2 22:34:12 INFO - PROCESS | 20602 | 22:34:12 INFO - PROCESS | 20602 | [#4] prototype.html Cycles:180 Average:4104.81 Median:4504.94 stddev:1167.72 (25.9%) stddev-sans-first:1135.15 22:34:12 INFO - PROCESS | 20602 | Values: 279.3 282.0 289.1 291.0 292.5 4794.6 4907.4 4943.2 5015.4 5041.8 4684.4 4813.3 4841.5 4861.3 4893.9 3820.5 3831.3 3864.9 3866.4 3868.1 3728.9 3863.8 3874.5 3896.7 3897.6 3805.3 3810.7 3820.3 3830.7 3864.3 3812.8 3819.6 3824.2 3831.3 3840.3 3382.5 3400.5 3402.9 3408.8 3413.2 4691.0 4770.8 4810.6 4833.3 4867.5 4333.9 4343.9 4353.9 4358.4 4376.9 5087.9 5126.4 5134.4 5143.6 5187.4 3595.3 3687.3 3699.4 3703.7 3708.5 5330.5 5338.3 5349.7 5349.7 5351.9 3737.9 3768.7 3771.5 3779.1 3789.5 3825.1 3830.8 3836.3 3836.6 3836.6 4181.9 4304.2 4356.7 4363.6 4382.5 5103.4 5103.8 5110.0 5114.9 5122.3 1223.3 1256.5 1288.5 1310.7 1333.7 890.4 918.8 922.6 928.2 932.9 4600.5 4626.4 4629.8 4630.1 4633.6 5142.3 5300.4 5346.5 5362.4 5366.5 4471.3 4579.7 4599.5 4602.4 4623.0 2454.7 2459.0 2463.2 2481.4 2494.9 4400.4 4429.7 4430.5 4438.8 4454.2 4470.5 4723.7 4731.3 4744.7 4772.8 4454.0 4469.7 4479.2 4491.9 4508.1 4675.2 4683.9 4729.4 4731.9 4746.8 4356.6 4544.5 4547.0 4561.5 4595.3 4413.5 4452.8 4455.6 4472.6 4495.2 3428.3 3454.7 3476.2 3485.2 3485.4 4532.3 4614.6 4657.8 4730.4 4743.9 4497.7 4504.4 4515.0 4520.6 4548.9 4505.5 4514.5 4521.9 4547.7 4564.5 4491.2 4496.3 4604.7 4873.6 5143.9 5179.8 5183.5 5184.5 5199.4 5220.9 5058.9 5071.3 5074.6 5087.0 5111.7 22:34:12 INFO - PROCESS | 20602 | 22:34:12 INFO - PROCESS | 20602 | [#5] yui.html Cycles:180 Average:16700.93 Median:25755.62 stddev:23995.46 (93.2%) stddev-sans-first:24032.35 22:34:12 INFO - PROCESS | 20602 | Values: 607.2 629.6 650.9 665.9 717.5 12805.6 13796.4 13847.9 13895.1 13947.6 12532.2 12781.4 12880.5 12900.2 12908.8 740.4 755.7 757.9 758.0 758.8 602.8 618.4 738.8 757.1 770.9 805.0 806.1 806.6 806.9 808.2 794.7 795.6 797.3 798.6 798.9 587.8 588.5 589.0 589.7 590.2 12017.0 12053.0 12205.9 12237.6 12243.4 12378.3 12540.7 12823.6 12961.0 13026.2 10247.4 10283.3 10343.6 10521.2 10717.3 3243.9 3268.4 3319.0 3350.6 3475.9 55005.4 55759.7 56565.0 59288.4 59848.7 9585.7 9769.7 9792.1 9817.8 9892.4 16902.8 17445.1 17456.1 17482.2 17540.1 6626.3 6635.3 6761.3 6771.7 6902.0 3507.8 3710.4 3715.8 3727.7 3775.4 2862.6 2965.1 2972.1 2972.5 2981.7 496.5 507.5 509.0 511.5 538.6 564.0 611.6 616.7 619.7 634.4 8258.5 8817.6 8965.4 8991.8 9343.9 588.2 597.9 609.4 617.5 649.1 4034.9 4147.2 4169.3 4213.6 4245.9 81635.0 101573.0 104831.7 106352.5 106390.0 63853.7 83436.6 84309.2 84701.6 86330.6 46404.1 50999.7 56514.4 64921.7 71733.3 7528.0 8024.2 8132.6 8138.3 8171.7 43392.6 43799.0 44117.8 44397.3 45137.8 35742.3 47828.8 62468.7 62511.0 63632.0 10075.4 10144.5 10222.4 10271.2 10396.8 11907.6 11928.4 12024.6 12285.8 12292.8 11022.1 11237.2 11303.8 11309.5 11424.0 10305.0 10409.3 10488.8 11048.3 11640.3 10246.4 10370.0 10879.6 10923.6 11149.4 9077.5 9195.3 9280.4 9429.4 9458.7 8885.6 9483.8 9535.8 9744.5 9815.6 22:34:12 INFO - PROCESS | 20602 | -------- Summary: end -------- 22:34:12 INFO - PROCESS | 20602 | 22:34:13 INFO - TEST-INFO | 20602: exit 0 22:34:13 INFO - TEST-OK | dromaeo_css | took 1118480ms 22:34:13 INFO - TEST-START | kraken 22:34:13 INFO - operating with platform_type : linux_ 22:34:13 INFO - Initialising browser for kraken test... 22:34:13 INFO - TEST-INFO | started process 20969 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHkUAVg/profile http://localhost:60546/getInfo.html) 22:34:17 INFO - PROCESS | 20969 | __metrics Screen width/height:1600/1200 22:34:17 INFO - PROCESS | 20969 | colorDepth:24 22:34:17 INFO - PROCESS | 20969 | Browser inner width/height: 1024/697 22:34:17 INFO - PROCESS | 20969 | __metrics 22:34:18 ERROR - PROCESS | 20969 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 22:34:19 INFO - TEST-INFO | 20969: exit 0 22:34:19 INFO - Browser initialized. 22:34:19 INFO - Running cycle 1/1 for kraken test... 22:34:19 INFO - TEST-INFO | started process 21090 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHkUAVg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:34:31 INFO - PROCESS | 21090 | RSS: Main: 187043840 22:34:31 INFO - PROCESS | 21090 | 22:34:34 INFO - PROCESS | 21090 | Cycle 1(1): loaded http://localhost:60546/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60546/tests/kraken/driver.html?testName=audio-beat-detection) 22:34:35 INFO - PROCESS | 21090 | RSS: Main: 200282112 22:34:35 INFO - PROCESS | 21090 | 22:34:38 INFO - PROCESS | 21090 | Cycle 1(1): loaded http://localhost:60546/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60546/tests/kraken/driver.html?testName=audio-dft) 22:34:39 INFO - PROCESS | 21090 | RSS: Main: 198602752 22:34:39 INFO - PROCESS | 21090 | 22:34:41 INFO - PROCESS | 21090 | Cycle 1(1): loaded http://localhost:60546/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60546/tests/kraken/driver.html?testName=audio-fft) 22:34:42 INFO - PROCESS | 21090 | RSS: Main: 194420736 22:34:42 INFO - PROCESS | 21090 | 22:34:44 INFO - PROCESS | 21090 | Cycle 1(1): loaded http://localhost:60546/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60546/tests/kraken/driver.html?testName=audio-oscillator) 22:34:45 INFO - PROCESS | 21090 | RSS: Main: 194580480 22:34:45 INFO - PROCESS | 21090 | 22:34:47 INFO - PROCESS | 21090 | Cycle 1(1): loaded http://localhost:60546/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60546/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:34:48 INFO - PROCESS | 21090 | RSS: Main: 195788800 22:34:48 INFO - PROCESS | 21090 | 22:34:51 INFO - PROCESS | 21090 | Cycle 1(1): loaded http://localhost:60546/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60546/tests/kraken/driver.html?testName=imaging-darkroom) 22:34:52 INFO - PROCESS | 21090 | RSS: Main: 195538944 22:34:52 INFO - PROCESS | 21090 | 22:34:55 INFO - PROCESS | 21090 | Cycle 1(1): loaded http://localhost:60546/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60546/tests/kraken/driver.html?testName=imaging-desaturate) 22:34:56 INFO - PROCESS | 21090 | RSS: Main: 193318912 22:34:56 INFO - PROCESS | 21090 | 22:34:59 INFO - PROCESS | 21090 | Cycle 1(1): loaded http://localhost:60546/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60546/tests/kraken/driver.html?testName=json-parse-financial) 22:34:59 INFO - PROCESS | 21090 | RSS: Main: 194609152 22:34:59 INFO - PROCESS | 21090 | 22:35:01 INFO - PROCESS | 21090 | Cycle 1(1): loaded http://localhost:60546/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60546/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:35:02 INFO - PROCESS | 21090 | RSS: Main: 194973696 22:35:02 INFO - PROCESS | 21090 | 22:35:04 INFO - PROCESS | 21090 | Cycle 1(1): loaded http://localhost:60546/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60546/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:35:04 INFO - PROCESS | 21090 | RSS: Main: 194973696 22:35:04 INFO - PROCESS | 21090 | 22:35:06 INFO - PROCESS | 21090 | Cycle 1(1): loaded http://localhost:60546/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60546/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:35:07 INFO - PROCESS | 21090 | RSS: Main: 195522560 22:35:07 INFO - PROCESS | 21090 | 22:35:10 INFO - PROCESS | 21090 | Cycle 1(1): loaded http://localhost:60546/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60546/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:35:11 INFO - PROCESS | 21090 | RSS: Main: 195424256 22:35:11 INFO - PROCESS | 21090 | 22:35:14 INFO - PROCESS | 21090 | Cycle 1(1): loaded http://localhost:60546/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60546/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:35:14 INFO - PROCESS | 21090 | RSS: Main: 195497984 22:35:14 INFO - PROCESS | 21090 | 22:35:16 INFO - PROCESS | 21090 | Cycle 1(1): loaded http://localhost:60546/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60546/tests/kraken/driver.html?testName=ai-astar) 22:35:16 INFO - PROCESS | 21090 | RSS: Main: 197816320 22:35:16 INFO - PROCESS | 21090 | 22:35:16 INFO - PROCESS | 21090 | __start_tp_report 22:35:16 INFO - PROCESS | 21090 | _x_x_mozilla_page_load 22:35:16 INFO - PROCESS | 21090 | _x_x_mozilla_page_load_details 22:35:16 INFO - PROCESS | 21090 | |i|pagename|runs| 22:35:16 INFO - PROCESS | 21090 | |0;ai-astar;113;116;115;116;116;117;114;115;117;116 22:35:16 INFO - PROCESS | 21090 | |1;audio-beat-detection;158;132;132;174;136;131;130;131;173;135 22:35:16 INFO - PROCESS | 21090 | |2;audio-dft;177;164;164;165;164;166;163;164;163;164 22:35:16 INFO - PROCESS | 21090 | |3;audio-fft;76;78;76;106;78;77;75;78;98;76 22:35:16 INFO - PROCESS | 21090 | |4;audio-oscillator;86;83;119;86;85;85;101;84;83;125 22:35:16 INFO - PROCESS | 21090 | |5;imaging-gaussian-blur;118;118;117;117;119;117;118;117;120;120 22:35:16 INFO - PROCESS | 21090 | |6;imaging-darkroom;147;150;148;149;149;147;150;148;148;148 22:35:16 INFO - PROCESS | 21090 | |7;imaging-desaturate;96;95;97;97;97;97;96;97;97;99 22:35:16 INFO - PROCESS | 21090 | |8;json-parse-financial;70;65;65;66;67;69;66;65;66;65 22:35:16 INFO - PROCESS | 21090 | |9;json-stringify-tinderbox;67;67;66;66;69;66;67;67;66;67 22:35:16 INFO - PROCESS | 21090 | |10;stanford-crypto-aes;84;92;85;90;84;85;84;84;84;87 22:35:16 INFO - PROCESS | 21090 | |11;stanford-crypto-ccm;143;166;150;146;146;147;156;151;182;142 22:35:16 INFO - PROCESS | 21090 | |12;stanford-crypto-pbkdf2;178;185;184;181;182;174;175;177;179;174 22:35:16 INFO - PROCESS | 21090 | |13;stanford-crypto-sha256-iterative;75;73;79;71;73;69;73;70;73;76 22:35:16 INFO - PROCESS | 21090 | __end_tp_report 22:35:16 INFO - PROCESS | 21090 | __start_cc_report 22:35:16 INFO - PROCESS | 21090 | _x_x_mozilla_cycle_collect,879 22:35:16 INFO - PROCESS | 21090 | __end_cc_report 22:35:16 INFO - PROCESS | 21090 | __startTimestamp1475645716977__endTimestamp 22:35:16 INFO - PROCESS | 21090 | 22:35:16 INFO - PROCESS | 21090 | ------- Summary: start ------- 22:35:16 INFO - PROCESS | 21090 | Number of tests: 14 22:35:16 INFO - PROCESS | 21090 | 22:35:16 INFO - PROCESS | 21090 | [#0] ai-astar Cycles:10 Average:115.50 Median:116.00 stddev:1.27 (1.1%) stddev-sans-first:0.97 22:35:16 INFO - PROCESS | 21090 | Values: 113.0 116.0 115.0 116.0 116.0 117.0 114.0 115.0 117.0 116.0 22:35:16 INFO - PROCESS | 21090 | 22:35:16 INFO - PROCESS | 21090 | [#1] audio-beat-detection Cycles:10 Average:143.20 Median:135.50 stddev:17.94 (13.2%) stddev-sans-first:18.21 22:35:16 INFO - PROCESS | 21090 | Values: 158.0 132.0 132.0 174.0 136.0 131.0 130.0 131.0 173.0 135.0 22:35:16 INFO - PROCESS | 21090 | 22:35:16 INFO - PROCESS | 21090 | [#2] audio-dft Cycles:10 Average:165.40 Median:164.00 stddev:4.17 (2.5%) stddev-sans-first:0.93 22:35:16 INFO - PROCESS | 21090 | Values: 177.0 164.0 164.0 165.0 164.0 166.0 163.0 164.0 163.0 164.0 22:35:16 INFO - PROCESS | 21090 | 22:35:16 INFO - PROCESS | 21090 | [#3] audio-fft Cycles:10 Average:81.80 Median:77.50 stddev:10.86 (14.0%) stddev-sans-first:11.31 22:35:16 INFO - PROCESS | 21090 | Values: 76.0 78.0 76.0 106.0 78.0 77.0 75.0 78.0 98.0 76.0 22:35:16 INFO - PROCESS | 21090 | 22:35:16 INFO - PROCESS | 21090 | [#4] audio-oscillator Cycles:10 Average:93.70 Median:84.50 stddev:15.87 (18.8%) stddev-sans-first:16.58 22:35:16 INFO - PROCESS | 21090 | Values: 86.0 83.0 119.0 86.0 85.0 85.0 101.0 84.0 83.0 125.0 22:35:16 INFO - PROCESS | 21090 | 22:35:16 INFO - PROCESS | 21090 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:1.20 (1.0%) stddev-sans-first:1.27 22:35:16 INFO - PROCESS | 21090 | Values: 118.0 118.0 117.0 117.0 119.0 117.0 118.0 117.0 120.0 120.0 22:35:16 INFO - PROCESS | 21090 | 22:35:16 INFO - PROCESS | 21090 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.50 stddev:1.07 (0.7%) stddev-sans-first:1.01 22:35:16 INFO - PROCESS | 21090 | Values: 147.0 150.0 148.0 149.0 149.0 147.0 150.0 148.0 148.0 148.0 22:35:16 INFO - PROCESS | 21090 | 22:35:16 INFO - PROCESS | 21090 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:97.00 stddev:1.03 (1.1%) stddev-sans-first:1.05 22:35:16 INFO - PROCESS | 21090 | Values: 96.0 95.0 97.0 97.0 97.0 97.0 96.0 97.0 97.0 99.0 22:35:16 INFO - PROCESS | 21090 | 22:35:16 INFO - PROCESS | 21090 | [#8] json-parse-financial Cycles:10 Average:66.40 Median:66.00 stddev:1.78 (2.7%) stddev-sans-first:1.32 22:35:16 INFO - PROCESS | 21090 | Values: 70.0 65.0 65.0 66.0 67.0 69.0 66.0 65.0 66.0 65.0 22:35:16 INFO - PROCESS | 21090 | 22:35:16 INFO - PROCESS | 21090 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:67.00 stddev:0.92 (1.4%) stddev-sans-first:0.97 22:35:16 INFO - PROCESS | 21090 | Values: 67.0 67.0 66.0 66.0 69.0 66.0 67.0 67.0 66.0 67.0 22:35:16 INFO - PROCESS | 21090 | 22:35:16 INFO - PROCESS | 21090 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:85.00 stddev:2.88 (3.4%) stddev-sans-first:2.98 22:35:16 INFO - PROCESS | 21090 | Values: 84.0 92.0 85.0 90.0 84.0 85.0 84.0 84.0 84.0 87.0 22:35:16 INFO - PROCESS | 21090 | 22:35:16 INFO - PROCESS | 21090 | [#11] stanford-crypto-ccm Cycles:10 Average:152.90 Median:150.50 stddev:12.41 (8.2%) stddev-sans-first:12.64 22:35:16 INFO - PROCESS | 21090 | Values: 143.0 166.0 150.0 146.0 146.0 147.0 156.0 151.0 182.0 142.0 22:35:16 INFO - PROCESS | 21090 | 22:35:16 INFO - PROCESS | 21090 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.90 Median:180.00 stddev:4.01 (2.2%) stddev-sans-first:4.24 22:35:16 INFO - PROCESS | 21090 | Values: 178.0 185.0 184.0 181.0 182.0 174.0 175.0 177.0 179.0 174.0 22:35:16 INFO - PROCESS | 21090 | 22:35:16 INFO - PROCESS | 21090 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.20 Median:73.00 stddev:2.94 (4.0%) stddev-sans-first:3.04 22:35:16 INFO - PROCESS | 21090 | Values: 75.0 73.0 79.0 71.0 73.0 69.0 73.0 70.0 73.0 76.0 22:35:16 INFO - PROCESS | 21090 | -------- Summary: end -------- 22:35:16 INFO - PROCESS | 21090 | 22:35:18 INFO - TEST-INFO | 21090: exit 0 22:35:18 INFO - TEST-OK | kraken | took 64990ms 22:35:18 INFO - SUITE-END | took 1183s 22:35:18 INFO - Completed test suite (00:19:43) 22:35:18 INFO - javascript benchmark 22:35:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6241.104516068685, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2616.764491195792, 2631.947361052779, 2633.631291619173, 2637.8549179795104, 2654.0578094776365, 4634.096351211515, 4741.288806679, 4773.809047638095, 4788.377510923575, 4826.565609095181, 4691.953080469194, 4696.272077827942, 4768.856934291968, 4771.260454629538, 4805.903881922368, 4262.829486820523, 4339.717918335298, 4361.716488428242, 4418.82324707013, 4468.151051300242, 4389.363542286366, 4413.470383553962, 4435.445569303837, 4436.578525040116, 4493.865184044484, 4259.977605374719, 4289.1850548395705, 4299.97850010748, 4343.0, 4397.0, 4332.393464914914, 4345.695801293879, 4358.3244597087505, 4420.292753159511, 4431.313146462304, 4316.309390497506, 4331.371951067078, 4340.565943405666, 4356.542563030868, 4390.034192477649, 4636.652251081148, 4645.094206629708, 4753.239481682948, 4753.47711751707, 4768.583450210371, 4966.2798894160505, 5038.722870242135, 5038.79844806211, 5058.595312375001, 5120.820771273025, 5068.0, 5084.313617661605, 5097.6941383517105, 5105.617078719111, 5153.922691159635, 4633.814647414133, 4704.082703872712, 4738.857834264943, 4739.526047395302, 4793.32893394925, 5118.846434606968, 5184.222366644958, 5198.194279886548, 5198.610104242197, 5204.193350030751, 4945.851624451272, 4988.027334669777, 4999.475055119233, 5000.724960127155, 5002.924956125661, 4995.100881841231, 5034.34553508049, 5073.695578265316, 5083.974580127149, 5164.406093299319, 5000.074986127578, 5022.59819214462, 5039.168537191323, 5051.444341122474, 5118.155504341817, 5034.0686972910125, 5039.370078740158, 5041.420236672756, 5052.898942021139, 5054.7472626368535, 4154.91690166201, 4195.160967806451, 4208.326667733209, 4240.6395456385935, 4246.8725938221905, 3706.4069748840056, 3707.8331475083687, 3712.5730540987593, 3749.868754593631, 3754.8310326035394, 4420.469543654782, 4460.464744230713, 4467.8212871484775, 4502.459704835375, 4527.456705195397, 4946.901061978812, 5005.349304590452, 5044.621653376012, 5095.796168153306, 5123.487651234846, 4392.472903251631, 4413.293872980308, 4463.330500424897, 4496.280595104768, 4514.954850451519, 4542.409486766765, 4547.636189104864, 4548.090381923628, 4561.521040290721, 4600.700954437951, 4648.953510464852, 4707.482176960463, 4812.614990800657, 4816.470188279286, 4823.927641085316, 5122.129238029469, 5139.049275883974, 5144.022635699355, 5179.715115668674, 5203.297554830049, 4729.148753224453, 4840.854774356775, 4854.490278520846, 4857.271409288635, 4911.607071434348, 4972.204447288416, 4995.2507123930245, 5034.723090230073, 5056.696598204119, 5144.254083157846, 5150.871228219325, 5162.406323272871, 5177.119889618699, 5180.507851754077, 5186.507281808223, 5015.774290157025, 5016.046951079284, 5016.072026675077, 5016.849494515171, 5072.492750724898, 4829.5653391194965, 4863.635227357891, 4901.926471103007, 4925.433575138905, 4965.4786247444945, 4841.951580484291, 4856.053069651384, 4868.926966095441, 4880.121578115832, 4932.580730637936, 5004.449510553909, 5009.373828271466, 5017.949820501748, 5022.723750193774, 5058.215976523645, 4717.268823332389, 4719.787609557509, 4831.661783675109, 4855.320255164209, 4929.06347793918], "value": 4663.515161740364, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [522.1541103412472, 547.1737676109075, 560.081466395112, 563.5378989228834, 567.1945836911585, 38157.0, 40283.59716402835, 40347.79826100869, 44165.337519937224, 44184.11631767363, 40782.7960860196, 41094.0, 41128.79435602825, 41188.0, 41192.79403602985, 7663.042119735033, 7736.265054819812, 7770.106437759645, 7810.179931107237, 7820.843583128334, 7681.9231807682045, 7809.804754881145, 7810.0, 7813.374930005586, 7815.452918295721, 7821.0, 7861.0, 7861.449698521106, 7863.37093032556, 7864.095629002681, 7699.923000770033, 7737.187595302468, 7776.183500732426, 7800.804979875492, 7806.102298235719, 7512.849743005164, 7539.434542409341, 7625.771226863203, 7626.237376262385, 7640.770776876702, 37473.625263747286, 37584.24831503382, 37805.432918506245, 37873.62126378728, 37982.24035519274, 2976.880924763007, 3190.1865024418858, 3246.6104067511815, 3427.0, 3552.129728216578, 27717.0, 28027.859860700566, 28098.438031239464, 28123.0, 28570.857145714348, 3400.472926696366, 3427.2974040321674, 3472.2534655049035, 3542.734294927891, 3548.787072775616, 234168.0, 234244.0, 234486.8275658628, 235209.0, 235981.0, 51090.48909510932, 51292.74353628208, 51459.0, 51558.22662660063, 51703.673334700026, 53832.46167538274, 53849.0, 53861.19208211802, 53896.19155712589, 53935.190972135446, 13872.445102196001, 13972.790408143886, 14115.435382584581, 14122.435102595986, 14132.434702611987, 10195.133413659774, 10257.743556411, 10290.897091029143, 10305.124064454456, 10311.22665800068, 14605.634859128395, 15688.215589220494, 15716.214189290718, 15737.68524629501, 15798.447054353042, 5514.310711161105, 5542.196381524737, 5616.494515493543, 5711.0, 5746.827595172152, 742.6064185981438, 763.522798251093, 829.9210477753189, 853.1937319233389, 895.5119459894373, 26812.90554794583, 27505.17484475469, 27601.86199068992, 27604.585931211048, 27725.58411623827, 869.6086760957594, 951.5813042261383, 958.3818437108026, 969.8157350103457, 977.2768151567789, 13720.588382348546, 14440.638984025483, 14514.129152250687, 14531.346089426, 14827.18450485212, 364391.0, 369624.0, 369681.0, 371584.0, 372001.0, 49318.7670308238, 49371.50628493669, 49384.0, 49526.50473495219, 49545.0, 1141.9257748246503, 1163.8661553921238, 1199.9880001200052, 1200.5497938273147, 1204.9337286449154, 25983.22050338417, 26315.473690526465, 27107.72892271052, 27108.32229194286, 27309.726902731512, 41571.37642935419, 41820.79089604533, 41984.370234445894, 42051.0, 42101.78949105235, 308842.0, 309795.0, 310706.0, 311139.0, 311380.0, 24179.51640967206, 24982.875085624455, 25003.374915627253, 25100.874495627406, 25415.0, 39866.60133398745, 39959.0, 40508.0, 40951.38572921349, 41154.58845411507, 34621.65378346184, 35603.64396356003, 35608.28783424265, 36498.0, 37088.6291137096, 35581.64418355887, 35847.28305433929, 35910.28179436344, 36518.0, 36677.81661091677, 34768.30463390768, 35053.39145736772, 35255.647443526264, 35432.46851297181, 35841.28317433585, 29723.702762972094, 32480.675193247764, 32543.18642033968, 32567.37163141881, 32590.51114233241, 24838.50322993566, 25022.62466063047, 25090.749092508842, 25306.36734081589, 25372.619410709223], "value": 17055.857327593632, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.12774849266145, 342.61113636023106, 356.29453681710214, 359.6259889714696, 376.88505005973184, 15428.0, 16610.501684949442, 16992.745108823347, 17058.061806600632, 17305.913470432646, 15937.282822272997, 16611.41860034899, 16886.071266080362, 16922.915385423057, 16952.0, 4267.893302667427, 4500.684952053358, 4537.0925814837165, 4585.3122031695175, 4587.357769912215, 3386.2719515304207, 3580.104973756561, 4544.091181763644, 4575.519570445105, 4578.473475550304, 5052.696838189702, 5281.6830990140525, 5299.682019078868, 5357.49103835137, 5358.544523715489, 5304.946950530484, 5342.465753424646, 5345.545628621572, 5685.516731077863, 5773.884522309572, 5118.2578526113875, 5123.666961647518, 5124.615653825978, 5130.743462826844, 5131.255967884673, 12130.636080917586, 15128.697426051527, 20165.596688066158, 20243.39269821908, 20278.188872445233, 1714.5542159038614, 1814.383109742694, 1939.679952807785, 1946.912388942501, 2017.3342796877141, 9055.320850936141, 9069.501177435239, 9072.319576031758, 9157.038510956387, 11902.226355286879, 1672.540051485839, 1754.9824501754947, 1769.973450398245, 1798.190814133632, 1831.8076601956736, 63790.0, 64194.0, 67672.0, 69834.65082674604, 71206.0, 9678.17735492491, 9738.707838764849, 9878.259130565237, 9919.256055795844, 10149.695509134737, 13294.268815215062, 13407.396667150002, 13424.261665608485, 13431.522532521414, 13439.126456780277, 6698.550246622993, 7020.92979070213, 7044.22513523512, 7214.49498535108, 7228.927710722825, 6655.101561289164, 6790.7623233186605, 6952.409045231212, 6969.54697944632, 6991.825204369829, 4084.857030003995, 4085.1829634073306, 4111.814968326433, 4154.127633197002, 4186.079062606222, 1735.6788994035892, 1760.5862622283753, 1761.1381505054287, 1774.1927423022494, 1779.430582213705, 679.4462513051946, 810.4529442626203, 845.6490556419141, 910.740438974889, 923.8383282925461, 14879.628009299855, 16572.17139143038, 16652.16739163037, 16768.0, 16993.32026718942, 828.4076885027114, 829.7884039569992, 834.7620928035481, 853.3386625365267, 883.2977782662798, 8930.738482418403, 9314.394564353295, 9428.905710942803, 9486.146246837818, 9557.985646028685, 312026.0, 312760.0, 313363.0, 315590.0, 318432.0, 72076.63961680263, 73143.63428182826, 73826.0, 74363.62818185982, 77055.61472192603, 883.5228976352826, 883.6730409748434, 885.0883589902411, 895.6551727584797, 910.0399078971616, 14664.340104695528, 14785.704285914437, 15257.6185595361, 15280.694386112438, 15409.229538523254, 35310.646893530735, 35654.821725891205, 35657.28685426225, 35826.28347433089, 35842.64157358393, 47792.76103619599, 47842.760786197236, 48058.0, 48157.27764083471, 48307.5169248303, 7502.549847009197, 7553.509021913558, 7654.540727556365, 7730.0, 8065.758027259191, 8409.411341206056, 11631.53473861036, 11967.64097077089, 12060.15578909503, 12504.812427813407, 9976.551055202679, 10025.0, 10030.949845250727, 10138.087572118544, 10790.89209107899, 9725.367851089657, 9902.306838521234, 10039.749006274902, 10323.690289291333, 10517.316374435637, 9730.270229732656, 9947.682997719607, 9951.601935922483, 10352.327098738559, 10519.0, 7461.962690186514, 7490.625468726651, 7499.137599176164, 7620.618969051415, 7690.692372305045, 9761.951190244003, 9781.85327220078, 10122.190224781853, 10140.290179687647, 10406.73983150397], "value": 7884.817049929741, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1349.6895713985782, 1386.1890793885577, 1401.1593044173496, 1617.4985754416139, 1620.659661471091, 6505.739770409178, 6750.594964302145, 6853.965730171349, 7451.403887688985, 7471.663775130119, 6918.308169183079, 7197.604131772763, 7240.565566066027, 7429.219931907153, 7462.7014919403155, 2091.7908209179113, 2115.7566879808865, 2117.6611742121263, 2117.8729276243475, 2132.2430537159316, 2024.4432780985273, 2056.9588608227828, 2060.361288000717, 2092.246791155183, 2094.14140202517, 2077.428707105543, 2099.4121645939085, 2103.558252766913, 2106.189117189885, 2107.5258066934894, 2020.9494762630904, 2025.3721346382667, 2028.8681235719778, 2030.3198428526314, 2030.624334498115, 2043.3257025181804, 2073.782252863458, 2082.5938941906334, 2087.1964293746864, 2091.1426315210692, 7433.070866141732, 7529.247075292427, 7533.096028476563, 7536.095668519758, 7536.886946695804, 4364.454443194601, 4498.032922921588, 4506.031203291308, 4506.098780243931, 4512.3682684423875, 2785.7910656700624, 2854.685984541699, 2889.0321742216383, 2890.2340879666904, 2890.927726806826, 870.0, 888.8533391990314, 894.9642014319419, 903.737916004358, 912.4251721415532, 9930.80138397228, 9968.601255949754, 9996.850047249225, 10073.748156296078, 10074.89925100747, 3703.9814800925824, 3825.1967086911504, 3997.380406037069, 4019.2765302245293, 4027.496562929634, 8510.234078932803, 8513.74458766238, 8515.19105684959, 8519.105493923173, 8525.44584601999, 4428.047969686533, 4432.091421258634, 4434.623057040188, 4443.178012067778, 4458.242098843204, 3567.2152126532123, 3703.9814800925824, 3908.3160446922243, 4010.3583426651594, 4015.477987861559, 3417.743669224818, 3442.7934323940644, 3536.0629433200224, 3540.2211513466996, 3586.211033572662, 1109.434188563822, 1115.3809635652292, 1118.4854966715402, 1124.4827379405401, 1130.5025788652965, 763.5571368606195, 801.9494462254465, 831.9459235149695, 848.8472075026555, 889.6085722282176, 5010.924836127461, 5248.6325957182635, 5253.317068781034, 5279.234510995961, 5392.110301800238, 806.8144326804868, 826.4008593769469, 838.8322335532796, 858.8368210040072, 885.3404213860715, 3632.002398680715, 3773.566039905446, 3823.2735780201674, 3859.2474467478573, 3906.374980003186, 8867.955660221658, 9056.547172641342, 9105.81788364229, 9137.360384773003, 9139.314551408672, 9033.548322583845, 9058.36591438593, 9092.408993415407, 9134.132257435665, 9152.130547597968, 6804.591724496546, 6856.862862742717, 6869.0, 6899.793006209822, 6927.134108236471, 5042.243663450365, 5236.6857988520815, 5250.26496290512, 5263.7630156913865, 5268.998890210848, 8056.154103819014, 8188.672453101809, 8340.708075217339, 8384.077751447458, 8496.532690701824, 8235.629396677285, 8258.545779982158, 8437.578121094044, 8439.535825529654, 8449.197326253996, 5805.187273781758, 6002.759889604367, 6138.815835524942, 6196.1015652731, 6234.657093859882, 6687.264400915798, 6968.790936271717, 6978.581285122706, 7139.214686384597, 7155.92661100839, 6315.0, 6323.36766323364, 6389.233292004989, 6471.611703297817, 6646.069550263063, 6263.467605253422, 6268.341824108403, 6301.0863424804065, 6313.526485513513, 6327.86098502274, 5959.10613407975, 6032.607880487754, 6059.787907423219, 6068.0, 6073.301570319293, 4607.193741095228, 4701.294805779161, 4734.147853386424, 4742.881427964328, 4746.19314716506, 4612.377329060534, 4628.328892310664, 4679.953200468088, 4760.976195119002, 4872.171730805842], "value": 3971.2174645369355, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [279.27388789148216, 281.9816711913725, 289.0720786276053, 291.0236157690947, 292.5436319341828, 4794.640401969848, 4907.435644900837, 4943.184374578194, 5015.398152221734, 5041.77312020959, 4684.367610372598, 4813.253945638423, 4841.515848415157, 4861.270809378595, 4893.853184404474, 3820.4842346283313, 3831.329517334469, 3864.9227015459674, 3866.4007078902673, 3868.1490072184074, 3728.8881333560034, 3863.821534431997, 3874.4575759393706, 3896.6687831534355, 3897.59075297094, 3805.2602126468896, 3810.7141964352786, 3820.2550502651993, 3830.6743926766258, 3864.2851072551666, 3812.8474861005525, 3819.567662126716, 3824.177801772604, 3831.252905683393, 3840.2703486337505, 3382.475716263983, 3400.5409269748516, 3402.894059430695, 3408.7784294021058, 3413.2320227948762, 4691.0, 4770.833020844254, 4810.639721226529, 4833.275008748681, 4867.515407800619, 4333.8699839004885, 4343.913121737579, 4353.934690979638, 4358.36803663467, 4376.912461750779, 5087.898242035176, 5126.410462796789, 5134.383873935114, 5143.588512918995, 5187.429382767892, 3595.2989167112423, 3687.2994131115, 3699.3711069118044, 3703.7037037037244, 3708.4808126862263, 5330.520253177194, 5338.27933229013, 5349.679019258857, 5349.7057661828585, 5351.919721204185, 3737.9160043587053, 3768.717346199046, 3771.5474143103, 3779.149691319431, 3789.4694742736037, 3825.1202223488754, 3830.80845957701, 3836.271108489378, 3836.5779764225913, 3836.635519625631, 4181.853635122756, 4304.160688665743, 4356.6950313477755, 4363.5564084113, 4382.452193475816, 5103.438621751604, 5103.8468845934685, 5110.0, 5114.948850511521, 5122.282880396748, 1223.2721530689403, 1256.5162412471082, 1288.4910460368103, 1310.737852429518, 1333.7132516508998, 890.3589415620743, 918.820829938169, 922.6217250927087, 928.1971095002909, 932.8927173375013, 4600.493945665974, 4626.398568186181, 4629.768511574408, 4630.143423466669, 4633.62930965522, 5142.30578871855, 5300.416954135042, 5346.518813306821, 5362.410134885159, 5366.543843773245, 4471.329300604935, 4579.656525760582, 4599.494055653875, 4602.366160013214, 4622.976885115553, 2454.6931633545805, 2458.987705061463, 2463.1994601754145, 2481.4416756229703, 2494.9416731196834, 4400.359784129497, 4429.667774916894, 4430.490493593278, 4438.822447102079, 4454.22051141049, 4470.463544374696, 4723.6929599575915, 4731.313959475857, 4744.695208817603, 4772.832950846704, 4453.955460445354, 4469.664775141878, 4479.238529450001, 4491.910161796811, 4508.098380323882, 4675.200047981483, 4683.882902927454, 4729.43246810385, 4731.881702957454, 4746.833860814855, 4356.629686476685, 4544.454665440168, 4546.9545304547855, 4561.49823519406, 4595.276771210796, 4413.455290648248, 4452.821887124479, 4455.551945617752, 4472.597466228055, 4495.21333766583, 3428.348613763477, 3454.671806178409, 3476.210930086218, 3485.1984043670604, 3485.3726329260976, 4532.255081793467, 4614.561616646413, 4657.767111644472, 4730.385049943486, 4743.857684269477, 4497.740632622871, 4504.369388285708, 4514.977425112854, 4520.6383489320115, 4548.909021819479, 4505.504394516535, 4514.45826500822, 4521.909561808679, 4547.704399214041, 4564.452265728134, 4491.236489796677, 4496.303073023687, 4604.654650901129, 4873.585745211555, 5143.871403214949, 5179.766910488962, 5183.481651834786, 5184.533391994588, 5199.4020687621405, 5220.9477905220465, 5058.91233384824, 5071.290019397214, 5074.644774865724, 5087.0, 5111.744412779421], "value": 3735.941311187192, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [607.2075940897128, 629.6033498895695, 650.921889373275, 665.9400653941144, 717.4619035723208, 12805.615831525045, 13796.448142074305, 13847.861521384782, 13895.096818706777, 13947.581572552814, 12532.248065116099, 12781.360931953388, 12880.549180778675, 12900.1614895032, 12908.806367904488, 740.3743836458184, 755.7241606813528, 757.8711619024751, 757.9545227286353, 758.8140905478137, 602.7679343452759, 618.3785295777737, 738.78205929251, 757.0914902117454, 770.8728059870115, 804.9718259860906, 806.0649646410166, 806.6370133439946, 806.9031716194036, 808.2241048593357, 794.6980147543954, 795.5783434779576, 797.2904115337354, 798.6126728536655, 798.876174193001, 587.7913340764053, 588.4615576747271, 588.9617174883618, 589.6638915817986, 590.1796502861026, 12017.0, 12053.0, 12205.877941220562, 12237.632871013884, 12243.449044793006, 12378.257304561756, 12540.74918501634, 12823.61529154127, 12961.0, 13026.241457403225, 10247.38515689061, 10283.331583447052, 10343.637972670997, 10521.15830733547, 10717.30337528066, 3243.8702451901895, 3268.4116858965376, 3318.950215746766, 3350.5811773528308, 3475.930481390358, 55005.44994550043, 55759.72120139414, 56565.0, 59288.40711592915, 59848.70075649594, 9585.712428627152, 9769.706908792748, 9792.118709316195, 9817.754556136153, 9892.406455612687, 16902.830971690124, 17445.127743612768, 17456.12719364052, 17482.213300401512, 17540.122993850255, 6626.304238055031, 6635.303293154149, 6761.29006454325, 6771.695273712695, 6901.965490172517, 3507.8246087696025, 3710.350688629479, 3715.8142092895246, 3727.7390582658954, 3775.414810704345, 2862.627858378439, 2965.0660042086674, 2972.1380799567883, 2972.4500967320682, 2981.7167369099902, 496.5282981167905, 507.45955557331325, 508.9770960306795, 511.50384127396364, 538.6050130162897, 563.9904570818271, 611.6360765344613, 616.6824085595922, 619.662284055182, 634.4163369699887, 8258.463199891989, 8817.603207855662, 8965.417247878868, 8991.77520561978, 9343.859842102374, 588.2088590845307, 597.9402059793986, 609.442360240384, 617.5152505283331, 649.1496140056541, 4034.9394759078637, 4147.212029714345, 4169.2703776838935, 4213.641840443535, 4245.936310955338, 81635.0, 101573.0, 104831.66178367441, 106352.46823765832, 106390.0, 63853.68073159605, 83436.58281708675, 84309.15690843135, 84701.57649211837, 86330.56834715787, 46404.07191856211, 50999.74500127476, 56514.434855650914, 64921.67539162274, 71733.28266717267, 7528.0, 8024.197580242163, 8132.552709601029, 8138.348932085537, 8171.713990010321, 43392.56607433885, 43799.0, 44117.77941110402, 44397.33403999007, 45137.77431112823, 35742.285154297286, 47828.76085619689, 62468.68765656143, 62511.0, 63632.0, 10075.395476271447, 10144.479256051554, 10222.437765922648, 10271.229657775548, 10396.844047339144, 11907.642770716893, 11928.403579821148, 12024.639260822189, 12285.75428491443, 12292.754144917231, 11022.063124634175, 11237.157213208879, 11303.773924521627, 11309.491072901903, 11424.0, 10305.0, 10409.323393979366, 10488.842667360148, 11048.337099774039, 11640.301581905112, 10246.38521688701, 10370.014848589371, 10879.564817407532, 10923.617673381394, 11149.386783726648, 9077.500737459502, 9195.310351723514, 9280.396774209656, 9429.434233945985, 9458.668946586837, 8885.555722213734, 9483.810323793348, 9535.809283814146, 9744.512774361396, 9815.607375704893], "value": 6350.622809087899, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1587.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 116.0, 115.0, 116.0, 116.0, 117.0, 114.0, 115.0, 117.0, 116.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 132.0, 132.0, 174.0, 136.0, 131.0, 130.0, 131.0, 173.0, 135.0], "value": 143.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 164.0, 164.0, 165.0, 164.0, 166.0, 163.0, 164.0, 163.0, 164.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 76.0, 106.0, 78.0, 77.0, 75.0, 78.0, 98.0, 76.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 119.0, 86.0, 85.0, 85.0, 101.0, 84.0, 83.0, 125.0], "value": 93.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 119.0, 117.0, 118.0, 117.0, 120.0, 120.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 150.0, 148.0, 149.0, 149.0, 147.0, 150.0, 148.0, 148.0, 148.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 97.0, 97.0, 97.0, 97.0, 96.0, 97.0, 97.0, 99.0], "value": 96.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 65.0, 65.0, 66.0, 67.0, 69.0, 66.0, 65.0, 66.0, 65.0], "value": 66.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 66.0, 69.0, 66.0, 67.0, 67.0, 66.0, 67.0], "value": 66.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 92.0, 85.0, 90.0, 84.0, 85.0, 84.0, 84.0, 84.0, 87.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 166.0, 150.0, 146.0, 146.0, 147.0, 156.0, 151.0, 182.0, 142.0], "value": 152.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 185.0, 184.0, 181.0, 182.0, 174.0, 175.0, 177.0, 179.0, 174.0], "value": 178.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 79.0, 71.0, 73.0, 69.0, 73.0, 70.0, 73.0, 76.0], "value": 73.2, "unit": "score"}]}]} 22:35:18 INFO - Return code: 0 22:35:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:35:18 ERROR - # TBPL SUCCESS # 22:35:18 INFO - Running post-action listener: _resource_record_post_action 22:35:18 INFO - [mozharness: 2016-10-05 05:35:18.795693Z] Finished run-tests step (success) 22:35:18 INFO - Running post-run listener: _resource_record_post_run 22:35:18 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 409067520; Read time: 156; Write time: 257628 22:35:18 INFO - TinderboxPrint: CPU usage
13.5% 22:35:18 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 156 22:35:18 INFO - TinderboxPrint: I/O write bytes / time
409,067,520 / 257,628 22:35:18 INFO - TinderboxPrint: CPU idle
8,279.9 (86.5%) 22:35:18 INFO - TinderboxPrint: CPU user
1,229.7 (12.9%) 22:35:18 INFO - TinderboxPrint: Swap in / out
0 / 0 22:35:18 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 115884032; Read time: 0; Write time: 63004 22:35:18 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292028416; Read time: 156; Write time: 194552 22:35:19 INFO - Running post-run listener: _upload_blobber_files 22:35:19 INFO - Blob upload gear active. 22:35:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:35:19 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 22:35:19 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'] 22:35:19 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 22:35:19 INFO - (blobuploader) - INFO - Open directory for files ... 22:35:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:35:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:35:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:35:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:35:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:35:20 INFO - (blobuploader) - INFO - Done attempting. 22:35:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:35:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:35:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:35:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:35:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:35:21 INFO - (blobuploader) - INFO - Done attempting. 22:35:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:35:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:35:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:35:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:35:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:35:24 INFO - (blobuploader) - INFO - Done attempting. 22:35:24 INFO - (blobuploader) - INFO - Iteration through files over. 22:35:24 INFO - Return code: 0 22:35:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:35:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:35:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/30775731d27feaa54de4c7e3a41f96c863f5628739bce3b6f3cb88308f81f2eb5d9a593f405b4c3e01843f87fef036cb9c64f81c3e8329f3354526a4d839e185", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4df1eaed60f91ec4a3f71fd7760fb6d152e38089e5539dff79ad19ec17d7fc5d3beac677bf7ea94dec4bb0fb2d79ee24d6986585ff871c64f4e748a2a53df580", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1012563135c385b58d44dc7bba973428744caa2d6df712bfd0e3f1eda31cfd5c17607ba162a229e821f42ffd886bade95f7dc7efd44c31a31da3558bf4083b28"} 22:35:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:35:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:35:24 INFO - Contents: 22:35:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/30775731d27feaa54de4c7e3a41f96c863f5628739bce3b6f3cb88308f81f2eb5d9a593f405b4c3e01843f87fef036cb9c64f81c3e8329f3354526a4d839e185", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4df1eaed60f91ec4a3f71fd7760fb6d152e38089e5539dff79ad19ec17d7fc5d3beac677bf7ea94dec4bb0fb2d79ee24d6986585ff871c64f4e748a2a53df580", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1012563135c385b58d44dc7bba973428744caa2d6df712bfd0e3f1eda31cfd5c17607ba162a229e821f42ffd886bade95f7dc7efd44c31a31da3558bf4083b28"} 22:35:24 INFO - Running post-run listener: copy_logs_to_upload_dir 22:35:24 INFO - Copying logs to upload dir... 22:35:24 INFO - mkdir: /builds/slave/test/build/upload/logs 22:35:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.606273 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-10-04 22:35:24.493037) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 22:35:24.497521) ========= 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=0333a256a5e4f052382dd180000001b1-1475643662.990995-2126107780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/30775731d27feaa54de4c7e3a41f96c863f5628739bce3b6f3cb88308f81f2eb5d9a593f405b4c3e01843f87fef036cb9c64f81c3e8329f3354526a4d839e185", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4df1eaed60f91ec4a3f71fd7760fb6d152e38089e5539dff79ad19ec17d7fc5d3beac677bf7ea94dec4bb0fb2d79ee24d6986585ff871c64f4e748a2a53df580", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1012563135c385b58d44dc7bba973428744caa2d6df712bfd0e3f1eda31cfd5c17607ba162a229e821f42ffd886bade95f7dc7efd44c31a31da3558bf4083b28"} build_url:https://queue.taskcluster.net/v1/task/Pg9wISahRH--Kd5U-XBntg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011380 build_url: 'https://queue.taskcluster.net/v1/task/Pg9wISahRH--Kd5U-XBntg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/30775731d27feaa54de4c7e3a41f96c863f5628739bce3b6f3cb88308f81f2eb5d9a593f405b4c3e01843f87fef036cb9c64f81c3e8329f3354526a4d839e185", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4df1eaed60f91ec4a3f71fd7760fb6d152e38089e5539dff79ad19ec17d7fc5d3beac677bf7ea94dec4bb0fb2d79ee24d6986585ff871c64f4e748a2a53df580", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1012563135c385b58d44dc7bba973428744caa2d6df712bfd0e3f1eda31cfd5c17607ba162a229e821f42ffd886bade95f7dc7efd44c31a31da3558bf4083b28"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 22:35:24.524079) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 22:35:24.524476) ========= 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=0333a256a5e4f052382dd180000001b1-1475643662.990995-2126107780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004527 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 22:35:24.607965) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 22:35:24.608322) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 22:35:24.608696) ========= ========= Total master_lag: 0.18 =========