builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-046 starttime: 1465474215.51 results: success (0) buildid: 20160609042428 builduid: 0bfa6b74456c4e57b04adc8caddf9fee revision: c03e4314339f812e3a2aca39607f483e59b875ef ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 05:10:15.505839) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 05:10:15.506297) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 05:10:15.506759) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 05:10:15.582766) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 05:10:15.583155) ========= 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=652eb03db935cfc1c15ebda0000001ad-1465473723.975090-2071196256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 05:10:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.7M=0s 2016-06-09 05:10:16 (46.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100163 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 05:10:15.719439) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 05:10:15.720823) ========= 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=652eb03db935cfc1c15ebda0000001ad-1465473723.975090-2071196256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020386 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 05:10:15.803622) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-09 05:10:15.803971) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c03e4314339f812e3a2aca39607f483e59b875ef --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 c03e4314339f812e3a2aca39607f483e59b875ef --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=652eb03db935cfc1c15ebda0000001ad-1465473723.975090-2071196256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 05:10:16,248 truncating revision to first 12 chars 2016-06-09 05:10:16,248 Setting DEBUG logging. 2016-06-09 05:10:16,248 attempt 1/10 2016-06-09 05:10:16,248 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c03e4314339f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 05:10:17,626 unpacking tar archive at: fx-team-c03e4314339f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.697292 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-09 05:10:17.531190) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 05:10:17.531556) ========= script_repo_revision: c03e4314339f812e3a2aca39607f483e59b875ef ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 05:10:17.531957) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 05:10:17.532221) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 05:10:17.545875) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-06-09 05:10:17.546231) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=652eb03db935cfc1c15ebda0000001ad-1465473723.975090-2071196256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:10:18 INFO - MultiFileLogger online at 20160609 05:10:18 in /builds/slave/test 05:10:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 05:10:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:10:18 INFO - {'append_to_log': False, 05:10:18 INFO - 'base_work_dir': '/builds/slave/test', 05:10:18 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:10:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:10:18 INFO - 'branch': 'Fx-Team-Non-PGO', 05:10:18 INFO - 'buildbot_json_path': 'buildprops.json', 05:10:18 INFO - 'config_files': ('talos/linux_config.py',), 05:10:18 INFO - 'default_actions': ('clobber', 05:10:18 INFO - 'read-buildbot-config', 05:10:18 INFO - 'download-and-extract', 05:10:18 INFO - 'populate-webroot', 05:10:18 INFO - 'create-virtualenv', 05:10:18 INFO - 'install', 05:10:18 INFO - 'run-tests'), 05:10:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:10:18 INFO - 'download_minidump_stackwalk': True, 05:10:18 INFO - 'download_symbols': 'ondemand', 05:10:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:10:18 INFO - 'tooltool.py': '/tools/tooltool.py', 05:10:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:10:18 INFO - '/tools/misc-python/virtualenv.py')}, 05:10:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:10:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:10:18 INFO - 'installer_path': 'installer.exe', 05:10:18 INFO - 'log_level': 'info', 05:10:18 INFO - 'log_name': 'talos', 05:10:18 INFO - 'log_to_console': True, 05:10:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:10:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:10:18 INFO - 'opt_config_files': (), 05:10:18 INFO - 'pip_index': False, 05:10:18 INFO - 'sps_profile': False, 05:10:18 INFO - 'sps_profile_interval': 0, 05:10:18 INFO - 'suite': 'dromaeojs-e10s', 05:10:18 INFO - 'system_bits': '32', 05:10:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:10:18 INFO - 'title': 'talos-linux64-ix-046', 05:10:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:10:18 INFO - 'use_talos_json': True, 05:10:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:10:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:10:18 INFO - 'work_dir': 'build'} 05:10:18 INFO - ##### 05:10:18 INFO - ##### Running clobber step. 05:10:18 INFO - ##### 05:10:18 INFO - Running pre-action listener: _resource_record_pre_action 05:10:18 INFO - Running main action method: clobber 05:10:18 INFO - rmtree: /builds/slave/test/build 05:10:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:10:18 INFO - Running post-action listener: _resource_record_post_action 05:10:18 INFO - ##### 05:10:18 INFO - ##### Finished clobber step (success) 05:10:18 INFO - ##### 05:10:18 INFO - ##### 05:10:18 INFO - ##### Running read-buildbot-config step. 05:10:18 INFO - ##### 05:10:18 INFO - Running pre-action listener: _resource_record_pre_action 05:10:18 INFO - Running main action method: read_buildbot_config 05:10:18 INFO - Using buildbot properties: 05:10:18 INFO - { 05:10:18 INFO - "project": "", 05:10:18 INFO - "product": "firefox", 05:10:18 INFO - "script_repo_revision": "production", 05:10:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:10:18 INFO - "repository": "", 05:10:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 05:10:18 INFO - "buildid": "20160609042428", 05:10:18 INFO - "pgo_build": "False", 05:10:18 INFO - "basedir": "/builds/slave/test", 05:10:18 INFO - "buildnumber": 1576, 05:10:18 INFO - "slavename": "talos-linux64-ix-046", 05:10:18 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:10:18 INFO - "platform": "ubuntu64_hw", 05:10:18 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:10:18 INFO - "branch": "fx-team", 05:10:18 INFO - "repo_path": "integration/fx-team", 05:10:18 INFO - "revision": "c03e4314339f812e3a2aca39607f483e59b875ef", 05:10:18 INFO - "stage_platform": "linux64", 05:10:18 INFO - "builduid": "0bfa6b74456c4e57b04adc8caddf9fee", 05:10:18 INFO - "slavebuilddir": "test" 05:10:18 INFO - } 05:10:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/bh6ltXwNQg2y98oveuaF8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:10:18 INFO - Running post-action listener: _resource_record_post_action 05:10:18 INFO - ##### 05:10:18 INFO - ##### Finished read-buildbot-config step (success) 05:10:18 INFO - ##### 05:10:18 INFO - ##### 05:10:18 INFO - ##### Running download-and-extract step. 05:10:18 INFO - ##### 05:10:18 INFO - Running pre-action listener: _resource_record_pre_action 05:10:18 INFO - Running main action method: download_and_extract 05:10:18 INFO - mkdir: /builds/slave/test/build/tests 05:10:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:10:18 INFO - https://queue.taskcluster.net/v1/task/bh6ltXwNQg2y98oveuaF8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:10:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bh6ltXwNQg2y98oveuaF8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:10:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bh6ltXwNQg2y98oveuaF8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:10:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bh6ltXwNQg2y98oveuaF8A/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:10:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bh6ltXwNQg2y98oveuaF8A/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:10:21 INFO - Downloaded 1361 bytes. 05:10:21 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:10:21 INFO - Using the following test package requirements: 05:10:21 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:10:21 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:10:21 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:10:21 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:21 INFO - u'jsshell-linux-x86_64.zip'], 05:10:21 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:10:21 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:10:21 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:10:21 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:10:21 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:10:21 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:10:21 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:10:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:10:21 INFO - https://queue.taskcluster.net/v1/task/bh6ltXwNQg2y98oveuaF8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:10:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bh6ltXwNQg2y98oveuaF8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:10:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bh6ltXwNQg2y98oveuaF8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:10:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bh6ltXwNQg2y98oveuaF8A/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:10:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bh6ltXwNQg2y98oveuaF8A/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:10:24 INFO - Downloaded 22879579 bytes. 05:10:24 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:10:24 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:10:25 INFO - Return code: 0 05:10:25 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:10:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:10:25 INFO - https://queue.taskcluster.net/v1/task/bh6ltXwNQg2y98oveuaF8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:10:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bh6ltXwNQg2y98oveuaF8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:10:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bh6ltXwNQg2y98oveuaF8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:10:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bh6ltXwNQg2y98oveuaF8A/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:10:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bh6ltXwNQg2y98oveuaF8A/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:10:42 INFO - Downloaded 22879579 bytes. 05:10:42 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:10:42 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:10:43 INFO - Return code: 0 05:10:43 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:10:43 INFO - https://queue.taskcluster.net/v1/task/bh6ltXwNQg2y98oveuaF8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:10:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bh6ltXwNQg2y98oveuaF8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:10:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bh6ltXwNQg2y98oveuaF8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:10:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bh6ltXwNQg2y98oveuaF8A/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:10:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bh6ltXwNQg2y98oveuaF8A/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:10:44 INFO - Downloaded 10833377 bytes. 05:10:44 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:10:44 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:10:45 INFO - Return code: 0 05:10:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:10:45 INFO - https://queue.taskcluster.net/v1/task/bh6ltXwNQg2y98oveuaF8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:10:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bh6ltXwNQg2y98oveuaF8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:10:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bh6ltXwNQg2y98oveuaF8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:10:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bh6ltXwNQg2y98oveuaF8A/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:10:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bh6ltXwNQg2y98oveuaF8A/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:10:46 INFO - Downloaded 55433612 bytes. 05:10:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bh6ltXwNQg2y98oveuaF8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:10:46 INFO - mkdir: /builds/slave/test/properties 05:10:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:10:46 INFO - Writing to file /builds/slave/test/properties/build_url 05:10:46 INFO - Contents: 05:10:46 INFO - build_url:https://queue.taskcluster.net/v1/task/bh6ltXwNQg2y98oveuaF8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:10:48 INFO - Running post-action listener: _resource_record_post_action 05:10:48 INFO - Running post-action listener: set_extra_try_arguments 05:10:48 INFO - ##### 05:10:48 INFO - ##### Finished download-and-extract step (success) 05:10:48 INFO - ##### 05:10:48 INFO - ##### 05:10:48 INFO - ##### Running populate-webroot step. 05:10:48 INFO - ##### 05:10:48 INFO - Running pre-action listener: _resource_record_pre_action 05:10:48 INFO - Running main action method: populate_webroot 05:10:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:10:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:10:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:10:48 INFO - '--tppagecycles', 05:10:48 INFO - '7'], 05:10:48 INFO - 'tests': ['tsvgm']}}, 05:10:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:10:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:10:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:10:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:10:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:10:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:10:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:48 INFO - 'talos_options': ['--disable-e10s'], 05:10:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:10:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:10:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:48 INFO - 'talos_options': ['--disable-e10s'], 05:10:48 INFO - 'tests': ['damp', 'tps']}, 05:10:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:48 INFO - 'tests': ['damp', 'tps']}, 05:10:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:10:48 INFO - 'tests': ['dromaeo_dom']}, 05:10:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:10:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:10:48 INFO - 'tests': ['a11yr', 05:10:48 INFO - 'ts_paint', 05:10:48 INFO - 'tpaint', 05:10:48 INFO - 'sessionrestore', 05:10:48 INFO - 'sessionrestore_no_auto_restore', 05:10:48 INFO - 'tabpaint']}, 05:10:48 INFO - 'other-e10s': {'tests': ['a11yr', 05:10:48 INFO - 'ts_paint', 05:10:48 INFO - 'tpaint', 05:10:48 INFO - 'sessionrestore', 05:10:48 INFO - 'sessionrestore_no_auto_restore', 05:10:48 INFO - 'tabpaint']}, 05:10:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:10:48 INFO - 'ts_paint', 05:10:48 INFO - 'tpaint', 05:10:48 INFO - 'sessionrestore', 05:10:48 INFO - 'sessionrestore_no_auto_restore', 05:10:48 INFO - 'tabpaint']}, 05:10:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:10:48 INFO - 'ts_paint', 05:10:48 INFO - 'tpaint', 05:10:48 INFO - 'sessionrestore', 05:10:48 INFO - 'sessionrestore_no_auto_restore', 05:10:48 INFO - 'tabpaint']}, 05:10:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:10:48 INFO - 'tests': ['a11yr', 05:10:48 INFO - 'ts_paint', 05:10:48 INFO - 'tpaint', 05:10:48 INFO - 'sessionrestore', 05:10:48 INFO - 'sessionrestore_no_auto_restore', 05:10:48 INFO - 'tabpaint']}, 05:10:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:10:48 INFO - 'tests': ['a11yr', 05:10:48 INFO - 'ts_paint', 05:10:48 INFO - 'tpaint', 05:10:48 INFO - 'sessionrestore', 05:10:48 INFO - 'sessionrestore_no_auto_restore', 05:10:48 INFO - 'tabpaint']}, 05:10:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:10:48 INFO - 'tests': ['tsvgx', 05:10:48 INFO - 'tsvgr_opacity', 05:10:48 INFO - 'tart', 05:10:48 INFO - 'tscrollx', 05:10:48 INFO - 'cart']}, 05:10:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:10:48 INFO - 'tsvgr_opacity', 05:10:48 INFO - 'tart', 05:10:48 INFO - 'tscrollx', 05:10:48 INFO - 'cart']}, 05:10:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:48 INFO - 'talos_options': ['--disable-e10s'], 05:10:48 INFO - 'tests': ['tp5o']}, 05:10:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:48 INFO - 'tests': ['tp5o']}, 05:10:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:48 INFO - 'talos_options': ['--disable-e10s', 05:10:48 INFO - '--xperf_path', 05:10:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:10:48 INFO - 'tests': ['tp5n']}, 05:10:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:48 INFO - 'talos_options': ['--xperf_path', 05:10:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:10:48 INFO - 'tests': ['tp5n']}}, 05:10:48 INFO - 'talos.zip': {'path': '', 05:10:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:10:48 INFO - Running post-action listener: _resource_record_post_action 05:10:48 INFO - ##### 05:10:48 INFO - ##### Finished populate-webroot step (success) 05:10:48 INFO - ##### 05:10:48 INFO - ##### 05:10:48 INFO - ##### Running create-virtualenv step. 05:10:48 INFO - ##### 05:10:48 INFO - Running pre-action listener: _resource_record_pre_action 05:10:48 INFO - Running main action method: create_virtualenv 05:10:48 INFO - Creating virtualenv /builds/slave/test/build/venv 05:10:48 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:10:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:10:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:10:48 INFO - Using real prefix '/usr' 05:10:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:10:49 INFO - Installing distribute.............................................................................................................................................................................................done. 05:10:51 INFO - Installing pip.................done. 05:10:51 INFO - Return code: 0 05:10:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:10: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:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10: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:10:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:51 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 0x7f2ec4241f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18662e0>, '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 0x17d2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d25d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1465473723.975090-2071196256', '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:10:51 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:10:51 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:10:51 INFO - Using env: {'DISPLAY': ':0', 05:10:51 INFO - 'HOME': '/home/cltbld', 05:10:51 INFO - 'LANG': 'en_US.UTF-8', 05:10:51 INFO - 'LANGUAGE': 'en_US:en', 05:10:51 INFO - 'LOGNAME': 'cltbld', 05:10:51 INFO - 'MAIL': '/var/mail/cltbld', 05:10:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:51 INFO - 'MOZ_NO_REMOTE': '1', 05:10:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:51 INFO - 'NO_EM_RESTART': '1', 05:10:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:51 INFO - 'PWD': '/builds/slave/test', 05:10:51 INFO - 'SHELL': '/bin/bash', 05:10:51 INFO - 'SHLVL': '1', 05:10:51 INFO - 'TERM': 'linux', 05:10:51 INFO - 'TMOUT': '86400', 05:10:51 INFO - 'USER': 'cltbld', 05:10:51 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465473723.975090-2071196256', 05:10:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:51 INFO - '_': '/tools/buildbot/bin/python'} 05:10:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:51 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:10:51 INFO - Cleaning up... 05:10:51 INFO - Return code: 0 05:10:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:10: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:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10: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:10:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:51 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 0x7f2ec4241f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18662e0>, '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 0x17d2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d25d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1465473723.975090-2071196256', '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:10:51 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:10:51 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:10:51 INFO - Using env: {'DISPLAY': ':0', 05:10:51 INFO - 'HOME': '/home/cltbld', 05:10:51 INFO - 'LANG': 'en_US.UTF-8', 05:10:51 INFO - 'LANGUAGE': 'en_US:en', 05:10:51 INFO - 'LOGNAME': 'cltbld', 05:10:51 INFO - 'MAIL': '/var/mail/cltbld', 05:10:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:51 INFO - 'MOZ_NO_REMOTE': '1', 05:10:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:51 INFO - 'NO_EM_RESTART': '1', 05:10:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:51 INFO - 'PWD': '/builds/slave/test', 05:10:51 INFO - 'SHELL': '/bin/bash', 05:10:51 INFO - 'SHLVL': '1', 05:10:51 INFO - 'TERM': 'linux', 05:10:51 INFO - 'TMOUT': '86400', 05:10:51 INFO - 'USER': 'cltbld', 05:10:51 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465473723.975090-2071196256', 05:10:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:51 INFO - '_': '/tools/buildbot/bin/python'} 05:10:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:51 INFO - Downloading/unpacking psutil>=3.1.1 05:10:51 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:10:51 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:10:51 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:10:51 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:10:51 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:10:51 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:10:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:10:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:10:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:10:53 INFO - Installing collected packages: psutil 05:10:53 INFO - Running setup.py install for psutil 05:10:53 INFO - building 'psutil._psutil_linux' extension 05:10:53 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:10:54 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:10:54 INFO - building 'psutil._psutil_posix' extension 05:10:54 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:10:54 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:10:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:10:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:10:54 INFO - Successfully installed psutil 05:10:54 INFO - Cleaning up... 05:10:54 INFO - Return code: 0 05:10:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:10: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:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10: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:10:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:54 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 0x7f2ec4241f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18662e0>, '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 0x17d2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d25d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1465473723.975090-2071196256', '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:10:54 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:10:54 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:10:54 INFO - Using env: {'DISPLAY': ':0', 05:10:54 INFO - 'HOME': '/home/cltbld', 05:10:54 INFO - 'LANG': 'en_US.UTF-8', 05:10:54 INFO - 'LANGUAGE': 'en_US:en', 05:10:54 INFO - 'LOGNAME': 'cltbld', 05:10:54 INFO - 'MAIL': '/var/mail/cltbld', 05:10:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:54 INFO - 'MOZ_NO_REMOTE': '1', 05:10:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:54 INFO - 'NO_EM_RESTART': '1', 05:10:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:54 INFO - 'PWD': '/builds/slave/test', 05:10:54 INFO - 'SHELL': '/bin/bash', 05:10:54 INFO - 'SHLVL': '1', 05:10:54 INFO - 'TERM': 'linux', 05:10:54 INFO - 'TMOUT': '86400', 05:10:54 INFO - 'USER': 'cltbld', 05:10:54 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465473723.975090-2071196256', 05:10:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:54 INFO - '_': '/tools/buildbot/bin/python'} 05:10:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:10:54 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:10:54 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:10:54 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:10:54 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:10:54 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:10:54 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:10:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:10:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:10:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:10:56 INFO - Installing collected packages: mozsystemmonitor 05:10:56 INFO - Running setup.py install for mozsystemmonitor 05:10:56 INFO - Successfully installed mozsystemmonitor 05:10:56 INFO - Cleaning up... 05:10:56 INFO - Return code: 0 05:10:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:10:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:10:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:56 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 0x7f2ec4241f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18662e0>, '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 0x17d2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d25d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1465473723.975090-2071196256', '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:10:56 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:10:56 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:10:56 INFO - Using env: {'DISPLAY': ':0', 05:10:56 INFO - 'HOME': '/home/cltbld', 05:10:56 INFO - 'LANG': 'en_US.UTF-8', 05:10:56 INFO - 'LANGUAGE': 'en_US:en', 05:10:56 INFO - 'LOGNAME': 'cltbld', 05:10:56 INFO - 'MAIL': '/var/mail/cltbld', 05:10:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:56 INFO - 'MOZ_NO_REMOTE': '1', 05:10:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:56 INFO - 'NO_EM_RESTART': '1', 05:10:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:56 INFO - 'PWD': '/builds/slave/test', 05:10:56 INFO - 'SHELL': '/bin/bash', 05:10:56 INFO - 'SHLVL': '1', 05:10:56 INFO - 'TERM': 'linux', 05:10:56 INFO - 'TMOUT': '86400', 05:10:56 INFO - 'USER': 'cltbld', 05:10:56 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465473723.975090-2071196256', 05:10:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:56 INFO - '_': '/tools/buildbot/bin/python'} 05:10:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:56 INFO - Downloading/unpacking jsonschema==2.5.1 05:10:56 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:10:56 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:10:56 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:10:56 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:10:56 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:10:56 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:10:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:10:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:10:58 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:10:58 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:10:58 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:10:58 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:10:58 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:10:58 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:10:58 INFO - Downloading functools32-3.2.3-2.tar.gz 05:10:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:10:59 INFO - warning: no files found matching '*.txt' 05:10:59 INFO - no previously-included directories found matching 'build' 05:10:59 INFO - no previously-included directories found matching 'dist' 05:10:59 INFO - no previously-included directories found matching '.git*' 05:10:59 INFO - Installing collected packages: jsonschema, functools32 05:10:59 INFO - Running setup.py install for functools32 05:10:59 INFO - warning: no files found matching '*.txt' 05:10:59 INFO - no previously-included directories found matching 'build' 05:10:59 INFO - no previously-included directories found matching 'dist' 05:10:59 INFO - no previously-included directories found matching '.git*' 05:10:59 INFO - Successfully installed jsonschema functools32 05:10:59 INFO - Cleaning up... 05:10:59 INFO - Return code: 0 05:10:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:10: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:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10: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:10:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2ec4241f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18662e0>, '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 0x17d2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d25d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1465473723.975090-2071196256', '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:10:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:10:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:10:59 INFO - Using env: {'DISPLAY': ':0', 05:10:59 INFO - 'HOME': '/home/cltbld', 05:10:59 INFO - 'LANG': 'en_US.UTF-8', 05:10:59 INFO - 'LANGUAGE': 'en_US:en', 05:10:59 INFO - 'LOGNAME': 'cltbld', 05:10:59 INFO - 'MAIL': '/var/mail/cltbld', 05:10:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:59 INFO - 'MOZ_NO_REMOTE': '1', 05:10:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:59 INFO - 'NO_EM_RESTART': '1', 05:10:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:59 INFO - 'PWD': '/builds/slave/test', 05:10:59 INFO - 'SHELL': '/bin/bash', 05:10:59 INFO - 'SHLVL': '1', 05:10:59 INFO - 'TERM': 'linux', 05:10:59 INFO - 'TMOUT': '86400', 05:10:59 INFO - 'USER': 'cltbld', 05:10:59 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465473723.975090-2071196256', 05:10:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:59 INFO - '_': '/tools/buildbot/bin/python'} 05:10:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:59 INFO - Downloading/unpacking blobuploader==1.2.4 05:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:01 INFO - Downloading blobuploader-1.2.4.tar.gz 05:11:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:11:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:11:01 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:11:01 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:11:01 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:11:01 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:11:01 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:11:01 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:11:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:11:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:11:01 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:11:01 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:11:01 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:11:01 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:11:01 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:11:01 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:11:02 INFO - Downloading docopt-0.6.1.tar.gz 05:11:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:11:02 INFO - Installing collected packages: blobuploader, requests, docopt 05:11:02 INFO - Running setup.py install for blobuploader 05:11:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:11:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:11:02 INFO - Running setup.py install for requests 05:11:02 INFO - Running setup.py install for docopt 05:11:02 INFO - Successfully installed blobuploader requests docopt 05:11:02 INFO - Cleaning up... 05:11:02 INFO - Return code: 0 05:11:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11:02 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:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:02 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:11:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:02 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 0x7f2ec4241f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18662e0>, '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 0x17d2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d25d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1465473723.975090-2071196256', '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:11:02 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:11:02 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:11:02 INFO - Using env: {'DISPLAY': ':0', 05:11:02 INFO - 'HOME': '/home/cltbld', 05:11:02 INFO - 'LANG': 'en_US.UTF-8', 05:11:02 INFO - 'LANGUAGE': 'en_US:en', 05:11:02 INFO - 'LOGNAME': 'cltbld', 05:11:02 INFO - 'MAIL': '/var/mail/cltbld', 05:11:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:02 INFO - 'MOZ_NO_REMOTE': '1', 05:11:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:02 INFO - 'NO_EM_RESTART': '1', 05:11:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:02 INFO - 'PWD': '/builds/slave/test', 05:11:02 INFO - 'SHELL': '/bin/bash', 05:11:02 INFO - 'SHLVL': '1', 05:11:02 INFO - 'TERM': 'linux', 05:11:02 INFO - 'TMOUT': '86400', 05:11:02 INFO - 'USER': 'cltbld', 05:11:02 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465473723.975090-2071196256', 05:11:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:02 INFO - '_': '/tools/buildbot/bin/python'} 05:11:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:11:02 INFO - Running setup.py (path:/tmp/pip-Vo5HVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:11:03 INFO - Running setup.py (path:/tmp/pip-sUBBkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:11:03 INFO - Running setup.py (path:/tmp/pip-HP8XRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:11:03 INFO - Running setup.py (path:/tmp/pip-01HFDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:11:03 INFO - Running setup.py (path:/tmp/pip-MDrqdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:11:03 INFO - Running setup.py (path:/tmp/pip-KwEzXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:11:03 INFO - Running setup.py (path:/tmp/pip-_D3BFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:11:03 INFO - Running setup.py (path:/tmp/pip-qHphzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:11:03 INFO - Running setup.py (path:/tmp/pip-kACbIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:11:03 INFO - Running setup.py (path:/tmp/pip-xfJ_hk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:11:03 INFO - Running setup.py (path:/tmp/pip-5ZugDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:11:03 INFO - Running setup.py (path:/tmp/pip-_xT7rS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:11:03 INFO - Running setup.py (path:/tmp/pip-f5qpVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:11:03 INFO - Running setup.py (path:/tmp/pip-kpyVbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:03 INFO - Running setup.py (path:/tmp/pip-RIw738-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:11:04 INFO - Running setup.py (path:/tmp/pip-3trwfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:11:04 INFO - Running setup.py (path:/tmp/pip-o9o067-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:11:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:11:04 INFO - Running setup.py install for manifestparser 05:11:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:11:04 INFO - Running setup.py install for mozcrash 05:11:04 INFO - Running setup.py install for mozdebug 05:11:04 INFO - Running setup.py install for mozdevice 05:11:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:11:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:11:04 INFO - Running setup.py install for mozfile 05:11:04 INFO - Running setup.py install for mozhttpd 05:11:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:11:04 INFO - Running setup.py install for mozinfo 05:11:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:11:04 INFO - Running setup.py install for mozInstall 05:11:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:11:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:11:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:11:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:11:04 INFO - Running setup.py install for mozleak 05:11:05 INFO - Running setup.py install for mozlog 05:11:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:11:05 INFO - Running setup.py install for moznetwork 05:11:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:11:05 INFO - Running setup.py install for mozprocess 05:11:05 INFO - Running setup.py install for mozprofile 05:11:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:11:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:11:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:11:05 INFO - Running setup.py install for mozrunner 05:11:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:11:05 INFO - Running setup.py install for mozscreenshot 05:11:05 INFO - Running setup.py install for moztest 05:11:05 INFO - Running setup.py install for mozversion 05:11:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:11:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:11:05 INFO - Cleaning up... 05:11:05 INFO - Return code: 0 05:11:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11: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:11:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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:11:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:05 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 0x7f2ec4241f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18662e0>, '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 0x17d2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d25d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1465473723.975090-2071196256', '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:11:05 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:11:05 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:11:05 INFO - Using env: {'DISPLAY': ':0', 05:11:05 INFO - 'HOME': '/home/cltbld', 05:11:05 INFO - 'LANG': 'en_US.UTF-8', 05:11:05 INFO - 'LANGUAGE': 'en_US:en', 05:11:05 INFO - 'LOGNAME': 'cltbld', 05:11:05 INFO - 'MAIL': '/var/mail/cltbld', 05:11:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:05 INFO - 'MOZ_NO_REMOTE': '1', 05:11:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:05 INFO - 'NO_EM_RESTART': '1', 05:11:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:05 INFO - 'PWD': '/builds/slave/test', 05:11:05 INFO - 'SHELL': '/bin/bash', 05:11:05 INFO - 'SHLVL': '1', 05:11:05 INFO - 'TERM': 'linux', 05:11:05 INFO - 'TMOUT': '86400', 05:11:05 INFO - 'USER': 'cltbld', 05:11:05 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465473723.975090-2071196256', 05:11:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:05 INFO - '_': '/tools/buildbot/bin/python'} 05:11:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:11:06 INFO - Running setup.py (path:/tmp/pip-ClBqjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:11:06 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:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:11:06 INFO - Running setup.py (path:/tmp/pip-6wOPQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:11:06 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:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:11:06 INFO - Running setup.py (path:/tmp/pip-jD1NJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:11:06 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:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:11:06 INFO - Running setup.py (path:/tmp/pip-_4xdek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:11:06 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:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:11:06 INFO - Running setup.py (path:/tmp/pip-xaf5Or-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:11:06 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:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:11:06 INFO - Running setup.py (path:/tmp/pip-QiOg0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:11:06 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:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:11:06 INFO - Running setup.py (path:/tmp/pip-zqQA6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:11:06 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:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:11:06 INFO - Running setup.py (path:/tmp/pip-m6UA1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:11:06 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:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:11:06 INFO - Running setup.py (path:/tmp/pip-afHsQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:11:06 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:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:11:06 INFO - Running setup.py (path:/tmp/pip-xKHlef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:11:06 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:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:11:06 INFO - Running setup.py (path:/tmp/pip-dO4DmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:11:06 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:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:11:06 INFO - Running setup.py (path:/tmp/pip-jUqz6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:11:07 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:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:11:07 INFO - Running setup.py (path:/tmp/pip-kaOnr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:11:07 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:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:11:07 INFO - Running setup.py (path:/tmp/pip-hpRYMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:11:07 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:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:07 INFO - Running setup.py (path:/tmp/pip-OaMJVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:07 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:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:11:07 INFO - Running setup.py (path:/tmp/pip-KW0asO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:11:07 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:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:11:07 INFO - Running setup.py (path:/tmp/pip-yzOw27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:11:07 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:11:07 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:11:07 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:11:07 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:11:07 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:11:07 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:11:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:09 INFO - Downloading blessings-1.6.tar.gz 05:11:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:11:09 INFO - Installing collected packages: blessings 05:11:09 INFO - Running setup.py install for blessings 05:11:09 INFO - Successfully installed blessings 05:11:09 INFO - Cleaning up... 05:11:09 INFO - Return code: 0 05:11:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:11:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:11:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:11:09 INFO - Reading from file tmpfile_stdout 05:11:09 INFO - Current package versions: 05:11:09 INFO - argparse == 1.2.1 05:11:09 INFO - blessings == 1.6 05:11:09 INFO - blobuploader == 1.2.4 05:11:09 INFO - docopt == 0.6.1 05:11:09 INFO - functools32 == 3.2.3-2 05:11:09 INFO - jsonschema == 2.5.1 05:11:09 INFO - manifestparser == 1.1 05:11:09 INFO - mozInstall == 1.12 05:11:09 INFO - mozcrash == 0.17 05:11:09 INFO - mozdebug == 0.1 05:11:09 INFO - mozdevice == 0.48 05:11:09 INFO - mozfile == 1.2 05:11:09 INFO - mozhttpd == 0.7 05:11:09 INFO - mozinfo == 0.9 05:11:09 INFO - mozleak == 0.1 05:11:09 INFO - mozlog == 3.2 05:11:09 INFO - moznetwork == 0.27 05:11:09 INFO - mozprocess == 0.22 05:11:09 INFO - mozprofile == 0.28 05:11:09 INFO - mozrunner == 6.11 05:11:09 INFO - mozscreenshot == 0.1 05:11:09 INFO - mozsystemmonitor == 0.3 05:11:09 INFO - moztest == 0.7 05:11:09 INFO - mozversion == 1.4 05:11:09 INFO - psutil == 3.1.1 05:11:09 INFO - requests == 1.2.3 05:11:09 INFO - wsgiref == 0.1.2 05:11:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:11:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:09 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 0x7f2ec4241f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18662e0>, '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 0x17d2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d25d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1465473723.975090-2071196256', '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:11:09 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:11:09 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:11:09 INFO - Using env: {'DISPLAY': ':0', 05:11:09 INFO - 'HOME': '/home/cltbld', 05:11:09 INFO - 'LANG': 'en_US.UTF-8', 05:11:09 INFO - 'LANGUAGE': 'en_US:en', 05:11:09 INFO - 'LOGNAME': 'cltbld', 05:11:09 INFO - 'MAIL': '/var/mail/cltbld', 05:11:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:09 INFO - 'MOZ_NO_REMOTE': '1', 05:11:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:09 INFO - 'NO_EM_RESTART': '1', 05:11:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:09 INFO - 'PWD': '/builds/slave/test', 05:11:09 INFO - 'SHELL': '/bin/bash', 05:11:09 INFO - 'SHLVL': '1', 05:11:09 INFO - 'TERM': 'linux', 05:11:09 INFO - 'TMOUT': '86400', 05:11:09 INFO - 'USER': 'cltbld', 05:11:09 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465473723.975090-2071196256', 05:11:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:09 INFO - '_': '/tools/buildbot/bin/python'} 05:11:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:09 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:11:09 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:11:09 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:11:09 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:11:09 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:11:09 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:11:09 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:11:09 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:11:09 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:11:09 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:11:09 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:11:09 INFO - Cleaning up... 05:11:09 INFO - Return code: 0 05:11:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:11:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:11:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2ec4241f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18662e0>, '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 0x17d2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d25d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1465473723.975090-2071196256', '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:11:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:11:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:11:09 INFO - Using env: {'DISPLAY': ':0', 05:11:09 INFO - 'HOME': '/home/cltbld', 05:11:09 INFO - 'LANG': 'en_US.UTF-8', 05:11:09 INFO - 'LANGUAGE': 'en_US:en', 05:11:09 INFO - 'LOGNAME': 'cltbld', 05:11:09 INFO - 'MAIL': '/var/mail/cltbld', 05:11:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:09 INFO - 'MOZ_NO_REMOTE': '1', 05:11:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:09 INFO - 'NO_EM_RESTART': '1', 05:11:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:09 INFO - 'PWD': '/builds/slave/test', 05:11:09 INFO - 'SHELL': '/bin/bash', 05:11:09 INFO - 'SHLVL': '1', 05:11:09 INFO - 'TERM': 'linux', 05:11:09 INFO - 'TMOUT': '86400', 05:11:09 INFO - 'USER': 'cltbld', 05:11:09 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465473723.975090-2071196256', 05:11:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:09 INFO - '_': '/tools/buildbot/bin/python'} 05:11:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:11:10 INFO - Cleaning up... 05:11:10 INFO - Return code: 0 05:11:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:11: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:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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:11:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2ec4241f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17d4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18662e0>, '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 0x17d2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d25d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1465473723.975090-2071196256', '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:11: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', 'flake8'] in /builds/slave/test/build 05:11: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 flake8 05:11:10 INFO - Using env: {'DISPLAY': ':0', 05:11:10 INFO - 'HOME': '/home/cltbld', 05:11:10 INFO - 'LANG': 'en_US.UTF-8', 05:11:10 INFO - 'LANGUAGE': 'en_US:en', 05:11:10 INFO - 'LOGNAME': 'cltbld', 05:11:10 INFO - 'MAIL': '/var/mail/cltbld', 05:11:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:10 INFO - 'MOZ_NO_REMOTE': '1', 05:11:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:10 INFO - 'NO_EM_RESTART': '1', 05:11:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:10 INFO - 'PWD': '/builds/slave/test', 05:11:10 INFO - 'SHELL': '/bin/bash', 05:11:10 INFO - 'SHLVL': '1', 05:11:10 INFO - 'TERM': 'linux', 05:11:10 INFO - 'TMOUT': '86400', 05:11:10 INFO - 'USER': 'cltbld', 05:11:10 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465473723.975090-2071196256', 05:11:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:10 INFO - '_': '/tools/buildbot/bin/python'} 05:11:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:10 INFO - Downloading/unpacking flake8 05:11: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:11: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:11: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:11: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:11: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:11: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:11:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:11:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:11: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:11: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:11: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:11: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:11: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:11: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:11:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:11:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:11: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:11: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:11: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:11: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:11: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:11: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:11:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:11: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:11: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:11: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:11: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:11: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:11: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:11:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:11:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:11:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:11:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:11:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:11:13 INFO - no previously-included directories found matching 'docs/_build' 05:11:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:11:13 INFO - Running setup.py install for pep8 05:11:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:11:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:11:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:11:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:11:13 INFO - no previously-included directories found matching 'docs/_build' 05:11:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:11:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:11:13 INFO - Cleaning up... 05:11:13 INFO - Return code: 0 05:11:13 INFO - Running post-action listener: _resource_record_post_action 05:11:13 INFO - Running post-action listener: _start_resource_monitoring 05:11:13 INFO - Starting resource monitoring. 05:11:13 INFO - ##### 05:11:13 INFO - ##### Finished create-virtualenv step (success) 05:11:13 INFO - ##### 05:11:13 INFO - ##### 05:11:13 INFO - ##### Running install step. 05:11:13 INFO - ##### 05:11:13 INFO - Running pre-action listener: _resource_record_pre_action 05:11:13 INFO - Running main action method: install 05:11:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:11:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:11:13 INFO - Reading from file tmpfile_stdout 05:11:13 INFO - Detecting whether we're running mozinstall >=1.0... 05:11:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:11:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:11:13 INFO - Reading from file tmpfile_stdout 05:11:13 INFO - Output received: 05:11:13 INFO - Usage: mozinstall [options] installer 05:11:13 INFO - Options: 05:11:13 INFO - -h, --help show this help message and exit 05:11:13 INFO - -d DEST, --destination=DEST 05:11:13 INFO - Directory to install application into. [default: 05:11:13 INFO - "/builds/slave/test"] 05:11:13 INFO - --app=APP Application being installed. [default: firefox] 05:11:13 INFO - mkdir: /builds/slave/test/build/application 05:11:13 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:11:13 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:11:29 INFO - Reading from file tmpfile_stdout 05:11:29 INFO - Output received: 05:11:29 INFO - /builds/slave/test/build/application/firefox/firefox 05:11:29 INFO - Running post-action listener: _resource_record_post_action 05:11:29 INFO - ##### 05:11:29 INFO - ##### Finished install step (success) 05:11:29 INFO - ##### 05:11:29 INFO - ##### 05:11:29 INFO - ##### Running run-tests step. 05:11:29 INFO - ##### 05:11:29 INFO - Running pre-action listener: _resource_record_pre_action 05:11:29 INFO - Running main action method: run_tests 05:11:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:11:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:11:29 INFO - Python 2.7.3 05:11:29 INFO - Return code: 0 05:11:29 INFO - grabbing minidump binary from tooltool 05:11:29 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:11:29 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 0x18662e0>, '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 0x17d2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d25d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:11:29 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:11:29 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:11:29 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:11:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:11:29 INFO - Return code: 0 05:11:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:11:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:11:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:11:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:11:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:11:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:11:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:11:30 INFO - Return code: 0 05:11:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bh6ltXwNQg2y98oveuaF8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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:11:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bh6ltXwNQg2y98oveuaF8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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:11:30 INFO - Using env: {'DISPLAY': ':0', 05:11:30 INFO - 'HOME': '/home/cltbld', 05:11:30 INFO - 'LANG': 'en_US.UTF-8', 05:11:30 INFO - 'LANGUAGE': 'en_US:en', 05:11:30 INFO - 'LOGNAME': 'cltbld', 05:11:30 INFO - 'MAIL': '/var/mail/cltbld', 05:11:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:11:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:11:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:30 INFO - 'MOZ_NO_REMOTE': '1', 05:11:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:11:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:30 INFO - 'NO_EM_RESTART': '1', 05:11:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:30 INFO - 'PWD': '/builds/slave/test', 05:11:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:11:30 INFO - 'SHELL': '/bin/bash', 05:11:30 INFO - 'SHLVL': '1', 05:11:30 INFO - 'TERM': 'linux', 05:11:30 INFO - 'TMOUT': '86400', 05:11:30 INFO - 'USER': 'cltbld', 05:11:30 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1465473723.975090-2071196256', 05:11:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:30 INFO - '_': '/tools/buildbot/bin/python'} 05:11:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bh6ltXwNQg2y98oveuaF8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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:11:30 INFO - mozversion application_buildid: 20160609042428 05:11:30 INFO - mozversion application_changeset: c03e4314339f812e3a2aca39607f483e59b875ef 05:11:30 INFO - mozversion application_display_name: Nightly 05:11:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:11:30 INFO - mozversion application_name: Firefox 05:11:30 INFO - mozversion application_remotingname: firefox 05:11:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:11:30 INFO - mozversion application_vendor: Mozilla 05:11:30 INFO - mozversion application_version: 50.0a1 05:11:30 INFO - mozversion platform_buildid: 20160609042428 05:11:30 INFO - mozversion platform_changeset: c03e4314339f812e3a2aca39607f483e59b875ef 05:11:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:11:30 INFO - mozversion platform_version: 50.0a1 05:11:30 INFO - using testdate: 1465474290 05:11:30 INFO - actual date: 1465474290 05:11:30 INFO - starting webserver on 'localhost:50465' 05:11:30 INFO - SUITE-START | Running 2 tests 05:11:30 INFO - TEST-START | dromaeo_css 05:11:30 INFO - operating with platform_type : linux_ 05:11:30 INFO - Initialising browser for dromaeo_css test... 05:11:30 INFO - TEST-INFO | started process 10536 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBAXKCL/profile http://localhost:50465/getInfo.html) 05:11:35 INFO - PROCESS | 10536 | __metrics Screen width/height:1600/1200 05:11:35 INFO - PROCESS | 10536 | colorDepth:24 05:11:35 INFO - PROCESS | 10536 | Browser inner width/height: 1024/697 05:11:35 INFO - PROCESS | 10536 | __metrics 05:11:36 ERROR - PROCESS | 10536 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 05:11:37 INFO - TEST-INFO | 10536: exit 0 05:11:37 INFO - Browser initialized. 05:11:37 INFO - Running cycle 1/1 for dromaeo_css test... 05:11:37 INFO - TEST-INFO | started process 10656 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBAXKCL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:11:49 INFO - PROCESS | 10656 | RSS: Main: 185966592 05:11:49 INFO - PROCESS | 10656 | 05:12:39 INFO - PROCESS | 10656 | 1465474359210 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:14:50 INFO - PROCESS | 10656 | Cycle 1(1): loaded http://localhost:50465/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50465/tests/dromaeo/cssquery-ext.html) 05:14:51 INFO - PROCESS | 10656 | RSS: Main: 187838464 05:14:51 INFO - PROCESS | 10656 | 05:17:54 INFO - PROCESS | 10656 | Cycle 1(1): loaded http://localhost:50465/tests/dromaeo/cssquery-ext.html (next: http://localhost:50465/tests/dromaeo/cssquery-jquery.html) 05:17:54 INFO - PROCESS | 10656 | RSS: Main: 187662336 05:17:54 INFO - PROCESS | 10656 | 05:20:56 INFO - PROCESS | 10656 | Cycle 1(1): loaded http://localhost:50465/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50465/tests/dromaeo/cssquery-mootools.html) 05:20:57 INFO - PROCESS | 10656 | RSS: Main: 188534784 05:20:57 INFO - PROCESS | 10656 | 05:23:59 INFO - PROCESS | 10656 | Cycle 1(1): loaded http://localhost:50465/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50465/tests/dromaeo/cssquery-prototype.html) 05:23:59 INFO - PROCESS | 10656 | RSS: Main: 186474496 05:23:59 INFO - PROCESS | 10656 | 05:27:02 INFO - PROCESS | 10656 | Cycle 1(1): loaded http://localhost:50465/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50465/tests/dromaeo/cssquery-yui.html) 05:27:03 INFO - PROCESS | 10656 | RSS: Main: 188026880 05:27:03 INFO - PROCESS | 10656 | 05:30:05 INFO - PROCESS | 10656 | Cycle 1(1): loaded http://localhost:50465/tests/dromaeo/cssquery-yui.html (next: http://localhost:50465/tests/dromaeo/cssquery-dojo.html) 05:30:05 INFO - PROCESS | 10656 | RSS: Main: 189267968 05:30:05 INFO - PROCESS | 10656 | 05:30:05 INFO - PROCESS | 10656 | __start_tp_report 05:30:05 INFO - PROCESS | 10656 | _x_x_mozilla_page_load 05:30:05 INFO - PROCESS | 10656 | _x_x_mozilla_page_load_details 05:30:05 INFO - PROCESS | 10656 | |i|pagename|runs| 05:30:05 INFO - PROCESS | 10656 | |0;dojo.html;2558.0790915270504;2624.8556329401877;2629.4609605030964;2645.86770661467;2647.9338016549573;4722.834700785469;4736.597389221916;4752.144613969484;4857.028594281149;4912.705237685741;4624.699394539352;4761.214399624067;4784.5693887550115;4805.47139814621;4821.4937431569615;4384.430024096863;4412.955870441303;4511.954880451202;4533.523979982104;4539.114872599845;4201.516825565069;4479.955200448003;4496.415465989417;4571.817127314904;4576.4737055238575;4263.424437700902;4307.978460107711;4392.692511524195;4394.165108629382;4448.466184057917;4281.250781113324;4301.956980430218;4327.502337231227;4351;4369.060651959812;4295.570442955711;4302.204092242914;4307.633851122659;4320.632746216544;4372.27857403528;4724.7401392923375;4780.020095880371;4791.928121078186;4812.25410061441;4844.612431005547;5142.151544995071;5149.485051494858;5166.147585648364;5179.896402071975;5231.843044708665;5059.797608095671;5116.692998420107;5185.222216667492;5211.062008838408;5214.556762675139;4797.280407938767;4802.279658051285;4805.8558243252755;4828.227483602677;4844.176489996674;5216.817411390583;5230.032443997872;5259.39516955555;5264;5288.550473209821;5026.271190677405;5026.447090820006;5035.194368900959;5055.9241611375855;5071.39143302806;4957.429895562056;5139.563137133311;5149.098907691139;5151.5878729701535;5174.09453345663;5042.168042273057;5098.08234517783;5098.5411312982005;5108.872278193001;5123.641345105882;4919.163742163841;5060.5698515625845;5063.8480845574695;5079.339685840817;5123.821521050105;4439.66702497314;4444.977775111104;4448.866534003921;4455.331700244989;4465.285554311295;3821.675157611634;3860.4402361657963;3867.7485963412287;3885.7668539887695;3891.8248678809523;4285.121550082225;4427.46870375557;4501.819927202875;4512.435945506812;4519.141363141059;5167.276581278624;5227.738613069331;5235.842924712265;5240.868978275574;5288.365396152486;4404.053128577371;4449.777511124431;4487.842925497592;4495.910081798411;4541.182587134347;4616.307553866947;4621.838235661736;4629.629629629621;4663.976680116578;4681.344611754357;4818.277258411266;4835.879103022453;4844.467108617979;4848.0546293472435;4908.828191013369;5013.774380152829;5165.302684137593;5166.638335316642;5171.456997015259;5219.929914367622;4867.002264535691;4868.95131048685;4873.731944743073;4895.33912921751;4941.629377796751;5133.204353325241;5134.589232861287;5137.845864624067;5145.279660847409;5197.610179236497;5120.769565369493;5161.483851614808;5164.018836421068;5176.4047134578495;5184.922226166535;4872.561469467765;4970.3290055843445;5003.874903127451;5031.547160755549;5037.949620503748;5050.292958985671;5058.64589478733;5073.44192138857;5088.872778180427;5119.616028797929;4836.081144582518;4923.876903077452;4925.48282430354;4985.102681517216;4993.750312484289;5069.417017043087;5097.974510127426;5104.846854594368;5117.1300878851425;5126.923096153635;4936.802527898843;5008.098542262428;5008.949910500848;5011.523905228997;5014.623903207347 05:30:05 INFO - PROCESS | 10656 | |1;ext.html;541.401722898191;569.075252714339;576.0437673462053;593.3502814418212;614.4807637546278;35914.64085359146;37131.443028354595;40539.98650033747;40546.189076218456;40743.18513629726;41693.79153104238;42080.737577872635;42312.365314520306;42320;42591.36112958308;7852.725154619575;7951.125376208613;8015.639296231654;8037.5579343136105;8044.115147333789;7954.5227286362715;8022.839543209132;8034;8036.316913062367;8046.959765201166;7990.2009799019925;8039.236272554127;8042.557659328734;8045.195480451966;8051.355891528693;7926.841463170762;7935.880961785578;7953.12515623281;7970.681172753083;7988.640511177011;7841.647125879292;7879.133295337509;7879.606019699049;7933.246341597539;7975.401844861659;31170.220744481343;39182.21635567301;39452.21095578073;39493.40759888604;39594.604053959665;3024.077656314823;3060.173753086654;3105.6583775784648;3143.135637699628;3170.1599076244815;28163.718362816315;28433.85783071092;28812.42375152506;28893.56659650107;29152.125436236947;3112.9688703112906;3114.1280441476424;3137.137287246003;3140.5289206618963;3168.8574014169185;98737.5063124687;98922;99243.50378248135;99492;99980.50009749977;33110.50334244988;33278.334433311196;33311.16722081919;33337.66662333394;33342.66657333444;30426.391472170875;32853.67146328506;33982.32035359279;34161.487577686356;34215.4867676985;13816.171029738047;14061.78907316391;14094.647633809236;14112.153270803785;14170.858291416955;11386.544538218544;11541.365224912543;11601.477933493014;11644.475998580085;11715.238509496856;7840.803979900434;7854.921450785533;7890.132085470594;7924.564148971746;7933.404994625426;3101.395227930577;3123.7188653021335;3157.636871759731;3183.0609970058426;3184.3312904289896;882.8366752150744;921.1847514949318;930.3627015494408;931.6133804471204;1045.132539991805;28326.858365708038;28727.569086463718;29011.274718132216;29309.56035659467;29562.260943476584;931.8043210925781;1003.4581326083979;1021.1830535571513;1027.275770581738;1085.5060947268973;14860.068191135299;15204.923975380052;15215.467458638894;15423.768643470357;15552.377904883904;391154;394531;396287;397668;398333;50024.24963625549;50133.24800128001;50628;50681.493185068415;50772;1173.3194747046693;1189.2983139947473;1198.4427241332821;1228.5735672047635;1230.8215308780177;27214;27744.94805571426;28384.85807570949;28475.715242847305;28812.279693007844;42674.57325426706;43691.34462983121;43964.120717586105;44114.779426103945;44118;333500;335102;335127;337163;337459;25761.355966100997;26062.60906086448;26300.342491437867;26462.470750585264;26717.732822671525;43240.56759432366;43356;43675.78162109169;44252.557474424844;44736;36812.815935920145;37360.43959340666;37971.62028379681;38006.23987520179;38390.616093839824;36246.26965723028;37202.44196337003;37285;37461.250774984896;37559.81220093882;35959;35994.64005359913;36307;36601;36993.63006369902;32622.673773261962;33204.83397582997;33429.331413372085;33556;33621;25258.836397417115;25876.482470350864;25979.22062338133;26040.479190416463;26048.34879128037 05:30:05 INFO - PROCESS | 10656 | |2;jquery.html;346.37306475279746;347.28805947806995;358.3031004695866;376.5707093912938;376.7588743204348;15705.842941570596;16600.58498537537;17401.390951316705;17405.738913916302;17443;15351.309191086428;15973.760393594077;16648.08435536045;16664.75002874958;16690.58273543162;4991.825286114996;5099.59203263738;5193.143131383336;5195.532402083812;5195.584353251731;3583.9283214335696;5053.974730126344;5529.419410961851;5894.528437724972;5906.3798301178185;5976.970115149418;6002.129691194774;6015;6045.123457098718;6091.878162436748;5779.2775903012125;5958.702064896781;5980.10298455233;5992.161097446361;5999.070144127667;5015.974920125413;5138.075146473633;5142.4600416956055;5177.404598471187;5203.531682148587;20189.899050504653;20461.283855065;20570.28004019867;20693.68959465609;20815.791842081537;1888.1125870840683;1999.9000049997442;2038.6738121900573;2100.222917520512;2416.492536567323;13285.070045096847;13303.201807891557;13420.127691700009;13548.254845983467;13767.449302027906;1718.9656206875918;1746.9912650436665;1755.6839768841603;1778.5020194345605;1778.6887294723501;45055.54944450579;66265.3373466264;67089.66455167693;67746.66126669335;68534.9719754209;9129.360944733939;9372.67195648149;9382;9556.426614403159;9686.982866798884;13079.542216022393;13150.145240559334;13159.868401316056;13210.73578528424;13221.93389033068;6958.686859091353;7059.964700176466;7124.964375178091;7157;7369.410447164214;6725.686387529936;6889.862202756017;6907.896381554281;7045.260247674023;7049.92950070503;5983.730732117066;5993.61041532299;6032.758689652453;6045.516358691294;6070.726817293233;1515.0076699761673;1590.403598650506;1713.3746182643245;1734.4103004978367;1740.25169177255;912.2337236721186;927.9699533517789;941.1247539787926;992.771662517625;1020.974475638115;16404.507864764077;16969.0667013313;17107.81565512504;17355.652886942444;17465.38871139504;875.1030194051021;900.2527901841456;909.8726178335038;920.0661328751323;955.9808803824023;9734.805303893883;9981.900180998242;9988.400695958266;10108.444035577966;10128.088472037552;375544;375773;384627;393263;396396;65931;66362.33637663658;67428.6628566854;67757;68148;938.7230766923774;954.7040417470606;955.3885513271512;973.6105557776946;975.5268694683073;15439.228038597801;15509.5347139586;15540.378384864931;15676.608084797972;15734.134622595868;33538;33961.150971225914;34036.61743677919;34083.31833363269;34645.13387165341;44319.33520997123;44618.53814618512;44683.77658111689;44706.55293447024;44739.55260447484;7340;7452.888206676796;7456.105267367951;7681.500702454323;7709.036370453693;11914.821277681016;11956.701082473008;12089.81865272004;12190.08574356909;12194.573189938665;9999.450030248116;10047.14599259042;10333.689989300334;10476.109530689977;10671.626493072705;9872.173647875166;10471.476426178813;10517.106045986176;10548.314359566604;11025.61410350634;10321.296985997527;10376.221783366429;10378.636747713794;10432.947835260775;10762.19283553721;7368.078990126234;7425.257474252531;7546.735864244725;7636.389088872988;7746.728864489716;10133.391996480235;10165.085142337226;10235.744106397102;10237.232207584311;10346.948265258625 05:30:05 INFO - PROCESS | 10656 | |3;mootools.html;1379.2483096712294;1400.3418393355123;1478.3199728125062;1627.6744651069773;1658.9999999999993;6472.51456140789;7114.64426778661;7222.927770722291;7616.390688744894;7619.276168763972;7394.408447324215;7397.852042959137;7536.9246307536905;7558.886616700754;7564;2130.80822725955;2159.1795117855195;2163.4266919266406;2163.8485306028583;2170.1102547955343;2072.533679922013;2121.8302535797097;2184.0936011555186;2189.6715492676067;2190.8466407351493;2115.4076858479575;2116.153538584563;2122.4375540481783;2134.658454647257;2179.727534058243;2101.4116047506645;2119.3430036688674;2122.3632910127053;2125.861818981761;2131.11558703138;2080.074366906727;2101.2015434135083;2108.135664377598;2118.184498967893;2131.4564785979633;7571.924280757177;7633.389328853678;7659.425543084291;7669.923300767033;7675.961620191919;4332.220200363933;4398.208322501949;4430.468343798765;4434.201843668138;4464.977675111603;2694.7709444697225;2808.7050859659644;2853.329467575118;2856.814307070034;2859.6970499073605;834.1758118318173;849.9915000849974;864.584999200381;865.7013330401002;871.0418539606445;9833.213342932548;9878.950605246999;9900.702978910644;9921.75195620108;9940.850887236626;3990.82041308136;4053.4730485036757;4101.52832424269;4125.731827431207;4133.359329303963;8523.190296921783;8564.100769419247;8575.871361929576;8600.311975041981;8610.311175105977;4364.912701745948;4442.444694413199;4454.26504626733;4488.438945131858;4495.685302028826;3529.6293889141784;4028.576999415019;4049.1091959768805;4068.06434520062;4158.708890377645;3499.562554680665;3509.105178179599;3550.3609350317192;3587.946180807238;3636.945445818315;1132.1112926352773;1141.2524796258465;1155.8439610652454;1157.890000449956;1165.2552914133403;836.690424542923;837.2130197614345;852.0882655558493;862.0646598440637;869.3262721390972;4974.651774375831;4979.875503112378;5035.219540971156;5044.621653376012;5074.3657042869645;400.4253895659738;404.6398705152417;409.11834995584564;414.128260012675;414.1551235479648;3350.3466823969093;3379.425497665403;3537.6816086552335;3546.2730140321687;3547.7516573839584;8628.611712472954;8957.283417326598;9024;9080.182783549511;9239.676611318571;9079.046700096527;9102;9114.544272786334;9124.45253284805;9134;6919.515633905679;6988.965055174692;7021.929780702332;7032.789016329519;7038.824029399306;5141.251974328597;5275.287836142072;5351.866203344947;5438.374586922555;5459.863503412446;8434.957825210835;8473.915260847312;8513.659453621785;8519.403641745019;8592.828143436971;8036.598170091589;8405.285550728257;8424.452410593292;8572.52851093196;8677.132286771272;5684.175794509691;6337.4613157882095;6454.322296158835;6515.348465153636;6600.339966003361;7104.325089116525;7152.463565232524;7202.89195662076;7206.747763828241;7244.927550724636;6402.455791257796;6559.311272316338;6611.173603299588;6616.933830661632;6698.631575263407;6487.643179625166;6494.058361537645;6509.285113457054;6596.0435736816935;6616.338366163345;5830.504407125272;5834.241548598655;5869.413058694096;5877.823665290048;5898.321693005188;4174.123434078878;4287.485501739811;4305.677074219383;4358.171947329997;4382.320740285261;4236.639885609758;4398.494173169998;4458.910821783481;4501.054778496552;4579.290210017452 05:30:05 INFO - PROCESS | 10656 | |4;prototype.html;285.687172546062;290.4365530870112;295.3001386713489;298.76845444780304;302.14794280130013;4924.128831044207;4998.450170481244;5073.771680274387;5138.743062846856;5157.226416037596;5040.974795126029;5054.494550544944;5071.949280507194;5082.84751457456;5093.898122037557;3970.2258059678447;3992.2215168042244;3994.9001274968214;4004.1391100913297;4015.7389769665024;3944.5858184890603;3985.183037477325;4005.459262999487;4020.477337946063;4036.596340365955;3912.3740201567753;3934.3311637021775;3951.7826519541413;3960.9801950990204;3974.2250261198933;3924.8626298079716;3928.9803550982347;3947.9999999999854;3970.861019864291;3974.503187101612;3482.355764183634;3484.9651503484893;3494.1963348430004;3501.5973163086314;3502.614712381636;4846.345743324641;4919.720872573121;4941.48114447985;4968.7515624219;4987.875303117415;4448.377227188196;4469.955300447019;4470.061287129706;4496.977515112436;4501.257292546726;5209.400918894337;5266.7366631668265;5297.576193904479;5298.97350513245;5302.761375738101;3464.6362131976284;3661.304352173105;3666.8899933002053;3758.605346438612;3785.2807966486553;5524.861878453071;5527.281453411071;5545.72271386429;5547.611667183299;5577.581681373873;3730.309892669865;3746.175841314961;3751.7748935063983;3779.488204718135;3788.450674652215;3559.5906470755676;3770.9434358484646;3771.830267637963;3791.545014598266;3800.3349413852466;4312.417823593837;4324.459442569679;4380.145871555016;4392.890177745582;4394.340848872695;5274.630775845654;5309.7079660618265;5316.308879845673;5327.520523152934;5332.466753324637;1229.7294595189044;1274.6558429224058;1306.45129045801;1310.606817954629;1330.534312990465;818.423011776696;827.896512935883;842.6629348260623;849.9830003400021;850.2347886901838;4136.875893723133;4190.281984386387;4202.411662367271;4221.517248270128;4234.407182994383;4820.807167713252;4826.710397376169;4830.758462076882;4872;4882.804687812519;4125.422440858282;4133.483314585676;4165.958340416618;4167;4171.623364289777;2481.5533204023086;2528.331783266148;2586.275842764029;2589.611558266275;2608.8695565221665;4486.641068714495;4533.591976722111;4563.680542362069;4609.496782445366;4631.513691062457;4967.379077615298;4973.90052198954;4976.377952755905;4978.477259887732;4980.2778597103215;4577.679562430664;4792.880177995508;5158;5161.122609156452;5196.220566914993;5500.779968801203;5543.1408131739645;5548.306461692288;5572.3034620672415;5584.357798853184;5214.634975551675;5422.8373148805595;5430.212619170277;5440.347158340866;5459.617826752089;5146.588272938081;5162.457941916195;5181.326427564392;5188;5205.40137884133;3773.698104151716;3810.142717888453;3833.616638336144;3845.115623406576;3858.6141385861188;4896.632752543503;5536.169574563848;5551.278333816578;5551.944480555143;5575.972120139373;5314.362276526842;5316.867078323073;5347.358317001985;5356.410794812489;5370.838874833761;5265.104562357625;5322.536302516839;5350.785968561214;5366.409694933476;5398.811041613525;5109.948900511096;5160.48395160496;5230.215467679878;5246.344206974129;5251.474852514718;5298.841034768963;5324.227986941949;5328.17413300939;5334.333208348957;5380.273663055594;5236.528712415901;5248.212768084665;5260.2898608688865;5279.340082489689;5288.233206185005 05:30:05 INFO - PROCESS | 10656 | |5;yui.html;647.7635662983013;675.4495086504498;706.6431452116686;711.118213415365;728.5155371677835;12503;12788.744225115492;12846.807297890527;12920.935395323022;12952.15810972286;13786.310684465787;14322.140671559713;14344.211068391234;14380.424783008693;14994.175320357403;628.0955424189153;796.8645330293864;799.588212070784;802.8273921106961;804.2319584796505;765.4182821055982;794.2295972906271;798.8841617965392;798.9041315042203;803.9236272554098;827.0819390476596;827.1563005734178;828.0849661124461;828.7265202483167;829.3572481326989;819.5697258939045;823.7240524424295;823.9052508961486;824.0482243009304;827.2720006394395;600.1717629671026;602.3314121325326;602.8944934636465;604.3805099772724;608.1364462463313;13425.261610611413;13475.66310842227;13503.59489215325;13569.52506662262;13593.932030339884;12375.938120309342;13316.533921312708;13937.233452160228;14084.225367604779;14152.646183845383;10697.197710171768;10841.67474975752;10846.837297440545;10952;11073.390963497004;3137.372525494887;3186.808791472496;3190.090824115116;3209.277912469676;3223.4520131577688;61533.384666153215;62239.37760622426;63153.36846631521;63934;64068.359316406706;10239.641612543524;10474.68575942723;10566.154707623371;10659.147268218523;10685.145188385066;18493.90753046226;19135.330263440712;19206.231750729814;19310.227590896207;19873.801261987483;7137.821554461076;7233.348998590152;7256.818579535554;7275.67259473325;7308.926910730825;3574.338747331752;3593.4789455528803;3634.5009026572775;3653.6081244314687;3670.522832031872;2819.675737290238;2919.7080291971056;2931.4430258250864;2932.1643331650375;2938.8236705797294;496.91055609989826;510.54561440318145;513.9768710408041;514.3724655919847;516.302990962198;559.3260121553518;580.9970950145222;584.030509354478;588.7200055595795;599.4365296621162;8192.795180120545;8952.955235223782;9003.684871029482;9009.189172974333;9449.385789923634;611.7094380169384;612.3631423319698;614.2107392001257;630.2909227119491;635.3805040085972;3647.2887786881834;3799.2021675448464;3824.6366595173413;3856.5179352580926;3929.057026313664;54928.450715492334;55078;55241.44758552443;88922.55538722394;91380;75177;76021.23978760252;78507.60746196233;78954.21045789469;81290.59354703188;69934.30065699278;70846;71014.64492677606;71221;71402.28597713956;7456.96271518639;7546.622668866425;7692.38454928772;7695.115061767969;7908.8813667793875;37463.43804842875;43026.569734303506;43173.56826431696;43224.35163472487;44284.33573496336;57504;61544.69227653833;61619.45424911779;61840;61881.69059154675;9915.603375864885;9917.504124793588;10299.7425064371;10417.531211095671;10573.8942610576;11325.377104259016;11451.141164412536;11503.942480287546;11805.881941180478;11999.100067494799;9992.750181245236;10347.120494757728;10390.116840068678;10572.207084468542;10754;10359.896401035892;10520.874751491054;10592.788144237225;10648.574057037631;10661.946690266499;9643.421394716339;9745.26910481731;9829.705108846745;9943.850842237227;9953.402795832273;8009.279164875189;8626.266767324847;8738.344624153087;8752.343574232085;9062.501562413867;8453.154684531497;8525.19010693983;8668.566571671518;9048.321375896703;9134.771630709285 05:30:05 INFO - PROCESS | 10656 | __end_tp_report 05:30:05 INFO - PROCESS | 10656 | __start_cc_report 05:30:05 INFO - PROCESS | 10656 | _x_x_mozilla_cycle_collect,384 05:30:05 INFO - PROCESS | 10656 | __end_cc_report 05:30:05 INFO - PROCESS | 10656 | __startTimestamp1465475405801__endTimestamp 05:30:05 INFO - PROCESS | 10656 | 05:30:05 INFO - PROCESS | 10656 | ------- Summary: start ------- 05:30:05 INFO - PROCESS | 10656 | Number of tests: 6 05:30:05 INFO - PROCESS | 10656 | 05:30:05 INFO - PROCESS | 10656 | [#0] dojo.html Cycles:165 Average:4758.33 Median:4873.73 stddev:509.12 (10.4%) stddev-sans-first:480.54 05:30:05 INFO - PROCESS | 10656 | Values: 2558.1 2624.9 2629.5 2645.9 2647.9 4722.8 4736.6 4752.1 4857.0 4912.7 4624.7 4761.2 4784.6 4805.5 4821.5 4384.4 4413.0 4512.0 4533.5 4539.1 4201.5 4480.0 4496.4 4571.8 4576.5 4263.4 4308.0 4392.7 4394.2 4448.5 4281.3 4302.0 4327.5 4351.0 4369.1 4295.6 4302.2 4307.6 4320.6 4372.3 4724.7 4780.0 4791.9 4812.3 4844.6 5142.2 5149.5 5166.1 5179.9 5231.8 5059.8 5116.7 5185.2 5211.1 5214.6 4797.3 4802.3 4805.9 4828.2 4844.2 5216.8 5230.0 5259.4 5264.0 5288.6 5026.3 5026.4 5035.2 5055.9 5071.4 4957.4 5139.6 5149.1 5151.6 5174.1 5042.2 5098.1 5098.5 5108.9 5123.6 4919.2 5060.6 5063.8 5079.3 5123.8 4439.7 4445.0 4448.9 4455.3 4465.3 3821.7 3860.4 3867.7 3885.8 3891.8 4285.1 4427.5 4501.8 4512.4 4519.1 5167.3 5227.7 5235.8 5240.9 5288.4 4404.1 4449.8 4487.8 4495.9 4541.2 4616.3 4621.8 4629.6 4664.0 4681.3 4818.3 4835.9 4844.5 4848.1 4908.8 5013.8 5165.3 5166.6 5171.5 5219.9 4867.0 4869.0 4873.7 4895.3 4941.6 5133.2 5134.6 5137.8 5145.3 5197.6 5120.8 5161.5 5164.0 5176.4 5184.9 4872.6 4970.3 5003.9 5031.5 5037.9 5050.3 5058.6 5073.4 5088.9 5119.6 4836.1 4923.9 4925.5 4985.1 4993.8 5069.4 5098.0 5104.8 5117.1 5126.9 4936.8 5008.1 5008.9 5011.5 5014.6 05:30:05 INFO - PROCESS | 10656 | 05:30:05 INFO - PROCESS | 10656 | [#1] ext.html Cycles:180 Average:42725.46 Median:36454.00 stddev:81307.44 (223.0%) stddev-sans-first:81473.84 05:30:05 INFO - PROCESS | 10656 | Values: 541.4 569.1 576.0 593.4 614.5 35914.6 37131.4 40540.0 40546.2 40743.2 41693.8 42080.7 42312.4 42320.0 42591.4 7852.7 7951.1 8015.6 8037.6 8044.1 7954.5 8022.8 8034.0 8036.3 8047.0 7990.2 8039.2 8042.6 8045.2 8051.4 7926.8 7935.9 7953.1 7970.7 7988.6 7841.6 7879.1 7879.6 7933.2 7975.4 31170.2 39182.2 39452.2 39493.4 39594.6 3024.1 3060.2 3105.7 3143.1 3170.2 28163.7 28433.9 28812.4 28893.6 29152.1 3113.0 3114.1 3137.1 3140.5 3168.9 98737.5 98922.0 99243.5 99492.0 99980.5 33110.5 33278.3 33311.2 33337.7 33342.7 30426.4 32853.7 33982.3 34161.5 34215.5 13816.2 14061.8 14094.6 14112.2 14170.9 11386.5 11541.4 11601.5 11644.5 11715.2 7840.8 7854.9 7890.1 7924.6 7933.4 3101.4 3123.7 3157.6 3183.1 3184.3 882.8 921.2 930.4 931.6 1045.1 28326.9 28727.6 29011.3 29309.6 29562.3 931.8 1003.5 1021.2 1027.3 1085.5 14860.1 15204.9 15215.5 15423.8 15552.4 391154.0 394531.0 396287.0 397668.0 398333.0 50024.2 50133.2 50628.0 50681.5 50772.0 1173.3 1189.3 1198.4 1228.6 1230.8 27214.0 27744.9 28384.9 28475.7 28812.3 42674.6 43691.3 43964.1 44114.8 44118.0 333500.0 335102.0 335127.0 337163.0 337459.0 25761.4 26062.6 26300.3 26462.5 26717.7 43240.6 43356.0 43675.8 44252.6 44736.0 36812.8 37360.4 37971.6 38006.2 38390.6 36246.3 37202.4 37285.0 37461.3 37559.8 35959.0 35994.6 36307.0 36601.0 36993.6 32622.7 33204.8 33429.3 33556.0 33621.0 25258.8 25876.5 25979.2 26040.5 26048.3 05:30:05 INFO - PROCESS | 10656 | 05:30:05 INFO - PROCESS | 10656 | [#2] jquery.html Cycles:180 Average:23641.12 Median:394829.50 stddev:63203.79 (16.0%) stddev-sans-first:63356.89 05:30:05 INFO - PROCESS | 10656 | Values: 346.4 347.3 358.3 376.6 376.8 15705.8 16600.6 17401.4 17405.7 17443.0 15351.3 15973.8 16648.1 16664.8 16690.6 4991.8 5099.6 5193.1 5195.5 5195.6 3583.9 5054.0 5529.4 5894.5 5906.4 5977.0 6002.1 6015.0 6045.1 6091.9 5779.3 5958.7 5980.1 5992.2 5999.1 5016.0 5138.1 5142.5 5177.4 5203.5 20189.9 20461.3 20570.3 20693.7 20815.8 1888.1 1999.9 2038.7 2100.2 2416.5 13285.1 13303.2 13420.1 13548.3 13767.4 1719.0 1747.0 1755.7 1778.5 1778.7 45055.5 66265.3 67089.7 67746.7 68535.0 9129.4 9372.7 9382.0 9556.4 9687.0 13079.5 13150.1 13159.9 13210.7 13221.9 6958.7 7060.0 7125.0 7157.0 7369.4 6725.7 6889.9 6907.9 7045.3 7049.9 5983.7 5993.6 6032.8 6045.5 6070.7 1515.0 1590.4 1713.4 1734.4 1740.3 912.2 928.0 941.1 992.8 1021.0 16404.5 16969.1 17107.8 17355.7 17465.4 875.1 900.3 909.9 920.1 956.0 9734.8 9981.9 9988.4 10108.4 10128.1 375544.0 375773.0 384627.0 393263.0 396396.0 65931.0 66362.3 67428.7 67757.0 68148.0 938.7 954.7 955.4 973.6 975.5 15439.2 15509.5 15540.4 15676.6 15734.1 33538.0 33961.2 34036.6 34083.3 34645.1 44319.3 44618.5 44683.8 44706.6 44739.6 7340.0 7452.9 7456.1 7681.5 7709.0 11914.8 11956.7 12089.8 12190.1 12194.6 9999.5 10047.1 10333.7 10476.1 10671.6 9872.2 10471.5 10517.1 10548.3 11025.6 10321.3 10376.2 10378.6 10432.9 10762.2 7368.1 7425.3 7546.7 7636.4 7746.7 10133.4 10165.1 10235.7 10237.2 10346.9 05:30:05 INFO - PROCESS | 10656 | 05:30:05 INFO - PROCESS | 10656 | [#3] mootools.html Cycles:180 Average:4905.87 Median:5208.27 stddev:2716.20 (52.2%) stddev-sans-first:2710.89 05:30:05 INFO - PROCESS | 10656 | Values: 1379.2 1400.3 1478.3 1627.7 1659.0 6472.5 7114.6 7222.9 7616.4 7619.3 7394.4 7397.9 7536.9 7558.9 7564.0 2130.8 2159.2 2163.4 2163.8 2170.1 2072.5 2121.8 2184.1 2189.7 2190.8 2115.4 2116.2 2122.4 2134.7 2179.7 2101.4 2119.3 2122.4 2125.9 2131.1 2080.1 2101.2 2108.1 2118.2 2131.5 7571.9 7633.4 7659.4 7669.9 7676.0 4332.2 4398.2 4430.5 4434.2 4465.0 2694.8 2808.7 2853.3 2856.8 2859.7 834.2 850.0 864.6 865.7 871.0 9833.2 9879.0 9900.7 9921.8 9940.9 3990.8 4053.5 4101.5 4125.7 4133.4 8523.2 8564.1 8575.9 8600.3 8610.3 4364.9 4442.4 4454.3 4488.4 4495.7 3529.6 4028.6 4049.1 4068.1 4158.7 3499.6 3509.1 3550.4 3587.9 3636.9 1132.1 1141.3 1155.8 1157.9 1165.3 836.7 837.2 852.1 862.1 869.3 4974.7 4979.9 5035.2 5044.6 5074.4 400.4 404.6 409.1 414.1 414.2 3350.3 3379.4 3537.7 3546.3 3547.8 8628.6 8957.3 9024.0 9080.2 9239.7 9079.0 9102.0 9114.5 9124.5 9134.0 6919.5 6989.0 7021.9 7032.8 7038.8 5141.3 5275.3 5351.9 5438.4 5459.9 8435.0 8473.9 8513.7 8519.4 8592.8 8036.6 8405.3 8424.5 8572.5 8677.1 5684.2 6337.5 6454.3 6515.3 6600.3 7104.3 7152.5 7202.9 7206.7 7244.9 6402.5 6559.3 6611.2 6616.9 6698.6 6487.6 6494.1 6509.3 6596.0 6616.3 5830.5 5834.2 5869.4 5877.8 5898.3 4174.1 4287.5 4305.7 4358.2 4382.3 4236.6 4398.5 4458.9 4501.1 4579.3 05:30:05 INFO - PROCESS | 10656 | 05:30:05 INFO - PROCESS | 10656 | [#4] prototype.html Cycles:180 Average:4308.84 Median:4859.17 stddev:1281.87 (26.4%) stddev-sans-first:1249.39 05:30:05 INFO - PROCESS | 10656 | Values: 285.7 290.4 295.3 298.8 302.1 4924.1 4998.5 5073.8 5138.7 5157.2 5041.0 5054.5 5071.9 5082.8 5093.9 3970.2 3992.2 3994.9 4004.1 4015.7 3944.6 3985.2 4005.5 4020.5 4036.6 3912.4 3934.3 3951.8 3961.0 3974.2 3924.9 3929.0 3948.0 3970.9 3974.5 3482.4 3485.0 3494.2 3501.6 3502.6 4846.3 4919.7 4941.5 4968.8 4987.9 4448.4 4470.0 4470.1 4497.0 4501.3 5209.4 5266.7 5297.6 5299.0 5302.8 3464.6 3661.3 3666.9 3758.6 3785.3 5524.9 5527.3 5545.7 5547.6 5577.6 3730.3 3746.2 3751.8 3779.5 3788.5 3559.6 3770.9 3771.8 3791.5 3800.3 4312.4 4324.5 4380.1 4392.9 4394.3 5274.6 5309.7 5316.3 5327.5 5332.5 1229.7 1274.7 1306.5 1310.6 1330.5 818.4 827.9 842.7 850.0 850.2 4136.9 4190.3 4202.4 4221.5 4234.4 4820.8 4826.7 4830.8 4872.0 4882.8 4125.4 4133.5 4166.0 4167.0 4171.6 2481.6 2528.3 2586.3 2589.6 2608.9 4486.6 4533.6 4563.7 4609.5 4631.5 4967.4 4973.9 4976.4 4978.5 4980.3 4577.7 4792.9 5158.0 5161.1 5196.2 5500.8 5543.1 5548.3 5572.3 5584.4 5214.6 5422.8 5430.2 5440.3 5459.6 5146.6 5162.5 5181.3 5188.0 5205.4 3773.7 3810.1 3833.6 3845.1 3858.6 4896.6 5536.2 5551.3 5551.9 5576.0 5314.4 5316.9 5347.4 5356.4 5370.8 5265.1 5322.5 5350.8 5366.4 5398.8 5109.9 5160.5 5230.2 5246.3 5251.5 5298.8 5324.2 5328.2 5334.3 5380.3 5236.5 5248.2 5260.3 5279.3 5288.2 05:30:05 INFO - PROCESS | 10656 | 05:30:05 INFO - PROCESS | 10656 | [#5] yui.html Cycles:180 Average:16460.13 Median:599.80 stddev:22536.36 (3757.3%) stddev-sans-first:22568.30 05:30:05 INFO - PROCESS | 10656 | Values: 647.8 675.4 706.6 711.1 728.5 12503.0 12788.7 12846.8 12920.9 12952.2 13786.3 14322.1 14344.2 14380.4 14994.2 628.1 796.9 799.6 802.8 804.2 765.4 794.2 798.9 798.9 803.9 827.1 827.2 828.1 828.7 829.4 819.6 823.7 823.9 824.0 827.3 600.2 602.3 602.9 604.4 608.1 13425.3 13475.7 13503.6 13569.5 13593.9 12375.9 13316.5 13937.2 14084.2 14152.6 10697.2 10841.7 10846.8 10952.0 11073.4 3137.4 3186.8 3190.1 3209.3 3223.5 61533.4 62239.4 63153.4 63934.0 64068.4 10239.6 10474.7 10566.2 10659.1 10685.1 18493.9 19135.3 19206.2 19310.2 19873.8 7137.8 7233.3 7256.8 7275.7 7308.9 3574.3 3593.5 3634.5 3653.6 3670.5 2819.7 2919.7 2931.4 2932.2 2938.8 496.9 510.5 514.0 514.4 516.3 559.3 581.0 584.0 588.7 599.4 8192.8 8953.0 9003.7 9009.2 9449.4 611.7 612.4 614.2 630.3 635.4 3647.3 3799.2 3824.6 3856.5 3929.1 54928.5 55078.0 55241.4 88922.6 91380.0 75177.0 76021.2 78507.6 78954.2 81290.6 69934.3 70846.0 71014.6 71221.0 71402.3 7457.0 7546.6 7692.4 7695.1 7908.9 37463.4 43026.6 43173.6 43224.4 44284.3 57504.0 61544.7 61619.5 61840.0 61881.7 9915.6 9917.5 10299.7 10417.5 10573.9 11325.4 11451.1 11503.9 11805.9 11999.1 9992.8 10347.1 10390.1 10572.2 10754.0 10359.9 10520.9 10592.8 10648.6 10661.9 9643.4 9745.3 9829.7 9943.9 9953.4 8009.3 8626.3 8738.3 8752.3 9062.5 8453.2 8525.2 8668.6 9048.3 9134.8 05:30:05 INFO - PROCESS | 10656 | -------- Summary: end -------- 05:30:05 INFO - PROCESS | 10656 | 05:30:06 INFO - TEST-INFO | 10656: exit 0 05:30:06 INFO - TEST-OK | dromaeo_css | took 1115724ms 05:30:06 INFO - TEST-START | kraken 05:30:06 INFO - operating with platform_type : linux_ 05:30:06 INFO - Initialising browser for kraken test... 05:30:06 INFO - TEST-INFO | started process 10899 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp22Ipfz/profile http://localhost:50465/getInfo.html) 05:30:11 INFO - PROCESS | 10899 | __metrics Screen width/height:1600/1200 05:30:11 INFO - PROCESS | 10899 | colorDepth:24 05:30:11 INFO - PROCESS | 10899 | Browser inner width/height: 1024/697 05:30:11 INFO - PROCESS | 10899 | __metrics 05:30:12 ERROR - PROCESS | 10899 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 05:30:13 INFO - TEST-INFO | 10899: exit 0 05:30:13 INFO - Browser initialized. 05:30:13 INFO - Running cycle 1/1 for kraken test... 05:30:13 INFO - TEST-INFO | started process 11017 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp22Ipfz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:30:25 INFO - PROCESS | 11017 | RSS: Main: 185253888 05:30:25 INFO - PROCESS | 11017 | 05:30:27 INFO - PROCESS | 11017 | Cycle 1(1): loaded http://localhost:50465/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50465/tests/kraken/driver.html?testName=audio-beat-detection) 05:30:28 INFO - PROCESS | 11017 | RSS: Main: 190103552 05:30:28 INFO - PROCESS | 11017 | 05:30:31 INFO - PROCESS | 11017 | Cycle 1(1): loaded http://localhost:50465/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50465/tests/kraken/driver.html?testName=audio-dft) 05:30:32 INFO - PROCESS | 11017 | RSS: Main: 189542400 05:30:32 INFO - PROCESS | 11017 | 05:30:35 INFO - PROCESS | 11017 | Cycle 1(1): loaded http://localhost:50465/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50465/tests/kraken/driver.html?testName=audio-fft) 05:30:36 INFO - PROCESS | 11017 | RSS: Main: 185176064 05:30:36 INFO - PROCESS | 11017 | 05:30:38 INFO - PROCESS | 11017 | Cycle 1(1): loaded http://localhost:50465/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50465/tests/kraken/driver.html?testName=audio-oscillator) 05:30:38 INFO - PROCESS | 11017 | RSS: Main: 185815040 05:30:38 INFO - PROCESS | 11017 | 05:30:41 INFO - PROCESS | 11017 | Cycle 1(1): loaded http://localhost:50465/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50465/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:30:41 INFO - PROCESS | 11017 | RSS: Main: 186195968 05:30:41 INFO - PROCESS | 11017 | 05:30:44 INFO - PROCESS | 11017 | Cycle 1(1): loaded http://localhost:50465/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50465/tests/kraken/driver.html?testName=imaging-darkroom) 05:30:45 INFO - PROCESS | 11017 | RSS: Main: 186265600 05:30:45 INFO - PROCESS | 11017 | 05:30:49 INFO - PROCESS | 11017 | Cycle 1(1): loaded http://localhost:50465/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50465/tests/kraken/driver.html?testName=imaging-desaturate) 05:30:49 INFO - PROCESS | 11017 | RSS: Main: 184033280 05:30:49 INFO - PROCESS | 11017 | 05:30:52 INFO - PROCESS | 11017 | Cycle 1(1): loaded http://localhost:50465/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50465/tests/kraken/driver.html?testName=json-parse-financial) 05:30:53 INFO - PROCESS | 11017 | RSS: Main: 185102336 05:30:53 INFO - PROCESS | 11017 | 05:30:55 INFO - PROCESS | 11017 | Cycle 1(1): loaded http://localhost:50465/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50465/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:30:55 INFO - PROCESS | 11017 | RSS: Main: 185237504 05:30:55 INFO - PROCESS | 11017 | 05:30:57 INFO - PROCESS | 11017 | Cycle 1(1): loaded http://localhost:50465/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50465/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:30:58 INFO - PROCESS | 11017 | RSS: Main: 185573376 05:30:58 INFO - PROCESS | 11017 | 05:31:00 INFO - PROCESS | 11017 | Cycle 1(1): loaded http://localhost:50465/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50465/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:31:01 INFO - PROCESS | 11017 | RSS: Main: 185880576 05:31:01 INFO - PROCESS | 11017 | 05:31:03 INFO - PROCESS | 11017 | Cycle 1(1): loaded http://localhost:50465/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50465/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:31:04 INFO - PROCESS | 11017 | RSS: Main: 185978880 05:31:04 INFO - PROCESS | 11017 | 05:31:07 INFO - PROCESS | 11017 | Cycle 1(1): loaded http://localhost:50465/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50465/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:31:08 INFO - PROCESS | 11017 | RSS: Main: 185815040 05:31:08 INFO - PROCESS | 11017 | 05:31:09 INFO - PROCESS | 11017 | Cycle 1(1): loaded http://localhost:50465/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50465/tests/kraken/driver.html?testName=ai-astar) 05:31:10 INFO - PROCESS | 11017 | RSS: Main: 186531840 05:31:10 INFO - PROCESS | 11017 | 05:31:10 INFO - PROCESS | 11017 | __start_tp_report 05:31:10 INFO - PROCESS | 11017 | _x_x_mozilla_page_load 05:31:10 INFO - PROCESS | 11017 | _x_x_mozilla_page_load_details 05:31:10 INFO - PROCESS | 11017 | |i|pagename|runs| 05:31:10 INFO - PROCESS | 11017 | |0;ai-astar;114;107;117;115;114;113;118;113;114;115 05:31:10 INFO - PROCESS | 11017 | |1;audio-beat-detection;161;130;169;184;141;157;156;138;192;131 05:31:10 INFO - PROCESS | 11017 | |2;audio-dft;163;167;175;166;162;163;164;162;163;162 05:31:10 INFO - PROCESS | 11017 | |3;audio-fft;78;78;77;161;76;76;76;77;160;79 05:31:10 INFO - PROCESS | 11017 | |4;audio-oscillator;87;88;138;86;87;88;132;87;87;148 05:31:10 INFO - PROCESS | 11017 | |5;imaging-gaussian-blur;118;118;117;118;117;118;118;118;118;119 05:31:10 INFO - PROCESS | 11017 | |6;imaging-darkroom;150;150;149;150;149;149;148;149;150;148 05:31:10 INFO - PROCESS | 11017 | |7;imaging-desaturate;96;97;95;95;95;95;95;95;95;96 05:31:10 INFO - PROCESS | 11017 | |8;json-parse-financial;66;65;65;64;65;65;66;65;64;65 05:31:10 INFO - PROCESS | 11017 | |9;json-stringify-tinderbox;66;64;64;64;72;64;64;65;65;65 05:31:10 INFO - PROCESS | 11017 | |10;stanford-crypto-aes;92;84;84;86;86;86;87;86;110;86 05:31:10 INFO - PROCESS | 11017 | |11;stanford-crypto-ccm;142;153;145;141;147;130;134;148;138;156 05:31:10 INFO - PROCESS | 11017 | |12;stanford-crypto-pbkdf2;171;176;175;174;169;167;168;178;172;168 05:31:10 INFO - PROCESS | 11017 | |13;stanford-crypto-sha256-iterative;67;69;66;67;70;70;69;69;67;67 05:31:10 INFO - PROCESS | 11017 | __end_tp_report 05:31:10 INFO - PROCESS | 11017 | __start_cc_report 05:31:10 INFO - PROCESS | 11017 | _x_x_mozilla_cycle_collect,979 05:31:10 INFO - PROCESS | 11017 | __end_cc_report 05:31:10 INFO - PROCESS | 11017 | __startTimestamp1465475470198__endTimestamp 05:31:10 INFO - PROCESS | 11017 | 05:31:10 INFO - PROCESS | 11017 | ------- Summary: start ------- 05:31:10 INFO - PROCESS | 11017 | Number of tests: 14 05:31:10 INFO - PROCESS | 11017 | 05:31:10 INFO - PROCESS | 11017 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.50 stddev:2.94 (2.6%) stddev-sans-first:3.12 05:31:10 INFO - PROCESS | 11017 | Values: 114.0 107.0 117.0 115.0 114.0 113.0 118.0 113.0 114.0 115.0 05:31:10 INFO - PROCESS | 11017 | 05:31:10 INFO - PROCESS | 11017 | [#1] audio-beat-detection Cycles:10 Average:155.90 Median:159.00 stddev:21.41 (13.5%) stddev-sans-first:22.63 05:31:10 INFO - PROCESS | 11017 | Values: 161.0 130.0 169.0 184.0 141.0 157.0 156.0 138.0 192.0 131.0 05:31:10 INFO - PROCESS | 11017 | 05:31:10 INFO - PROCESS | 11017 | [#2] audio-dft Cycles:10 Average:164.70 Median:163.50 stddev:4.00 (2.4%) stddev-sans-first:4.20 05:31:10 INFO - PROCESS | 11017 | Values: 163.0 167.0 175.0 166.0 162.0 163.0 164.0 162.0 163.0 162.0 05:31:10 INFO - PROCESS | 11017 | 05:31:10 INFO - PROCESS | 11017 | [#3] audio-fft Cycles:10 Average:93.80 Median:77.00 stddev:35.17 (45.7%) stddev-sans-first:36.83 05:31:10 INFO - PROCESS | 11017 | Values: 78.0 78.0 77.0 161.0 76.0 76.0 76.0 77.0 160.0 79.0 05:31:10 INFO - PROCESS | 11017 | 05:31:10 INFO - PROCESS | 11017 | [#4] audio-oscillator Cycles:10 Average:102.80 Median:87.00 stddev:25.50 (29.3%) stddev-sans-first:26.40 05:31:10 INFO - PROCESS | 11017 | Values: 87.0 88.0 138.0 86.0 87.0 88.0 132.0 87.0 87.0 148.0 05:31:10 INFO - PROCESS | 11017 | 05:31:10 INFO - PROCESS | 11017 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 05:31:10 INFO - PROCESS | 11017 | Values: 118.0 118.0 117.0 118.0 117.0 118.0 118.0 118.0 118.0 119.0 05:31:10 INFO - PROCESS | 11017 | 05:31:10 INFO - PROCESS | 11017 | [#6] imaging-darkroom Cycles:10 Average:149.20 Median:149.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 05:31:10 INFO - PROCESS | 11017 | Values: 150.0 150.0 149.0 150.0 149.0 149.0 148.0 149.0 150.0 148.0 05:31:10 INFO - PROCESS | 11017 | 05:31:10 INFO - PROCESS | 11017 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 05:31:10 INFO - PROCESS | 11017 | Values: 96.0 97.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 05:31:10 INFO - PROCESS | 11017 | 05:31:10 INFO - PROCESS | 11017 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 05:31:10 INFO - PROCESS | 11017 | Values: 66.0 65.0 65.0 64.0 65.0 65.0 66.0 65.0 64.0 65.0 05:31:10 INFO - PROCESS | 11017 | 05:31:10 INFO - PROCESS | 11017 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.00 stddev:2.45 (3.8%) stddev-sans-first:2.59 05:31:10 INFO - PROCESS | 11017 | Values: 66.0 64.0 64.0 64.0 72.0 64.0 64.0 65.0 65.0 65.0 05:31:10 INFO - PROCESS | 11017 | 05:31:10 INFO - PROCESS | 11017 | [#10] stanford-crypto-aes Cycles:10 Average:88.70 Median:86.00 stddev:7.80 (9.1%) stddev-sans-first:8.19 05:31:10 INFO - PROCESS | 11017 | Values: 92.0 84.0 84.0 86.0 86.0 86.0 87.0 86.0 110.0 86.0 05:31:10 INFO - PROCESS | 11017 | 05:31:10 INFO - PROCESS | 11017 | [#11] stanford-crypto-ccm Cycles:10 Average:143.40 Median:146.00 stddev:8.11 (5.6%) stddev-sans-first:8.59 05:31:10 INFO - PROCESS | 11017 | Values: 142.0 153.0 145.0 141.0 147.0 130.0 134.0 148.0 138.0 156.0 05:31:10 INFO - PROCESS | 11017 | 05:31:10 INFO - PROCESS | 11017 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.80 Median:173.00 stddev:3.82 (2.2%) stddev-sans-first:4.04 05:31:10 INFO - PROCESS | 11017 | Values: 171.0 176.0 175.0 174.0 169.0 167.0 168.0 178.0 172.0 168.0 05:31:10 INFO - PROCESS | 11017 | 05:31:10 INFO - PROCESS | 11017 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:69.00 stddev:1.45 (2.1%) stddev-sans-first:1.48 05:31:10 INFO - PROCESS | 11017 | Values: 67.0 69.0 66.0 67.0 70.0 70.0 69.0 69.0 67.0 67.0 05:31:10 INFO - PROCESS | 11017 | -------- Summary: end -------- 05:31:10 INFO - PROCESS | 11017 | 05:31:11 INFO - TEST-INFO | 11017: exit 0 05:31:11 INFO - TEST-OK | kraken | took 64681ms 05:31:11 INFO - SUITE-END | took 1180s 05:31:11 INFO - Completed test suite (00:19:40) 05:31:11 INFO - javascript benchmark 05:31:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6284.874636872317, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2558.0790915270504, 2624.8556329401877, 2629.4609605030964, 2645.86770661467, 2647.9338016549573, 4722.834700785469, 4736.597389221916, 4752.144613969484, 4857.028594281149, 4912.705237685741, 4624.699394539352, 4761.214399624067, 4784.5693887550115, 4805.47139814621, 4821.4937431569615, 4384.430024096863, 4412.955870441303, 4511.954880451202, 4533.523979982104, 4539.114872599845, 4201.516825565069, 4479.955200448003, 4496.415465989417, 4571.817127314904, 4576.4737055238575, 4263.424437700902, 4307.978460107711, 4392.692511524195, 4394.165108629382, 4448.466184057917, 4281.250781113324, 4301.956980430218, 4327.502337231227, 4351.0, 4369.060651959812, 4295.570442955711, 4302.204092242914, 4307.633851122659, 4320.632746216544, 4372.27857403528, 4724.7401392923375, 4780.020095880371, 4791.928121078186, 4812.25410061441, 4844.612431005547, 5142.151544995071, 5149.485051494858, 5166.147585648364, 5179.896402071975, 5231.843044708665, 5059.797608095671, 5116.692998420107, 5185.222216667492, 5211.062008838408, 5214.556762675139, 4797.280407938767, 4802.279658051285, 4805.8558243252755, 4828.227483602677, 4844.176489996674, 5216.817411390583, 5230.032443997872, 5259.39516955555, 5264.0, 5288.550473209821, 5026.271190677405, 5026.447090820006, 5035.194368900959, 5055.9241611375855, 5071.39143302806, 4957.429895562056, 5139.563137133311, 5149.098907691139, 5151.5878729701535, 5174.09453345663, 5042.168042273057, 5098.08234517783, 5098.5411312982005, 5108.872278193001, 5123.641345105882, 4919.163742163841, 5060.5698515625845, 5063.8480845574695, 5079.339685840817, 5123.821521050105, 4439.66702497314, 4444.977775111104, 4448.866534003921, 4455.331700244989, 4465.285554311295, 3821.675157611634, 3860.4402361657963, 3867.7485963412287, 3885.7668539887695, 3891.8248678809523, 4285.121550082225, 4427.46870375557, 4501.819927202875, 4512.435945506812, 4519.141363141059, 5167.276581278624, 5227.738613069331, 5235.842924712265, 5240.868978275574, 5288.365396152486, 4404.053128577371, 4449.777511124431, 4487.842925497592, 4495.910081798411, 4541.182587134347, 4616.307553866947, 4621.838235661736, 4629.629629629621, 4663.976680116578, 4681.344611754357, 4818.277258411266, 4835.879103022453, 4844.467108617979, 4848.0546293472435, 4908.828191013369, 5013.774380152829, 5165.302684137593, 5166.638335316642, 5171.456997015259, 5219.929914367622, 4867.002264535691, 4868.95131048685, 4873.731944743073, 4895.33912921751, 4941.629377796751, 5133.204353325241, 5134.589232861287, 5137.845864624067, 5145.279660847409, 5197.610179236497, 5120.769565369493, 5161.483851614808, 5164.018836421068, 5176.4047134578495, 5184.922226166535, 4872.561469467765, 4970.3290055843445, 5003.874903127451, 5031.547160755549, 5037.949620503748, 5050.292958985671, 5058.64589478733, 5073.44192138857, 5088.872778180427, 5119.616028797929, 4836.081144582518, 4923.876903077452, 4925.48282430354, 4985.102681517216, 4993.750312484289, 5069.417017043087, 5097.974510127426, 5104.846854594368, 5117.1300878851425, 5126.923096153635, 4936.802527898843, 5008.098542262428, 5008.949910500848, 5011.523905228997, 5014.623903207347], "value": 4724.78388832536, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.401722898191, 569.075252714339, 576.0437673462053, 593.3502814418212, 614.4807637546278, 35914.64085359146, 37131.443028354595, 40539.98650033747, 40546.189076218456, 40743.18513629726, 41693.79153104238, 42080.737577872635, 42312.365314520306, 42320.0, 42591.36112958308, 7852.725154619575, 7951.125376208613, 8015.639296231654, 8037.5579343136105, 8044.115147333789, 7954.5227286362715, 8022.839543209132, 8034.0, 8036.316913062367, 8046.959765201166, 7990.2009799019925, 8039.236272554127, 8042.557659328734, 8045.195480451966, 8051.355891528693, 7926.841463170762, 7935.880961785578, 7953.12515623281, 7970.681172753083, 7988.640511177011, 7841.647125879292, 7879.133295337509, 7879.606019699049, 7933.246341597539, 7975.401844861659, 31170.220744481343, 39182.21635567301, 39452.21095578073, 39493.40759888604, 39594.604053959665, 3024.077656314823, 3060.173753086654, 3105.6583775784648, 3143.135637699628, 3170.1599076244815, 28163.718362816315, 28433.85783071092, 28812.42375152506, 28893.56659650107, 29152.125436236947, 3112.9688703112906, 3114.1280441476424, 3137.137287246003, 3140.5289206618963, 3168.8574014169185, 98737.5063124687, 98922.0, 99243.50378248135, 99492.0, 99980.50009749977, 33110.50334244988, 33278.334433311196, 33311.16722081919, 33337.66662333394, 33342.66657333444, 30426.391472170875, 32853.67146328506, 33982.32035359279, 34161.487577686356, 34215.4867676985, 13816.171029738047, 14061.78907316391, 14094.647633809236, 14112.153270803785, 14170.858291416955, 11386.544538218544, 11541.365224912543, 11601.477933493014, 11644.475998580085, 11715.238509496856, 7840.803979900434, 7854.921450785533, 7890.132085470594, 7924.564148971746, 7933.404994625426, 3101.395227930577, 3123.7188653021335, 3157.636871759731, 3183.0609970058426, 3184.3312904289896, 882.8366752150744, 921.1847514949318, 930.3627015494408, 931.6133804471204, 1045.132539991805, 28326.858365708038, 28727.569086463718, 29011.274718132216, 29309.56035659467, 29562.260943476584, 931.8043210925781, 1003.4581326083979, 1021.1830535571513, 1027.275770581738, 1085.5060947268973, 14860.068191135299, 15204.923975380052, 15215.467458638894, 15423.768643470357, 15552.377904883904, 391154.0, 394531.0, 396287.0, 397668.0, 398333.0, 50024.24963625549, 50133.24800128001, 50628.0, 50681.493185068415, 50772.0, 1173.3194747046693, 1189.2983139947473, 1198.4427241332821, 1228.5735672047635, 1230.8215308780177, 27214.0, 27744.94805571426, 28384.85807570949, 28475.715242847305, 28812.279693007844, 42674.57325426706, 43691.34462983121, 43964.120717586105, 44114.779426103945, 44118.0, 333500.0, 335102.0, 335127.0, 337163.0, 337459.0, 25761.355966100997, 26062.60906086448, 26300.342491437867, 26462.470750585264, 26717.732822671525, 43240.56759432366, 43356.0, 43675.78162109169, 44252.557474424844, 44736.0, 36812.815935920145, 37360.43959340666, 37971.62028379681, 38006.23987520179, 38390.616093839824, 36246.26965723028, 37202.44196337003, 37285.0, 37461.250774984896, 37559.81220093882, 35959.0, 35994.64005359913, 36307.0, 36601.0, 36993.63006369902, 32622.673773261962, 33204.83397582997, 33429.331413372085, 33556.0, 33621.0, 25258.836397417115, 25876.482470350864, 25979.22062338133, 26040.479190416463, 26048.34879128037], "value": 16139.173215760651, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.37306475279746, 347.28805947806995, 358.3031004695866, 376.5707093912938, 376.7588743204348, 15705.842941570596, 16600.58498537537, 17401.390951316705, 17405.738913916302, 17443.0, 15351.309191086428, 15973.760393594077, 16648.08435536045, 16664.75002874958, 16690.58273543162, 4991.825286114996, 5099.59203263738, 5193.143131383336, 5195.532402083812, 5195.584353251731, 3583.9283214335696, 5053.974730126344, 5529.419410961851, 5894.528437724972, 5906.3798301178185, 5976.970115149418, 6002.129691194774, 6015.0, 6045.123457098718, 6091.878162436748, 5779.2775903012125, 5958.702064896781, 5980.10298455233, 5992.161097446361, 5999.070144127667, 5015.974920125413, 5138.075146473633, 5142.4600416956055, 5177.404598471187, 5203.531682148587, 20189.899050504653, 20461.283855065, 20570.28004019867, 20693.68959465609, 20815.791842081537, 1888.1125870840683, 1999.9000049997442, 2038.6738121900573, 2100.222917520512, 2416.492536567323, 13285.070045096847, 13303.201807891557, 13420.127691700009, 13548.254845983467, 13767.449302027906, 1718.9656206875918, 1746.9912650436665, 1755.6839768841603, 1778.5020194345605, 1778.6887294723501, 45055.54944450579, 66265.3373466264, 67089.66455167693, 67746.66126669335, 68534.9719754209, 9129.360944733939, 9372.67195648149, 9382.0, 9556.426614403159, 9686.982866798884, 13079.542216022393, 13150.145240559334, 13159.868401316056, 13210.73578528424, 13221.93389033068, 6958.686859091353, 7059.964700176466, 7124.964375178091, 7157.0, 7369.410447164214, 6725.686387529936, 6889.862202756017, 6907.896381554281, 7045.260247674023, 7049.92950070503, 5983.730732117066, 5993.61041532299, 6032.758689652453, 6045.516358691294, 6070.726817293233, 1515.0076699761673, 1590.403598650506, 1713.3746182643245, 1734.4103004978367, 1740.25169177255, 912.2337236721186, 927.9699533517789, 941.1247539787926, 992.771662517625, 1020.974475638115, 16404.507864764077, 16969.0667013313, 17107.81565512504, 17355.652886942444, 17465.38871139504, 875.1030194051021, 900.2527901841456, 909.8726178335038, 920.0661328751323, 955.9808803824023, 9734.805303893883, 9981.900180998242, 9988.400695958266, 10108.444035577966, 10128.088472037552, 375544.0, 375773.0, 384627.0, 393263.0, 396396.0, 65931.0, 66362.33637663658, 67428.6628566854, 67757.0, 68148.0, 938.7230766923774, 954.7040417470606, 955.3885513271512, 973.6105557776946, 975.5268694683073, 15439.228038597801, 15509.5347139586, 15540.378384864931, 15676.608084797972, 15734.134622595868, 33538.0, 33961.150971225914, 34036.61743677919, 34083.31833363269, 34645.13387165341, 44319.33520997123, 44618.53814618512, 44683.77658111689, 44706.55293447024, 44739.55260447484, 7340.0, 7452.888206676796, 7456.105267367951, 7681.500702454323, 7709.036370453693, 11914.821277681016, 11956.701082473008, 12089.81865272004, 12190.08574356909, 12194.573189938665, 9999.450030248116, 10047.14599259042, 10333.689989300334, 10476.109530689977, 10671.626493072705, 9872.173647875166, 10471.476426178813, 10517.106045986176, 10548.314359566604, 11025.61410350634, 10321.296985997527, 10376.221783366429, 10378.636747713794, 10432.947835260775, 10762.19283553721, 7368.078990126234, 7425.257474252531, 7546.735864244725, 7636.389088872988, 7746.728864489716, 10133.391996480235, 10165.085142337226, 10235.744106397102, 10237.232207584311, 10346.948265258625], "value": 8319.42343114362, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1379.2483096712294, 1400.3418393355123, 1478.3199728125062, 1627.6744651069773, 1658.9999999999993, 6472.51456140789, 7114.64426778661, 7222.927770722291, 7616.390688744894, 7619.276168763972, 7394.408447324215, 7397.852042959137, 7536.9246307536905, 7558.886616700754, 7564.0, 2130.80822725955, 2159.1795117855195, 2163.4266919266406, 2163.8485306028583, 2170.1102547955343, 2072.533679922013, 2121.8302535797097, 2184.0936011555186, 2189.6715492676067, 2190.8466407351493, 2115.4076858479575, 2116.153538584563, 2122.4375540481783, 2134.658454647257, 2179.727534058243, 2101.4116047506645, 2119.3430036688674, 2122.3632910127053, 2125.861818981761, 2131.11558703138, 2080.074366906727, 2101.2015434135083, 2108.135664377598, 2118.184498967893, 2131.4564785979633, 7571.924280757177, 7633.389328853678, 7659.425543084291, 7669.923300767033, 7675.961620191919, 4332.220200363933, 4398.208322501949, 4430.468343798765, 4434.201843668138, 4464.977675111603, 2694.7709444697225, 2808.7050859659644, 2853.329467575118, 2856.814307070034, 2859.6970499073605, 834.1758118318173, 849.9915000849974, 864.584999200381, 865.7013330401002, 871.0418539606445, 9833.213342932548, 9878.950605246999, 9900.702978910644, 9921.75195620108, 9940.850887236626, 3990.82041308136, 4053.4730485036757, 4101.52832424269, 4125.731827431207, 4133.359329303963, 8523.190296921783, 8564.100769419247, 8575.871361929576, 8600.311975041981, 8610.311175105977, 4364.912701745948, 4442.444694413199, 4454.26504626733, 4488.438945131858, 4495.685302028826, 3529.6293889141784, 4028.576999415019, 4049.1091959768805, 4068.06434520062, 4158.708890377645, 3499.562554680665, 3509.105178179599, 3550.3609350317192, 3587.946180807238, 3636.945445818315, 1132.1112926352773, 1141.2524796258465, 1155.8439610652454, 1157.890000449956, 1165.2552914133403, 836.690424542923, 837.2130197614345, 852.0882655558493, 862.0646598440637, 869.3262721390972, 4974.651774375831, 4979.875503112378, 5035.219540971156, 5044.621653376012, 5074.3657042869645, 400.4253895659738, 404.6398705152417, 409.11834995584564, 414.128260012675, 414.1551235479648, 3350.3466823969093, 3379.425497665403, 3537.6816086552335, 3546.2730140321687, 3547.7516573839584, 8628.611712472954, 8957.283417326598, 9024.0, 9080.182783549511, 9239.676611318571, 9079.046700096527, 9102.0, 9114.544272786334, 9124.45253284805, 9134.0, 6919.515633905679, 6988.965055174692, 7021.929780702332, 7032.789016329519, 7038.824029399306, 5141.251974328597, 5275.287836142072, 5351.866203344947, 5438.374586922555, 5459.863503412446, 8434.957825210835, 8473.915260847312, 8513.659453621785, 8519.403641745019, 8592.828143436971, 8036.598170091589, 8405.285550728257, 8424.452410593292, 8572.52851093196, 8677.132286771272, 5684.175794509691, 6337.4613157882095, 6454.322296158835, 6515.348465153636, 6600.339966003361, 7104.325089116525, 7152.463565232524, 7202.89195662076, 7206.747763828241, 7244.927550724636, 6402.455791257796, 6559.311272316338, 6611.173603299588, 6616.933830661632, 6698.631575263407, 6487.643179625166, 6494.058361537645, 6509.285113457054, 6596.0435736816935, 6616.338366163345, 5830.504407125272, 5834.241548598655, 5869.413058694096, 5877.823665290048, 5898.321693005188, 4174.123434078878, 4287.485501739811, 4305.677074219383, 4358.171947329997, 4382.320740285261, 4236.639885609758, 4398.494173169998, 4458.910821783481, 4501.054778496552, 4579.290210017452], "value": 3912.841575113402, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.687172546062, 290.4365530870112, 295.3001386713489, 298.76845444780304, 302.14794280130013, 4924.128831044207, 4998.450170481244, 5073.771680274387, 5138.743062846856, 5157.226416037596, 5040.974795126029, 5054.494550544944, 5071.949280507194, 5082.84751457456, 5093.898122037557, 3970.2258059678447, 3992.2215168042244, 3994.9001274968214, 4004.1391100913297, 4015.7389769665024, 3944.5858184890603, 3985.183037477325, 4005.459262999487, 4020.477337946063, 4036.596340365955, 3912.3740201567753, 3934.3311637021775, 3951.7826519541413, 3960.9801950990204, 3974.2250261198933, 3924.8626298079716, 3928.9803550982347, 3947.9999999999854, 3970.861019864291, 3974.503187101612, 3482.355764183634, 3484.9651503484893, 3494.1963348430004, 3501.5973163086314, 3502.614712381636, 4846.345743324641, 4919.720872573121, 4941.48114447985, 4968.7515624219, 4987.875303117415, 4448.377227188196, 4469.955300447019, 4470.061287129706, 4496.977515112436, 4501.257292546726, 5209.400918894337, 5266.7366631668265, 5297.576193904479, 5298.97350513245, 5302.761375738101, 3464.6362131976284, 3661.304352173105, 3666.8899933002053, 3758.605346438612, 3785.2807966486553, 5524.861878453071, 5527.281453411071, 5545.72271386429, 5547.611667183299, 5577.581681373873, 3730.309892669865, 3746.175841314961, 3751.7748935063983, 3779.488204718135, 3788.450674652215, 3559.5906470755676, 3770.9434358484646, 3771.830267637963, 3791.545014598266, 3800.3349413852466, 4312.417823593837, 4324.459442569679, 4380.145871555016, 4392.890177745582, 4394.340848872695, 5274.630775845654, 5309.7079660618265, 5316.308879845673, 5327.520523152934, 5332.466753324637, 1229.7294595189044, 1274.6558429224058, 1306.45129045801, 1310.606817954629, 1330.534312990465, 818.423011776696, 827.896512935883, 842.6629348260623, 849.9830003400021, 850.2347886901838, 4136.875893723133, 4190.281984386387, 4202.411662367271, 4221.517248270128, 4234.407182994383, 4820.807167713252, 4826.710397376169, 4830.758462076882, 4872.0, 4882.804687812519, 4125.422440858282, 4133.483314585676, 4165.958340416618, 4167.0, 4171.623364289777, 2481.5533204023086, 2528.331783266148, 2586.275842764029, 2589.611558266275, 2608.8695565221665, 4486.641068714495, 4533.591976722111, 4563.680542362069, 4609.496782445366, 4631.513691062457, 4967.379077615298, 4973.90052198954, 4976.377952755905, 4978.477259887732, 4980.2778597103215, 4577.679562430664, 4792.880177995508, 5158.0, 5161.122609156452, 5196.220566914993, 5500.779968801203, 5543.1408131739645, 5548.306461692288, 5572.3034620672415, 5584.357798853184, 5214.634975551675, 5422.8373148805595, 5430.212619170277, 5440.347158340866, 5459.617826752089, 5146.588272938081, 5162.457941916195, 5181.326427564392, 5188.0, 5205.40137884133, 3773.698104151716, 3810.142717888453, 3833.616638336144, 3845.115623406576, 3858.6141385861188, 4896.632752543503, 5536.169574563848, 5551.278333816578, 5551.944480555143, 5575.972120139373, 5314.362276526842, 5316.867078323073, 5347.358317001985, 5356.410794812489, 5370.838874833761, 5265.104562357625, 5322.536302516839, 5350.785968561214, 5366.409694933476, 5398.811041613525, 5109.948900511096, 5160.48395160496, 5230.215467679878, 5246.344206974129, 5251.474852514718, 5298.841034768963, 5324.227986941949, 5328.17413300939, 5334.333208348957, 5380.273663055594, 5236.528712415901, 5248.212768084665, 5260.2898608688865, 5279.340082489689, 5288.233206185005], "value": 3894.0368180015444, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.7635662983013, 675.4495086504498, 706.6431452116686, 711.118213415365, 728.5155371677835, 12503.0, 12788.744225115492, 12846.807297890527, 12920.935395323022, 12952.15810972286, 13786.310684465787, 14322.140671559713, 14344.211068391234, 14380.424783008693, 14994.175320357403, 628.0955424189153, 796.8645330293864, 799.588212070784, 802.8273921106961, 804.2319584796505, 765.4182821055982, 794.2295972906271, 798.8841617965392, 798.9041315042203, 803.9236272554098, 827.0819390476596, 827.1563005734178, 828.0849661124461, 828.7265202483167, 829.3572481326989, 819.5697258939045, 823.7240524424295, 823.9052508961486, 824.0482243009304, 827.2720006394395, 600.1717629671026, 602.3314121325326, 602.8944934636465, 604.3805099772724, 608.1364462463313, 13425.261610611413, 13475.66310842227, 13503.59489215325, 13569.52506662262, 13593.932030339884, 12375.938120309342, 13316.533921312708, 13937.233452160228, 14084.225367604779, 14152.646183845383, 10697.197710171768, 10841.67474975752, 10846.837297440545, 10952.0, 11073.390963497004, 3137.372525494887, 3186.808791472496, 3190.090824115116, 3209.277912469676, 3223.4520131577688, 61533.384666153215, 62239.37760622426, 63153.36846631521, 63934.0, 64068.359316406706, 10239.641612543524, 10474.68575942723, 10566.154707623371, 10659.147268218523, 10685.145188385066, 18493.90753046226, 19135.330263440712, 19206.231750729814, 19310.227590896207, 19873.801261987483, 7137.821554461076, 7233.348998590152, 7256.818579535554, 7275.67259473325, 7308.926910730825, 3574.338747331752, 3593.4789455528803, 3634.5009026572775, 3653.6081244314687, 3670.522832031872, 2819.675737290238, 2919.7080291971056, 2931.4430258250864, 2932.1643331650375, 2938.8236705797294, 496.91055609989826, 510.54561440318145, 513.9768710408041, 514.3724655919847, 516.302990962198, 559.3260121553518, 580.9970950145222, 584.030509354478, 588.7200055595795, 599.4365296621162, 8192.795180120545, 8952.955235223782, 9003.684871029482, 9009.189172974333, 9449.385789923634, 611.7094380169384, 612.3631423319698, 614.2107392001257, 630.2909227119491, 635.3805040085972, 3647.2887786881834, 3799.2021675448464, 3824.6366595173413, 3856.5179352580926, 3929.057026313664, 54928.450715492334, 55078.0, 55241.44758552443, 88922.55538722394, 91380.0, 75177.0, 76021.23978760252, 78507.60746196233, 78954.21045789469, 81290.59354703188, 69934.30065699278, 70846.0, 71014.64492677606, 71221.0, 71402.28597713956, 7456.96271518639, 7546.622668866425, 7692.38454928772, 7695.115061767969, 7908.8813667793875, 37463.43804842875, 43026.569734303506, 43173.56826431696, 43224.35163472487, 44284.33573496336, 57504.0, 61544.69227653833, 61619.45424911779, 61840.0, 61881.69059154675, 9915.603375864885, 9917.504124793588, 10299.7425064371, 10417.531211095671, 10573.8942610576, 11325.377104259016, 11451.141164412536, 11503.942480287546, 11805.881941180478, 11999.100067494799, 9992.750181245236, 10347.120494757728, 10390.116840068678, 10572.207084468542, 10754.0, 10359.896401035892, 10520.874751491054, 10592.788144237225, 10648.574057037631, 10661.946690266499, 9643.421394716339, 9745.26910481731, 9829.705108846745, 9943.850842237227, 9953.402795832273, 8009.279164875189, 8626.266767324847, 8738.344624153087, 8752.343574232085, 9062.501562413867, 8453.154684531497, 8525.19010693983, 8668.566571671518, 9048.321375896703, 9134.771630709285], "value": 6375.054282708519, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1595.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 107.0, 117.0, 115.0, 114.0, 113.0, 118.0, 113.0, 114.0, 115.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 130.0, 169.0, 184.0, 141.0, 157.0, 156.0, 138.0, 192.0, 131.0], "value": 155.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 167.0, 175.0, 166.0, 162.0, 163.0, 164.0, 162.0, 163.0, 162.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 77.0, 161.0, 76.0, 76.0, 76.0, 77.0, 160.0, 79.0], "value": 93.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 138.0, 86.0, 87.0, 88.0, 132.0, 87.0, 87.0, 148.0], "value": 102.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 119.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 149.0, 150.0, 149.0, 149.0, 148.0, 149.0, 150.0, 148.0], "value": 149.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 64.0, 65.0, 65.0, 66.0, 65.0, 64.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 64.0, 64.0, 72.0, 64.0, 64.0, 65.0, 65.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 84.0, 84.0, 86.0, 86.0, 86.0, 87.0, 86.0, 110.0, 86.0], "value": 88.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 153.0, 145.0, 141.0, 147.0, 130.0, 134.0, 148.0, 138.0, 156.0], "value": 143.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 176.0, 175.0, 174.0, 169.0, 167.0, 168.0, 178.0, 172.0, 168.0], "value": 171.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 66.0, 67.0, 70.0, 70.0, 69.0, 69.0, 67.0, 67.0], "value": 68.1, "unit": "score"}]}]} 05:31:11 INFO - Return code: 0 05:31:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:31:11 ERROR - # TBPL SUCCESS # 05:31:11 INFO - Running post-action listener: _resource_record_post_action 05:31:11 INFO - ##### 05:31:11 INFO - ##### Finished run-tests step (success) 05:31:11 INFO - ##### 05:31:11 INFO - Running post-run listener: _resource_record_post_run 05:31:11 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 536616960; Read time: 8; Write time: 430568 05:31:11 INFO - TinderboxPrint: CPU usage
13.5% 05:31:11 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 05:31:11 INFO - TinderboxPrint: I/O write bytes / time
536,616,960 / 430,568 05:31:11 INFO - TinderboxPrint: CPU idle
8,267.5 (86.5%) 05:31:11 INFO - TinderboxPrint: CPU user
1,233.5 (12.9%) 05:31:11 INFO - TinderboxPrint: Swap in / out
0 / 0 05:31:11 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 243924992; Read time: 0; Write time: 234908 05:31:11 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292691968; Read time: 8; Write time: 195660 05:31:12 INFO - Running post-run listener: _upload_blobber_files 05:31:12 INFO - Blob upload gear active. 05:31:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:31:12 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:31:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:31:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:31:12 INFO - (blobuploader) - INFO - Open directory for files ... 05:31:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:31:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:31:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:13 INFO - (blobuploader) - INFO - Done attempting. 05:31:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:31:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:31:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:14 INFO - (blobuploader) - INFO - Done attempting. 05:31:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:31:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:31:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:19 INFO - (blobuploader) - INFO - Done attempting. 05:31:19 INFO - (blobuploader) - INFO - Iteration through files over. 05:31:19 INFO - Return code: 0 05:31:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:31:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:31:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/21ab927295ddf1b5f7417a60b77e86fc0885a7aa6b133575f43e7fde28228debc43f002c0ffca21098ee4b00525e40d999890cefbfc1ef3e079a1b4e3b97f6a7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6f15f255fcd258b7244efd88e022fa57c99b83608b34e48ae7c434217ed2885a94b35403109ebc06ab3c8278f1f1e4fa476c04f6659e7a2da73a280a0f39bffd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/63241334230d6aebfca79a3549ec0839531f167f94948f974303e6d3c7fd94c92affe5246e59994327db7c788ccea465e951451c3032600133696122859e809a"} 05:31:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:31:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:31:19 INFO - Contents: 05:31:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/21ab927295ddf1b5f7417a60b77e86fc0885a7aa6b133575f43e7fde28228debc43f002c0ffca21098ee4b00525e40d999890cefbfc1ef3e079a1b4e3b97f6a7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6f15f255fcd258b7244efd88e022fa57c99b83608b34e48ae7c434217ed2885a94b35403109ebc06ab3c8278f1f1e4fa476c04f6659e7a2da73a280a0f39bffd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/63241334230d6aebfca79a3549ec0839531f167f94948f974303e6d3c7fd94c92affe5246e59994327db7c788ccea465e951451c3032600133696122859e809a"} 05:31:19 INFO - Running post-run listener: copy_logs_to_upload_dir 05:31:19 INFO - Copying logs to upload dir... 05:31:19 INFO - mkdir: /builds/slave/test/build/upload/logs 05:31:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.355799 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-06-09 05:31:18.921189) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 05:31:18.924896) ========= 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=652eb03db935cfc1c15ebda0000001ad-1465473723.975090-2071196256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/21ab927295ddf1b5f7417a60b77e86fc0885a7aa6b133575f43e7fde28228debc43f002c0ffca21098ee4b00525e40d999890cefbfc1ef3e079a1b4e3b97f6a7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6f15f255fcd258b7244efd88e022fa57c99b83608b34e48ae7c434217ed2885a94b35403109ebc06ab3c8278f1f1e4fa476c04f6659e7a2da73a280a0f39bffd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/63241334230d6aebfca79a3549ec0839531f167f94948f974303e6d3c7fd94c92affe5246e59994327db7c788ccea465e951451c3032600133696122859e809a"} build_url:https://queue.taskcluster.net/v1/task/bh6ltXwNQg2y98oveuaF8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011460 build_url: 'https://queue.taskcluster.net/v1/task/bh6ltXwNQg2y98oveuaF8A/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-Non-PGO/sha512/21ab927295ddf1b5f7417a60b77e86fc0885a7aa6b133575f43e7fde28228debc43f002c0ffca21098ee4b00525e40d999890cefbfc1ef3e079a1b4e3b97f6a7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6f15f255fcd258b7244efd88e022fa57c99b83608b34e48ae7c434217ed2885a94b35403109ebc06ab3c8278f1f1e4fa476c04f6659e7a2da73a280a0f39bffd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/63241334230d6aebfca79a3549ec0839531f167f94948f974303e6d3c7fd94c92affe5246e59994327db7c788ccea465e951451c3032600133696122859e809a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 05:31:18.950187) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 05:31:18.950771) ========= 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=652eb03db935cfc1c15ebda0000001ad-1465473723.975090-2071196256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004519 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 05:31:19.034859) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 05:31:19.035384) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 05:31:19.035917) ========= ========= Total master_lag: 0.24 =========