builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-058 starttime: 1465301148.18 results: success (0) buildid: 20160607023009 builduid: a910ca6b4951493db05745f6650c5535 revision: c227ee36b4844af150165c64e13347f483db8284 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 05:05:48.180760) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 05:05:48.181237) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 05:05:48.182720) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 05:05:48.197965) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 05:05:48.198314) ========= 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=0e2a256762fed810e2f0f810000001b3-1465300942.668297-897120733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-07 05:05:48-- 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% 219M=0s 2016-06-07 05:05:48 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.147047 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 05:05:48.361603) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 05:05:48.361898) ========= 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=0e2a256762fed810e2f0f810000001b3-1465300942.668297-897120733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015930 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 05:05:48.412580) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-07 05:05:48.412965) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c227ee36b4844af150165c64e13347f483db8284 --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 c227ee36b4844af150165c64e13347f483db8284 --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=0e2a256762fed810e2f0f810000001b3-1465300942.668297-897120733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-07 05:05:48,562 truncating revision to first 12 chars 2016-06-07 05:05:48,562 Setting DEBUG logging. 2016-06-07 05:05:48,563 attempt 1/10 2016-06-07 05:05:48,563 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c227ee36b484?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-07 05:05:49,556 unpacking tar archive at: fx-team-c227ee36b484/testing/mozharness/ program finished with exit code 0 elapsedTime=1.319856 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-07 05:05:49.746955) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 05:05:49.747295) ========= script_repo_revision: c227ee36b4844af150165c64e13347f483db8284 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 05:05:49.747697) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 05:05:49.747966) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 05:05:49.756168) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-07 05:05:49.756498) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1465300942.668297-897120733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:05:49 INFO - MultiFileLogger online at 20160607 05:05:49 in /builds/slave/test 05:05:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:05:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:05:49 INFO - {'append_to_log': False, 05:05:49 INFO - 'base_work_dir': '/builds/slave/test', 05:05:49 INFO - 'blob_upload_branch': 'Fx-Team', 05:05:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:05:49 INFO - 'branch': 'Fx-Team', 05:05:49 INFO - 'buildbot_json_path': 'buildprops.json', 05:05:49 INFO - 'config_files': ('talos/linux_config.py',), 05:05:49 INFO - 'default_actions': ('clobber', 05:05:49 INFO - 'read-buildbot-config', 05:05:49 INFO - 'download-and-extract', 05:05:49 INFO - 'populate-webroot', 05:05:49 INFO - 'create-virtualenv', 05:05:49 INFO - 'install', 05:05:49 INFO - 'run-tests'), 05:05:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:05:49 INFO - 'download_minidump_stackwalk': True, 05:05:49 INFO - 'download_symbols': 'ondemand', 05:05:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:05:49 INFO - 'tooltool.py': '/tools/tooltool.py', 05:05:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:05:49 INFO - '/tools/misc-python/virtualenv.py')}, 05:05:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:05:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:05:49 INFO - 'installer_path': 'installer.exe', 05:05:49 INFO - 'log_level': 'info', 05:05:49 INFO - 'log_name': 'talos', 05:05:49 INFO - 'log_to_console': True, 05:05:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:05:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:05:49 INFO - 'opt_config_files': (), 05:05:49 INFO - 'pip_index': False, 05:05:49 INFO - 'sps_profile': False, 05:05:49 INFO - 'sps_profile_interval': 0, 05:05:49 INFO - 'suite': 'dromaeojs-e10s', 05:05:49 INFO - 'system_bits': '32', 05:05:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:05:49 INFO - 'title': 'talos-linux64-ix-058', 05:05:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:05:49 INFO - 'use_talos_json': True, 05:05:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:05:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:05:49 INFO - 'work_dir': 'build'} 05:05:49 INFO - ##### 05:05:49 INFO - ##### Running clobber step. 05:05:49 INFO - ##### 05:05:49 INFO - Running pre-action listener: _resource_record_pre_action 05:05:49 INFO - Running main action method: clobber 05:05:49 INFO - rmtree: /builds/slave/test/build 05:05:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:05:50 INFO - Running post-action listener: _resource_record_post_action 05:05:50 INFO - ##### 05:05:50 INFO - ##### Finished clobber step (success) 05:05:50 INFO - ##### 05:05:50 INFO - ##### 05:05:50 INFO - ##### Running read-buildbot-config step. 05:05:50 INFO - ##### 05:05:50 INFO - Running pre-action listener: _resource_record_pre_action 05:05:50 INFO - Running main action method: read_buildbot_config 05:05:50 INFO - Using buildbot properties: 05:05:50 INFO - { 05:05:50 INFO - "project": "", 05:05:50 INFO - "product": "firefox", 05:05:50 INFO - "script_repo_revision": "production", 05:05:50 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:05:50 INFO - "repository": "", 05:05:50 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 05:05:50 INFO - "buildid": "20160607023009", 05:05:50 INFO - "pgo_build": "True", 05:05:50 INFO - "basedir": "/builds/slave/test", 05:05:50 INFO - "buildnumber": 818, 05:05:50 INFO - "slavename": "talos-linux64-ix-058", 05:05:50 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:05:50 INFO - "platform": "ubuntu64_hw", 05:05:50 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:05:50 INFO - "branch": "fx-team", 05:05:50 INFO - "repo_path": "integration/fx-team", 05:05:50 INFO - "revision": "c227ee36b4844af150165c64e13347f483db8284", 05:05:50 INFO - "stage_platform": "linux64-pgo", 05:05:50 INFO - "builduid": "a910ca6b4951493db05745f6650c5535", 05:05:50 INFO - "slavebuilddir": "test" 05:05:50 INFO - } 05:05:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/cLJdxxO8SB-zVBlqpzJzFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:05:50 INFO - Running post-action listener: _resource_record_post_action 05:05:50 INFO - ##### 05:05:50 INFO - ##### Finished read-buildbot-config step (success) 05:05:50 INFO - ##### 05:05:50 INFO - ##### 05:05:50 INFO - ##### Running download-and-extract step. 05:05:50 INFO - ##### 05:05:50 INFO - Running pre-action listener: _resource_record_pre_action 05:05:50 INFO - Running main action method: download_and_extract 05:05:50 INFO - mkdir: /builds/slave/test/build/tests 05:05:50 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:50 INFO - https://queue.taskcluster.net/v1/task/cLJdxxO8SB-zVBlqpzJzFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:05:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLJdxxO8SB-zVBlqpzJzFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:05:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLJdxxO8SB-zVBlqpzJzFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:05:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLJdxxO8SB-zVBlqpzJzFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:05:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLJdxxO8SB-zVBlqpzJzFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:05:51 INFO - Downloaded 1361 bytes. 05:05:51 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:05:51 INFO - Using the following test package requirements: 05:05:51 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:05:51 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:05:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:05:51 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:05:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:05:51 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:05:51 INFO - u'jsshell-linux-x86_64.zip'], 05:05:51 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:05:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:05:51 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:05:51 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:05:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:05:51 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:05:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:05:51 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:05:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:05:51 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:05:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:05:51 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:05:51 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:51 INFO - https://queue.taskcluster.net/v1/task/cLJdxxO8SB-zVBlqpzJzFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:05:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLJdxxO8SB-zVBlqpzJzFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:05:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLJdxxO8SB-zVBlqpzJzFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:05:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLJdxxO8SB-zVBlqpzJzFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:05:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLJdxxO8SB-zVBlqpzJzFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:05:52 INFO - Downloaded 24444404 bytes. 05:05:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:05:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:05:54 INFO - Return code: 0 05:05:54 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:05: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:54 INFO - https://queue.taskcluster.net/v1/task/cLJdxxO8SB-zVBlqpzJzFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:05:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLJdxxO8SB-zVBlqpzJzFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:05:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLJdxxO8SB-zVBlqpzJzFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:05:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLJdxxO8SB-zVBlqpzJzFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:05:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLJdxxO8SB-zVBlqpzJzFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:05:56 INFO - Downloaded 24444404 bytes. 05:05:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:05:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:05:58 INFO - Return code: 0 05:05: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:58 INFO - https://queue.taskcluster.net/v1/task/cLJdxxO8SB-zVBlqpzJzFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:05:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLJdxxO8SB-zVBlqpzJzFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:05:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLJdxxO8SB-zVBlqpzJzFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:05:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLJdxxO8SB-zVBlqpzJzFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:05:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLJdxxO8SB-zVBlqpzJzFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:05:59 INFO - Downloaded 10833369 bytes. 05:05:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:05:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:05:59 INFO - Return code: 0 05:05: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:59 INFO - https://queue.taskcluster.net/v1/task/cLJdxxO8SB-zVBlqpzJzFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:05:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLJdxxO8SB-zVBlqpzJzFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:05:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLJdxxO8SB-zVBlqpzJzFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:05:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLJdxxO8SB-zVBlqpzJzFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:05:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLJdxxO8SB-zVBlqpzJzFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:06:01 INFO - Downloaded 59201006 bytes. 05:06:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cLJdxxO8SB-zVBlqpzJzFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:06:01 INFO - mkdir: /builds/slave/test/properties 05:06:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:06:01 INFO - Writing to file /builds/slave/test/properties/build_url 05:06:01 INFO - Contents: 05:06:01 INFO - build_url:https://queue.taskcluster.net/v1/task/cLJdxxO8SB-zVBlqpzJzFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:06:02 INFO - Running post-action listener: _resource_record_post_action 05:06:02 INFO - Running post-action listener: set_extra_try_arguments 05:06:02 INFO - ##### 05:06:02 INFO - ##### Finished download-and-extract step (success) 05:06:02 INFO - ##### 05:06:02 INFO - ##### 05:06:02 INFO - ##### Running populate-webroot step. 05:06:02 INFO - ##### 05:06:02 INFO - Running pre-action listener: _resource_record_pre_action 05:06:02 INFO - Running main action method: populate_webroot 05:06:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:06:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:06:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:06:02 INFO - '--tppagecycles', 05:06:02 INFO - '7'], 05:06:02 INFO - 'tests': ['tsvgm']}}, 05:06:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:06:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:06:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:06:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:06:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:06:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:06:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:02 INFO - 'talos_options': ['--disable-e10s'], 05:06:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:06:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:06:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:02 INFO - 'talos_options': ['--disable-e10s'], 05:06:02 INFO - 'tests': ['damp', 'tps']}, 05:06:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:02 INFO - 'tests': ['damp', 'tps']}, 05:06:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:06:02 INFO - 'tests': ['dromaeo_dom']}, 05:06:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:06:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:06:02 INFO - 'tests': ['a11yr', 05:06:02 INFO - 'ts_paint', 05:06:02 INFO - 'tpaint', 05:06:02 INFO - 'sessionrestore', 05:06:02 INFO - 'sessionrestore_no_auto_restore', 05:06:02 INFO - 'tabpaint']}, 05:06:02 INFO - 'other-e10s': {'tests': ['a11yr', 05:06:02 INFO - 'ts_paint', 05:06:02 INFO - 'tpaint', 05:06:02 INFO - 'sessionrestore', 05:06:02 INFO - 'sessionrestore_no_auto_restore', 05:06:02 INFO - 'tabpaint']}, 05:06:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:06:02 INFO - 'ts_paint', 05:06:02 INFO - 'tpaint', 05:06:02 INFO - 'sessionrestore', 05:06:02 INFO - 'sessionrestore_no_auto_restore', 05:06:02 INFO - 'tabpaint']}, 05:06:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:06:02 INFO - 'ts_paint', 05:06:02 INFO - 'tpaint', 05:06:02 INFO - 'sessionrestore', 05:06:02 INFO - 'sessionrestore_no_auto_restore', 05:06:02 INFO - 'tabpaint']}, 05:06:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:06:02 INFO - 'tests': ['a11yr', 05:06:02 INFO - 'ts_paint', 05:06:02 INFO - 'tpaint', 05:06:02 INFO - 'sessionrestore', 05:06:02 INFO - 'sessionrestore_no_auto_restore', 05:06:02 INFO - 'tabpaint']}, 05:06:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:06:02 INFO - 'tests': ['a11yr', 05:06:02 INFO - 'ts_paint', 05:06:02 INFO - 'tpaint', 05:06:02 INFO - 'sessionrestore', 05:06:02 INFO - 'sessionrestore_no_auto_restore', 05:06:02 INFO - 'tabpaint']}, 05:06:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:06:02 INFO - 'tests': ['tsvgx', 05:06:02 INFO - 'tsvgr_opacity', 05:06:02 INFO - 'tart', 05:06:02 INFO - 'tscrollx', 05:06:02 INFO - 'cart']}, 05:06:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:06:02 INFO - 'tsvgr_opacity', 05:06:02 INFO - 'tart', 05:06:02 INFO - 'tscrollx', 05:06:02 INFO - 'cart']}, 05:06:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:02 INFO - 'talos_options': ['--disable-e10s'], 05:06:02 INFO - 'tests': ['tp5o']}, 05:06:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:02 INFO - 'tests': ['tp5o']}, 05:06:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:02 INFO - 'talos_options': ['--disable-e10s', 05:06:02 INFO - '--xperf_path', 05:06:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:06:02 INFO - 'tests': ['tp5n']}, 05:06:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:02 INFO - 'talos_options': ['--xperf_path', 05:06:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:06:02 INFO - 'tests': ['tp5n']}}, 05:06:02 INFO - 'talos.zip': {'path': '', 05:06:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:06:02 INFO - Running post-action listener: _resource_record_post_action 05:06:02 INFO - ##### 05:06:02 INFO - ##### Finished populate-webroot step (success) 05:06:02 INFO - ##### 05:06:02 INFO - ##### 05:06:02 INFO - ##### Running create-virtualenv step. 05:06:02 INFO - ##### 05:06:02 INFO - Running pre-action listener: _resource_record_pre_action 05:06:02 INFO - Running main action method: create_virtualenv 05:06:02 INFO - Creating virtualenv /builds/slave/test/build/venv 05:06:02 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:06:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:06:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:06:02 INFO - Using real prefix '/usr' 05:06:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:06:03 INFO - Installing distribute.............................................................................................................................................................................................done. 05:06:05 INFO - Installing pip.................done. 05:06:05 INFO - Return code: 0 05:06:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:06:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa336ea7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1904190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1996110>, '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 0x1902230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19026c0>, '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': '0e2a256762fed810e2f0f810000001b3-1465300942.668297-897120733', '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 05:06:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:06:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:06:05 INFO - Using env: {'DISPLAY': ':0', 05:06:05 INFO - 'HOME': '/home/cltbld', 05:06:05 INFO - 'LANG': 'en_US.UTF-8', 05:06:05 INFO - 'LANGUAGE': 'en_US:en', 05:06:05 INFO - 'LOGNAME': 'cltbld', 05:06:05 INFO - 'MAIL': '/var/mail/cltbld', 05:06:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:05 INFO - 'MOZ_NO_REMOTE': '1', 05:06:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:05 INFO - 'NO_EM_RESTART': '1', 05:06:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:05 INFO - 'PWD': '/builds/slave/test', 05:06:05 INFO - 'SHELL': '/bin/bash', 05:06:05 INFO - 'SHLVL': '1', 05:06:05 INFO - 'TERM': 'linux', 05:06:05 INFO - 'TMOUT': '86400', 05:06:05 INFO - 'USER': 'cltbld', 05:06:05 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465300942.668297-897120733', 05:06:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:05 INFO - '_': '/tools/buildbot/bin/python'} 05:06:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:05 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:06:05 INFO - Cleaning up... 05:06:05 INFO - Return code: 0 05:06:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:06:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa336ea7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1904190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1996110>, '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 0x1902230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19026c0>, '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': '0e2a256762fed810e2f0f810000001b3-1465300942.668297-897120733', '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 05:06:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:06:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:06:05 INFO - Using env: {'DISPLAY': ':0', 05:06:05 INFO - 'HOME': '/home/cltbld', 05:06:05 INFO - 'LANG': 'en_US.UTF-8', 05:06:05 INFO - 'LANGUAGE': 'en_US:en', 05:06:05 INFO - 'LOGNAME': 'cltbld', 05:06:05 INFO - 'MAIL': '/var/mail/cltbld', 05:06:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:05 INFO - 'MOZ_NO_REMOTE': '1', 05:06:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:05 INFO - 'NO_EM_RESTART': '1', 05:06:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:05 INFO - 'PWD': '/builds/slave/test', 05:06:05 INFO - 'SHELL': '/bin/bash', 05:06:05 INFO - 'SHLVL': '1', 05:06:05 INFO - 'TERM': 'linux', 05:06:05 INFO - 'TMOUT': '86400', 05:06:05 INFO - 'USER': 'cltbld', 05:06:05 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465300942.668297-897120733', 05:06:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:05 INFO - '_': '/tools/buildbot/bin/python'} 05:06:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:05 INFO - Downloading/unpacking psutil>=3.1.1 05:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:06:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:06:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:06:07 INFO - Installing collected packages: psutil 05:06:07 INFO - Running setup.py install for psutil 05:06:07 INFO - building 'psutil._psutil_linux' extension 05:06:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:06:07 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 05:06:07 INFO - building 'psutil._psutil_posix' extension 05:06:07 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 05:06:07 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 05:06:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:06:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:06:08 INFO - Successfully installed psutil 05:06:08 INFO - Cleaning up... 05:06:08 INFO - Return code: 0 05:06:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:06:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa336ea7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1904190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1996110>, '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 0x1902230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19026c0>, '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': '0e2a256762fed810e2f0f810000001b3-1465300942.668297-897120733', '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 05:06:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:06:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:06:08 INFO - Using env: {'DISPLAY': ':0', 05:06:08 INFO - 'HOME': '/home/cltbld', 05:06:08 INFO - 'LANG': 'en_US.UTF-8', 05:06:08 INFO - 'LANGUAGE': 'en_US:en', 05:06:08 INFO - 'LOGNAME': 'cltbld', 05:06:08 INFO - 'MAIL': '/var/mail/cltbld', 05:06:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:08 INFO - 'MOZ_NO_REMOTE': '1', 05:06:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:08 INFO - 'NO_EM_RESTART': '1', 05:06:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:08 INFO - 'PWD': '/builds/slave/test', 05:06:08 INFO - 'SHELL': '/bin/bash', 05:06:08 INFO - 'SHLVL': '1', 05:06:08 INFO - 'TERM': 'linux', 05:06:08 INFO - 'TMOUT': '86400', 05:06:08 INFO - 'USER': 'cltbld', 05:06:08 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465300942.668297-897120733', 05:06:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:08 INFO - '_': '/tools/buildbot/bin/python'} 05:06:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:06:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:06:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:06:10 INFO - Installing collected packages: mozsystemmonitor 05:06:10 INFO - Running setup.py install for mozsystemmonitor 05:06:10 INFO - Successfully installed mozsystemmonitor 05:06:10 INFO - Cleaning up... 05:06:10 INFO - Return code: 0 05:06:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:06: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa336ea7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1904190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1996110>, '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 0x1902230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19026c0>, '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': '0e2a256762fed810e2f0f810000001b3-1465300942.668297-897120733', '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 05:06:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:06:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:06:10 INFO - Using env: {'DISPLAY': ':0', 05:06:10 INFO - 'HOME': '/home/cltbld', 05:06:10 INFO - 'LANG': 'en_US.UTF-8', 05:06:10 INFO - 'LANGUAGE': 'en_US:en', 05:06:10 INFO - 'LOGNAME': 'cltbld', 05:06:10 INFO - 'MAIL': '/var/mail/cltbld', 05:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:10 INFO - 'MOZ_NO_REMOTE': '1', 05:06:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:10 INFO - 'NO_EM_RESTART': '1', 05:06:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:10 INFO - 'PWD': '/builds/slave/test', 05:06:10 INFO - 'SHELL': '/bin/bash', 05:06:10 INFO - 'SHLVL': '1', 05:06:10 INFO - 'TERM': 'linux', 05:06:10 INFO - 'TMOUT': '86400', 05:06:10 INFO - 'USER': 'cltbld', 05:06:10 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465300942.668297-897120733', 05:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:10 INFO - '_': '/tools/buildbot/bin/python'} 05:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:10 INFO - Downloading/unpacking jsonschema==2.5.1 05:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:06:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:12 INFO - Downloading functools32-3.2.3-2.tar.gz 05:06:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:06:12 INFO - warning: no files found matching '*.txt' 05:06:12 INFO - no previously-included directories found matching 'build' 05:06:12 INFO - no previously-included directories found matching 'dist' 05:06:12 INFO - no previously-included directories found matching '.git*' 05:06:12 INFO - Installing collected packages: jsonschema, functools32 05:06:12 INFO - Running setup.py install for functools32 05:06:12 INFO - warning: no files found matching '*.txt' 05:06:12 INFO - no previously-included directories found matching 'build' 05:06:12 INFO - no previously-included directories found matching 'dist' 05:06:12 INFO - no previously-included directories found matching '.git*' 05:06:12 INFO - Successfully installed jsonschema functools32 05:06:12 INFO - Cleaning up... 05:06:13 INFO - Return code: 0 05:06:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:06: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa336ea7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1904190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1996110>, '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 0x1902230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19026c0>, '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': '0e2a256762fed810e2f0f810000001b3-1465300942.668297-897120733', '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 05:06:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:06:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:06:13 INFO - Using env: {'DISPLAY': ':0', 05:06:13 INFO - 'HOME': '/home/cltbld', 05:06:13 INFO - 'LANG': 'en_US.UTF-8', 05:06:13 INFO - 'LANGUAGE': 'en_US:en', 05:06:13 INFO - 'LOGNAME': 'cltbld', 05:06:13 INFO - 'MAIL': '/var/mail/cltbld', 05:06:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:13 INFO - 'MOZ_NO_REMOTE': '1', 05:06:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:13 INFO - 'NO_EM_RESTART': '1', 05:06:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:13 INFO - 'PWD': '/builds/slave/test', 05:06:13 INFO - 'SHELL': '/bin/bash', 05:06:13 INFO - 'SHLVL': '1', 05:06:13 INFO - 'TERM': 'linux', 05:06:13 INFO - 'TMOUT': '86400', 05:06:13 INFO - 'USER': 'cltbld', 05:06:13 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465300942.668297-897120733', 05:06:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:13 INFO - '_': '/tools/buildbot/bin/python'} 05:06:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:13 INFO - Downloading/unpacking blobuploader==1.2.4 05:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:15 INFO - Downloading blobuploader-1.2.4.tar.gz 05:06:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:06:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:06: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 05:06: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 05:06: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 05:06: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 05:06: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 05:06: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 05:06:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:06:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:06: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 05:06: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 05:06: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 05:06: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 05:06: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 05:06: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 05:06:15 INFO - Downloading docopt-0.6.1.tar.gz 05:06:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:06:15 INFO - Installing collected packages: blobuploader, requests, docopt 05:06:15 INFO - Running setup.py install for blobuploader 05:06:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:06:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:06:15 INFO - Running setup.py install for requests 05:06:16 INFO - Running setup.py install for docopt 05:06:16 INFO - Successfully installed blobuploader requests docopt 05:06:16 INFO - Cleaning up... 05:06:16 INFO - Return code: 0 05:06:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:06:16 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:16 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:16 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 0x7fa336ea7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1904190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1996110>, '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 0x1902230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19026c0>, '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': '0e2a256762fed810e2f0f810000001b3-1465300942.668297-897120733', '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 05:06:16 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 05:06:16 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 05:06:16 INFO - Using env: {'DISPLAY': ':0', 05:06:16 INFO - 'HOME': '/home/cltbld', 05:06:16 INFO - 'LANG': 'en_US.UTF-8', 05:06:16 INFO - 'LANGUAGE': 'en_US:en', 05:06:16 INFO - 'LOGNAME': 'cltbld', 05:06:16 INFO - 'MAIL': '/var/mail/cltbld', 05:06:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:16 INFO - 'MOZ_NO_REMOTE': '1', 05:06:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:16 INFO - 'NO_EM_RESTART': '1', 05:06:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:16 INFO - 'PWD': '/builds/slave/test', 05:06:16 INFO - 'SHELL': '/bin/bash', 05:06:16 INFO - 'SHLVL': '1', 05:06:16 INFO - 'TERM': 'linux', 05:06:16 INFO - 'TMOUT': '86400', 05:06:16 INFO - 'USER': 'cltbld', 05:06:16 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465300942.668297-897120733', 05:06:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:16 INFO - '_': '/tools/buildbot/bin/python'} 05:06:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:06:16 INFO - Running setup.py (path:/tmp/pip-CWVgKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:06:16 INFO - Running setup.py (path:/tmp/pip-_v_1O3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:06:16 INFO - Running setup.py (path:/tmp/pip-7OHTsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:06:16 INFO - Running setup.py (path:/tmp/pip-Ze54qO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:06:16 INFO - Running setup.py (path:/tmp/pip-lI9pNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:06:17 INFO - Running setup.py (path:/tmp/pip-OOekUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:06:17 INFO - Running setup.py (path:/tmp/pip-kPas0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:06:17 INFO - Running setup.py (path:/tmp/pip-JroTsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:06:17 INFO - Running setup.py (path:/tmp/pip-p2B3tz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:06:17 INFO - Running setup.py (path:/tmp/pip-sG19fo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:06:17 INFO - Running setup.py (path:/tmp/pip-EGzzNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:06:17 INFO - Running setup.py (path:/tmp/pip-UtN1Y7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:06:17 INFO - Running setup.py (path:/tmp/pip-98vHS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:06:17 INFO - Running setup.py (path:/tmp/pip-blu5j0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:17 INFO - Running setup.py (path:/tmp/pip-i7hiwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:06:17 INFO - Running setup.py (path:/tmp/pip-3lOk47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:06:17 INFO - Running setup.py (path:/tmp/pip-2lHAky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:06:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:06:17 INFO - Running setup.py install for manifestparser 05:06:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:06:17 INFO - Running setup.py install for mozcrash 05:06:18 INFO - Running setup.py install for mozdebug 05:06:18 INFO - Running setup.py install for mozdevice 05:06:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:06:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:06:18 INFO - Running setup.py install for mozfile 05:06:18 INFO - Running setup.py install for mozhttpd 05:06:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:06:18 INFO - Running setup.py install for mozinfo 05:06:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:06:18 INFO - Running setup.py install for mozInstall 05:06:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:06:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:06:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:06:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:06:18 INFO - Running setup.py install for mozleak 05:06:18 INFO - Running setup.py install for mozlog 05:06:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:06:18 INFO - Running setup.py install for moznetwork 05:06:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:06:19 INFO - Running setup.py install for mozprocess 05:06:19 INFO - Running setup.py install for mozprofile 05:06:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:06:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:06:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:06:19 INFO - Running setup.py install for mozrunner 05:06:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:06:19 INFO - Running setup.py install for mozscreenshot 05:06:19 INFO - Running setup.py install for moztest 05:06:19 INFO - Running setup.py install for mozversion 05:06:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:06:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:06:19 INFO - Cleaning up... 05:06:19 INFO - Return code: 0 05:06:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:06:19 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:19 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:19 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 0x7fa336ea7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1904190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1996110>, '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 0x1902230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19026c0>, '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': '0e2a256762fed810e2f0f810000001b3-1465300942.668297-897120733', '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 05:06:19 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 05:06:19 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 05:06:19 INFO - Using env: {'DISPLAY': ':0', 05:06:19 INFO - 'HOME': '/home/cltbld', 05:06:19 INFO - 'LANG': 'en_US.UTF-8', 05:06:19 INFO - 'LANGUAGE': 'en_US:en', 05:06:19 INFO - 'LOGNAME': 'cltbld', 05:06:19 INFO - 'MAIL': '/var/mail/cltbld', 05:06:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:19 INFO - 'MOZ_NO_REMOTE': '1', 05:06:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:19 INFO - 'NO_EM_RESTART': '1', 05:06:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:19 INFO - 'PWD': '/builds/slave/test', 05:06:19 INFO - 'SHELL': '/bin/bash', 05:06:19 INFO - 'SHLVL': '1', 05:06:19 INFO - 'TERM': 'linux', 05:06:19 INFO - 'TMOUT': '86400', 05:06:19 INFO - 'USER': 'cltbld', 05:06:19 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465300942.668297-897120733', 05:06:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:19 INFO - '_': '/tools/buildbot/bin/python'} 05:06:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:06:19 INFO - Running setup.py (path:/tmp/pip-3V1CIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:06:19 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)) 05:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:06:19 INFO - Running setup.py (path:/tmp/pip-aRB_5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:06:20 INFO - Running setup.py (path:/tmp/pip-3C7tbQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:06:20 INFO - Running setup.py (path:/tmp/pip-ANNLlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:06:20 INFO - Running setup.py (path:/tmp/pip-ax6C6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:06:20 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)) 05:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:06:20 INFO - Running setup.py (path:/tmp/pip-YUNN9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:06:20 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)) 05:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:06:20 INFO - Running setup.py (path:/tmp/pip-ACJ44u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:06:20 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)) 05:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:06:20 INFO - Running setup.py (path:/tmp/pip-CyxtXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:06:20 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)) 05:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:06:20 INFO - Running setup.py (path:/tmp/pip-JWbHbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:06:20 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)) 05:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:06:20 INFO - Running setup.py (path:/tmp/pip-052Cj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 05:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:06:20 INFO - Running setup.py (path:/tmp/pip-_sJDqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:06:20 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)) 05:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:06:20 INFO - Running setup.py (path:/tmp/pip-LkcRY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 05:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:06:20 INFO - Running setup.py (path:/tmp/pip-boFMao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:06:20 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)) 05:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:06:20 INFO - Running setup.py (path:/tmp/pip-hLEPLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 05:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:20 INFO - Running setup.py (path:/tmp/pip-pQwt0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:06:21 INFO - Running setup.py (path:/tmp/pip-TF8MhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:06:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:06:21 INFO - Running setup.py (path:/tmp/pip-hzQ1N7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:06:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:06:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:06:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:06:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:06:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:06:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:06:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:23 INFO - Downloading blessings-1.6.tar.gz 05:06:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:06:23 INFO - Installing collected packages: blessings 05:06:23 INFO - Running setup.py install for blessings 05:06:23 INFO - Successfully installed blessings 05:06:23 INFO - Cleaning up... 05:06:23 INFO - Return code: 0 05:06:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:06:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:06:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:06:23 INFO - Reading from file tmpfile_stdout 05:06:23 INFO - Current package versions: 05:06:23 INFO - argparse == 1.2.1 05:06:23 INFO - blessings == 1.6 05:06:23 INFO - blobuploader == 1.2.4 05:06:23 INFO - docopt == 0.6.1 05:06:23 INFO - functools32 == 3.2.3-2 05:06:23 INFO - jsonschema == 2.5.1 05:06:23 INFO - manifestparser == 1.1 05:06:23 INFO - mozInstall == 1.12 05:06:23 INFO - mozcrash == 0.17 05:06:23 INFO - mozdebug == 0.1 05:06:23 INFO - mozdevice == 0.48 05:06:23 INFO - mozfile == 1.2 05:06:23 INFO - mozhttpd == 0.7 05:06:23 INFO - mozinfo == 0.9 05:06:23 INFO - mozleak == 0.1 05:06:23 INFO - mozlog == 3.2 05:06:23 INFO - moznetwork == 0.27 05:06:23 INFO - mozprocess == 0.22 05:06:23 INFO - mozprofile == 0.28 05:06:23 INFO - mozrunner == 6.11 05:06:23 INFO - mozscreenshot == 0.1 05:06:23 INFO - mozsystemmonitor == 0.3 05:06:23 INFO - moztest == 0.7 05:06:23 INFO - mozversion == 1.4 05:06:23 INFO - psutil == 3.1.1 05:06:23 INFO - requests == 1.2.3 05:06:23 INFO - wsgiref == 0.1.2 05:06:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:06:23 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:23 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:23 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 0x7fa336ea7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1904190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1996110>, '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 0x1902230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19026c0>, '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': '0e2a256762fed810e2f0f810000001b3-1465300942.668297-897120733', '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 05:06:23 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 05:06:23 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 05:06:23 INFO - Using env: {'DISPLAY': ':0', 05:06:23 INFO - 'HOME': '/home/cltbld', 05:06:23 INFO - 'LANG': 'en_US.UTF-8', 05:06:23 INFO - 'LANGUAGE': 'en_US:en', 05:06:23 INFO - 'LOGNAME': 'cltbld', 05:06:23 INFO - 'MAIL': '/var/mail/cltbld', 05:06:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:23 INFO - 'MOZ_NO_REMOTE': '1', 05:06:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:23 INFO - 'NO_EM_RESTART': '1', 05:06:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:23 INFO - 'PWD': '/builds/slave/test', 05:06:23 INFO - 'SHELL': '/bin/bash', 05:06:23 INFO - 'SHLVL': '1', 05:06:23 INFO - 'TERM': 'linux', 05:06:23 INFO - 'TMOUT': '86400', 05:06:23 INFO - 'USER': 'cltbld', 05:06:23 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465300942.668297-897120733', 05:06:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:23 INFO - '_': '/tools/buildbot/bin/python'} 05:06:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:23 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)) 05:06:23 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)) 05:06:23 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)) 05:06:23 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)) 05:06:23 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)) 05:06:23 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)) 05:06:23 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)) 05:06:23 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)) 05:06:23 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)) 05:06:23 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)) 05:06:23 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)) 05:06:23 INFO - Cleaning up... 05:06:23 INFO - Return code: 0 05:06:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:06:23 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:23 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:23 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 0x7fa336ea7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1904190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1996110>, '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 0x1902230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19026c0>, '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': '0e2a256762fed810e2f0f810000001b3-1465300942.668297-897120733', '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 05:06:23 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 05:06:23 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 05:06:23 INFO - Using env: {'DISPLAY': ':0', 05:06:23 INFO - 'HOME': '/home/cltbld', 05:06:23 INFO - 'LANG': 'en_US.UTF-8', 05:06:23 INFO - 'LANGUAGE': 'en_US:en', 05:06:23 INFO - 'LOGNAME': 'cltbld', 05:06:23 INFO - 'MAIL': '/var/mail/cltbld', 05:06:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:23 INFO - 'MOZ_NO_REMOTE': '1', 05:06:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:23 INFO - 'NO_EM_RESTART': '1', 05:06:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:23 INFO - 'PWD': '/builds/slave/test', 05:06:23 INFO - 'SHELL': '/bin/bash', 05:06:23 INFO - 'SHLVL': '1', 05:06:23 INFO - 'TERM': 'linux', 05:06:23 INFO - 'TMOUT': '86400', 05:06:23 INFO - 'USER': 'cltbld', 05:06:23 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465300942.668297-897120733', 05:06:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:23 INFO - '_': '/tools/buildbot/bin/python'} 05:06:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:06:23 INFO - Cleaning up... 05:06:23 INFO - Return code: 0 05:06:23 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:06:23 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:23 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:23 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa336ea7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1904190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1996110>, '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 0x1902230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19026c0>, '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': '0e2a256762fed810e2f0f810000001b3-1465300942.668297-897120733', '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 05:06:23 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', 'flake8'] in /builds/slave/test/build 05:06:23 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 flake8 05:06:23 INFO - Using env: {'DISPLAY': ':0', 05:06:23 INFO - 'HOME': '/home/cltbld', 05:06:23 INFO - 'LANG': 'en_US.UTF-8', 05:06:23 INFO - 'LANGUAGE': 'en_US:en', 05:06:23 INFO - 'LOGNAME': 'cltbld', 05:06:23 INFO - 'MAIL': '/var/mail/cltbld', 05:06:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:23 INFO - 'MOZ_NO_REMOTE': '1', 05:06:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:23 INFO - 'NO_EM_RESTART': '1', 05:06:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:23 INFO - 'PWD': '/builds/slave/test', 05:06:23 INFO - 'SHELL': '/bin/bash', 05:06:23 INFO - 'SHLVL': '1', 05:06:23 INFO - 'TERM': 'linux', 05:06:23 INFO - 'TMOUT': '86400', 05:06:23 INFO - 'USER': 'cltbld', 05:06:23 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465300942.668297-897120733', 05:06:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:23 INFO - '_': '/tools/buildbot/bin/python'} 05:06:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:24 INFO - Downloading/unpacking flake8 05:06:24 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 05:06:24 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 05:06:24 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 05:06:24 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 05:06:24 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 05:06:24 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 05:06:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:06:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:06:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:06:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:06:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:06:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:06:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:06:26 INFO - no previously-included directories found matching 'docs/_build' 05:06:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:06:26 INFO - Running setup.py install for pep8 05:06:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:06:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:06:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:06:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:06:26 INFO - no previously-included directories found matching 'docs/_build' 05:06:26 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:06:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:06:26 INFO - Cleaning up... 05:06:27 INFO - Return code: 0 05:06:27 INFO - Running post-action listener: _resource_record_post_action 05:06:27 INFO - Running post-action listener: _start_resource_monitoring 05:06:27 INFO - Starting resource monitoring. 05:06:27 INFO - ##### 05:06:27 INFO - ##### Finished create-virtualenv step (success) 05:06:27 INFO - ##### 05:06:27 INFO - ##### 05:06:27 INFO - ##### Running install step. 05:06:27 INFO - ##### 05:06:27 INFO - Running pre-action listener: _resource_record_pre_action 05:06:27 INFO - Running main action method: install 05:06:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:06:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:06:27 INFO - Reading from file tmpfile_stdout 05:06:27 INFO - Detecting whether we're running mozinstall >=1.0... 05:06:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:06:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:06:27 INFO - Reading from file tmpfile_stdout 05:06:27 INFO - Output received: 05:06:27 INFO - Usage: mozinstall [options] installer 05:06:27 INFO - Options: 05:06:27 INFO - -h, --help show this help message and exit 05:06:27 INFO - -d DEST, --destination=DEST 05:06:27 INFO - Directory to install application into. [default: 05:06:27 INFO - "/builds/slave/test"] 05:06:27 INFO - --app=APP Application being installed. [default: firefox] 05:06:27 INFO - mkdir: /builds/slave/test/build/application 05:06:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:06:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:06:44 INFO - Reading from file tmpfile_stdout 05:06:44 INFO - Output received: 05:06:44 INFO - /builds/slave/test/build/application/firefox/firefox 05:06:44 INFO - Running post-action listener: _resource_record_post_action 05:06:44 INFO - ##### 05:06:44 INFO - ##### Finished install step (success) 05:06:44 INFO - ##### 05:06:44 INFO - ##### 05:06:44 INFO - ##### Running run-tests step. 05:06:44 INFO - ##### 05:06:44 INFO - Running pre-action listener: _resource_record_pre_action 05:06:44 INFO - Running main action method: run_tests 05:06:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:06:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:06:44 INFO - Python 2.7.3 05:06:44 INFO - Return code: 0 05:06:44 INFO - grabbing minidump binary from tooltool 05:06:44 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:44 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 0x1996110>, '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 0x1902230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19026c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:06:44 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 05:06:44 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 05:06:44 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 05:06:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:06:44 INFO - Return code: 0 05:06:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:06:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:06:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:06:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:06:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:06:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:06:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:06:45 INFO - Return code: 0 05:06:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cLJdxxO8SB-zVBlqpzJzFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 05:06:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cLJdxxO8SB-zVBlqpzJzFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --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 05:06:45 INFO - Using env: {'DISPLAY': ':0', 05:06:45 INFO - 'HOME': '/home/cltbld', 05:06:45 INFO - 'LANG': 'en_US.UTF-8', 05:06:45 INFO - 'LANGUAGE': 'en_US:en', 05:06:45 INFO - 'LOGNAME': 'cltbld', 05:06:45 INFO - 'MAIL': '/var/mail/cltbld', 05:06:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:06:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:06:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:45 INFO - 'MOZ_NO_REMOTE': '1', 05:06:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:06:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:45 INFO - 'NO_EM_RESTART': '1', 05:06:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:45 INFO - 'PWD': '/builds/slave/test', 05:06:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:06:45 INFO - 'SHELL': '/bin/bash', 05:06:45 INFO - 'SHLVL': '1', 05:06:45 INFO - 'TERM': 'linux', 05:06:45 INFO - 'TMOUT': '86400', 05:06:45 INFO - 'USER': 'cltbld', 05:06:45 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1465300942.668297-897120733', 05:06:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:45 INFO - '_': '/tools/buildbot/bin/python'} 05:06:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cLJdxxO8SB-zVBlqpzJzFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 05:06:45 INFO - mozversion application_buildid: 20160607023009 05:06:45 INFO - mozversion application_changeset: c227ee36b4844af150165c64e13347f483db8284 05:06:45 INFO - mozversion application_display_name: Nightly 05:06:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:06:45 INFO - mozversion application_name: Firefox 05:06:45 INFO - mozversion application_remotingname: firefox 05:06:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:06:45 INFO - mozversion application_vendor: Mozilla 05:06:45 INFO - mozversion application_version: 50.0a1 05:06:45 INFO - mozversion platform_buildid: 20160607023009 05:06:45 INFO - mozversion platform_changeset: c227ee36b4844af150165c64e13347f483db8284 05:06:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:06:45 INFO - mozversion platform_version: 50.0a1 05:06:45 INFO - using testdate: 1465301205 05:06:45 INFO - actual date: 1465301205 05:06:45 INFO - starting webserver on 'localhost:59771' 05:06:45 INFO - SUITE-START | Running 2 tests 05:06:45 INFO - TEST-START | dromaeo_css 05:06:45 INFO - operating with platform_type : linux_ 05:06:45 INFO - Initialising browser for dromaeo_css test... 05:06:45 INFO - TEST-INFO | started process 15759 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnJ0si1/profile http://localhost:59771/getInfo.html) 05:06:50 INFO - PROCESS | 15759 | __metrics Screen width/height:1600/1200 05:06:50 INFO - PROCESS | 15759 | colorDepth:24 05:06:50 INFO - PROCESS | 15759 | Browser inner width/height: 1024/697 05:06:50 INFO - PROCESS | 15759 | __metrics 05:06:50 ERROR - PROCESS | 15759 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 05:06:51 INFO - TEST-INFO | 15759: exit 0 05:06:51 INFO - Browser initialized. 05:06:51 INFO - Running cycle 1/1 for dromaeo_css test... 05:06:51 INFO - TEST-INFO | started process 15883 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnJ0si1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:07:03 INFO - PROCESS | 15883 | RSS: Main: 167137280 05:07:03 INFO - PROCESS | 15883 | 05:07:52 INFO - PROCESS | 15883 | 1465301272936 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] 05:10:00 INFO - PROCESS | 15883 | Cycle 1(1): loaded http://localhost:59771/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59771/tests/dromaeo/cssquery-ext.html) 05:10:01 INFO - PROCESS | 15883 | RSS: Main: 169836544 05:10:01 INFO - PROCESS | 15883 | 05:13:03 INFO - PROCESS | 15883 | Cycle 1(1): loaded http://localhost:59771/tests/dromaeo/cssquery-ext.html (next: http://localhost:59771/tests/dromaeo/cssquery-jquery.html) 05:13:04 INFO - PROCESS | 15883 | RSS: Main: 169775104 05:13:04 INFO - PROCESS | 15883 | 05:16:05 INFO - PROCESS | 15883 | Cycle 1(1): loaded http://localhost:59771/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59771/tests/dromaeo/cssquery-mootools.html) 05:16:06 INFO - PROCESS | 15883 | RSS: Main: 170569728 05:16:06 INFO - PROCESS | 15883 | 05:19:08 INFO - PROCESS | 15883 | Cycle 1(1): loaded http://localhost:59771/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59771/tests/dromaeo/cssquery-prototype.html) 05:19:08 INFO - PROCESS | 15883 | RSS: Main: 167903232 05:19:08 INFO - PROCESS | 15883 | 05:22:11 INFO - PROCESS | 15883 | Cycle 1(1): loaded http://localhost:59771/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59771/tests/dromaeo/cssquery-yui.html) 05:22:11 INFO - PROCESS | 15883 | RSS: Main: 170319872 05:22:11 INFO - PROCESS | 15883 | 05:25:14 INFO - PROCESS | 15883 | Cycle 1(1): loaded http://localhost:59771/tests/dromaeo/cssquery-yui.html (next: http://localhost:59771/tests/dromaeo/cssquery-dojo.html) 05:25:14 INFO - PROCESS | 15883 | RSS: Main: 171413504 05:25:14 INFO - PROCESS | 15883 | 05:25:14 INFO - PROCESS | 15883 | __start_tp_report 05:25:14 INFO - PROCESS | 15883 | _x_x_mozilla_page_load 05:25:14 INFO - PROCESS | 15883 | _x_x_mozilla_page_load_details 05:25:14 INFO - PROCESS | 15883 | |i|pagename|runs| 05:25:14 INFO - PROCESS | 15883 | |0;dojo.html;3062.800917940334;3095.4737694591945;3132.8276944768027;3135.1535085526907;3151.8108913465194;5250.343707036621;5268.157094864822;5320.547753440957;5377.247185394048;5400.432954539776;5247.711375874325;5357.571394288458;5362.249285100089;5405.621606487547;5445.128779395298;4841.709497430156;4881.974785295092;4991.101601711691;5031.195008798593;5036.194208926572;756.663843731702;4893.241547560134;4918.877028074291;4932.53140951609;4961;4894.926576101361;4896.045271172123;4902.509749025105;4904.4605093439695;4948.1093403187415;4805.351277577517;4920.21276595743;4921.040397122527;4937.35814344133;4989.825356112555;4787.545183207624;4796.952030479685;4815.903681926342;4833.154198015369;4843.39457567804;5101.642884998052;5205.583553315726;5243.318368612094;5248.475152484759;5276.182191760245;5593.552515798727;5648.237487939116;5660.320761508604;5694.430556944314;5696.430356964312;5667.716614169316;5682.431756824326;5693.402192769741;5694.088945768657;5726.79956201531;5346.812861549866;5385.35375754908;5392.946070539284;5400.756965936543;5416.485433883814;5718.027935250934;5765.279340082406;5776.884462310814;5784.334801497882;5945.940540594625;5587.469190426903;5592.356878958972;5602.355729091125;5637.323521177403;5646.57650676201;5658.688772117491;5725.141228815628;5732.140178973187;5734.139879018181;5736.856578585485;5515.558755299567;5538.972305138529;5585.525230355384;5677.914831277534;5695.288088988877;5521.309836270466;5676.914846277309;5678.063119585222;5697.088465845445;5699;4371.23503386906;4374.365716971021;4380.9780951095045;4384.079343337935;4390.912181756347;3776.848061341262;3877.747946383476;3886.106195575034;3904.7266691331333;3918.2359439908946;5478.534324582375;5479.424660410679;5501.284832971688;5504.532114770209;5524.723763811793;5634;5748.885022299614;5787.363390027093;5787.768489260382;5792.681402522901;5422.186671999153;5443.836684899459;5467.234587157801;5503.477169668875;5511.090670039479;4786.114568804782;4800.183968725325;4801.927971080437;4814.277858321279;4840.661153719206;5839.036558967808;5990.101484777231;5993.430624090704;6001.549883758736;6004.159417681441;5739.713014349266;5771.85570360736;5789.8263052108505;5835.037218859011;5838.532917366685;5932.5550583705535;5951.672658003851;5956.642601443928;5981.222441082631;5984.491318237999;5586.581006424616;5628.577856660849;5688.288963879515;5694.715264236689;5700.686462244616;5709.54323654115;5768.192453056491;5775.537956963349;5784.045632470596;5836.037053886062;5544.805931792368;5609.775608975595;5612.102063669793;5646;5660.15097735343;5498.615096943176;5569;5580.720963951868;5595.804146854841;5622.662640241599;5368.8389348319615;5391.4608539145775;5429;5460.071787796163;5501.229827824188;5586.050371436784;5597.496225339739;5612.130119831432;5612.158176273429;5657.745401456862;5433.619646624698;5469;5493.23094766725;5515.172724091258;5536.667799932017 05:25:14 INFO - PROCESS | 15883 | |1;ext.html;549.1734938916929;596.7762089216544;613.9232595925511;621.2110619513219;627.2786295759878;42132.36801447977;42979.57020429799;43515.78242108789;46654;47243;43957;44230.55769442305;44766;44793;44839.77580112103;8824.20582147605;8935.55322233889;8967.506787126706;8968.865467018;8971.519699249617;8779.2098711116;8852.645894164225;8858.73423797287;8863.468191908474;8869;8951.820963580756;8968.327375446868;8987.685431009915;9004.819903601923;9024.278057755364;8878.334124940622;8886.46681199127;8901.24339431146;8903.55482225886;8905.599248033854;8786.64853405863;8804.899387576554;8855.203031727175;8875.245604123656;8883.20051195389;41574.1685166295;41733;41903;41909;42027.159456810696;3576.8926932192076;3634.218642991743;3636.0935023771844;4187.225363307798;4196.622303992624;31952.840235798903;32812.867163634284;32852;32945;33020.33959320824;4300.677449191292;4417.138657961698;4514.8419805306985;4581.152486789954;4616.215243408628;355475;355624;356182;356254;357724;53104.203436948475;58220.417795822344;58821.41178588245;58884.411155887894;64466;60398.396016040155;61611.38388616056;61771.382286176566;61810.69094654588;61813.690931545956;15135.470258541118;15315.923420382827;15331.61670958235;15373.538793836204;15446.0732356059;11045.889541104647;11241.494132764044;11254.324740515594;11269.09847212221;11339.659810205707;18683.252669893052;18700.625987480445;18817;18832.34086806955;18859.90570047141;7021.894671579828;7108.573485590881;7190.640467976685;7212.891806622905;7218.530795498381;953.4708236928433;1054.752133248686;1066.9437257115555;1076.612419528969;1154.9307041577533;32561.511577325884;32579.837100814817;32764.344713105605;32833.835830820695;33310.333793324484;1068.3216157739892;1133.9773204535863;1210.3222195570333;1211.1703483114095;1279.539365828301;16563;16606.173320934686;16642.58393540171;16721.749173762404;16906;571801;575043;576010;577159;577477;55946.440535594935;55978.72010639921;56024.43975560274;56581.71709141428;56748.432515675144;1334.312828893121;1344.1934839096464;1365.6858922447893;1370.3216907630785;1372.3001269352503;29792.70207297899;30621.23446913845;31206.843965780026;31257.531137032507;31339.216519587193;48082.27876581924;48130.75934620304;48446;48573.5142648569;48730.99999999858;470888;470964;471213;471255;472886;27858;27871.581926271527;28502.144935651962;28722.281942951595;28778.28054298659;47707.52292477031;47885.28172077491;47913.281300781215;48707.75646121747;49162.50837491579;41349.586504134575;41387.7930610345;41668;42302.153956920076;42914;40333.798331008154;41178.32026473337;41230;41399.1720165589;41478;35417.64582354143;39541.60458395494;39821.60178398179;40756.388654170805;41623.58376416197;35873.46189807207;36838;37281.62718372782;37330;37783.62216377911;27512;28681.28296792597;29067;33730;34061.65938340684 05:25:14 INFO - PROCESS | 15883 | |2;jquery.html;394.3808221092884;397.5289282200591;400.30147392799563;404.08877980154745;417.5573891674825;13493.932530337335;18061.729074063882;18215.27138914445;19153.61692766144;19170.808291917077;18469.445916622488;18509.167087481062;18911.90544047278;19563.413097607096;19606.70589941152;5691.146328050805;5734.541236701064;5850.444207800252;5874.060150375941;5894.6168499047635;5768.884622307552;5779.104238842965;5802.767889284423;5827.096799996008;5886.587938844283;5143.742812859342;5400.432954539776;5426.75579598917;5761.53907687384;5819.592628516006;5322.2282768998275;5434.592405569579;5494.203340515603;5532.834014979557;5608.074667679828;5481.588880833953;5512.531434828044;5516.834494965117;5520.889582208333;5529.917051244234;12381;12881.742365152739;21386.786132138634;21985.780142198535;22179.66730499044;2143.9464013399634;2232.3975453548724;2265.7054582904284;2332.428555004018;2796.9160925172278;9349.76625584359;10180.134688551481;10395.740106497322;10642.414667193301;14638.268086595734;1910.6178764247068;1914.1960376641844;1924.259160223324;1933.1011079847797;2001.8798872067723;66077.66961165164;72655;77434.54398224509;78837;79003.20996790074;9517.476538790295;10145.594176233015;10795.568177272979;10815.35107893529;11614.303141811519;14974.775378369333;15036.097834129987;15038.624034399008;15040.548783536511;15100.093994360373;7274.963625181946;7473.4021278297605;7528;7535.962320188364;7656.310932016146;6840.794776156723;6919.792406227822;6965.651717414109;7064.293570642997;7097.751578694824;4578.130155270488;4788.760561971957;4789.95210047895;4819.445763737145;4834.7824347904425;1845.4648152036027;1987.3342430286016;2014.5366565689974;2035.063870619502;2044.9693254601193;958.166395236149;1038.60532997462;1048.8741351037925;1059.3220338983058;1105.8954570769308;18233.08834558293;18892.527686807665;19376.128074236694;19664.901675491532;19721.60556788856;1035.4615599888166;1040.3133931605255;1049.3494033699003;1065.2543219746208;1074.7635520185547;10473.790524189626;10695.572177112985;10732.517036733365;10755.516001779939;10879.184061195441;429731;434652;445835;447447;447830;93157;94636;94836;94922;94931;1020.7448137965508;1030.922680798928;1072.1958531101673;1075.3547871277171;1089.3899416326883;16222.26999784989;17046.14769261507;17170.141492925555;17201.74197387015;17250.482485525456;42110.78944605257;42200.78899605482;42204.57795422006;42352;43130.47130051425;49882.25176622426;51762.741186293824;52175;55456.44543554513;55539.72230138823;8067.798305042421;8162.6734930602115;8404.495730256203;8547.188017138362;8798.516081615573;10922.672319830417;12781;13247.337633118499;13607.79588306196;13704.931475342559;11828.763424731285;11949;12095.57665481704;12294;12373.75252494963;7010.614416207158;9891.406515609087;11901.702457438634;11920.344381059125;12105.455254513745;12303.56937507183;12377.443015064164;12437.813432798695;12443.813342799684;12541.31022793755;8196.180381961756;8224.465409748347;8533.146685331418;8554.91445085566;8571.970226098052;8542.615582298935;11653.88346116528;11983.700407489534;12201.938990304992;12204.084693647834 05:25:14 INFO - PROCESS | 15883 | |3;mootools.html;1495.3495229575135;1521.855423734745;1663.5425258054033;1787.2761531579715;1796.6316905034469;7939.325157361617;8551.401401901869;8594.269487093597;9216.124468175522;9234.769130771725;8592.785180370494;8879.689210877621;8922.776930576723;8925.375223734341;8936.151065648754;2312.5490529346785;2343.121329501437;2343.1915988983774;2346.5658853112227;2348.941276468085;2308.803751681109;2321.0947730385165;2331.2773040357542;2361.929142125739;2363.5863723848342;2307.3193407944614;2309.4226443389152;2322.686437330964;2329.813614910803;2337.123578658003;2267.807236384909;2280.9051655205594;2292.3925159832656;2293.6674182243646;2304.8271379646594;2250.054976909702;2259.7853203945765;2267.954640907189;2272.670462782887;2282.8173746100274;8804;8883.689070882489;8907.109289071106;8921.821563568757;8965.372423930328;4937.80248790048;5017.623678224148;5034.84895453137;5054.494550544916;5081.23781432788;3230.4346739320526;3280.5735254416772;3431.3995050865997;3445.4831775233665;3459.463783113596;1147.8622565292135;1166.2011522107384;1171.3616079236836;1186.6440067979572;1195.8983486403665;12260.75478490434;12478.18891772041;12480.625581232578;12489.063320250927;12491.375431228493;4421.2262854001065;4542.909141817145;4612.469565999886;4642.280446530793;4646.3727396801;10537.525811338355;10544.841827372595;10561;10580.25938184335;10593.735156620993;5178.145605975047;5209.921851172236;5251.894962100737;5287.20691896211;5287.68273903567;4321.891952701145;4636;4747.264174053027;4754.049190161982;4885.1206782779445;4002.199560087994;4045.3325201342036;4108.794560272034;4117.691173161965;4152.709310348307;1246.0218728298241;1265.5633806336798;1271.783796754554;1272.961811145667;1277.157076329618;976.1751320134475;976.5654283843763;991.2070343725135;1007.3250921882357;1027.7071034755209;5969.76120955157;6102.755889764359;6128.509719222451;6324.929302584944;6368.331325210879;927.703134996808;948.4546385828177;988.7132731507783;1017.6183931025865;1094.2176343914139;4068.7965601719798;4188.706790524634;4228.2177797107015;4245.766482843412;4265.189613973335;10715.83926241107;10922.29005114665;10952.890471095347;10960;10990.065844403316;10885.945570272099;11060.059894908862;11081.889181108247;11161.386123763272;11207.943960280147;7722.459427839997;7979.281864632211;8231.42380033404;8234.258916697407;8350.707725229588;6027.849303767441;6143.477804386677;6206.162168107247;6240.375962403905;6267.937320626917;10127.544260508443;10200.693979180636;10201.897981020094;10229.232807539316;10350.275480716278;9924.354916930377;10364.326318789255;10367.63713270032;10422.583096676048;10432.426216558162;7067.399271062018;7560.319571238615;7764.961175194314;7808.804779880548;7975.441719079608;8588.398812083095;8618.78453038679;8658.090900455361;8670.26302764272;8692.478451292942;7560.886586701314;7718.343940765098;7851.803704907423;7853.175416581176;7875.566843823644;7595.240475952361;7624.161342252237;7724.459287850022;7802.570858602831;7837.177096405024;6940.93059069423;7001.404880585207;7005.824854378681;7022.754203602849;7031.156261248479;5161.122609156528;5162.5869930406225;5249.868753281198;5254.710990895537;5261.868453288698;5172.405173405106;5173.198154286091;5228.6078544110105;5248.265242865926;5262.158054711228 05:25:14 INFO - PROCESS | 15883 | |4;prototype.html;317.4238756656668;325.84848045658765;327.6363236807144;329.52219282041045;330.2404469719645;5572.359178694446;5629.6340737852015;5636.520895723863;5636.746346414406;5651.8304450866435;5507.953488837118;5551.333839939213;5554.305711786027;5558.610897237195;5582.972085139579;4104.835806567741;4178.811953462086;4323.805428755713;4359.912801743963;4381.277089280281;4305.268104422255;4315.374270730742;4325.416068830715;4354.847580334689;4370.606645401913;4296.806643701026;4308.698391112608;4339.500957389909;4354.1944740223;4360.324149756792;4211.157768446307;4224.775224775225;4320.330348795942;4321.7406955582765;4341.41390912226;3741.3639681254253;3751.681107105899;3781.735278530504;3788.8295026723863;3805.1818858945458;5276.419593844674;5301.443348448396;5353.277307563507;5377.892442151135;5400.729963501809;4822.807087716487;4882.023595280958;4938.1111399947995;4956.21576232556;4967.900641987176;5775.047117225653;5780.88438231233;5784.537237021028;5828.184054232411;5854.4730974212525;4216.578342165759;4221.598948099926;4229.6827737919775;4232.217039847638;4258.382534532476;5909.881802363929;6065.150878876917;6096.628258641815;6113.270904748145;6138.8772224555705;4293.098449325614;4303.33298338758;4304.440422745023;4309.978450107729;4318.740875547414;4375.671824613167;4377.68669399179;4385.342198670161;4405.427294451701;4414.3157810539415;4849.151398505247;4856.975715121402;4933.210686290176;4957.628177886673;5005.747413663866;5768.942310576925;5787.363390027093;5843.298804143445;5872.765089396462;5882.499987501024;1459.489178787416;1475.1886462445611;1487.323267913097;1490.4485340424112;1490.5528341497507;939.6147579492375;949.5489642419795;951.8191543606692;958.166395236149;961.8653388525612;4959.140322379108;4964;4966.304717339575;4986.276989836453;4996.876327560773;5174.327337446183;5282.6302158849285;5311.804843910167;5324.1747529133045;5346.732663366816;4677.947461821131;5022.020705962375;5038.395392552917;5172.577541176207;5177.663451875691;2889.19102651258;2894.4789937810974;2903.6951120132503;2903.7822163337833;2937.588737576741;5394.300795249484;5460.31746031746;5460.645058071213;5506.504414602705;5514.6139770216505;5137.460566640449;5377.247185394048;5402.459754024645;5450.91823622646;5543.447834606317;5453.745638503166;5492.286002819608;5493.560515158778;5522.729772152427;5564.916526252109;5227.607929405386;5297.78151025274;5325.760340784596;5373.677579345252;5656.377798442086;5988.730507127277;6004.699765011819;6012.579119461596;6056.606320589148;6065.7573697053385;6320.968395157995;6333.240011198502;6335.968320158369;6341.397567231105;6358.682065896594;3970.5632380438706;4176.642591157946;4215;4221.261279276053;4263.403123562765;5914.260717410324;5953.124765698791;6028.33688294296;6048.5161187105805;6160.815175544741;5893.585539470582;5906.586538942404;5913.733881975408;5950.7917222896995;5968.269201931391;5870.647761134345;5876.500497457764;5890.440408161217;5984.31180414258;6005.129256257906;5629.521490673339;5825.79609713658;5831.717022255097;5848.333225030846;5862.677552734641;5930.584859059824;6057.333693293646;6071.51427885777;6073.5748497604745;6089.695515224133;5649.079313033589;5822.272215973004;5867.911981320198;5892.5285977122585;5917.940820591739 05:25:14 INFO - PROCESS | 15883 | |5;yui.html;721.3471808013746;744.757953665059;789.28175360422;809.8299357135002;820.9014918209814;15054.096754194756;15290.541283761491;15907.80691448143;15907.92046039771;15922.601934951617;14532.200728959902;14715.190664513448;14759;15054.548363549111;15204.771928421083;806.8951036365279;807.6042739057849;808.9514629122242;813.7640084375524;815.1237419773737;791.9485233459835;793.9126696063429;794.6424109150877;820.5240960243045;821.137805304428;845.5434065604566;855.6748435594466;857.3784006595231;858.5578427110044;858.8625819868822;850.7235148576707;850.8213275212213;852.1606217875387;852.6802449081595;853.7524118005771;612.7640858269554;614.5759425996048;615.7844754335991;616.1589430427479;616.9321374648785;13842.653933651638;13876.444942202299;13879.236641984688;13924.37340319678;13929.094608850392;14555.490557830424;14727.190004549746;14822.703545929022;14925.25373731309;14938.925305373512;12256.632301030893;12383.19509231906;12435.75128497425;12450.439730212162;12508.123781432858;3761.962380376189;3844.442555829389;3860.073582340246;3885.9805700971597;3988.940165897514;73513.26486735171;75172.62413687952;75379.24620753832;75598.62200688961;76530.61734691347;10777.353358798497;11492.195546311677;11552.76894462106;11560.826587601192;11774.116941229271;21278.893605532183;21301.147954081975;21345.78654213469;21352.14591416357;21406.250781222894;8526.78683032929;8531.274841638531;8598.269147122439;8737.475751454933;8750.168733970262;4813.085513752376;4825.420949486084;4852.393450818648;4904.068227036852;5001.649884508122;3560.946585801215;3671.81640917953;3688.981555092207;3698.6486283802997;3698.9088218975467;628.7893555658814;630.124127462827;631.1416473595906;638.7700427845972;640.5324113397246;526.2159382520017;563.0934195944526;684.3772167327808;791.6912404162381;820.1265652080515;9835.262355323379;10452.581896724198;10770.138388929023;10821.675349739364;10924.235303528836;740.2930201657405;740.3706849178155;763.595294493908;776.3323541754087;791.4815795653856;4678.3216433616935;4787.305840653085;4899.534544218293;4903.632227582945;4903.926441103386;81203;112673.43663281632;114052;118462.40768796101;119137;62363.37636623576;62974;88375.55812220898;95587;96695.51652241693;89339.55330223308;90948.54525727329;91858.54070729604;92202.53898730598;92882;9565.378250413702;9695.466749328854;9733.805323893625;9744.707658770249;9749.805003900025;51230.74384628202;51378.22932656088;51504.48495514997;51595.484045159064;52742.47257527376;68566;72877.6356118216;73012.6349368271;73073.6346318265;73767.89348159675;12082.637520874388;12142.150049496451;12337.444814983526;12352.517697875954;12647.367631618199;13343.866561334651;13616.795748063589;13776.311184440938;13864.722705545631;14231.857681423053;12655.240685558896;12714.427850746553;12975.351232438528;13277.66805829862;13525.797113043509;12725.61823145307;12846.421911014213;12904.870951290366;12974.347468401615;13286.933565332112;12038.217515861441;12623.87376126227;13444.46222151103;13701.383437745524;13708.108972916729;10979.341239525655;11265.549378024787;11445.740968493626;11782.646520604396;11787.233829801036;11111.777764444827;11290.661280161608;11521.769564608829;11542.249753765978;11680.415979201176 05:25:14 INFO - PROCESS | 15883 | __end_tp_report 05:25:14 INFO - PROCESS | 15883 | __start_cc_report 05:25:14 INFO - PROCESS | 15883 | _x_x_mozilla_cycle_collect,338 05:25:14 INFO - PROCESS | 15883 | __end_cc_report 05:25:14 INFO - PROCESS | 15883 | __startTimestamp1465302314776__endTimestamp 05:25:14 INFO - PROCESS | 15883 | 05:25:14 INFO - PROCESS | 15883 | ------- Summary: start ------- 05:25:14 INFO - PROCESS | 15883 | Number of tests: 6 05:25:14 INFO - PROCESS | 15883 | 05:25:14 INFO - PROCESS | 15883 | [#0] dojo.html Cycles:165 Average:5287.51 Median:5515.17 stddev:697.74 (12.7%) stddev-sans-first:677.71 05:25:14 INFO - PROCESS | 15883 | Values: 3062.8 3095.5 3132.8 3135.2 3151.8 5250.3 5268.2 5320.5 5377.2 5400.4 5247.7 5357.6 5362.2 5405.6 5445.1 4841.7 4882.0 4991.1 5031.2 5036.2 756.7 4893.2 4918.9 4932.5 4961.0 4894.9 4896.0 4902.5 4904.5 4948.1 4805.4 4920.2 4921.0 4937.4 4989.8 4787.5 4797.0 4815.9 4833.2 4843.4 5101.6 5205.6 5243.3 5248.5 5276.2 5593.6 5648.2 5660.3 5694.4 5696.4 5667.7 5682.4 5693.4 5694.1 5726.8 5346.8 5385.4 5392.9 5400.8 5416.5 5718.0 5765.3 5776.9 5784.3 5945.9 5587.5 5592.4 5602.4 5637.3 5646.6 5658.7 5725.1 5732.1 5734.1 5736.9 5515.6 5539.0 5585.5 5677.9 5695.3 5521.3 5676.9 5678.1 5697.1 5699.0 4371.2 4374.4 4381.0 4384.1 4390.9 3776.8 3877.7 3886.1 3904.7 3918.2 5478.5 5479.4 5501.3 5504.5 5524.7 5634.0 5748.9 5787.4 5787.8 5792.7 5422.2 5443.8 5467.2 5503.5 5511.1 4786.1 4800.2 4801.9 4814.3 4840.7 5839.0 5990.1 5993.4 6001.5 6004.2 5739.7 5771.9 5789.8 5835.0 5838.5 5932.6 5951.7 5956.6 5981.2 5984.5 5586.6 5628.6 5688.3 5694.7 5700.7 5709.5 5768.2 5775.5 5784.0 5836.0 5544.8 5609.8 5612.1 5646.0 5660.2 5498.6 5569.0 5580.7 5595.8 5622.7 5368.8 5391.5 5429.0 5460.1 5501.2 5586.1 5597.5 5612.1 5612.2 5657.7 5433.6 5469.0 5493.2 5515.2 5536.7 05:25:14 INFO - PROCESS | 15883 | 05:25:14 INFO - PROCESS | 15883 | [#1] ext.html Cycles:180 Average:62449.39 Median:23111.89 stddev:126565.80 (547.6%) stddev-sans-first:126835.52 05:25:14 INFO - PROCESS | 15883 | Values: 549.2 596.8 613.9 621.2 627.3 42132.4 42979.6 43515.8 46654.0 47243.0 43957.0 44230.6 44766.0 44793.0 44839.8 8824.2 8935.6 8967.5 8968.9 8971.5 8779.2 8852.6 8858.7 8863.5 8869.0 8951.8 8968.3 8987.7 9004.8 9024.3 8878.3 8886.5 8901.2 8903.6 8905.6 8786.6 8804.9 8855.2 8875.2 8883.2 41574.2 41733.0 41903.0 41909.0 42027.2 3576.9 3634.2 3636.1 4187.2 4196.6 31952.8 32812.9 32852.0 32945.0 33020.3 4300.7 4417.1 4514.8 4581.2 4616.2 355475.0 355624.0 356182.0 356254.0 357724.0 53104.2 58220.4 58821.4 58884.4 64466.0 60398.4 61611.4 61771.4 61810.7 61813.7 15135.5 15315.9 15331.6 15373.5 15446.1 11045.9 11241.5 11254.3 11269.1 11339.7 18683.3 18700.6 18817.0 18832.3 18859.9 7021.9 7108.6 7190.6 7212.9 7218.5 953.5 1054.8 1066.9 1076.6 1154.9 32561.5 32579.8 32764.3 32833.8 33310.3 1068.3 1134.0 1210.3 1211.2 1279.5 16563.0 16606.2 16642.6 16721.7 16906.0 571801.0 575043.0 576010.0 577159.0 577477.0 55946.4 55978.7 56024.4 56581.7 56748.4 1334.3 1344.2 1365.7 1370.3 1372.3 29792.7 30621.2 31206.8 31257.5 31339.2 48082.3 48130.8 48446.0 48573.5 48731.0 470888.0 470964.0 471213.0 471255.0 472886.0 27858.0 27871.6 28502.1 28722.3 28778.3 47707.5 47885.3 47913.3 48707.8 49162.5 41349.6 41387.8 41668.0 42302.2 42914.0 40333.8 41178.3 41230.0 41399.2 41478.0 35417.6 39541.6 39821.6 40756.4 41623.6 35873.5 36838.0 37281.6 37330.0 37783.6 27512.0 28681.3 29067.0 33730.0 34061.7 05:25:14 INFO - PROCESS | 15883 | 05:25:14 INFO - PROCESS | 15883 | [#2] jquery.html Cycles:180 Average:27148.34 Median:2249.05 stddev:72978.76 (3244.9%) stddev-sans-first:73155.84 05:25:14 INFO - PROCESS | 15883 | Values: 394.4 397.5 400.3 404.1 417.6 13493.9 18061.7 18215.3 19153.6 19170.8 18469.4 18509.2 18911.9 19563.4 19606.7 5691.1 5734.5 5850.4 5874.1 5894.6 5768.9 5779.1 5802.8 5827.1 5886.6 5143.7 5400.4 5426.8 5761.5 5819.6 5322.2 5434.6 5494.2 5532.8 5608.1 5481.6 5512.5 5516.8 5520.9 5529.9 12381.0 12881.7 21386.8 21985.8 22179.7 2143.9 2232.4 2265.7 2332.4 2796.9 9349.8 10180.1 10395.7 10642.4 14638.3 1910.6 1914.2 1924.3 1933.1 2001.9 66077.7 72655.0 77434.5 78837.0 79003.2 9517.5 10145.6 10795.6 10815.4 11614.3 14974.8 15036.1 15038.6 15040.5 15100.1 7275.0 7473.4 7528.0 7536.0 7656.3 6840.8 6919.8 6965.7 7064.3 7097.8 4578.1 4788.8 4790.0 4819.4 4834.8 1845.5 1987.3 2014.5 2035.1 2045.0 958.2 1038.6 1048.9 1059.3 1105.9 18233.1 18892.5 19376.1 19664.9 19721.6 1035.5 1040.3 1049.3 1065.3 1074.8 10473.8 10695.6 10732.5 10755.5 10879.2 429731.0 434652.0 445835.0 447447.0 447830.0 93157.0 94636.0 94836.0 94922.0 94931.0 1020.7 1030.9 1072.2 1075.4 1089.4 16222.3 17046.1 17170.1 17201.7 17250.5 42110.8 42200.8 42204.6 42352.0 43130.5 49882.3 51762.7 52175.0 55456.4 55539.7 8067.8 8162.7 8404.5 8547.2 8798.5 10922.7 12781.0 13247.3 13607.8 13704.9 11828.8 11949.0 12095.6 12294.0 12373.8 7010.6 9891.4 11901.7 11920.3 12105.5 12303.6 12377.4 12437.8 12443.8 12541.3 8196.2 8224.5 8533.1 8554.9 8572.0 8542.6 11653.9 11983.7 12201.9 12204.1 05:25:14 INFO - PROCESS | 15883 | 05:25:14 INFO - PROCESS | 15883 | [#3] mootools.html Cycles:180 Average:5845.43 Median:4577.69 stddev:3328.05 (72.7%) stddev-sans-first:3321.33 05:25:14 INFO - PROCESS | 15883 | Values: 1495.3 1521.9 1663.5 1787.3 1796.6 7939.3 8551.4 8594.3 9216.1 9234.8 8592.8 8879.7 8922.8 8925.4 8936.2 2312.5 2343.1 2343.2 2346.6 2348.9 2308.8 2321.1 2331.3 2361.9 2363.6 2307.3 2309.4 2322.7 2329.8 2337.1 2267.8 2280.9 2292.4 2293.7 2304.8 2250.1 2259.8 2268.0 2272.7 2282.8 8804.0 8883.7 8907.1 8921.8 8965.4 4937.8 5017.6 5034.8 5054.5 5081.2 3230.4 3280.6 3431.4 3445.5 3459.5 1147.9 1166.2 1171.4 1186.6 1195.9 12260.8 12478.2 12480.6 12489.1 12491.4 4421.2 4542.9 4612.5 4642.3 4646.4 10537.5 10544.8 10561.0 10580.3 10593.7 5178.1 5209.9 5251.9 5287.2 5287.7 4321.9 4636.0 4747.3 4754.0 4885.1 4002.2 4045.3 4108.8 4117.7 4152.7 1246.0 1265.6 1271.8 1273.0 1277.2 976.2 976.6 991.2 1007.3 1027.7 5969.8 6102.8 6128.5 6324.9 6368.3 927.7 948.5 988.7 1017.6 1094.2 4068.8 4188.7 4228.2 4245.8 4265.2 10715.8 10922.3 10952.9 10960.0 10990.1 10885.9 11060.1 11081.9 11161.4 11207.9 7722.5 7979.3 8231.4 8234.3 8350.7 6027.8 6143.5 6206.2 6240.4 6267.9 10127.5 10200.7 10201.9 10229.2 10350.3 9924.4 10364.3 10367.6 10422.6 10432.4 7067.4 7560.3 7765.0 7808.8 7975.4 8588.4 8618.8 8658.1 8670.3 8692.5 7560.9 7718.3 7851.8 7853.2 7875.6 7595.2 7624.2 7724.5 7802.6 7837.2 6940.9 7001.4 7005.8 7022.8 7031.2 5161.1 5162.6 5249.9 5254.7 5261.9 5172.4 5173.2 5228.6 5248.3 5262.2 05:25:14 INFO - PROCESS | 15883 | 05:25:14 INFO - PROCESS | 15883 | [#4] prototype.html Cycles:180 Average:4798.11 Median:5350.00 stddev:1412.51 (26.4%) stddev-sans-first:1375.86 05:25:14 INFO - PROCESS | 15883 | Values: 317.4 325.8 327.6 329.5 330.2 5572.4 5629.6 5636.5 5636.7 5651.8 5508.0 5551.3 5554.3 5558.6 5583.0 4104.8 4178.8 4323.8 4359.9 4381.3 4305.3 4315.4 4325.4 4354.8 4370.6 4296.8 4308.7 4339.5 4354.2 4360.3 4211.2 4224.8 4320.3 4321.7 4341.4 3741.4 3751.7 3781.7 3788.8 3805.2 5276.4 5301.4 5353.3 5377.9 5400.7 4822.8 4882.0 4938.1 4956.2 4967.9 5775.0 5780.9 5784.5 5828.2 5854.5 4216.6 4221.6 4229.7 4232.2 4258.4 5909.9 6065.2 6096.6 6113.3 6138.9 4293.1 4303.3 4304.4 4310.0 4318.7 4375.7 4377.7 4385.3 4405.4 4414.3 4849.2 4857.0 4933.2 4957.6 5005.7 5768.9 5787.4 5843.3 5872.8 5882.5 1459.5 1475.2 1487.3 1490.4 1490.6 939.6 949.5 951.8 958.2 961.9 4959.1 4964.0 4966.3 4986.3 4996.9 5174.3 5282.6 5311.8 5324.2 5346.7 4677.9 5022.0 5038.4 5172.6 5177.7 2889.2 2894.5 2903.7 2903.8 2937.6 5394.3 5460.3 5460.6 5506.5 5514.6 5137.5 5377.2 5402.5 5450.9 5543.4 5453.7 5492.3 5493.6 5522.7 5564.9 5227.6 5297.8 5325.8 5373.7 5656.4 5988.7 6004.7 6012.6 6056.6 6065.8 6321.0 6333.2 6336.0 6341.4 6358.7 3970.6 4176.6 4215.0 4221.3 4263.4 5914.3 5953.1 6028.3 6048.5 6160.8 5893.6 5906.6 5913.7 5950.8 5968.3 5870.6 5876.5 5890.4 5984.3 6005.1 5629.5 5825.8 5831.7 5848.3 5862.7 5930.6 6057.3 6071.5 6073.6 6089.7 5649.1 5822.3 5867.9 5892.5 5917.9 05:25:14 INFO - PROCESS | 15883 | 05:25:14 INFO - PROCESS | 15883 | [#5] yui.html Cycles:180 Average:20173.09 Median:4819.25 stddev:28607.41 (593.6%) stddev-sans-first:28650.37 05:25:14 INFO - PROCESS | 15883 | Values: 721.3 744.8 789.3 809.8 820.9 15054.1 15290.5 15907.8 15907.9 15922.6 14532.2 14715.2 14759.0 15054.5 15204.8 806.9 807.6 809.0 813.8 815.1 791.9 793.9 794.6 820.5 821.1 845.5 855.7 857.4 858.6 858.9 850.7 850.8 852.2 852.7 853.8 612.8 614.6 615.8 616.2 616.9 13842.7 13876.4 13879.2 13924.4 13929.1 14555.5 14727.2 14822.7 14925.3 14938.9 12256.6 12383.2 12435.8 12450.4 12508.1 3762.0 3844.4 3860.1 3886.0 3988.9 73513.3 75172.6 75379.2 75598.6 76530.6 10777.4 11492.2 11552.8 11560.8 11774.1 21278.9 21301.1 21345.8 21352.1 21406.3 8526.8 8531.3 8598.3 8737.5 8750.2 4813.1 4825.4 4852.4 4904.1 5001.6 3560.9 3671.8 3689.0 3698.6 3698.9 628.8 630.1 631.1 638.8 640.5 526.2 563.1 684.4 791.7 820.1 9835.3 10452.6 10770.1 10821.7 10924.2 740.3 740.4 763.6 776.3 791.5 4678.3 4787.3 4899.5 4903.6 4903.9 81203.0 112673.4 114052.0 118462.4 119137.0 62363.4 62974.0 88375.6 95587.0 96695.5 89339.6 90948.5 91858.5 92202.5 92882.0 9565.4 9695.5 9733.8 9744.7 9749.8 51230.7 51378.2 51504.5 51595.5 52742.5 68566.0 72877.6 73012.6 73073.6 73767.9 12082.6 12142.2 12337.4 12352.5 12647.4 13343.9 13616.8 13776.3 13864.7 14231.9 12655.2 12714.4 12975.4 13277.7 13525.8 12725.6 12846.4 12904.9 12974.3 13286.9 12038.2 12623.9 13444.5 13701.4 13708.1 10979.3 11265.5 11445.7 11782.6 11787.2 11111.8 11290.7 11521.8 11542.2 11680.4 05:25:14 INFO - PROCESS | 15883 | -------- Summary: end -------- 05:25:14 INFO - PROCESS | 15883 | 05:25:15 INFO - TEST-INFO | 15883: exit 0 05:25:15 INFO - TEST-OK | dromaeo_css | took 1110156ms 05:25:15 INFO - TEST-START | kraken 05:25:15 INFO - operating with platform_type : linux_ 05:25:15 INFO - Initialising browser for kraken test... 05:25:15 INFO - TEST-INFO | started process 16125 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoSbHMB/profile http://localhost:59771/getInfo.html) 05:25:20 INFO - PROCESS | 16125 | __metrics Screen width/height:1600/1200 05:25:20 INFO - PROCESS | 16125 | colorDepth:24 05:25:20 INFO - PROCESS | 16125 | Browser inner width/height: 1024/697 05:25:20 INFO - PROCESS | 16125 | __metrics 05:25:20 ERROR - PROCESS | 16125 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 05:25:21 INFO - TEST-INFO | 16125: exit 0 05:25:21 INFO - Browser initialized. 05:25:21 INFO - Running cycle 1/1 for kraken test... 05:25:21 INFO - TEST-INFO | started process 16245 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoSbHMB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:25:33 INFO - PROCESS | 16245 | RSS: Main: 167669760 05:25:33 INFO - PROCESS | 16245 | 05:25:35 INFO - PROCESS | 16245 | Cycle 1(1): loaded http://localhost:59771/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59771/tests/kraken/driver.html?testName=audio-beat-detection) 05:25:36 INFO - PROCESS | 16245 | RSS: Main: 172933120 05:25:36 INFO - PROCESS | 16245 | 05:25:39 INFO - PROCESS | 16245 | Cycle 1(1): loaded http://localhost:59771/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59771/tests/kraken/driver.html?testName=audio-dft) 05:25:40 INFO - PROCESS | 16245 | RSS: Main: 172605440 05:25:40 INFO - PROCESS | 16245 | 05:25:42 INFO - PROCESS | 16245 | Cycle 1(1): loaded http://localhost:59771/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59771/tests/kraken/driver.html?testName=audio-fft) 05:25:43 INFO - PROCESS | 16245 | RSS: Main: 167038976 05:25:43 INFO - PROCESS | 16245 | 05:25:45 INFO - PROCESS | 16245 | Cycle 1(1): loaded http://localhost:59771/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59771/tests/kraken/driver.html?testName=audio-oscillator) 05:25:46 INFO - PROCESS | 16245 | RSS: Main: 168177664 05:25:46 INFO - PROCESS | 16245 | 05:25:48 INFO - PROCESS | 16245 | Cycle 1(1): loaded http://localhost:59771/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59771/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:25:49 INFO - PROCESS | 16245 | RSS: Main: 168439808 05:25:49 INFO - PROCESS | 16245 | 05:25:52 INFO - PROCESS | 16245 | Cycle 1(1): loaded http://localhost:59771/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59771/tests/kraken/driver.html?testName=imaging-darkroom) 05:25:53 INFO - PROCESS | 16245 | RSS: Main: 168865792 05:25:53 INFO - PROCESS | 16245 | 05:25:56 INFO - PROCESS | 16245 | Cycle 1(1): loaded http://localhost:59771/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59771/tests/kraken/driver.html?testName=imaging-desaturate) 05:25:57 INFO - PROCESS | 16245 | RSS: Main: 166670336 05:25:57 INFO - PROCESS | 16245 | 05:25:59 INFO - PROCESS | 16245 | Cycle 1(1): loaded http://localhost:59771/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59771/tests/kraken/driver.html?testName=json-parse-financial) 05:26:00 INFO - PROCESS | 16245 | RSS: Main: 167944192 05:26:00 INFO - PROCESS | 16245 | 05:26:02 INFO - PROCESS | 16245 | Cycle 1(1): loaded http://localhost:59771/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59771/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:26:02 INFO - PROCESS | 16245 | RSS: Main: 168095744 05:26:02 INFO - PROCESS | 16245 | 05:26:04 INFO - PROCESS | 16245 | Cycle 1(1): loaded http://localhost:59771/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59771/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:26:05 INFO - PROCESS | 16245 | RSS: Main: 168267776 05:26:05 INFO - PROCESS | 16245 | 05:26:07 INFO - PROCESS | 16245 | Cycle 1(1): loaded http://localhost:59771/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59771/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:26:07 INFO - PROCESS | 16245 | RSS: Main: 168615936 05:26:07 INFO - PROCESS | 16245 | 05:26:10 INFO - PROCESS | 16245 | Cycle 1(1): loaded http://localhost:59771/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59771/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:26:11 INFO - PROCESS | 16245 | RSS: Main: 168902656 05:26:11 INFO - PROCESS | 16245 | 05:26:13 INFO - PROCESS | 16245 | Cycle 1(1): loaded http://localhost:59771/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59771/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:26:14 INFO - PROCESS | 16245 | RSS: Main: 168886272 05:26:14 INFO - PROCESS | 16245 | 05:26:16 INFO - PROCESS | 16245 | Cycle 1(1): loaded http://localhost:59771/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59771/tests/kraken/driver.html?testName=ai-astar) 05:26:16 INFO - PROCESS | 16245 | RSS: Main: 169725952 05:26:16 INFO - PROCESS | 16245 | 05:26:16 INFO - PROCESS | 16245 | __start_tp_report 05:26:16 INFO - PROCESS | 16245 | _x_x_mozilla_page_load 05:26:16 INFO - PROCESS | 16245 | _x_x_mozilla_page_load_details 05:26:16 INFO - PROCESS | 16245 | |i|pagename|runs| 05:26:16 INFO - PROCESS | 16245 | |0;ai-astar;115;107;112;110;112;112;111;111;112;110 05:26:16 INFO - PROCESS | 16245 | |1;audio-beat-detection;160;126;150;188;126;160;159;130;178;125 05:26:16 INFO - PROCESS | 16245 | |2;audio-dft;164;163;163;163;163;164;168;162;164;162 05:26:16 INFO - PROCESS | 16245 | |3;audio-fft;75;76;77;167;77;75;75;75;165;76 05:26:16 INFO - PROCESS | 16245 | |4;audio-oscillator;86;85;150;87;84;85;148;85;85;139 05:26:16 INFO - PROCESS | 16245 | |5;imaging-gaussian-blur;117;120;117;118;118;117;118;120;118;118 05:26:16 INFO - PROCESS | 16245 | |6;imaging-darkroom;146;146;147;149;146;148;147;147;147;148 05:26:16 INFO - PROCESS | 16245 | |7;imaging-desaturate;98;95;96;96;95;96;96;95;95;96 05:26:16 INFO - PROCESS | 16245 | |8;json-parse-financial;55;56;54;55;53;53;55;56;56;54 05:26:16 INFO - PROCESS | 16245 | |9;json-stringify-tinderbox;62;62;62;61;61;62;61;61;63;64 05:26:16 INFO - PROCESS | 16245 | |10;stanford-crypto-aes;82;81;80;82;82;80;81;81;106;86 05:26:16 INFO - PROCESS | 16245 | |11;stanford-crypto-ccm;123;140;130;139;123;123;129;127;138;127 05:26:16 INFO - PROCESS | 16245 | |12;stanford-crypto-pbkdf2;165;169;162;161;167;160;162;162;164;162 05:26:16 INFO - PROCESS | 16245 | |13;stanford-crypto-sha256-iterative;66;64;65;63;62;66;71;62;64;62 05:26:16 INFO - PROCESS | 16245 | __end_tp_report 05:26:16 INFO - PROCESS | 16245 | __start_cc_report 05:26:16 INFO - PROCESS | 16245 | _x_x_mozilla_cycle_collect,889 05:26:16 INFO - PROCESS | 16245 | __end_cc_report 05:26:16 INFO - PROCESS | 16245 | __startTimestamp1465302376459__endTimestamp 05:26:16 INFO - PROCESS | 16245 | 05:26:16 INFO - PROCESS | 16245 | ------- Summary: start ------- 05:26:16 INFO - PROCESS | 16245 | Number of tests: 14 05:26:16 INFO - PROCESS | 16245 | 05:26:16 INFO - PROCESS | 16245 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.00 stddev:2.04 (1.8%) stddev-sans-first:1.64 05:26:16 INFO - PROCESS | 16245 | Values: 115.0 107.0 112.0 110.0 112.0 112.0 111.0 111.0 112.0 110.0 05:26:16 INFO - PROCESS | 16245 | 05:26:16 INFO - PROCESS | 16245 | [#1] audio-beat-detection Cycles:10 Average:150.20 Median:159.50 stddev:22.82 (14.3%) stddev-sans-first:23.92 05:26:16 INFO - PROCESS | 16245 | Values: 160.0 126.0 150.0 188.0 126.0 160.0 159.0 130.0 178.0 125.0 05:26:16 INFO - PROCESS | 16245 | 05:26:16 INFO - PROCESS | 16245 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.50 stddev:1.71 (1.0%) stddev-sans-first:1.81 05:26:16 INFO - PROCESS | 16245 | Values: 164.0 163.0 163.0 163.0 163.0 164.0 168.0 162.0 164.0 162.0 05:26:16 INFO - PROCESS | 16245 | 05:26:16 INFO - PROCESS | 16245 | [#3] audio-fft Cycles:10 Average:93.80 Median:75.50 stddev:38.06 (50.4%) stddev-sans-first:39.76 05:26:16 INFO - PROCESS | 16245 | Values: 75.0 76.0 77.0 167.0 77.0 75.0 75.0 75.0 165.0 76.0 05:26:16 INFO - PROCESS | 16245 | 05:26:16 INFO - PROCESS | 16245 | [#4] audio-oscillator Cycles:10 Average:103.40 Median:85.00 stddev:29.31 (34.5%) stddev-sans-first:30.40 05:26:16 INFO - PROCESS | 16245 | Values: 86.0 85.0 150.0 87.0 84.0 85.0 148.0 85.0 85.0 139.0 05:26:16 INFO - PROCESS | 16245 | 05:26:16 INFO - PROCESS | 16245 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:1.10 (0.9%) stddev-sans-first:1.09 05:26:16 INFO - PROCESS | 16245 | Values: 117.0 120.0 117.0 118.0 118.0 117.0 118.0 120.0 118.0 118.0 05:26:16 INFO - PROCESS | 16245 | 05:26:16 INFO - PROCESS | 16245 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.99 (0.7%) stddev-sans-first:0.97 05:26:16 INFO - PROCESS | 16245 | Values: 146.0 146.0 147.0 149.0 146.0 148.0 147.0 147.0 147.0 148.0 05:26:16 INFO - PROCESS | 16245 | 05:26:16 INFO - PROCESS | 16245 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.92 (1.0%) stddev-sans-first:0.53 05:26:16 INFO - PROCESS | 16245 | Values: 98.0 95.0 96.0 96.0 95.0 96.0 96.0 95.0 95.0 96.0 05:26:16 INFO - PROCESS | 16245 | 05:26:16 INFO - PROCESS | 16245 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:1.16 (2.1%) stddev-sans-first:1.22 05:26:16 INFO - PROCESS | 16245 | Values: 55.0 56.0 54.0 55.0 53.0 53.0 55.0 56.0 56.0 54.0 05:26:16 INFO - PROCESS | 16245 | 05:26:16 INFO - PROCESS | 16245 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:0.99 (1.6%) stddev-sans-first:1.05 05:26:16 INFO - PROCESS | 16245 | Values: 62.0 62.0 62.0 61.0 61.0 62.0 61.0 61.0 63.0 64.0 05:26:16 INFO - PROCESS | 16245 | 05:26:16 INFO - PROCESS | 16245 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:81.50 stddev:7.88 (9.7%) stddev-sans-first:8.32 05:26:16 INFO - PROCESS | 16245 | Values: 82.0 81.0 80.0 82.0 82.0 80.0 81.0 81.0 106.0 86.0 05:26:16 INFO - PROCESS | 16245 | 05:26:16 INFO - PROCESS | 16245 | [#11] stanford-crypto-ccm Cycles:10 Average:129.90 Median:129.50 stddev:6.76 (5.2%) stddev-sans-first:6.69 05:26:16 INFO - PROCESS | 16245 | Values: 123.0 140.0 130.0 139.0 123.0 123.0 129.0 127.0 138.0 127.0 05:26:16 INFO - PROCESS | 16245 | 05:26:16 INFO - PROCESS | 16245 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.40 Median:163.00 stddev:2.84 (1.7%) stddev-sans-first:2.95 05:26:16 INFO - PROCESS | 16245 | Values: 165.0 169.0 162.0 161.0 167.0 160.0 162.0 162.0 164.0 162.0 05:26:16 INFO - PROCESS | 16245 | 05:26:16 INFO - PROCESS | 16245 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:64.50 stddev:2.76 (4.3%) stddev-sans-first:2.87 05:26:16 INFO - PROCESS | 16245 | Values: 66.0 64.0 65.0 63.0 62.0 66.0 71.0 62.0 64.0 62.0 05:26:16 INFO - PROCESS | 16245 | -------- Summary: end -------- 05:26:16 INFO - PROCESS | 16245 | 05:26:17 INFO - TEST-INFO | 16245: exit 0 05:26:17 INFO - TEST-OK | kraken | took 61905ms 05:26:17 INFO - SUITE-END | took 1172s 05:26:17 INFO - Completed test suite (00:19:32) 05:26:17 INFO - javascript benchmark 05:26:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7262.022161854725, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3062.800917940334, 3095.4737694591945, 3132.8276944768027, 3135.1535085526907, 3151.8108913465194, 5250.343707036621, 5268.157094864822, 5320.547753440957, 5377.247185394048, 5400.432954539776, 5247.711375874325, 5357.571394288458, 5362.249285100089, 5405.621606487547, 5445.128779395298, 4841.709497430156, 4881.974785295092, 4991.101601711691, 5031.195008798593, 5036.194208926572, 756.663843731702, 4893.241547560134, 4918.877028074291, 4932.53140951609, 4961.0, 4894.926576101361, 4896.045271172123, 4902.509749025105, 4904.4605093439695, 4948.1093403187415, 4805.351277577517, 4920.21276595743, 4921.040397122527, 4937.35814344133, 4989.825356112555, 4787.545183207624, 4796.952030479685, 4815.903681926342, 4833.154198015369, 4843.39457567804, 5101.642884998052, 5205.583553315726, 5243.318368612094, 5248.475152484759, 5276.182191760245, 5593.552515798727, 5648.237487939116, 5660.320761508604, 5694.430556944314, 5696.430356964312, 5667.716614169316, 5682.431756824326, 5693.402192769741, 5694.088945768657, 5726.79956201531, 5346.812861549866, 5385.35375754908, 5392.946070539284, 5400.756965936543, 5416.485433883814, 5718.027935250934, 5765.279340082406, 5776.884462310814, 5784.334801497882, 5945.940540594625, 5587.469190426903, 5592.356878958972, 5602.355729091125, 5637.323521177403, 5646.57650676201, 5658.688772117491, 5725.141228815628, 5732.140178973187, 5734.139879018181, 5736.856578585485, 5515.558755299567, 5538.972305138529, 5585.525230355384, 5677.914831277534, 5695.288088988877, 5521.309836270466, 5676.914846277309, 5678.063119585222, 5697.088465845445, 5699.0, 4371.23503386906, 4374.365716971021, 4380.9780951095045, 4384.079343337935, 4390.912181756347, 3776.848061341262, 3877.747946383476, 3886.106195575034, 3904.7266691331333, 3918.2359439908946, 5478.534324582375, 5479.424660410679, 5501.284832971688, 5504.532114770209, 5524.723763811793, 5634.0, 5748.885022299614, 5787.363390027093, 5787.768489260382, 5792.681402522901, 5422.186671999153, 5443.836684899459, 5467.234587157801, 5503.477169668875, 5511.090670039479, 4786.114568804782, 4800.183968725325, 4801.927971080437, 4814.277858321279, 4840.661153719206, 5839.036558967808, 5990.101484777231, 5993.430624090704, 6001.549883758736, 6004.159417681441, 5739.713014349266, 5771.85570360736, 5789.8263052108505, 5835.037218859011, 5838.532917366685, 5932.5550583705535, 5951.672658003851, 5956.642601443928, 5981.222441082631, 5984.491318237999, 5586.581006424616, 5628.577856660849, 5688.288963879515, 5694.715264236689, 5700.686462244616, 5709.54323654115, 5768.192453056491, 5775.537956963349, 5784.045632470596, 5836.037053886062, 5544.805931792368, 5609.775608975595, 5612.102063669793, 5646.0, 5660.15097735343, 5498.615096943176, 5569.0, 5580.720963951868, 5595.804146854841, 5622.662640241599, 5368.8389348319615, 5391.4608539145775, 5429.0, 5460.071787796163, 5501.229827824188, 5586.050371436784, 5597.496225339739, 5612.130119831432, 5612.158176273429, 5657.745401456862, 5433.619646624698, 5469.0, 5493.23094766725, 5515.172724091258, 5536.667799932017], "value": 5242.760641069891, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.1734938916929, 596.7762089216544, 613.9232595925511, 621.2110619513219, 627.2786295759878, 42132.36801447977, 42979.57020429799, 43515.78242108789, 46654.0, 47243.0, 43957.0, 44230.55769442305, 44766.0, 44793.0, 44839.77580112103, 8824.20582147605, 8935.55322233889, 8967.506787126706, 8968.865467018, 8971.519699249617, 8779.2098711116, 8852.645894164225, 8858.73423797287, 8863.468191908474, 8869.0, 8951.820963580756, 8968.327375446868, 8987.685431009915, 9004.819903601923, 9024.278057755364, 8878.334124940622, 8886.46681199127, 8901.24339431146, 8903.55482225886, 8905.599248033854, 8786.64853405863, 8804.899387576554, 8855.203031727175, 8875.245604123656, 8883.20051195389, 41574.1685166295, 41733.0, 41903.0, 41909.0, 42027.159456810696, 3576.8926932192076, 3634.218642991743, 3636.0935023771844, 4187.225363307798, 4196.622303992624, 31952.840235798903, 32812.867163634284, 32852.0, 32945.0, 33020.33959320824, 4300.677449191292, 4417.138657961698, 4514.8419805306985, 4581.152486789954, 4616.215243408628, 355475.0, 355624.0, 356182.0, 356254.0, 357724.0, 53104.203436948475, 58220.417795822344, 58821.41178588245, 58884.411155887894, 64466.0, 60398.396016040155, 61611.38388616056, 61771.382286176566, 61810.69094654588, 61813.690931545956, 15135.470258541118, 15315.923420382827, 15331.61670958235, 15373.538793836204, 15446.0732356059, 11045.889541104647, 11241.494132764044, 11254.324740515594, 11269.09847212221, 11339.659810205707, 18683.252669893052, 18700.625987480445, 18817.0, 18832.34086806955, 18859.90570047141, 7021.894671579828, 7108.573485590881, 7190.640467976685, 7212.891806622905, 7218.530795498381, 953.4708236928433, 1054.752133248686, 1066.9437257115555, 1076.612419528969, 1154.9307041577533, 32561.511577325884, 32579.837100814817, 32764.344713105605, 32833.835830820695, 33310.333793324484, 1068.3216157739892, 1133.9773204535863, 1210.3222195570333, 1211.1703483114095, 1279.539365828301, 16563.0, 16606.173320934686, 16642.58393540171, 16721.749173762404, 16906.0, 571801.0, 575043.0, 576010.0, 577159.0, 577477.0, 55946.440535594935, 55978.72010639921, 56024.43975560274, 56581.71709141428, 56748.432515675144, 1334.312828893121, 1344.1934839096464, 1365.6858922447893, 1370.3216907630785, 1372.3001269352503, 29792.70207297899, 30621.23446913845, 31206.843965780026, 31257.531137032507, 31339.216519587193, 48082.27876581924, 48130.75934620304, 48446.0, 48573.5142648569, 48730.99999999858, 470888.0, 470964.0, 471213.0, 471255.0, 472886.0, 27858.0, 27871.581926271527, 28502.144935651962, 28722.281942951595, 28778.28054298659, 47707.52292477031, 47885.28172077491, 47913.281300781215, 48707.75646121747, 49162.50837491579, 41349.586504134575, 41387.7930610345, 41668.0, 42302.153956920076, 42914.0, 40333.798331008154, 41178.32026473337, 41230.0, 41399.1720165589, 41478.0, 35417.64582354143, 39541.60458395494, 39821.60178398179, 40756.388654170805, 41623.58376416197, 35873.46189807207, 36838.0, 37281.62718372782, 37330.0, 37783.62216377911, 27512.0, 28681.28296792597, 29067.0, 33730.0, 34061.65938340684], "value": 20236.27518626421, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.3808221092884, 397.5289282200591, 400.30147392799563, 404.08877980154745, 417.5573891674825, 13493.932530337335, 18061.729074063882, 18215.27138914445, 19153.61692766144, 19170.808291917077, 18469.445916622488, 18509.167087481062, 18911.90544047278, 19563.413097607096, 19606.70589941152, 5691.146328050805, 5734.541236701064, 5850.444207800252, 5874.060150375941, 5894.6168499047635, 5768.884622307552, 5779.104238842965, 5802.767889284423, 5827.096799996008, 5886.587938844283, 5143.742812859342, 5400.432954539776, 5426.75579598917, 5761.53907687384, 5819.592628516006, 5322.2282768998275, 5434.592405569579, 5494.203340515603, 5532.834014979557, 5608.074667679828, 5481.588880833953, 5512.531434828044, 5516.834494965117, 5520.889582208333, 5529.917051244234, 12381.0, 12881.742365152739, 21386.786132138634, 21985.780142198535, 22179.66730499044, 2143.9464013399634, 2232.3975453548724, 2265.7054582904284, 2332.428555004018, 2796.9160925172278, 9349.76625584359, 10180.134688551481, 10395.740106497322, 10642.414667193301, 14638.268086595734, 1910.6178764247068, 1914.1960376641844, 1924.259160223324, 1933.1011079847797, 2001.8798872067723, 66077.66961165164, 72655.0, 77434.54398224509, 78837.0, 79003.20996790074, 9517.476538790295, 10145.594176233015, 10795.568177272979, 10815.35107893529, 11614.303141811519, 14974.775378369333, 15036.097834129987, 15038.624034399008, 15040.548783536511, 15100.093994360373, 7274.963625181946, 7473.4021278297605, 7528.0, 7535.962320188364, 7656.310932016146, 6840.794776156723, 6919.792406227822, 6965.651717414109, 7064.293570642997, 7097.751578694824, 4578.130155270488, 4788.760561971957, 4789.95210047895, 4819.445763737145, 4834.7824347904425, 1845.4648152036027, 1987.3342430286016, 2014.5366565689974, 2035.063870619502, 2044.9693254601193, 958.166395236149, 1038.60532997462, 1048.8741351037925, 1059.3220338983058, 1105.8954570769308, 18233.08834558293, 18892.527686807665, 19376.128074236694, 19664.901675491532, 19721.60556788856, 1035.4615599888166, 1040.3133931605255, 1049.3494033699003, 1065.2543219746208, 1074.7635520185547, 10473.790524189626, 10695.572177112985, 10732.517036733365, 10755.516001779939, 10879.184061195441, 429731.0, 434652.0, 445835.0, 447447.0, 447830.0, 93157.0, 94636.0, 94836.0, 94922.0, 94931.0, 1020.7448137965508, 1030.922680798928, 1072.1958531101673, 1075.3547871277171, 1089.3899416326883, 16222.26999784989, 17046.14769261507, 17170.141492925555, 17201.74197387015, 17250.482485525456, 42110.78944605257, 42200.78899605482, 42204.57795422006, 42352.0, 43130.47130051425, 49882.25176622426, 51762.741186293824, 52175.0, 55456.44543554513, 55539.72230138823, 8067.798305042421, 8162.6734930602115, 8404.495730256203, 8547.188017138362, 8798.516081615573, 10922.672319830417, 12781.0, 13247.337633118499, 13607.79588306196, 13704.931475342559, 11828.763424731285, 11949.0, 12095.57665481704, 12294.0, 12373.75252494963, 7010.614416207158, 9891.406515609087, 11901.702457438634, 11920.344381059125, 12105.455254513745, 12303.56937507183, 12377.443015064164, 12437.813432798695, 12443.813342799684, 12541.31022793755, 8196.180381961756, 8224.465409748347, 8533.146685331418, 8554.91445085566, 8571.970226098052, 8542.615582298935, 11653.88346116528, 11983.700407489534, 12201.938990304992, 12204.084693647834], "value": 9029.75062252112, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1495.3495229575135, 1521.855423734745, 1663.5425258054033, 1787.2761531579715, 1796.6316905034469, 7939.325157361617, 8551.401401901869, 8594.269487093597, 9216.124468175522, 9234.769130771725, 8592.785180370494, 8879.689210877621, 8922.776930576723, 8925.375223734341, 8936.151065648754, 2312.5490529346785, 2343.121329501437, 2343.1915988983774, 2346.5658853112227, 2348.941276468085, 2308.803751681109, 2321.0947730385165, 2331.2773040357542, 2361.929142125739, 2363.5863723848342, 2307.3193407944614, 2309.4226443389152, 2322.686437330964, 2329.813614910803, 2337.123578658003, 2267.807236384909, 2280.9051655205594, 2292.3925159832656, 2293.6674182243646, 2304.8271379646594, 2250.054976909702, 2259.7853203945765, 2267.954640907189, 2272.670462782887, 2282.8173746100274, 8804.0, 8883.689070882489, 8907.109289071106, 8921.821563568757, 8965.372423930328, 4937.80248790048, 5017.623678224148, 5034.84895453137, 5054.494550544916, 5081.23781432788, 3230.4346739320526, 3280.5735254416772, 3431.3995050865997, 3445.4831775233665, 3459.463783113596, 1147.8622565292135, 1166.2011522107384, 1171.3616079236836, 1186.6440067979572, 1195.8983486403665, 12260.75478490434, 12478.18891772041, 12480.625581232578, 12489.063320250927, 12491.375431228493, 4421.2262854001065, 4542.909141817145, 4612.469565999886, 4642.280446530793, 4646.3727396801, 10537.525811338355, 10544.841827372595, 10561.0, 10580.25938184335, 10593.735156620993, 5178.145605975047, 5209.921851172236, 5251.894962100737, 5287.20691896211, 5287.68273903567, 4321.891952701145, 4636.0, 4747.264174053027, 4754.049190161982, 4885.1206782779445, 4002.199560087994, 4045.3325201342036, 4108.794560272034, 4117.691173161965, 4152.709310348307, 1246.0218728298241, 1265.5633806336798, 1271.783796754554, 1272.961811145667, 1277.157076329618, 976.1751320134475, 976.5654283843763, 991.2070343725135, 1007.3250921882357, 1027.7071034755209, 5969.76120955157, 6102.755889764359, 6128.509719222451, 6324.929302584944, 6368.331325210879, 927.703134996808, 948.4546385828177, 988.7132731507783, 1017.6183931025865, 1094.2176343914139, 4068.7965601719798, 4188.706790524634, 4228.2177797107015, 4245.766482843412, 4265.189613973335, 10715.83926241107, 10922.29005114665, 10952.890471095347, 10960.0, 10990.065844403316, 10885.945570272099, 11060.059894908862, 11081.889181108247, 11161.386123763272, 11207.943960280147, 7722.459427839997, 7979.281864632211, 8231.42380033404, 8234.258916697407, 8350.707725229588, 6027.849303767441, 6143.477804386677, 6206.162168107247, 6240.375962403905, 6267.937320626917, 10127.544260508443, 10200.693979180636, 10201.897981020094, 10229.232807539316, 10350.275480716278, 9924.354916930377, 10364.326318789255, 10367.63713270032, 10422.583096676048, 10432.426216558162, 7067.399271062018, 7560.319571238615, 7764.961175194314, 7808.804779880548, 7975.441719079608, 8588.398812083095, 8618.78453038679, 8658.090900455361, 8670.26302764272, 8692.478451292942, 7560.886586701314, 7718.343940765098, 7851.803704907423, 7853.175416581176, 7875.566843823644, 7595.240475952361, 7624.161342252237, 7724.459287850022, 7802.570858602831, 7837.177096405024, 6940.93059069423, 7001.404880585207, 7005.824854378681, 7022.754203602849, 7031.156261248479, 5161.122609156528, 5162.5869930406225, 5249.868753281198, 5254.710990895537, 5261.868453288698, 5172.405173405106, 5173.198154286091, 5228.6078544110105, 5248.265242865926, 5262.158054711228], "value": 4685.0285713193225, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.4238756656668, 325.84848045658765, 327.6363236807144, 329.52219282041045, 330.2404469719645, 5572.359178694446, 5629.6340737852015, 5636.520895723863, 5636.746346414406, 5651.8304450866435, 5507.953488837118, 5551.333839939213, 5554.305711786027, 5558.610897237195, 5582.972085139579, 4104.835806567741, 4178.811953462086, 4323.805428755713, 4359.912801743963, 4381.277089280281, 4305.268104422255, 4315.374270730742, 4325.416068830715, 4354.847580334689, 4370.606645401913, 4296.806643701026, 4308.698391112608, 4339.500957389909, 4354.1944740223, 4360.324149756792, 4211.157768446307, 4224.775224775225, 4320.330348795942, 4321.7406955582765, 4341.41390912226, 3741.3639681254253, 3751.681107105899, 3781.735278530504, 3788.8295026723863, 3805.1818858945458, 5276.419593844674, 5301.443348448396, 5353.277307563507, 5377.892442151135, 5400.729963501809, 4822.807087716487, 4882.023595280958, 4938.1111399947995, 4956.21576232556, 4967.900641987176, 5775.047117225653, 5780.88438231233, 5784.537237021028, 5828.184054232411, 5854.4730974212525, 4216.578342165759, 4221.598948099926, 4229.6827737919775, 4232.217039847638, 4258.382534532476, 5909.881802363929, 6065.150878876917, 6096.628258641815, 6113.270904748145, 6138.8772224555705, 4293.098449325614, 4303.33298338758, 4304.440422745023, 4309.978450107729, 4318.740875547414, 4375.671824613167, 4377.68669399179, 4385.342198670161, 4405.427294451701, 4414.3157810539415, 4849.151398505247, 4856.975715121402, 4933.210686290176, 4957.628177886673, 5005.747413663866, 5768.942310576925, 5787.363390027093, 5843.298804143445, 5872.765089396462, 5882.499987501024, 1459.489178787416, 1475.1886462445611, 1487.323267913097, 1490.4485340424112, 1490.5528341497507, 939.6147579492375, 949.5489642419795, 951.8191543606692, 958.166395236149, 961.8653388525612, 4959.140322379108, 4964.0, 4966.304717339575, 4986.276989836453, 4996.876327560773, 5174.327337446183, 5282.6302158849285, 5311.804843910167, 5324.1747529133045, 5346.732663366816, 4677.947461821131, 5022.020705962375, 5038.395392552917, 5172.577541176207, 5177.663451875691, 2889.19102651258, 2894.4789937810974, 2903.6951120132503, 2903.7822163337833, 2937.588737576741, 5394.300795249484, 5460.31746031746, 5460.645058071213, 5506.504414602705, 5514.6139770216505, 5137.460566640449, 5377.247185394048, 5402.459754024645, 5450.91823622646, 5543.447834606317, 5453.745638503166, 5492.286002819608, 5493.560515158778, 5522.729772152427, 5564.916526252109, 5227.607929405386, 5297.78151025274, 5325.760340784596, 5373.677579345252, 5656.377798442086, 5988.730507127277, 6004.699765011819, 6012.579119461596, 6056.606320589148, 6065.7573697053385, 6320.968395157995, 6333.240011198502, 6335.968320158369, 6341.397567231105, 6358.682065896594, 3970.5632380438706, 4176.642591157946, 4215.0, 4221.261279276053, 4263.403123562765, 5914.260717410324, 5953.124765698791, 6028.33688294296, 6048.5161187105805, 6160.815175544741, 5893.585539470582, 5906.586538942404, 5913.733881975408, 5950.7917222896995, 5968.269201931391, 5870.647761134345, 5876.500497457764, 5890.440408161217, 5984.31180414258, 6005.129256257906, 5629.521490673339, 5825.79609713658, 5831.717022255097, 5848.333225030846, 5862.677552734641, 5930.584859059824, 6057.333693293646, 6071.51427885777, 6073.5748497604745, 6089.695515224133, 5649.079313033589, 5822.272215973004, 5867.911981320198, 5892.5285977122585, 5917.940820591739], "value": 4342.642554421756, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [721.3471808013746, 744.757953665059, 789.28175360422, 809.8299357135002, 820.9014918209814, 15054.096754194756, 15290.541283761491, 15907.80691448143, 15907.92046039771, 15922.601934951617, 14532.200728959902, 14715.190664513448, 14759.0, 15054.548363549111, 15204.771928421083, 806.8951036365279, 807.6042739057849, 808.9514629122242, 813.7640084375524, 815.1237419773737, 791.9485233459835, 793.9126696063429, 794.6424109150877, 820.5240960243045, 821.137805304428, 845.5434065604566, 855.6748435594466, 857.3784006595231, 858.5578427110044, 858.8625819868822, 850.7235148576707, 850.8213275212213, 852.1606217875387, 852.6802449081595, 853.7524118005771, 612.7640858269554, 614.5759425996048, 615.7844754335991, 616.1589430427479, 616.9321374648785, 13842.653933651638, 13876.444942202299, 13879.236641984688, 13924.37340319678, 13929.094608850392, 14555.490557830424, 14727.190004549746, 14822.703545929022, 14925.25373731309, 14938.925305373512, 12256.632301030893, 12383.19509231906, 12435.75128497425, 12450.439730212162, 12508.123781432858, 3761.962380376189, 3844.442555829389, 3860.073582340246, 3885.9805700971597, 3988.940165897514, 73513.26486735171, 75172.62413687952, 75379.24620753832, 75598.62200688961, 76530.61734691347, 10777.353358798497, 11492.195546311677, 11552.76894462106, 11560.826587601192, 11774.116941229271, 21278.893605532183, 21301.147954081975, 21345.78654213469, 21352.14591416357, 21406.250781222894, 8526.78683032929, 8531.274841638531, 8598.269147122439, 8737.475751454933, 8750.168733970262, 4813.085513752376, 4825.420949486084, 4852.393450818648, 4904.068227036852, 5001.649884508122, 3560.946585801215, 3671.81640917953, 3688.981555092207, 3698.6486283802997, 3698.9088218975467, 628.7893555658814, 630.124127462827, 631.1416473595906, 638.7700427845972, 640.5324113397246, 526.2159382520017, 563.0934195944526, 684.3772167327808, 791.6912404162381, 820.1265652080515, 9835.262355323379, 10452.581896724198, 10770.138388929023, 10821.675349739364, 10924.235303528836, 740.2930201657405, 740.3706849178155, 763.595294493908, 776.3323541754087, 791.4815795653856, 4678.3216433616935, 4787.305840653085, 4899.534544218293, 4903.632227582945, 4903.926441103386, 81203.0, 112673.43663281632, 114052.0, 118462.40768796101, 119137.0, 62363.37636623576, 62974.0, 88375.55812220898, 95587.0, 96695.51652241693, 89339.55330223308, 90948.54525727329, 91858.54070729604, 92202.53898730598, 92882.0, 9565.378250413702, 9695.466749328854, 9733.805323893625, 9744.707658770249, 9749.805003900025, 51230.74384628202, 51378.22932656088, 51504.48495514997, 51595.484045159064, 52742.47257527376, 68566.0, 72877.6356118216, 73012.6349368271, 73073.6346318265, 73767.89348159675, 12082.637520874388, 12142.150049496451, 12337.444814983526, 12352.517697875954, 12647.367631618199, 13343.866561334651, 13616.795748063589, 13776.311184440938, 13864.722705545631, 14231.857681423053, 12655.240685558896, 12714.427850746553, 12975.351232438528, 13277.66805829862, 13525.797113043509, 12725.61823145307, 12846.421911014213, 12904.870951290366, 12974.347468401615, 13286.933565332112, 12038.217515861441, 12623.87376126227, 13444.46222151103, 13701.383437745524, 13708.108972916729, 10979.341239525655, 11265.549378024787, 11445.740968493626, 11782.646520604396, 11787.233829801036, 11111.777764444827, 11290.661280161608, 11521.769564608829, 11542.249753765978, 11680.415979201176], "value": 7524.345747317728, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1541.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 107.0, 112.0, 110.0, 112.0, 112.0, 111.0, 111.0, 112.0, 110.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 126.0, 150.0, 188.0, 126.0, 160.0, 159.0, 130.0, 178.0, 125.0], "value": 150.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 163.0, 163.0, 163.0, 164.0, 168.0, 162.0, 164.0, 162.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 167.0, 77.0, 75.0, 75.0, 75.0, 165.0, 76.0], "value": 93.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 150.0, 87.0, 84.0, 85.0, 148.0, 85.0, 85.0, 139.0], "value": 103.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 120.0, 117.0, 118.0, 118.0, 117.0, 118.0, 120.0, 118.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 149.0, 146.0, 148.0, 147.0, 147.0, 147.0, 148.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 54.0, 55.0, 53.0, 53.0, 55.0, 56.0, 56.0, 54.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 61.0, 61.0, 62.0, 61.0, 61.0, 63.0, 64.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 80.0, 82.0, 82.0, 80.0, 81.0, 81.0, 106.0, 86.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 140.0, 130.0, 139.0, 123.0, 123.0, 129.0, 127.0, 138.0, 127.0], "value": 129.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 169.0, 162.0, 161.0, 167.0, 160.0, 162.0, 162.0, 164.0, 162.0], "value": 163.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 65.0, 63.0, 62.0, 66.0, 71.0, 62.0, 64.0, 62.0], "value": 64.5, "unit": "score"}]}]} 05:26:17 INFO - Return code: 0 05:26:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:26:17 ERROR - # TBPL SUCCESS # 05:26:17 INFO - Running post-action listener: _resource_record_post_action 05:26:17 INFO - ##### 05:26:17 INFO - ##### Finished run-tests step (success) 05:26:17 INFO - ##### 05:26:17 INFO - Running post-run listener: _resource_record_post_run 05:26:17 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 541175808; Read time: 12; Write time: 468668 05:26:17 INFO - TinderboxPrint: CPU usage
13.5% 05:26:17 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 05:26:17 INFO - TinderboxPrint: I/O write bytes / time
541,175,808 / 468,668 05:26:17 INFO - TinderboxPrint: CPU idle
8,212.5 (86.5%) 05:26:17 INFO - TinderboxPrint: CPU user
1,226.5 (12.9%) 05:26:17 INFO - TinderboxPrint: Swap in / out
0 / 0 05:26:17 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 247783424; Read time: 0; Write time: 244192 05:26:17 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292806656; Read time: 12; Write time: 224464 05:26:18 INFO - Running post-run listener: _upload_blobber_files 05:26:18 INFO - Blob upload gear active. 05:26:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:26:18 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 05:26:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:26:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:26:18 INFO - (blobuploader) - INFO - Open directory for files ... 05:26:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:26:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:26:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:26:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:26:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:26:22 INFO - (blobuploader) - INFO - Done attempting. 05:26:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:26:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:26:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:26:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:26:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:26:23 INFO - (blobuploader) - INFO - Done attempting. 05:26:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:26:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:26:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:26:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:26:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:26:24 INFO - (blobuploader) - INFO - Done attempting. 05:26:24 INFO - (blobuploader) - INFO - Iteration through files over. 05:26:24 INFO - Return code: 0 05:26:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:26:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:26:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3284ef9156473e42a96a2f9862d18b2eb26bedf36184df66af36a99fa0ce7f0a540de7d4e93d09d3518c60f117914917f54392724d79db9be46d34b719dee199", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a5c324fd4f07113fc7ba7e3d95a46d97b7b22ffb7854e3cdd105fde37bac1896a7c5d9561473a6072676939a1e6142f0199fec4ead1e5b6ca8e304b07ad3ff00", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d1471432c9873ffd4706f278231cd9542edfea09e9b094a0e7a7fcf8cda3b724b1d78c8bc60848155315bc9e1e54acde28855e5034e82e2e282e9242fb018f46"} 05:26:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:26:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:26:24 INFO - Contents: 05:26:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3284ef9156473e42a96a2f9862d18b2eb26bedf36184df66af36a99fa0ce7f0a540de7d4e93d09d3518c60f117914917f54392724d79db9be46d34b719dee199", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a5c324fd4f07113fc7ba7e3d95a46d97b7b22ffb7854e3cdd105fde37bac1896a7c5d9561473a6072676939a1e6142f0199fec4ead1e5b6ca8e304b07ad3ff00", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d1471432c9873ffd4706f278231cd9542edfea09e9b094a0e7a7fcf8cda3b724b1d78c8bc60848155315bc9e1e54acde28855e5034e82e2e282e9242fb018f46"} 05:26:24 INFO - Running post-run listener: copy_logs_to_upload_dir 05:26:24 INFO - Copying logs to upload dir... 05:26:24 INFO - mkdir: /builds/slave/test/build/upload/logs 05:26:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.501040 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-07 05:26:24.276097) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 05:26:24.280090) ========= 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=0e2a256762fed810e2f0f810000001b3-1465300942.668297-897120733 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/sha512/3284ef9156473e42a96a2f9862d18b2eb26bedf36184df66af36a99fa0ce7f0a540de7d4e93d09d3518c60f117914917f54392724d79db9be46d34b719dee199", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a5c324fd4f07113fc7ba7e3d95a46d97b7b22ffb7854e3cdd105fde37bac1896a7c5d9561473a6072676939a1e6142f0199fec4ead1e5b6ca8e304b07ad3ff00", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d1471432c9873ffd4706f278231cd9542edfea09e9b094a0e7a7fcf8cda3b724b1d78c8bc60848155315bc9e1e54acde28855e5034e82e2e282e9242fb018f46"} build_url:https://queue.taskcluster.net/v1/task/cLJdxxO8SB-zVBlqpzJzFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011401 build_url: 'https://queue.taskcluster.net/v1/task/cLJdxxO8SB-zVBlqpzJzFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3284ef9156473e42a96a2f9862d18b2eb26bedf36184df66af36a99fa0ce7f0a540de7d4e93d09d3518c60f117914917f54392724d79db9be46d34b719dee199", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a5c324fd4f07113fc7ba7e3d95a46d97b7b22ffb7854e3cdd105fde37bac1896a7c5d9561473a6072676939a1e6142f0199fec4ead1e5b6ca8e304b07ad3ff00", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d1471432c9873ffd4706f278231cd9542edfea09e9b094a0e7a7fcf8cda3b724b1d78c8bc60848155315bc9e1e54acde28855e5034e82e2e282e9242fb018f46"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 05:26:24.309770) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 05:26:24.310508) ========= 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=0e2a256762fed810e2f0f810000001b3-1465300942.668297-897120733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004453 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 05:26:24.393188) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 05:26:24.393857) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 05:26:24.394520) ========= ========= Total master_lag: 0.18 =========