builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-023 starttime: 1465308031.05 results: success (0) buildid: 20160607043100 builduid: 962fdadb644544b294d473df38702ffe revision: 448365b11e377ebf1c572d54e45bbd36c45af03a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 07:00:31.051745) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 07:00:31.052189) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 07:00:31.052465) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 07:00:31.071529) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 07:00:31.071807) ========= 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=6d15e502d8e29d5d2676d664000001c3-1465307526.595883-331799599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-07 07:00:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 218M=0s 2016-06-07 07:00:31 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.076964 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 07:00:31.167123) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 07:00:31.167434) ========= 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=6d15e502d8e29d5d2676d664000001c3-1465307526.595883-331799599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017629 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 07:00:31.219638) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 07:00:31.220043) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 448365b11e377ebf1c572d54e45bbd36c45af03a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 448365b11e377ebf1c572d54e45bbd36c45af03a --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=6d15e502d8e29d5d2676d664000001c3-1465307526.595883-331799599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-07 07:00:31,825 truncating revision to first 12 chars 2016-06-07 07:00:31,825 Setting DEBUG logging. 2016-06-07 07:00:31,826 attempt 1/10 2016-06-07 07:00:31,826 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/448365b11e37?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-07 07:00:32,153 unpacking tar archive at: mozilla-inbound-448365b11e37/testing/mozharness/ program finished with exit code 0 elapsedTime=0.637934 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 07:00:31.871389) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 07:00:31.871709) ========= script_repo_revision: 448365b11e377ebf1c572d54e45bbd36c45af03a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 07:00:31.872095) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 07:00:31.872355) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 07:00:31.881186) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 28 secs) (at 2016-06-07 07:00:31.881581) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=6d15e502d8e29d5d2676d664000001c3-1465307526.595883-331799599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:00:32 INFO - MultiFileLogger online at 20160607 07:00:32 in /builds/slave/test 07:00:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 07:00:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:00:32 INFO - {'append_to_log': False, 07:00:32 INFO - 'base_work_dir': '/builds/slave/test', 07:00:32 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 07:00:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:00:32 INFO - 'branch': 'Mozilla-Inbound', 07:00:32 INFO - 'buildbot_json_path': 'buildprops.json', 07:00:32 INFO - 'config_files': ('talos/linux_config.py',), 07:00:32 INFO - 'default_actions': ('clobber', 07:00:32 INFO - 'read-buildbot-config', 07:00:32 INFO - 'download-and-extract', 07:00:32 INFO - 'populate-webroot', 07:00:32 INFO - 'create-virtualenv', 07:00:32 INFO - 'install', 07:00:32 INFO - 'run-tests'), 07:00:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:00:32 INFO - 'download_minidump_stackwalk': True, 07:00:32 INFO - 'download_symbols': 'ondemand', 07:00:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:00:32 INFO - 'tooltool.py': '/tools/tooltool.py', 07:00:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:00:32 INFO - '/tools/misc-python/virtualenv.py')}, 07:00:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:00:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:00:32 INFO - 'installer_path': 'installer.exe', 07:00:32 INFO - 'log_level': 'info', 07:00:32 INFO - 'log_name': 'talos', 07:00:32 INFO - 'log_to_console': True, 07:00:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:00:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:00:32 INFO - 'opt_config_files': (), 07:00:32 INFO - 'pip_index': False, 07:00:32 INFO - 'sps_profile': False, 07:00:32 INFO - 'sps_profile_interval': 0, 07:00:32 INFO - 'suite': 'dromaeojs-e10s', 07:00:32 INFO - 'system_bits': '32', 07:00:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:00:32 INFO - 'title': 'talos-linux64-ix-023', 07:00:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:00:32 INFO - 'use_talos_json': True, 07:00:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:00:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:00:32 INFO - 'work_dir': 'build'} 07:00:32 INFO - ##### 07:00:32 INFO - ##### Running clobber step. 07:00:32 INFO - ##### 07:00:32 INFO - Running pre-action listener: _resource_record_pre_action 07:00:32 INFO - Running main action method: clobber 07:00:32 INFO - rmtree: /builds/slave/test/build 07:00:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:00:33 INFO - Running post-action listener: _resource_record_post_action 07:00:33 INFO - ##### 07:00:33 INFO - ##### Finished clobber step (success) 07:00:33 INFO - ##### 07:00:33 INFO - ##### 07:00:33 INFO - ##### Running read-buildbot-config step. 07:00:33 INFO - ##### 07:00:33 INFO - Running pre-action listener: _resource_record_pre_action 07:00:33 INFO - Running main action method: read_buildbot_config 07:00:33 INFO - Using buildbot properties: 07:00:33 INFO - { 07:00:33 INFO - "project": "", 07:00:33 INFO - "product": "firefox", 07:00:33 INFO - "script_repo_revision": "production", 07:00:33 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 07:00:33 INFO - "repository": "", 07:00:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 07:00:33 INFO - "buildid": "20160607043100", 07:00:33 INFO - "pgo_build": "True", 07:00:33 INFO - "basedir": "/builds/slave/test", 07:00:33 INFO - "buildnumber": 1131, 07:00:33 INFO - "slavename": "talos-linux64-ix-023", 07:00:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:00:33 INFO - "platform": "ubuntu64_hw", 07:00:33 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 07:00:33 INFO - "branch": "mozilla-inbound", 07:00:33 INFO - "repo_path": "integration/mozilla-inbound", 07:00:33 INFO - "revision": "448365b11e377ebf1c572d54e45bbd36c45af03a", 07:00:33 INFO - "stage_platform": "linux64-pgo", 07:00:33 INFO - "builduid": "962fdadb644544b294d473df38702ffe", 07:00:33 INFO - "slavebuilddir": "test" 07:00:33 INFO - } 07:00:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:00:33 INFO - Running post-action listener: _resource_record_post_action 07:00:33 INFO - ##### 07:00:33 INFO - ##### Finished read-buildbot-config step (success) 07:00:33 INFO - ##### 07:00:33 INFO - ##### 07:00:33 INFO - ##### Running download-and-extract step. 07:00:33 INFO - ##### 07:00:33 INFO - Running pre-action listener: _resource_record_pre_action 07:00:33 INFO - Running main action method: download_and_extract 07:00:33 INFO - mkdir: /builds/slave/test/build/tests 07:00:33 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')]} 07:00:33 INFO - https://queue.taskcluster.net/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:00:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:00:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:00:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpcl35WPSNO7upkvoxwKoA/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 07:00:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpcl35WPSNO7upkvoxwKoA/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 07:00:33 INFO - Downloaded 1361 bytes. 07:00:33 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:00:33 INFO - Using the following test package requirements: 07:00:33 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:00:33 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:00:33 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:00:33 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:33 INFO - u'jsshell-linux-x86_64.zip'], 07:00:33 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:00:33 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:00:33 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:00:33 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:00:33 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:00:33 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:00:33 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:00:33 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')]} 07:00:33 INFO - https://queue.taskcluster.net/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:00:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:00:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:00:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpcl35WPSNO7upkvoxwKoA/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 07:00:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpcl35WPSNO7upkvoxwKoA/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 07:00:36 INFO - Downloaded 24440428 bytes. 07:00:36 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'] 07:00:36 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 07:00:38 INFO - Return code: 0 07:00:38 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 07:00:38 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')]} 07:00:38 INFO - https://queue.taskcluster.net/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:00:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:00:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:00:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpcl35WPSNO7upkvoxwKoA/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 07:00:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpcl35WPSNO7upkvoxwKoA/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 07:00:43 INFO - Downloaded 24440428 bytes. 07:00:43 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'] 07:00:43 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 07:00:44 INFO - Return code: 0 07:00:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:44 INFO - https://queue.taskcluster.net/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:00:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:00:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:00:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpcl35WPSNO7upkvoxwKoA/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 07:00:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpcl35WPSNO7upkvoxwKoA/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 07:00:45 INFO - Downloaded 10833369 bytes. 07:00:45 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'] 07:00:45 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 07:00:45 INFO - Return code: 0 07:00: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')]} 07:00:45 INFO - https://queue.taskcluster.net/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:00:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:00:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:00:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpcl35WPSNO7upkvoxwKoA/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 07:00:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpcl35WPSNO7upkvoxwKoA/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 07:00:47 INFO - Downloaded 59188444 bytes. 07:00:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:00:47 INFO - mkdir: /builds/slave/test/properties 07:00:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:00:47 INFO - Writing to file /builds/slave/test/properties/build_url 07:00:47 INFO - Contents: 07:00:47 INFO - build_url:https://queue.taskcluster.net/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:00:48 INFO - Running post-action listener: _resource_record_post_action 07:00:48 INFO - Running post-action listener: set_extra_try_arguments 07:00:48 INFO - ##### 07:00:48 INFO - ##### Finished download-and-extract step (success) 07:00:48 INFO - ##### 07:00:48 INFO - ##### 07:00:48 INFO - ##### Running populate-webroot step. 07:00:48 INFO - ##### 07:00:48 INFO - Running pre-action listener: _resource_record_pre_action 07:00:48 INFO - Running main action method: populate_webroot 07:00:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:00:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:00:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:00:48 INFO - '--tppagecycles', 07:00:48 INFO - '7'], 07:00:48 INFO - 'tests': ['tsvgm']}}, 07:00:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:00:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:00:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:00:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:00:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:00:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:00:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:48 INFO - 'talos_options': ['--disable-e10s'], 07:00:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:00:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:00:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:48 INFO - 'talos_options': ['--disable-e10s'], 07:00:48 INFO - 'tests': ['damp', 'tps']}, 07:00:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:48 INFO - 'tests': ['damp', 'tps']}, 07:00:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:00:48 INFO - 'tests': ['dromaeo_dom']}, 07:00:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:00:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:00:48 INFO - 'tests': ['a11yr', 07:00:48 INFO - 'ts_paint', 07:00:48 INFO - 'tpaint', 07:00:48 INFO - 'sessionrestore', 07:00:48 INFO - 'sessionrestore_no_auto_restore', 07:00:48 INFO - 'tabpaint']}, 07:00:48 INFO - 'other-e10s': {'tests': ['a11yr', 07:00:48 INFO - 'ts_paint', 07:00:48 INFO - 'tpaint', 07:00:48 INFO - 'sessionrestore', 07:00:48 INFO - 'sessionrestore_no_auto_restore', 07:00:48 INFO - 'tabpaint']}, 07:00:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:00:48 INFO - 'ts_paint', 07:00:48 INFO - 'tpaint', 07:00:48 INFO - 'sessionrestore', 07:00:48 INFO - 'sessionrestore_no_auto_restore', 07:00:48 INFO - 'tabpaint']}, 07:00:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:00:48 INFO - 'ts_paint', 07:00:48 INFO - 'tpaint', 07:00:48 INFO - 'sessionrestore', 07:00:48 INFO - 'sessionrestore_no_auto_restore', 07:00:48 INFO - 'tabpaint']}, 07:00:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:00:48 INFO - 'tests': ['a11yr', 07:00:48 INFO - 'ts_paint', 07:00:48 INFO - 'tpaint', 07:00:48 INFO - 'sessionrestore', 07:00:48 INFO - 'sessionrestore_no_auto_restore', 07:00:48 INFO - 'tabpaint']}, 07:00:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:00:48 INFO - 'tests': ['a11yr', 07:00:48 INFO - 'ts_paint', 07:00:48 INFO - 'tpaint', 07:00:48 INFO - 'sessionrestore', 07:00:48 INFO - 'sessionrestore_no_auto_restore', 07:00:48 INFO - 'tabpaint']}, 07:00:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:00:48 INFO - 'tests': ['tsvgx', 07:00:48 INFO - 'tsvgr_opacity', 07:00:48 INFO - 'tart', 07:00:48 INFO - 'tscrollx', 07:00:48 INFO - 'cart']}, 07:00:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:00:48 INFO - 'tsvgr_opacity', 07:00:48 INFO - 'tart', 07:00:48 INFO - 'tscrollx', 07:00:48 INFO - 'cart']}, 07:00:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:48 INFO - 'talos_options': ['--disable-e10s'], 07:00:48 INFO - 'tests': ['tp5o']}, 07:00:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:48 INFO - 'tests': ['tp5o']}, 07:00:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:48 INFO - 'talos_options': ['--disable-e10s', 07:00:48 INFO - '--xperf_path', 07:00:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:00:48 INFO - 'tests': ['tp5n']}, 07:00:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:48 INFO - 'talos_options': ['--xperf_path', 07:00:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:00:48 INFO - 'tests': ['tp5n']}}, 07:00:48 INFO - 'talos.zip': {'path': '', 07:00:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:00:48 INFO - Running post-action listener: _resource_record_post_action 07:00:48 INFO - ##### 07:00:48 INFO - ##### Finished populate-webroot step (success) 07:00:48 INFO - ##### 07:00:48 INFO - ##### 07:00:48 INFO - ##### Running create-virtualenv step. 07:00:48 INFO - ##### 07:00:48 INFO - Running pre-action listener: _resource_record_pre_action 07:00:48 INFO - Running main action method: create_virtualenv 07:00:48 INFO - Creating virtualenv /builds/slave/test/build/venv 07:00: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 07:00:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:00:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:00:48 INFO - Using real prefix '/usr' 07:00:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:00:49 INFO - Installing distribute.............................................................................................................................................................................................done. 07:00:51 INFO - Installing pip.................done. 07:00:51 INFO - Return code: 0 07:00:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:00: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')]} 07:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00: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')]} 07:00:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00: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 0x7f462da87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1766350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f51c0>, '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 0x17f60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f6550>, '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': '6d15e502d8e29d5d2676d664000001c3-1465307526.595883-331799599', '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 07:00: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 07:00: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 07:00:51 INFO - Using env: {'DISPLAY': ':0', 07:00:51 INFO - 'HOME': '/home/cltbld', 07:00:51 INFO - 'LANG': 'en_US.UTF-8', 07:00:51 INFO - 'LANGUAGE': 'en_US:en', 07:00:51 INFO - 'LOGNAME': 'cltbld', 07:00:51 INFO - 'MAIL': '/var/mail/cltbld', 07:00:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:51 INFO - 'MOZ_NO_REMOTE': '1', 07:00:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:51 INFO - 'NO_EM_RESTART': '1', 07:00:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:51 INFO - 'PWD': '/builds/slave/test', 07:00:51 INFO - 'SHELL': '/bin/bash', 07:00:51 INFO - 'SHLVL': '1', 07:00:51 INFO - 'TERM': 'linux', 07:00:51 INFO - 'TMOUT': '86400', 07:00:51 INFO - 'USER': 'cltbld', 07:00:51 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465307526.595883-331799599', 07:00:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:51 INFO - '_': '/tools/buildbot/bin/python'} 07:00:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00: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 07:00:51 INFO - Cleaning up... 07:00:51 INFO - Return code: 0 07:00:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:00: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')]} 07:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00: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')]} 07:00:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00: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 0x7f462da87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1766350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f51c0>, '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 0x17f60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f6550>, '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': '6d15e502d8e29d5d2676d664000001c3-1465307526.595883-331799599', '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 07:00: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 07:00: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 07:00:51 INFO - Using env: {'DISPLAY': ':0', 07:00:51 INFO - 'HOME': '/home/cltbld', 07:00:51 INFO - 'LANG': 'en_US.UTF-8', 07:00:51 INFO - 'LANGUAGE': 'en_US:en', 07:00:51 INFO - 'LOGNAME': 'cltbld', 07:00:51 INFO - 'MAIL': '/var/mail/cltbld', 07:00:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:51 INFO - 'MOZ_NO_REMOTE': '1', 07:00:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:51 INFO - 'NO_EM_RESTART': '1', 07:00:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:51 INFO - 'PWD': '/builds/slave/test', 07:00:51 INFO - 'SHELL': '/bin/bash', 07:00:51 INFO - 'SHLVL': '1', 07:00:51 INFO - 'TERM': 'linux', 07:00:51 INFO - 'TMOUT': '86400', 07:00:51 INFO - 'USER': 'cltbld', 07:00:51 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465307526.595883-331799599', 07:00:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:51 INFO - '_': '/tools/buildbot/bin/python'} 07:00:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:51 INFO - Downloading/unpacking psutil>=3.1.1 07:00: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 07:00: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 07:00: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 07:00: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 07:00: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 07:00: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 07:00:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:00:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:00:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:00:53 INFO - Installing collected packages: psutil 07:00:53 INFO - Running setup.py install for psutil 07:00:53 INFO - building 'psutil._psutil_linux' extension 07:00: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 07:00:53 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 07:00:53 INFO - building 'psutil._psutil_posix' extension 07:00:53 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 07:00:53 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 07:00:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:00:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:00:54 INFO - Successfully installed psutil 07:00:54 INFO - Cleaning up... 07:00:54 INFO - Return code: 0 07:00:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:00: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')]} 07:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00: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')]} 07:00:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00: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 0x7f462da87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1766350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f51c0>, '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 0x17f60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f6550>, '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': '6d15e502d8e29d5d2676d664000001c3-1465307526.595883-331799599', '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 07:00: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 07:00: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 07:00:54 INFO - Using env: {'DISPLAY': ':0', 07:00:54 INFO - 'HOME': '/home/cltbld', 07:00:54 INFO - 'LANG': 'en_US.UTF-8', 07:00:54 INFO - 'LANGUAGE': 'en_US:en', 07:00:54 INFO - 'LOGNAME': 'cltbld', 07:00:54 INFO - 'MAIL': '/var/mail/cltbld', 07:00:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:54 INFO - 'MOZ_NO_REMOTE': '1', 07:00:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:54 INFO - 'NO_EM_RESTART': '1', 07:00:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:54 INFO - 'PWD': '/builds/slave/test', 07:00:54 INFO - 'SHELL': '/bin/bash', 07:00:54 INFO - 'SHLVL': '1', 07:00:54 INFO - 'TERM': 'linux', 07:00:54 INFO - 'TMOUT': '86400', 07:00:54 INFO - 'USER': 'cltbld', 07:00:54 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465307526.595883-331799599', 07:00:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:54 INFO - '_': '/tools/buildbot/bin/python'} 07:00:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:00: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 07:00: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 07:00: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 07:00: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 07:00: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 07:00: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 07:00:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:00:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:00:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:00:56 INFO - Installing collected packages: mozsystemmonitor 07:00:56 INFO - Running setup.py install for mozsystemmonitor 07:00:56 INFO - Successfully installed mozsystemmonitor 07:00:56 INFO - Cleaning up... 07:00:56 INFO - Return code: 0 07:00:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:00: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')]} 07:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00: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')]} 07:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00: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 0x7f462da87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1766350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f51c0>, '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 0x17f60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f6550>, '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': '6d15e502d8e29d5d2676d664000001c3-1465307526.595883-331799599', '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 07:00: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 07:00: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 07:00:56 INFO - Using env: {'DISPLAY': ':0', 07:00:56 INFO - 'HOME': '/home/cltbld', 07:00:56 INFO - 'LANG': 'en_US.UTF-8', 07:00:56 INFO - 'LANGUAGE': 'en_US:en', 07:00:56 INFO - 'LOGNAME': 'cltbld', 07:00:56 INFO - 'MAIL': '/var/mail/cltbld', 07:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:56 INFO - 'MOZ_NO_REMOTE': '1', 07:00:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:56 INFO - 'NO_EM_RESTART': '1', 07:00:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:56 INFO - 'PWD': '/builds/slave/test', 07:00:56 INFO - 'SHELL': '/bin/bash', 07:00:56 INFO - 'SHLVL': '1', 07:00:56 INFO - 'TERM': 'linux', 07:00:56 INFO - 'TMOUT': '86400', 07:00:56 INFO - 'USER': 'cltbld', 07:00:56 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465307526.595883-331799599', 07:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:56 INFO - '_': '/tools/buildbot/bin/python'} 07:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:56 INFO - Downloading/unpacking jsonschema==2.5.1 07:00: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 07:00: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 07:00: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 07:00: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 07:00: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 07:00: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 07:00:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:00:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:00: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 07:00: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 07:00: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 07:00: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 07:00: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 07:00: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 07:00:58 INFO - Downloading functools32-3.2.3-2.tar.gz 07:00:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:00:58 INFO - warning: no files found matching '*.txt' 07:00:58 INFO - no previously-included directories found matching 'build' 07:00:58 INFO - no previously-included directories found matching 'dist' 07:00:58 INFO - no previously-included directories found matching '.git*' 07:00:58 INFO - Installing collected packages: jsonschema, functools32 07:00:58 INFO - Running setup.py install for functools32 07:00:58 INFO - warning: no files found matching '*.txt' 07:00:58 INFO - no previously-included directories found matching 'build' 07:00:58 INFO - no previously-included directories found matching 'dist' 07:00:58 INFO - no previously-included directories found matching '.git*' 07:00:58 INFO - Successfully installed jsonschema functools32 07:00:58 INFO - Cleaning up... 07:00:59 INFO - Return code: 0 07:00:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:00: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')]} 07:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00: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')]} 07:00:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00: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 0x7f462da87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1766350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f51c0>, '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 0x17f60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f6550>, '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': '6d15e502d8e29d5d2676d664000001c3-1465307526.595883-331799599', '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 07:00: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 07:00: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 07:00:59 INFO - Using env: {'DISPLAY': ':0', 07:00:59 INFO - 'HOME': '/home/cltbld', 07:00:59 INFO - 'LANG': 'en_US.UTF-8', 07:00:59 INFO - 'LANGUAGE': 'en_US:en', 07:00:59 INFO - 'LOGNAME': 'cltbld', 07:00:59 INFO - 'MAIL': '/var/mail/cltbld', 07:00:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:59 INFO - 'MOZ_NO_REMOTE': '1', 07:00:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:59 INFO - 'NO_EM_RESTART': '1', 07:00:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:59 INFO - 'PWD': '/builds/slave/test', 07:00:59 INFO - 'SHELL': '/bin/bash', 07:00:59 INFO - 'SHLVL': '1', 07:00:59 INFO - 'TERM': 'linux', 07:00:59 INFO - 'TMOUT': '86400', 07:00:59 INFO - 'USER': 'cltbld', 07:00:59 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465307526.595883-331799599', 07:00:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:59 INFO - '_': '/tools/buildbot/bin/python'} 07:00:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:59 INFO - Downloading/unpacking blobuploader==1.2.4 07:00: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 07:00: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 07:00: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 07:00: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 07:00: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 07:00: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 07:01:01 INFO - Downloading blobuploader-1.2.4.tar.gz 07:01:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:01:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:01: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 07:01: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 07:01: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 07:01: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 07:01: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 07:01: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 07:01:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:01:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:01: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 07:01: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 07:01: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 07:01: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 07:01: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 07:01: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 07:01:01 INFO - Downloading docopt-0.6.1.tar.gz 07:01:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:01:01 INFO - Installing collected packages: blobuploader, requests, docopt 07:01:01 INFO - Running setup.py install for blobuploader 07:01:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:01:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:01:02 INFO - Running setup.py install for requests 07:01:02 INFO - Running setup.py install for docopt 07:01:02 INFO - Successfully installed blobuploader requests docopt 07:01:02 INFO - Cleaning up... 07:01:02 INFO - Return code: 0 07:01:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:01: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')]} 07:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:01:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01: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')]} 07:01:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:01:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01: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 0x7f462da87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1766350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f51c0>, '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 0x17f60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f6550>, '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': '6d15e502d8e29d5d2676d664000001c3-1465307526.595883-331799599', '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 07:01: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 07:01: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 07:01:02 INFO - Using env: {'DISPLAY': ':0', 07:01:02 INFO - 'HOME': '/home/cltbld', 07:01:02 INFO - 'LANG': 'en_US.UTF-8', 07:01:02 INFO - 'LANGUAGE': 'en_US:en', 07:01:02 INFO - 'LOGNAME': 'cltbld', 07:01:02 INFO - 'MAIL': '/var/mail/cltbld', 07:01:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:02 INFO - 'MOZ_NO_REMOTE': '1', 07:01:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:02 INFO - 'NO_EM_RESTART': '1', 07:01:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:01:02 INFO - 'PWD': '/builds/slave/test', 07:01:02 INFO - 'SHELL': '/bin/bash', 07:01:02 INFO - 'SHLVL': '1', 07:01:02 INFO - 'TERM': 'linux', 07:01:02 INFO - 'TMOUT': '86400', 07:01:02 INFO - 'USER': 'cltbld', 07:01:02 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465307526.595883-331799599', 07:01:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:02 INFO - '_': '/tools/buildbot/bin/python'} 07:01:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:01:02 INFO - Running setup.py (path:/tmp/pip-Ib9na6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:01:02 INFO - Running setup.py (path:/tmp/pip-1YqSLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:01:02 INFO - Running setup.py (path:/tmp/pip-Uvck8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:01:02 INFO - Running setup.py (path:/tmp/pip-r0_LIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:01:03 INFO - Running setup.py (path:/tmp/pip-dU9_Vp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:01:03 INFO - Running setup.py (path:/tmp/pip-TYQ5sE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:01:03 INFO - Running setup.py (path:/tmp/pip-13qoxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:01:03 INFO - Running setup.py (path:/tmp/pip-IE4fJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:01:03 INFO - Running setup.py (path:/tmp/pip-Up3FDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:01:03 INFO - Running setup.py (path:/tmp/pip-wPZKpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:01:03 INFO - Running setup.py (path:/tmp/pip-c1xJv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:01:03 INFO - Running setup.py (path:/tmp/pip-J7815v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:01:03 INFO - Running setup.py (path:/tmp/pip-a8iNr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:01:03 INFO - Running setup.py (path:/tmp/pip-1Ld5Qf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:01:03 INFO - Running setup.py (path:/tmp/pip-D8d2ce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:01:03 INFO - Running setup.py (path:/tmp/pip-7_ClOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:01:03 INFO - Running setup.py (path:/tmp/pip-k39npv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:01:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:01:03 INFO - Running setup.py install for manifestparser 07:01:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:01:04 INFO - Running setup.py install for mozcrash 07:01:04 INFO - Running setup.py install for mozdebug 07:01:04 INFO - Running setup.py install for mozdevice 07:01:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:01:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:01:04 INFO - Running setup.py install for mozfile 07:01:04 INFO - Running setup.py install for mozhttpd 07:01:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:01:04 INFO - Running setup.py install for mozinfo 07:01:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:01:04 INFO - Running setup.py install for mozInstall 07:01:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:01:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:01:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:01:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:01:04 INFO - Running setup.py install for mozleak 07:01:04 INFO - Running setup.py install for mozlog 07:01:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:01:05 INFO - Running setup.py install for moznetwork 07:01:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:01:05 INFO - Running setup.py install for mozprocess 07:01:05 INFO - Running setup.py install for mozprofile 07:01:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:01:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:01:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:01:05 INFO - Running setup.py install for mozrunner 07:01:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:01:05 INFO - Running setup.py install for mozscreenshot 07:01:05 INFO - Running setup.py install for moztest 07:01:05 INFO - Running setup.py install for mozversion 07:01:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:01:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:01:05 INFO - Cleaning up... 07:01:05 INFO - Return code: 0 07:01:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:01: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')]} 07:01:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:01:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01: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')]} 07:01:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:01:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01: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 0x7f462da87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1766350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f51c0>, '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 0x17f60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f6550>, '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': '6d15e502d8e29d5d2676d664000001c3-1465307526.595883-331799599', '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 07:01: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 07:01: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 07:01:05 INFO - Using env: {'DISPLAY': ':0', 07:01:05 INFO - 'HOME': '/home/cltbld', 07:01:05 INFO - 'LANG': 'en_US.UTF-8', 07:01:05 INFO - 'LANGUAGE': 'en_US:en', 07:01:05 INFO - 'LOGNAME': 'cltbld', 07:01:05 INFO - 'MAIL': '/var/mail/cltbld', 07:01:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:05 INFO - 'MOZ_NO_REMOTE': '1', 07:01:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:05 INFO - 'NO_EM_RESTART': '1', 07:01:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:01:05 INFO - 'PWD': '/builds/slave/test', 07:01:05 INFO - 'SHELL': '/bin/bash', 07:01:05 INFO - 'SHLVL': '1', 07:01:05 INFO - 'TERM': 'linux', 07:01:05 INFO - 'TMOUT': '86400', 07:01:05 INFO - 'USER': 'cltbld', 07:01:05 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465307526.595883-331799599', 07:01:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:05 INFO - '_': '/tools/buildbot/bin/python'} 07:01:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:01:05 INFO - Running setup.py (path:/tmp/pip-Okb4Ld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:01: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)) 07:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:01:06 INFO - Running setup.py (path:/tmp/pip-w6pHWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:01: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)) 07:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:01:06 INFO - Running setup.py (path:/tmp/pip-99dqX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:01: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)) 07:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:01:06 INFO - Running setup.py (path:/tmp/pip-3xn5AC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:01: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)) 07:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:01:06 INFO - Running setup.py (path:/tmp/pip-QJRgWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:01: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)) 07:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:01:06 INFO - Running setup.py (path:/tmp/pip-uQWMQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:01: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)) 07:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:01:06 INFO - Running setup.py (path:/tmp/pip-JfvOkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:01: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)) 07:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:01:06 INFO - Running setup.py (path:/tmp/pip-JivQVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:01: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)) 07:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:01:06 INFO - Running setup.py (path:/tmp/pip-CLB8hf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:01: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)) 07:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:01:06 INFO - Running setup.py (path:/tmp/pip-E1dLU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:01: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)) 07:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:01:06 INFO - Running setup.py (path:/tmp/pip-gKfu6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:01: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)) 07:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:01:06 INFO - Running setup.py (path:/tmp/pip-Nu3tpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:01:06 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)) 07:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:01:06 INFO - Running setup.py (path:/tmp/pip-ADEhvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:01:06 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)) 07:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:01:06 INFO - Running setup.py (path:/tmp/pip-VA2TM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:01: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)) 07:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:01:07 INFO - Running setup.py (path:/tmp/pip-iUIr1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:01: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)) 07:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:01:07 INFO - Running setup.py (path:/tmp/pip-c_2huv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:01: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)) 07:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:01:07 INFO - Running setup.py (path:/tmp/pip-f3661r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:01: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)) 07:01: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)) 07:01: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)) 07:01: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)) 07:01: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)) 07:01: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)) 07:01:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:01: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 07:01: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 07:01: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 07:01: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 07:01: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 07:01: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 07:01:09 INFO - Downloading blessings-1.6.tar.gz 07:01:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:01:09 INFO - Installing collected packages: blessings 07:01:09 INFO - Running setup.py install for blessings 07:01:09 INFO - Successfully installed blessings 07:01:09 INFO - Cleaning up... 07:01:09 INFO - Return code: 0 07:01:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:01:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:01:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:01:09 INFO - Reading from file tmpfile_stdout 07:01:09 INFO - Current package versions: 07:01:09 INFO - argparse == 1.2.1 07:01:09 INFO - blessings == 1.6 07:01:09 INFO - blobuploader == 1.2.4 07:01:09 INFO - docopt == 0.6.1 07:01:09 INFO - functools32 == 3.2.3-2 07:01:09 INFO - jsonschema == 2.5.1 07:01:09 INFO - manifestparser == 1.1 07:01:09 INFO - mozInstall == 1.12 07:01:09 INFO - mozcrash == 0.17 07:01:09 INFO - mozdebug == 0.1 07:01:09 INFO - mozdevice == 0.48 07:01:09 INFO - mozfile == 1.2 07:01:09 INFO - mozhttpd == 0.7 07:01:09 INFO - mozinfo == 0.9 07:01:09 INFO - mozleak == 0.1 07:01:09 INFO - mozlog == 3.2 07:01:09 INFO - moznetwork == 0.27 07:01:09 INFO - mozprocess == 0.22 07:01:09 INFO - mozprofile == 0.28 07:01:09 INFO - mozrunner == 6.11 07:01:09 INFO - mozscreenshot == 0.1 07:01:09 INFO - mozsystemmonitor == 0.3 07:01:09 INFO - moztest == 0.7 07:01:09 INFO - mozversion == 1.4 07:01:09 INFO - psutil == 3.1.1 07:01:09 INFO - requests == 1.2.3 07:01:09 INFO - wsgiref == 0.1.2 07:01:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:01: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')]} 07:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:01:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01: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')]} 07:01:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:01:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01: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 0x7f462da87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1766350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f51c0>, '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 0x17f60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f6550>, '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': '6d15e502d8e29d5d2676d664000001c3-1465307526.595883-331799599', '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 07:01: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 07:01: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 07:01:09 INFO - Using env: {'DISPLAY': ':0', 07:01:09 INFO - 'HOME': '/home/cltbld', 07:01:09 INFO - 'LANG': 'en_US.UTF-8', 07:01:09 INFO - 'LANGUAGE': 'en_US:en', 07:01:09 INFO - 'LOGNAME': 'cltbld', 07:01:09 INFO - 'MAIL': '/var/mail/cltbld', 07:01:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:09 INFO - 'MOZ_NO_REMOTE': '1', 07:01:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:09 INFO - 'NO_EM_RESTART': '1', 07:01:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:01:09 INFO - 'PWD': '/builds/slave/test', 07:01:09 INFO - 'SHELL': '/bin/bash', 07:01:09 INFO - 'SHLVL': '1', 07:01:09 INFO - 'TERM': 'linux', 07:01:09 INFO - 'TMOUT': '86400', 07:01:09 INFO - 'USER': 'cltbld', 07:01:09 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465307526.595883-331799599', 07:01:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:09 INFO - '_': '/tools/buildbot/bin/python'} 07:01:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:01: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)) 07:01: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)) 07:01: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)) 07:01: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)) 07:01: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)) 07:01: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)) 07:01: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)) 07:01: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)) 07:01: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)) 07:01: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)) 07:01: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)) 07:01:09 INFO - Cleaning up... 07:01:09 INFO - Return code: 0 07:01:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:01: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')]} 07:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:01:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01: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')]} 07:01:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:01:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01: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 0x7f462da87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1766350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f51c0>, '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 0x17f60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f6550>, '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': '6d15e502d8e29d5d2676d664000001c3-1465307526.595883-331799599', '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 07:01: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 07:01: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 07:01:09 INFO - Using env: {'DISPLAY': ':0', 07:01:09 INFO - 'HOME': '/home/cltbld', 07:01:09 INFO - 'LANG': 'en_US.UTF-8', 07:01:09 INFO - 'LANGUAGE': 'en_US:en', 07:01:09 INFO - 'LOGNAME': 'cltbld', 07:01:09 INFO - 'MAIL': '/var/mail/cltbld', 07:01:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:09 INFO - 'MOZ_NO_REMOTE': '1', 07:01:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:09 INFO - 'NO_EM_RESTART': '1', 07:01:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:01:09 INFO - 'PWD': '/builds/slave/test', 07:01:09 INFO - 'SHELL': '/bin/bash', 07:01:09 INFO - 'SHLVL': '1', 07:01:09 INFO - 'TERM': 'linux', 07:01:09 INFO - 'TMOUT': '86400', 07:01:09 INFO - 'USER': 'cltbld', 07:01:09 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465307526.595883-331799599', 07:01:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:09 INFO - '_': '/tools/buildbot/bin/python'} 07:01:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:01:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:01:10 INFO - Cleaning up... 07:01:10 INFO - Return code: 0 07:01:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:01: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')]} 07:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:01:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01: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')]} 07:01:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:01:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01: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 0x7f462da87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1766350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f51c0>, '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 0x17f60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f6550>, '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': '6d15e502d8e29d5d2676d664000001c3-1465307526.595883-331799599', '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 07:01: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 07:01: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 07:01:10 INFO - Using env: {'DISPLAY': ':0', 07:01:10 INFO - 'HOME': '/home/cltbld', 07:01:10 INFO - 'LANG': 'en_US.UTF-8', 07:01:10 INFO - 'LANGUAGE': 'en_US:en', 07:01:10 INFO - 'LOGNAME': 'cltbld', 07:01:10 INFO - 'MAIL': '/var/mail/cltbld', 07:01:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:10 INFO - 'MOZ_NO_REMOTE': '1', 07:01:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:10 INFO - 'NO_EM_RESTART': '1', 07:01:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:01:10 INFO - 'PWD': '/builds/slave/test', 07:01:10 INFO - 'SHELL': '/bin/bash', 07:01:10 INFO - 'SHLVL': '1', 07:01:10 INFO - 'TERM': 'linux', 07:01:10 INFO - 'TMOUT': '86400', 07:01:10 INFO - 'USER': 'cltbld', 07:01:10 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465307526.595883-331799599', 07:01:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:10 INFO - '_': '/tools/buildbot/bin/python'} 07:01:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:01:10 INFO - Downloading/unpacking flake8 07:01: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 07:01: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 07:01: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 07:01: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 07:01: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 07:01: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 07:01:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:01:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:01: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 07:01: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 07:01: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 07:01: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 07:01: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 07:01: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 07:01:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:01:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:01: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 07:01: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 07:01: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 07:01: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 07:01: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 07:01: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 07:01:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:01: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 07:01: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 07:01: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 07:01: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 07:01: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 07:01: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 07:01:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:01:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:01:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:01:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:01:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:01:13 INFO - no previously-included directories found matching 'docs/_build' 07:01:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:01:13 INFO - Running setup.py install for pep8 07:01:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:01:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:01:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:01:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:01:13 INFO - no previously-included directories found matching 'docs/_build' 07:01:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:01:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:01:13 INFO - Cleaning up... 07:01:13 INFO - Return code: 0 07:01:13 INFO - Running post-action listener: _resource_record_post_action 07:01:13 INFO - Running post-action listener: _start_resource_monitoring 07:01:13 INFO - Starting resource monitoring. 07:01:13 INFO - ##### 07:01:13 INFO - ##### Finished create-virtualenv step (success) 07:01:13 INFO - ##### 07:01:13 INFO - ##### 07:01:13 INFO - ##### Running install step. 07:01:13 INFO - ##### 07:01:13 INFO - Running pre-action listener: _resource_record_pre_action 07:01:13 INFO - Running main action method: install 07:01:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:01:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:01:13 INFO - Reading from file tmpfile_stdout 07:01:13 INFO - Detecting whether we're running mozinstall >=1.0... 07:01:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:01:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:01:13 INFO - Reading from file tmpfile_stdout 07:01:13 INFO - Output received: 07:01:13 INFO - Usage: mozinstall [options] installer 07:01:13 INFO - Options: 07:01:13 INFO - -h, --help show this help message and exit 07:01:13 INFO - -d DEST, --destination=DEST 07:01:13 INFO - Directory to install application into. [default: 07:01:13 INFO - "/builds/slave/test"] 07:01:13 INFO - --app=APP Application being installed. [default: firefox] 07:01:13 INFO - mkdir: /builds/slave/test/build/application 07:01: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'] 07:01: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 07:01:30 INFO - Reading from file tmpfile_stdout 07:01:30 INFO - Output received: 07:01:30 INFO - /builds/slave/test/build/application/firefox/firefox 07:01:30 INFO - Running post-action listener: _resource_record_post_action 07:01:30 INFO - ##### 07:01:30 INFO - ##### Finished install step (success) 07:01:30 INFO - ##### 07:01:30 INFO - ##### 07:01:30 INFO - ##### Running run-tests step. 07:01:30 INFO - ##### 07:01:30 INFO - Running pre-action listener: _resource_record_pre_action 07:01:30 INFO - Running main action method: run_tests 07:01:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:01:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:01:30 INFO - Python 2.7.3 07:01:30 INFO - Return code: 0 07:01:30 INFO - grabbing minidump binary from tooltool 07:01:30 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')]} 07:01:30 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 0x17f51c0>, '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 0x17f60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f6550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:01:30 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 07:01:30 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 07:01:30 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 07:01:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:01:30 INFO - Return code: 0 07:01:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:01:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:01:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:01:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:01:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:01:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:01:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:01:31 INFO - Return code: 0 07:01:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 07:01:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 07:01:31 INFO - Using env: {'DISPLAY': ':0', 07:01:31 INFO - 'HOME': '/home/cltbld', 07:01:31 INFO - 'LANG': 'en_US.UTF-8', 07:01:31 INFO - 'LANGUAGE': 'en_US:en', 07:01:31 INFO - 'LOGNAME': 'cltbld', 07:01:31 INFO - 'MAIL': '/var/mail/cltbld', 07:01:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:01:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:01:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:31 INFO - 'MOZ_NO_REMOTE': '1', 07:01:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:01:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:31 INFO - 'NO_EM_RESTART': '1', 07:01:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:01:31 INFO - 'PWD': '/builds/slave/test', 07:01:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:01:31 INFO - 'SHELL': '/bin/bash', 07:01:31 INFO - 'SHLVL': '1', 07:01:31 INFO - 'TERM': 'linux', 07:01:31 INFO - 'TMOUT': '86400', 07:01:31 INFO - 'USER': 'cltbld', 07:01:31 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465307526.595883-331799599', 07:01:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:31 INFO - '_': '/tools/buildbot/bin/python'} 07:01:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 07:01:31 INFO - mozversion application_buildid: 20160607043100 07:01:31 INFO - mozversion application_changeset: 448365b11e377ebf1c572d54e45bbd36c45af03a 07:01:31 INFO - mozversion application_display_name: Nightly 07:01:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:01:31 INFO - mozversion application_name: Firefox 07:01:31 INFO - mozversion application_remotingname: firefox 07:01:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:01:31 INFO - mozversion application_vendor: Mozilla 07:01:31 INFO - mozversion application_version: 50.0a1 07:01:31 INFO - mozversion platform_buildid: 20160607043100 07:01:31 INFO - mozversion platform_changeset: 448365b11e377ebf1c572d54e45bbd36c45af03a 07:01:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:01:31 INFO - mozversion platform_version: 50.0a1 07:01:31 INFO - using testdate: 1465308091 07:01:31 INFO - actual date: 1465308091 07:01:31 INFO - starting webserver on 'localhost:54736' 07:01:31 INFO - SUITE-START | Running 2 tests 07:01:31 INFO - TEST-START | dromaeo_css 07:01:31 INFO - operating with platform_type : linux_ 07:01:31 INFO - Initialising browser for dromaeo_css test... 07:01:31 INFO - TEST-INFO | started process 21716 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP1FiCF/profile http://localhost:54736/getInfo.html) 07:01:36 INFO - PROCESS | 21716 | __metrics Screen width/height:1600/1200 07:01:36 INFO - PROCESS | 21716 | colorDepth:24 07:01:36 INFO - PROCESS | 21716 | Browser inner width/height: 1024/697 07:01:36 INFO - PROCESS | 21716 | __metrics 07:01:36 ERROR - PROCESS | 21716 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 07:01:37 INFO - TEST-INFO | 21716: exit 0 07:01:37 INFO - Browser initialized. 07:01:37 INFO - Running cycle 1/1 for dromaeo_css test... 07:01:37 INFO - TEST-INFO | started process 21840 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP1FiCF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:01:49 INFO - PROCESS | 21840 | RSS: Main: 167006208 07:01:49 INFO - PROCESS | 21840 | 07:02:38 INFO - PROCESS | 21840 | 1465308158957 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] 07:04:46 INFO - PROCESS | 21840 | Cycle 1(1): loaded http://localhost:54736/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54736/tests/dromaeo/cssquery-ext.html) 07:04:47 INFO - PROCESS | 21840 | RSS: Main: 170688512 07:04:47 INFO - PROCESS | 21840 | 07:07:49 INFO - PROCESS | 21840 | Cycle 1(1): loaded http://localhost:54736/tests/dromaeo/cssquery-ext.html (next: http://localhost:54736/tests/dromaeo/cssquery-jquery.html) 07:07:50 INFO - PROCESS | 21840 | RSS: Main: 169693184 07:07:50 INFO - PROCESS | 21840 | 07:10:52 INFO - PROCESS | 21840 | Cycle 1(1): loaded http://localhost:54736/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54736/tests/dromaeo/cssquery-mootools.html) 07:10:52 INFO - PROCESS | 21840 | RSS: Main: 171409408 07:10:52 INFO - PROCESS | 21840 | 07:13:54 INFO - PROCESS | 21840 | Cycle 1(1): loaded http://localhost:54736/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54736/tests/dromaeo/cssquery-prototype.html) 07:13:55 INFO - PROCESS | 21840 | RSS: Main: 168488960 07:13:55 INFO - PROCESS | 21840 | 07:16:57 INFO - PROCESS | 21840 | Cycle 1(1): loaded http://localhost:54736/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54736/tests/dromaeo/cssquery-yui.html) 07:16:58 INFO - PROCESS | 21840 | RSS: Main: 169930752 07:16:58 INFO - PROCESS | 21840 | 07:20:00 INFO - PROCESS | 21840 | Cycle 1(1): loaded http://localhost:54736/tests/dromaeo/cssquery-yui.html (next: http://localhost:54736/tests/dromaeo/cssquery-dojo.html) 07:20:01 INFO - PROCESS | 21840 | RSS: Main: 171929600 07:20:01 INFO - PROCESS | 21840 | 07:20:01 INFO - PROCESS | 21840 | __start_tp_report 07:20:01 INFO - PROCESS | 21840 | _x_x_mozilla_page_load 07:20:01 INFO - PROCESS | 21840 | _x_x_mozilla_page_load_details 07:20:01 INFO - PROCESS | 21840 | |i|pagename|runs| 07:20:01 INFO - PROCESS | 21840 | |0;dojo.html;3141.7172454479096;3184;3191.617005959285;3198.1045307313952;3223.403670320991;5315.840524784253;5399.649022813514;5423.783048678053;5475.6440831345935;5479.753411096501;5258.973705131469;5327.946720532794;5381.058314794905;5398.865028374293;5501.587380946435;4822.662413631038;4842.44311904132;4918.016396720653;4986.551210391064;5012.9749351253195;982.9195474728353;4812.278158276252;4863.19757240055;4902.3626928499425;4960.776765045582;4879.33496176826;4897.559219670229;4919.163742163841;4926.852194434173;4932.7780249888665;4938.777755000998;4944.35723355965;4949.975250123763;4969.229769385751;4974.403071631391;4827.613790896755;4860.343853579757;4891.315215869781;4912.435069966964;4913.410390753097;5187.325647665817;5303.893922121574;5313.495217954288;5327.573794096502;5349.465053494659;5594.636348637326;5763.827085187451;5775.3935836736955;5789.507891829157;5794.304683437972;5842.298924129089;5888.5877988540815;5902.734376953047;5907.054871220584;5956.821295361103;5403.756830942617;5428.321459817523;5461.836144915619;5467.261919640838;5469.808556700496;5770.913436298459;5864.296284445893;5866.266716660418;6017.2779266488305;6062.848428789315;5648.8870222595315;5684.8010319638615;5694.886102277931;5705.600607957486;5707.6290041147195;5741.024025915604;5824.271966004249;5840.912386314209;5853.678047707332;5855.209546711225;5704.201411802351;5731.885362292731;5822.82531524055;5831.067029275296;5839.270091238595;5751.8562035949435;5796.565257605696;5801.709914504342;5808.912866307009;5858.062709966385;4463.174312752151;4467.530909254547;4472.552744725502;4479.574440428154;4489.438820147481;3878.786666733357;3944.447777311179;3964.643182113566;3980.422838688432;3993.4209539617173;5566.415526369754;5575.191597218381;5592.916106258409;5643.717814109278;5675.1487276907965;5829.94170058294;5865.4134586541;5869.53043756507;5875.735591898289;5894.351621321651;5434.456554344613;5498.065328894098;5540.833774986757;5547.833564992976;5578.135389014709;4998.825041123543;5004.224345226496;5004.799808007711;5020.849374518771;5090.974545127251;5893.499052580579;6010.849728756816;6012.909806352908;6026.9095963560585;6039.939600604026;5839.445252701072;5865.677387743715;5878.118282257696;5906.557008224487;5943.405659434022;6158.04550294705;6163.3836616338;6172.290186628596;6175.166352542349;6181.35095814933;5529.087700529368;5633.971830140823;5737.483626473638;5742.310922689304;5750.0512415450985;5736;5737.540996720336;5740.339860916049;5747.971260143672;5801.1878337033695;5594.356648985418;5635.971820140873;5644.379118297066;5654.773809047592;5668.51817595509;5481.972590137183;5589.469000444951;5612.298462692163;5634.211210430625;5654.46282603152;5584.497395234448;5620.887582248414;5625.662460252398;5629.211910332475;5660.801871934463;5738.512226460798;5751.079827227623;5754.539636829128;5759.798407055733;5762.279715035621;5435.891282174255;5582.27430434041;5626.971865140648;5636.4927156556105;5656.830295091154 07:20:01 INFO - PROCESS | 21840 | |1;ext.html;575.9460187856223;619.0157649337553;625.0811307378156;639.0286764118541;656.9802905912825;36701.26597468049;41011.38482922759;41286.38070428938;41526;41596.37605435917;43126.137477250515;43164.784176079076;43501.34747978783;43915;43922.34116488247;8526;8678.609462574168;8688.869666955;8707.825843483126;8720.084391138902;8649.178328058824;8672.8699069514;8724.607392667345;8727.301815854717;8754.430961987482;8703.825923481527;8713.520756358397;8786.956065219665;8811.77970550735;8824.117588241188;8698.47809131451;8753.737387878375;8759.781005474882;8773.210411063003;8793.20861122502;8572.357073219533;8627.137286271385;8645.783855403603;8665.306775457948;8667.306615470747;33208.833955830065;39840;40232.195356093005;40302.19395612101;40511.7974410129;3259.282957749291;3511;3538.31002954424;3662.212624285765;3684.889453316405;32640.83679581587;33386;33446.33107337864;33478.497822532685;34150.82924585361;4294.592013758688;4365.825366985317;4385.868423947287;4556.838006308403;4567.771611419449;347968;355666;356699;356964;357879;55406;61569;63312.366876331565;63316.68341658262;69686;68796.312036879;69054.65472672605;69182;69275.3072469279;69599.65200173967;17040.914795425942;17395.217215225344;17468.825311746976;17576.209070591853;17593.29626814913;12707.364631768374;12794.872051279368;12811.871881281255;12921;12995.675108122183;20337.79662203359;20733.377998660064;20816.687749683766;20907.47731306699;20946.581068378546;7235.819104522324;7567.583782891994;7660.5403675779635;7725.575093369806;7732.8383678111895;937.7749340158313;1154.7344110854551;1156.2253290295523;1178.3460179600404;1184.4551506307196;32560.348793024008;32977.67022329746;33099.50350744741;33221.66778332186;33752.66247337544;1101.2291396022815;1131.5417256011328;1147.8794726553758;1231.7967535356565;1238.5169783784331;15945.840541594667;16425.1787410629;16515.504534863972;16619.83380166207;16675.24961376741;557913;560252;561146;563043;564171;54650;56057;56130.719346403006;56144.719276404176;56170.15744763832;1377.1324065838658;1380.9585712428843;1386.8627725265185;1388.7014291927285;1394.5328315014583;29531.409371812013;30307.848460757556;30811.987309430093;30900;31039.68960310368;49462.75268623634;50512;50519.74740126276;50568.49431505638;50580.747096264284;511503;514412;515758;516414;516594;27821.582676260277;28231.57652635253;28272.43455130927;28381;28394.290142746595;44816;47022.29466557936;47440.28839567478;48099;48479.75760121177;40822.387664185655;40995.590044099175;41695.42924405995;42331.7883410581;42555.3616695756;40467.59532404756;40492.39261411022;40653.796731016155;41165;41338.379924301764;40940.79529602333;41753.373699393924;42540.787296063325;42773.71678849639;44655.55344446644;33889;37056;37821.43267851039;39955;40000.799995999834;28587.28531786722;28620.856895715388;29000;29235.122946311643;29279.707202927697 07:20:01 INFO - PROCESS | 21840 | |2;jquery.html;384.8383678854881;390.7987386495955;391.3738019169328;394.1820722001847;410.9137081212945;17553.385631502882;18295.451136465894;19221.903890480564;19240.23039078437;19362.12870420831;17838.464846054638;17945;18109;19172.616547669037;19300.420987370366;5468.945310546903;5486.725663716808;5675.404082571333;5714.114312281582;5792.71036448178;5689.943100568983;5710.428957104298;5713.228714123582;5730.742116604742;5778.624389414675;6512.1208636834135;6525.4779617630475;6555.836104097388;6561.376669216417;6597.769078082268;6230.096635987779;6515.185601799775;6515.218173819125;6525.412712855842;6541.116949211843;5741.110127930177;5777.613372790542;5787.942120578825;5795.362510123883;5805.651660900317;13036.41336139876;13873.09824861391;13913.373898174606;13954.58136255914;13965.79051314231;2201.8458707890454;2211.48162314407;2297.5404919016264;2313.4447732544068;2757.5863620457094;9243.584038718274;9621.374610650355;9738.367006144577;11495.712607184803;14445.638859028504;1908.8663793534458;1924.2399252295265;1982.2071171531359;1988.9900550497155;2005.6991451282279;79328.60335698284;81317.59341203255;81654.59172704158;82114;83020.16979830185;10295.176385889261;10580.788384232272;10715.303505272132;10870.945645271722;11126.165537584713;15341.309641065956;15392.615184620474;15405;15410.845891540941;15417.845821541865;7800.609969501502;7861.567613781297;7957.323627491728;8047.195280472023;8101.392395570356;7043.612601306875;7131.429485641136;7142.250063743336;7235.710571577078;7610.847783044419;4559.931601025987;4734.479207287196;4751.073540659608;4781.737004464719;4877.853704379468;1895.876768010075;1961.8822870627807;1979.4358607796996;1984.5237143085556;2022.8685135466148;962.7496850818698;1045.4720366215165;1081.3457857995957;1099.7855418193535;1113.8607674040745;18204.726929096076;18707.438776836716;18885.772424792343;18911.905440472983;19420.902895485433;971.6842026341467;1037.6731329631143;1050.579768092769;1077.9407132607782;1083.9945800270948;10601.204909631655;10910.127189824794;10923.836142457869;10959.342439453658;11015.614453494089;550338;568339;568450;569092;572602;94338;94963.52518237365;95668.52165739126;95947.52026239964;97026.51486742521;990.2424645146468;1010.5604062232806;1019.9337043092323;1039.1323245090282;1043.337480699761;16615.750763738313;16807.579810504834;16888.324467021674;17107.743383849003;17336.826631733522;38582;39394.01514962149;39521.60478395294;40514;41125;59567;59729.40270597238;60083.699581501816;60145;60694.393056068875;8075.475094118863;8372.455790373606;8566.229039386486;8584.270337021173;8733.475991440533;9321.580528876353;11721.41392930333;11748.29510229389;12943.02927280439;13346.06577539563;11217.831732524182;11336;11474.311541307214;11672.649820505398;11783.941080294544;11002.614908478485;11332.603358882729;11496.770064598828;11635.76728465409;11734.002609778265;5993.670348130895;9335.833020872391;11414.258073225214;11927.403629818647;11977.401129943642;8415.70545030921;8518.574071296534;8537.487750734976;8648.740537783877;8779.25376343018;10523.368597884151;10741.194410419093;11113.110951124052;11116.277441966246;11560.190786644855 07:20:01 INFO - PROCESS | 21840 | |3;mootools.html;1537.8462153784624;1548.527699051789;1728.3691452619798;1791.9014454205014;1853.4810253129128;7600.88598671019;8533.189347012023;8691.782705432368;9252.722418327452;9284.90715092849;8514.191151840581;8654.524001179932;8774.254188393994;8875.289976801856;8881.555922203881;2294.7819957104048;2345.8240631952585;2346.108478778062;2352.9882350588223;2354.9764502355015;2310.4339436838;2347.8708671023173;2365.8343915925893;2370.265217782493;2371.134535894395;2329.8369114162015;2331.755165707602;2352.470694093832;2355.1639168095335;2367.964480532785;2251.977480225193;2259.9774002260096;2277.032261288954;2282.2696737044234;2324.407276144589;2246.6854640350366;2248.347979086063;2248.5502899420017;2253.8873056347115;2253.954920901589;8834.779130521723;8892.15524525169;8912.64349426022;8927.151920567601;8934.195922367018;5260.447652996457;5332.3601167859715;5339.813106541253;5375.43557926416;5378.408375078739;3381.408253555618;3418.7265018798685;3586.910327241814;3624.9275014499563;3626.202235508184;1129.2716198052292;1169.625719769674;1170.7190274334184;1195.6891208285822;1198.2091819399243;12409.317487538181;12587.118901676886;12602.55891043809;12724.745505089939;12773.936130319289;4537.115262523842;4609.124266389375;4721.763911804396;4725.763711814464;4787.497312782178;10802.297850639683;10827.24209305341;10831.566737330577;10840.945795270973;10864.619738309279;5357.223202635674;5402.6758394496455;5439.211314359396;5444.945550544444;5447.754851031713;4240.957590424118;4764.190087685102;4934.753262336869;4946.554810067111;4965.155923492943;3951.8616848410165;3991.980040099781;4017.276890159741;4103.651189648854;4147.751134931914;1237.0907383073434;1263.3051821498138;1270.8030255310257;1273.8471383434048;1282.3716378974236;888.8044630181349;910.8360495110944;914.3508109242513;929.330881765128;931.9970725732993;6191.133241346215;6295.842603934847;6354.809355719336;6458.321876203025;6508.544401891822;456.8789270843229;471.2671795358251;475.643267549338;477.3698717692682;480.58909632264607;4061.147159096564;4161.063760653889;4176.937345939813;4178.540360560336;4255.872323830228;10814.513346899408;11084.944575277234;11255.718607034725;11316.038136758303;11317.320960742381;10903.563857445772;11003.504842282116;11056.668299951014;11166.888331116746;11277.097832173406;8348.66605335792;8365.665373384996;8421.957890210631;8435.156484351515;8457.53483558398;6065.636061836304;6157.1072194532435;6165.568410211422;6331.05034244867;6390.616563006234;9788.559514821707;10060.597576096874;10227.181825453798;10490.685279441628;10495;10445.373277603368;10564.683059508227;10673.679789606324;10708.946455267675;10784.352938823695;6754.358335958076;7483.176850546327;7606.04924384452;7806.570638614704;8059.919400805917;8745.825083498166;8765.298776097768;8777.210051095431;8846.95576522139;8853.203211710977;7485.588292643957;7700.537967721954;7874.56689882062;7965.402594805529;8098.554579497949;7604.8479030420185;7774.144844067035;7788.376929845485;7788.649510772142;8132.715354962548;6942.444604431735;7047.260037695968;7062.435005199674;7078.1506219254015;7111.43108551325;5254.842354729364;5323.707196104251;5385.3268341457315;5455.972720136374;5458.153986132156;5067.41724701664;5077.086124497626;5119.48805119485;5174.275601415729;5209.374875015023 07:20:01 INFO - PROCESS | 21840 | |4;prototype.html;328.58269997103696;339.4875828185434;339.7384014308982;340.1292690711778;346.54602470763285;5355.607542039069;5432;5508.531774799142;5612.66324020559;5618.241537392456;5472.097103977839;5496.0931446311415;5516.503514683678;5517.724113794315;5525.696086715229;4287.614114729674;4313.223619748444;4319.848805291816;4337.178385078275;4341.39220509129;4177.871974566865;4340.131973605276;4340.891477713067;4341.305391137403;4354.281543545311;4230.323148296273;4262.126264115849;4264.33902745075;4286.314189729644;4300.290452075404;4277.337012763011;4285.335772955197;4291.9570804292025;4311.8059687313835;4320.546342634041;3551.5383000210068;3826.545912553212;3834.482344883433;3856.1709232515145;3856.3444214483607;5325.360956685223;5344.690550815037;5347.598930080259;5349.491798279158;5368.570514358881;4883.12103821312;4887.511248875084;4907.730074845882;4934.432540257881;4946.233333833262;5531.170324451325;5767.538596912237;5772.9711351442975;5795.536357091422;5805.5065319447895;4077.1641813428178;4083.6528895043957;4088.9795551022053;4106.281400754856;4107.568705285932;6033.42682445167;6050.183225264577;6071.757129714806;6090.5736598438125;6107.725152368154;4140.772257525805;4160.895977600584;4194.224068547329;4204.66362690984;4238.427812245307;4235.597618226264;4239.703220774578;4242.342436922282;4257.531671516131;4264.552222016706;4883.218685010453;4894.975525122423;4900.26496025599;4900.705957642482;4901.877453063702;5560.193771903051;5816.88366232673;5836.766529338779;5850;5866.266716660418;1459.4381163252224;1472.2859413184597;1472.6539263273123;1476.217604669527;1477;935.3873213045466;941.9011003844498;943.7121677888173;956.3592393096642;963.6482683820495;5038.470960549163;5051.419086804991;5062.341895553554;5089.821856235014;5115.232715092766;5265.708931917551;5280.419153893069;5286.497782710637;5291.603129765283;5419.430959749248;5046.772895219724;5071.340725705634;5081.662435279813;5284.286621306152;5746.109353050284;3164.730997865161;3167.0182243504587;3176.396484667952;3182.315802102513;3188.8883889064236;6029.849253768691;6196.628202307876;6210.223722034746;6220.502359811204;6251.468625166912;6036;6056.273247210363;6129.548180727656;6134.938650613437;6163.876722465526;6169.413905678954;6205.937940620626;6225.595336303126;6252.812415627538;6260.123582698517;5783.8554036149435;5957.314908785545;5973.223480947449;5979.850503737442;5988.640681559121;5824.708764561839;5860.501857342174;5924.763009479572;5931.258592675916;5940.287165540163;6074.848128796815;6203.534734894811;6232.158658581215;6232.25212974446;6251.937480625135;4136.400221967858;4171.541130475706;4172.186423647359;4201.285781417106;4228.556001619786;5936.168936349001;6010.759569617341;6033.577649564489;6061.575689701678;6084.178635884276;5544.500994910478;5780.94219057804;5822.883542329215;5839.459834971801;5861.677607731445;5822.796202132905;5835.7373918174635;5839.620424672383;5854.502367298657;5861.472467477947;5588.86027849307;5675.2406753906425;5722.540752108186;5749.453801888814;5750.683712395691;5817.418258174149;5860.443257890493;5871.383504731942;5885.733417953077;5918.940810592011;5736.246601631157;5752.626079305;5754.251947246831;5759.531319513498;5764.279465066867 07:20:01 INFO - PROCESS | 21840 | |5;yui.html;737.7823542055097;781.5740421470298;814.4380377539501;818.1532114261738;840.096895836975;14470.638234044141;14665.560033199008;14671.853281467182;14706.705865882675;15147.166905820175;14544.345504452298;14697.77953330701;14804.185769782685;14813.407463701466;14834.851651483483;680.2890978927021;792.2236208515658;819.1480859905691;822.5763731678161;824.814416756231;799.9880001799949;803.333233416263;805.8549461097;806.6612022950375;809.5587904591982;860.1785295043219;862.0861886400436;862.3101518784978;863.8013256950906;863.9740807775777;853.4111463090447;857.7341024282492;858.026140330726;860.6213266162931;860.7589874835056;618.6164577961692;618.6968385491122;621.6332363905273;622.3745136138198;623.5292354272541;14294.428222871073;14300.356483958247;14330.785038224434;14331.996760226788;14369.137851728825;14576.635584110376;14960.177190254532;15100.697986040328;15274.15992120433;15363.385464581403;12261.570845020382;12298;12360.505579776798;12520.186187897758;12554.121211515198;3817.2938006468894;3867.671247943928;3948.309045916953;4035.7376770509823;4042.151148258869;72117.27882721211;73100;73656;74034.62982685106;78311.21688783153;11861.881381186251;11884.227525210834;11928.46321915516;12077.516899324104;12199.512019519298;22874.771252287595;23008.309750707507;23036.424089397566;23083.614983101066;23084.422889427562;8398.076211616717;8409.579521024047;8654.22112009922;8667;8912.108789121166;4814.15752243356;4817.566419022235;4912.164931961575;4956.553910148032;5163.380394352702;3607.1703508192736;3715.925681486355;3735.701143908481;3749.5875453700073;3754.6808521276;607.5413063137391;615.4211479286414;623.0591806372411;637.6492928889093;640.1773720768883;636.4526507203893;702.884024136022;709.4395427612128;736.988945165823;745.9776206713807;8203.75388738327;8290.170982901782;8292.212239837327;8315.251627353568;8651.091635378194;669.5313280703527;700.2962023166787;709.5454318646754;718.4755128756037;725.26747984536;3656.1773600939578;3737.495438115874;4061.614146656063;4180;4298.677599180011;92053;107252;108125.45937270421;109071.45464272628;113853;64036;73630.2636973634;91508.54245728729;96506;97436.51281743546;84319.5784021076;85030.57484712538;85564.14435855686;85569.57215213885;85712.14287857166;9183.265338773015;9527;9555.713328600154;9562.521873906138;9693.6122555097;49480;50508.747456262485;50729.49270507248;51747.48252517577;52320.215196771314;64767.35232647613;71178;72489;72700;72765;12624;12648;13880.305984700926;13894.561118480597;14005.229712365917;14673.70652586921;14756.63108422298;14890.627734306729;15188.848111518744;15868.841311586737;12895.41970611306;13277.40251688657;13317.467301308227;13879.167249965034;14011.649708757363;12728.1726687765;13148.34258287101;13442.596722098353;13445.193288402726;13749.793753093913;12684.492620295085;12970.67573310637;13117.60647180586;13237.205767653972;13252.536161234311;10893.618723344645;11302.886971130183;11451;11462.598809041643;11535.423228838357;10731.839022414513;11116.444177790916;11344.9432752839;11462;11535.423228838692 07:20:01 INFO - PROCESS | 21840 | __end_tp_report 07:20:01 INFO - PROCESS | 21840 | __start_cc_report 07:20:01 INFO - PROCESS | 21840 | _x_x_mozilla_cycle_collect,348 07:20:01 INFO - PROCESS | 21840 | __end_cc_report 07:20:01 INFO - PROCESS | 21840 | __startTimestamp1465309201147__endTimestamp 07:20:01 INFO - PROCESS | 21840 | 07:20:01 INFO - PROCESS | 21840 | ------- Summary: start ------- 07:20:01 INFO - PROCESS | 21840 | Number of tests: 6 07:20:01 INFO - PROCESS | 21840 | 07:20:01 INFO - PROCESS | 21840 | [#0] dojo.html Cycles:165 Average:5372.23 Median:5625.66 stddev:704.71 (12.5%) stddev-sans-first:684.81 07:20:01 INFO - PROCESS | 21840 | Values: 3141.7 3184.0 3191.6 3198.1 3223.4 5315.8 5399.6 5423.8 5475.6 5479.8 5259.0 5327.9 5381.1 5398.9 5501.6 4822.7 4842.4 4918.0 4986.6 5013.0 982.9 4812.3 4863.2 4902.4 4960.8 4879.3 4897.6 4919.2 4926.9 4932.8 4938.8 4944.4 4950.0 4969.2 4974.4 4827.6 4860.3 4891.3 4912.4 4913.4 5187.3 5303.9 5313.5 5327.6 5349.5 5594.6 5763.8 5775.4 5789.5 5794.3 5842.3 5888.6 5902.7 5907.1 5956.8 5403.8 5428.3 5461.8 5467.3 5469.8 5770.9 5864.3 5866.3 6017.3 6062.8 5648.9 5684.8 5694.9 5705.6 5707.6 5741.0 5824.3 5840.9 5853.7 5855.2 5704.2 5731.9 5822.8 5831.1 5839.3 5751.9 5796.6 5801.7 5808.9 5858.1 4463.2 4467.5 4472.6 4479.6 4489.4 3878.8 3944.4 3964.6 3980.4 3993.4 5566.4 5575.2 5592.9 5643.7 5675.1 5829.9 5865.4 5869.5 5875.7 5894.4 5434.5 5498.1 5540.8 5547.8 5578.1 4998.8 5004.2 5004.8 5020.8 5091.0 5893.5 6010.8 6012.9 6026.9 6039.9 5839.4 5865.7 5878.1 5906.6 5943.4 6158.0 6163.4 6172.3 6175.2 6181.4 5529.1 5634.0 5737.5 5742.3 5750.1 5736.0 5737.5 5740.3 5748.0 5801.2 5594.4 5636.0 5644.4 5654.8 5668.5 5482.0 5589.5 5612.3 5634.2 5654.5 5584.5 5620.9 5625.7 5629.2 5660.8 5738.5 5751.1 5754.5 5759.8 5762.3 5435.9 5582.3 5627.0 5636.5 5656.8 07:20:01 INFO - PROCESS | 21840 | 07:20:01 INFO - PROCESS | 21840 | [#1] ext.html Cycles:180 Average:63529.13 Median:41561.19 stddev:128997.52 (310.4%) stddev-sans-first:129272.80 07:20:01 INFO - PROCESS | 21840 | Values: 575.9 619.0 625.1 639.0 657.0 36701.3 41011.4 41286.4 41526.0 41596.4 43126.1 43164.8 43501.3 43915.0 43922.3 8526.0 8678.6 8688.9 8707.8 8720.1 8649.2 8672.9 8724.6 8727.3 8754.4 8703.8 8713.5 8787.0 8811.8 8824.1 8698.5 8753.7 8759.8 8773.2 8793.2 8572.4 8627.1 8645.8 8665.3 8667.3 33208.8 39840.0 40232.2 40302.2 40511.8 3259.3 3511.0 3538.3 3662.2 3684.9 32640.8 33386.0 33446.3 33478.5 34150.8 4294.6 4365.8 4385.9 4556.8 4567.8 347968.0 355666.0 356699.0 356964.0 357879.0 55406.0 61569.0 63312.4 63316.7 69686.0 68796.3 69054.7 69182.0 69275.3 69599.7 17040.9 17395.2 17468.8 17576.2 17593.3 12707.4 12794.9 12811.9 12921.0 12995.7 20337.8 20733.4 20816.7 20907.5 20946.6 7235.8 7567.6 7660.5 7725.6 7732.8 937.8 1154.7 1156.2 1178.3 1184.5 32560.3 32977.7 33099.5 33221.7 33752.7 1101.2 1131.5 1147.9 1231.8 1238.5 15945.8 16425.2 16515.5 16619.8 16675.2 557913.0 560252.0 561146.0 563043.0 564171.0 54650.0 56057.0 56130.7 56144.7 56170.2 1377.1 1381.0 1386.9 1388.7 1394.5 29531.4 30307.8 30812.0 30900.0 31039.7 49462.8 50512.0 50519.7 50568.5 50580.7 511503.0 514412.0 515758.0 516414.0 516594.0 27821.6 28231.6 28272.4 28381.0 28394.3 44816.0 47022.3 47440.3 48099.0 48479.8 40822.4 40995.6 41695.4 42331.8 42555.4 40467.6 40492.4 40653.8 41165.0 41338.4 40940.8 41753.4 42540.8 42773.7 44655.6 33889.0 37056.0 37821.4 39955.0 40000.8 28587.3 28620.9 29000.0 29235.1 29279.7 07:20:01 INFO - PROCESS | 21840 | 07:20:01 INFO - PROCESS | 21840 | [#2] jquery.html Cycles:180 Average:30838.11 Median:1571.21 stddev:93073.18 (5923.7%) stddev-sans-first:93306.19 07:20:01 INFO - PROCESS | 21840 | Values: 384.8 390.8 391.4 394.2 410.9 17553.4 18295.5 19221.9 19240.2 19362.1 17838.5 17945.0 18109.0 19172.6 19300.4 5468.9 5486.7 5675.4 5714.1 5792.7 5689.9 5710.4 5713.2 5730.7 5778.6 6512.1 6525.5 6555.8 6561.4 6597.8 6230.1 6515.2 6515.2 6525.4 6541.1 5741.1 5777.6 5787.9 5795.4 5805.7 13036.4 13873.1 13913.4 13954.6 13965.8 2201.8 2211.5 2297.5 2313.4 2757.6 9243.6 9621.4 9738.4 11495.7 14445.6 1908.9 1924.2 1982.2 1989.0 2005.7 79328.6 81317.6 81654.6 82114.0 83020.2 10295.2 10580.8 10715.3 10870.9 11126.2 15341.3 15392.6 15405.0 15410.8 15417.8 7800.6 7861.6 7957.3 8047.2 8101.4 7043.6 7131.4 7142.3 7235.7 7610.8 4559.9 4734.5 4751.1 4781.7 4877.9 1895.9 1961.9 1979.4 1984.5 2022.9 962.7 1045.5 1081.3 1099.8 1113.9 18204.7 18707.4 18885.8 18911.9 19420.9 971.7 1037.7 1050.6 1077.9 1084.0 10601.2 10910.1 10923.8 10959.3 11015.6 550338.0 568339.0 568450.0 569092.0 572602.0 94338.0 94963.5 95668.5 95947.5 97026.5 990.2 1010.6 1019.9 1039.1 1043.3 16615.8 16807.6 16888.3 17107.7 17336.8 38582.0 39394.0 39521.6 40514.0 41125.0 59567.0 59729.4 60083.7 60145.0 60694.4 8075.5 8372.5 8566.2 8584.3 8733.5 9321.6 11721.4 11748.3 12943.0 13346.1 11217.8 11336.0 11474.3 11672.6 11783.9 11002.6 11332.6 11496.8 11635.8 11734.0 5993.7 9335.8 11414.3 11927.4 11977.4 8415.7 8518.6 8537.5 8648.7 8779.3 10523.4 10741.2 11113.1 11116.3 11560.2 07:20:01 INFO - PROCESS | 21840 | 07:20:01 INFO - PROCESS | 21840 | [#3] mootools.html Cycles:180 Average:5900.10 Median:2600.70 stddev:3398.85 (130.7%) stddev-sans-first:3392.57 07:20:01 INFO - PROCESS | 21840 | Values: 1537.8 1548.5 1728.4 1791.9 1853.5 7600.9 8533.2 8691.8 9252.7 9284.9 8514.2 8654.5 8774.3 8875.3 8881.6 2294.8 2345.8 2346.1 2353.0 2355.0 2310.4 2347.9 2365.8 2370.3 2371.1 2329.8 2331.8 2352.5 2355.2 2368.0 2252.0 2260.0 2277.0 2282.3 2324.4 2246.7 2248.3 2248.6 2253.9 2254.0 8834.8 8892.2 8912.6 8927.2 8934.2 5260.4 5332.4 5339.8 5375.4 5378.4 3381.4 3418.7 3586.9 3624.9 3626.2 1129.3 1169.6 1170.7 1195.7 1198.2 12409.3 12587.1 12602.6 12724.7 12773.9 4537.1 4609.1 4721.8 4725.8 4787.5 10802.3 10827.2 10831.6 10840.9 10864.6 5357.2 5402.7 5439.2 5444.9 5447.8 4241.0 4764.2 4934.8 4946.6 4965.2 3951.9 3992.0 4017.3 4103.7 4147.8 1237.1 1263.3 1270.8 1273.8 1282.4 888.8 910.8 914.4 929.3 932.0 6191.1 6295.8 6354.8 6458.3 6508.5 456.9 471.3 475.6 477.4 480.6 4061.1 4161.1 4176.9 4178.5 4255.9 10814.5 11084.9 11255.7 11316.0 11317.3 10903.6 11003.5 11056.7 11166.9 11277.1 8348.7 8365.7 8422.0 8435.2 8457.5 6065.6 6157.1 6165.6 6331.1 6390.6 9788.6 10060.6 10227.2 10490.7 10495.0 10445.4 10564.7 10673.7 10708.9 10784.4 6754.4 7483.2 7606.0 7806.6 8059.9 8745.8 8765.3 8777.2 8847.0 8853.2 7485.6 7700.5 7874.6 7965.4 8098.6 7604.8 7774.1 7788.4 7788.6 8132.7 6942.4 7047.3 7062.4 7078.2 7111.4 5254.8 5323.7 5385.3 5456.0 5458.2 5067.4 5077.1 5119.5 5174.3 5209.4 07:20:01 INFO - PROCESS | 21840 | 07:20:01 INFO - PROCESS | 21840 | [#4] prototype.html Cycles:180 Average:4847.51 Median:5452.05 stddev:1437.02 (26.4%) stddev-sans-first:1400.45 07:20:01 INFO - PROCESS | 21840 | Values: 328.6 339.5 339.7 340.1 346.5 5355.6 5432.0 5508.5 5612.7 5618.2 5472.1 5496.1 5516.5 5517.7 5525.7 4287.6 4313.2 4319.8 4337.2 4341.4 4177.9 4340.1 4340.9 4341.3 4354.3 4230.3 4262.1 4264.3 4286.3 4300.3 4277.3 4285.3 4292.0 4311.8 4320.5 3551.5 3826.5 3834.5 3856.2 3856.3 5325.4 5344.7 5347.6 5349.5 5368.6 4883.1 4887.5 4907.7 4934.4 4946.2 5531.2 5767.5 5773.0 5795.5 5805.5 4077.2 4083.7 4089.0 4106.3 4107.6 6033.4 6050.2 6071.8 6090.6 6107.7 4140.8 4160.9 4194.2 4204.7 4238.4 4235.6 4239.7 4242.3 4257.5 4264.6 4883.2 4895.0 4900.3 4900.7 4901.9 5560.2 5816.9 5836.8 5850.0 5866.3 1459.4 1472.3 1472.7 1476.2 1477.0 935.4 941.9 943.7 956.4 963.6 5038.5 5051.4 5062.3 5089.8 5115.2 5265.7 5280.4 5286.5 5291.6 5419.4 5046.8 5071.3 5081.7 5284.3 5746.1 3164.7 3167.0 3176.4 3182.3 3188.9 6029.8 6196.6 6210.2 6220.5 6251.5 6036.0 6056.3 6129.5 6134.9 6163.9 6169.4 6205.9 6225.6 6252.8 6260.1 5783.9 5957.3 5973.2 5979.9 5988.6 5824.7 5860.5 5924.8 5931.3 5940.3 6074.8 6203.5 6232.2 6232.3 6251.9 4136.4 4171.5 4172.2 4201.3 4228.6 5936.2 6010.8 6033.6 6061.6 6084.2 5544.5 5780.9 5822.9 5839.5 5861.7 5822.8 5835.7 5839.6 5854.5 5861.5 5588.9 5675.2 5722.5 5749.5 5750.7 5817.4 5860.4 5871.4 5885.7 5918.9 5736.2 5752.6 5754.3 5759.5 5764.3 07:20:01 INFO - PROCESS | 21840 | 07:20:01 INFO - PROCESS | 21840 | [#5] yui.html Cycles:180 Average:19968.44 Median:4864.87 stddev:27909.14 (573.7%) stddev-sans-first:27950.08 07:20:01 INFO - PROCESS | 21840 | Values: 737.8 781.6 814.4 818.2 840.1 14470.6 14665.6 14671.9 14706.7 15147.2 14544.3 14697.8 14804.2 14813.4 14834.9 680.3 792.2 819.1 822.6 824.8 800.0 803.3 805.9 806.7 809.6 860.2 862.1 862.3 863.8 864.0 853.4 857.7 858.0 860.6 860.8 618.6 618.7 621.6 622.4 623.5 14294.4 14300.4 14330.8 14332.0 14369.1 14576.6 14960.2 15100.7 15274.2 15363.4 12261.6 12298.0 12360.5 12520.2 12554.1 3817.3 3867.7 3948.3 4035.7 4042.2 72117.3 73100.0 73656.0 74034.6 78311.2 11861.9 11884.2 11928.5 12077.5 12199.5 22874.8 23008.3 23036.4 23083.6 23084.4 8398.1 8409.6 8654.2 8667.0 8912.1 4814.2 4817.6 4912.2 4956.6 5163.4 3607.2 3715.9 3735.7 3749.6 3754.7 607.5 615.4 623.1 637.6 640.2 636.5 702.9 709.4 737.0 746.0 8203.8 8290.2 8292.2 8315.3 8651.1 669.5 700.3 709.5 718.5 725.3 3656.2 3737.5 4061.6 4180.0 4298.7 92053.0 107252.0 108125.5 109071.5 113853.0 64036.0 73630.3 91508.5 96506.0 97436.5 84319.6 85030.6 85564.1 85569.6 85712.1 9183.3 9527.0 9555.7 9562.5 9693.6 49480.0 50508.7 50729.5 51747.5 52320.2 64767.4 71178.0 72489.0 72700.0 72765.0 12624.0 12648.0 13880.3 13894.6 14005.2 14673.7 14756.6 14890.6 15188.8 15868.8 12895.4 13277.4 13317.5 13879.2 14011.6 12728.2 13148.3 13442.6 13445.2 13749.8 12684.5 12970.7 13117.6 13237.2 13252.5 10893.6 11302.9 11451.0 11462.6 11535.4 10731.8 11116.4 11344.9 11462.0 11535.4 07:20:01 INFO - PROCESS | 21840 | -------- Summary: end -------- 07:20:01 INFO - PROCESS | 21840 | 07:20:01 INFO - TEST-INFO | 21840: exit 0 07:20:01 INFO - TEST-OK | dromaeo_css | took 1110226ms 07:20:01 INFO - TEST-START | kraken 07:20:01 INFO - operating with platform_type : linux_ 07:20:01 INFO - Initialising browser for kraken test... 07:20:01 INFO - TEST-INFO | started process 22080 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxAedgK/profile http://localhost:54736/getInfo.html) 07:20:06 INFO - PROCESS | 22080 | __metrics Screen width/height:1600/1200 07:20:06 INFO - PROCESS | 22080 | colorDepth:24 07:20:06 INFO - PROCESS | 22080 | Browser inner width/height: 1024/697 07:20:06 INFO - PROCESS | 22080 | __metrics 07:20:06 ERROR - PROCESS | 22080 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 07:20:07 INFO - TEST-INFO | 22080: exit 0 07:20:07 INFO - Browser initialized. 07:20:07 INFO - Running cycle 1/1 for kraken test... 07:20:07 INFO - TEST-INFO | started process 22200 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxAedgK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:20:19 INFO - PROCESS | 22200 | RSS: Main: 167657472 07:20:19 INFO - PROCESS | 22200 | 07:20:22 INFO - PROCESS | 22200 | Cycle 1(1): loaded http://localhost:54736/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54736/tests/kraken/driver.html?testName=audio-beat-detection) 07:20:22 INFO - PROCESS | 22200 | RSS: Main: 173273088 07:20:22 INFO - PROCESS | 22200 | 07:20:25 INFO - PROCESS | 22200 | Cycle 1(1): loaded http://localhost:54736/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54736/tests/kraken/driver.html?testName=audio-dft) 07:20:26 INFO - PROCESS | 22200 | RSS: Main: 172089344 07:20:26 INFO - PROCESS | 22200 | 07:20:29 INFO - PROCESS | 22200 | Cycle 1(1): loaded http://localhost:54736/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54736/tests/kraken/driver.html?testName=audio-fft) 07:20:29 INFO - PROCESS | 22200 | RSS: Main: 167301120 07:20:29 INFO - PROCESS | 22200 | 07:20:31 INFO - PROCESS | 22200 | Cycle 1(1): loaded http://localhost:54736/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54736/tests/kraken/driver.html?testName=audio-oscillator) 07:20:32 INFO - PROCESS | 22200 | RSS: Main: 168009728 07:20:32 INFO - PROCESS | 22200 | 07:20:34 INFO - PROCESS | 22200 | Cycle 1(1): loaded http://localhost:54736/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54736/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:20:35 INFO - PROCESS | 22200 | RSS: Main: 168361984 07:20:35 INFO - PROCESS | 22200 | 07:20:38 INFO - PROCESS | 22200 | Cycle 1(1): loaded http://localhost:54736/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54736/tests/kraken/driver.html?testName=imaging-darkroom) 07:20:39 INFO - PROCESS | 22200 | RSS: Main: 168562688 07:20:39 INFO - PROCESS | 22200 | 07:20:42 INFO - PROCESS | 22200 | Cycle 1(1): loaded http://localhost:54736/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54736/tests/kraken/driver.html?testName=imaging-desaturate) 07:20:43 INFO - PROCESS | 22200 | RSS: Main: 166596608 07:20:43 INFO - PROCESS | 22200 | 07:20:46 INFO - PROCESS | 22200 | Cycle 1(1): loaded http://localhost:54736/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54736/tests/kraken/driver.html?testName=json-parse-financial) 07:20:46 INFO - PROCESS | 22200 | RSS: Main: 167534592 07:20:46 INFO - PROCESS | 22200 | 07:20:48 INFO - PROCESS | 22200 | Cycle 1(1): loaded http://localhost:54736/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54736/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:20:48 INFO - PROCESS | 22200 | RSS: Main: 168108032 07:20:48 INFO - PROCESS | 22200 | 07:20:50 INFO - PROCESS | 22200 | Cycle 1(1): loaded http://localhost:54736/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54736/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:20:51 INFO - PROCESS | 22200 | RSS: Main: 168497152 07:20:51 INFO - PROCESS | 22200 | 07:20:53 INFO - PROCESS | 22200 | Cycle 1(1): loaded http://localhost:54736/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54736/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:20:54 INFO - PROCESS | 22200 | RSS: Main: 168800256 07:20:54 INFO - PROCESS | 22200 | 07:20:56 INFO - PROCESS | 22200 | Cycle 1(1): loaded http://localhost:54736/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54736/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:20:57 INFO - PROCESS | 22200 | RSS: Main: 168796160 07:20:57 INFO - PROCESS | 22200 | 07:21:00 INFO - PROCESS | 22200 | Cycle 1(1): loaded http://localhost:54736/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54736/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:21:00 INFO - PROCESS | 22200 | RSS: Main: 169037824 07:21:00 INFO - PROCESS | 22200 | 07:21:02 INFO - PROCESS | 22200 | Cycle 1(1): loaded http://localhost:54736/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54736/tests/kraken/driver.html?testName=ai-astar) 07:21:02 INFO - PROCESS | 22200 | RSS: Main: 169484288 07:21:02 INFO - PROCESS | 22200 | 07:21:02 INFO - PROCESS | 22200 | __start_tp_report 07:21:02 INFO - PROCESS | 22200 | _x_x_mozilla_page_load 07:21:02 INFO - PROCESS | 22200 | _x_x_mozilla_page_load_details 07:21:02 INFO - PROCESS | 22200 | |i|pagename|runs| 07:21:02 INFO - PROCESS | 22200 | |0;ai-astar;112;107;111;111;110;114;110;112;111;112 07:21:02 INFO - PROCESS | 22200 | |1;audio-beat-detection;151;126;157;178;128;161;157;126;188;132 07:21:02 INFO - PROCESS | 22200 | |2;audio-dft;161;161;161;161;166;168;166;162;161;161 07:21:02 INFO - PROCESS | 22200 | |3;audio-fft;73;74;75;155;77;76;75;75;159;75 07:21:02 INFO - PROCESS | 22200 | |4;audio-oscillator;86;84;157;83;86;85;142;85;87;139 07:21:02 INFO - PROCESS | 22200 | |5;imaging-gaussian-blur;117;118;118;118;118;117;118;118;117;118 07:21:02 INFO - PROCESS | 22200 | |6;imaging-darkroom;147;146;148;147;147;148;147;148;147;148 07:21:02 INFO - PROCESS | 22200 | |7;imaging-desaturate;97;96;96;97;95;96;96;96;95;95 07:21:02 INFO - PROCESS | 22200 | |8;json-parse-financial;57;56;57;56;57;57;56;58;58;56 07:21:02 INFO - PROCESS | 22200 | |9;json-stringify-tinderbox;61;62;60;61;62;61;63;62;61;61 07:21:02 INFO - PROCESS | 22200 | |10;stanford-crypto-aes;85;80;85;81;80;86;83;81;109;81 07:21:02 INFO - PROCESS | 22200 | |11;stanford-crypto-ccm;131;127;125;123;137;124;137;130;132;125 07:21:02 INFO - PROCESS | 22200 | |12;stanford-crypto-pbkdf2;160;166;159;160;158;160;163;161;161;162 07:21:02 INFO - PROCESS | 22200 | |13;stanford-crypto-sha256-iterative;64;64;63;63;63;65;65;62;62;62 07:21:02 INFO - PROCESS | 22200 | __end_tp_report 07:21:02 INFO - PROCESS | 22200 | __start_cc_report 07:21:02 INFO - PROCESS | 22200 | _x_x_mozilla_cycle_collect,896 07:21:02 INFO - PROCESS | 22200 | __end_cc_report 07:21:02 INFO - PROCESS | 22200 | __startTimestamp1465309262603__endTimestamp 07:21:02 INFO - PROCESS | 22200 | 07:21:02 INFO - PROCESS | 22200 | ------- Summary: start ------- 07:21:02 INFO - PROCESS | 22200 | Number of tests: 14 07:21:02 INFO - PROCESS | 22200 | 07:21:02 INFO - PROCESS | 22200 | [#0] ai-astar Cycles:10 Average:111.00 Median:111.50 stddev:1.83 (1.6%) stddev-sans-first:1.90 07:21:02 INFO - PROCESS | 22200 | Values: 112.0 107.0 111.0 111.0 110.0 114.0 110.0 112.0 111.0 112.0 07:21:02 INFO - PROCESS | 22200 | 07:21:02 INFO - PROCESS | 22200 | [#1] audio-beat-detection Cycles:10 Average:150.40 Median:157.00 stddev:22.13 (14.1%) stddev-sans-first:23.47 07:21:02 INFO - PROCESS | 22200 | Values: 151.0 126.0 157.0 178.0 128.0 161.0 157.0 126.0 188.0 132.0 07:21:02 INFO - PROCESS | 22200 | 07:21:02 INFO - PROCESS | 22200 | [#2] audio-dft Cycles:10 Average:162.80 Median:161.50 stddev:2.74 (1.7%) stddev-sans-first:2.83 07:21:02 INFO - PROCESS | 22200 | Values: 161.0 161.0 161.0 161.0 166.0 168.0 166.0 162.0 161.0 161.0 07:21:02 INFO - PROCESS | 22200 | 07:21:02 INFO - PROCESS | 22200 | [#3] audio-fft Cycles:10 Average:91.40 Median:75.00 stddev:34.60 (46.1%) stddev-sans-first:36.06 07:21:02 INFO - PROCESS | 22200 | Values: 73.0 74.0 75.0 155.0 77.0 76.0 75.0 75.0 159.0 75.0 07:21:02 INFO - PROCESS | 22200 | 07:21:02 INFO - PROCESS | 22200 | [#4] audio-oscillator Cycles:10 Average:103.40 Median:85.00 stddev:29.77 (35.0%) stddev-sans-first:30.90 07:21:02 INFO - PROCESS | 22200 | Values: 86.0 84.0 157.0 83.0 86.0 85.0 142.0 85.0 87.0 139.0 07:21:02 INFO - PROCESS | 22200 | 07:21:02 INFO - PROCESS | 22200 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 07:21:02 INFO - PROCESS | 22200 | Values: 117.0 118.0 118.0 118.0 118.0 117.0 118.0 118.0 117.0 118.0 07:21:02 INFO - PROCESS | 22200 | 07:21:02 INFO - PROCESS | 22200 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 07:21:02 INFO - PROCESS | 22200 | Values: 147.0 146.0 148.0 147.0 147.0 148.0 147.0 148.0 147.0 148.0 07:21:02 INFO - PROCESS | 22200 | 07:21:02 INFO - PROCESS | 22200 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 07:21:02 INFO - PROCESS | 22200 | Values: 97.0 96.0 96.0 97.0 95.0 96.0 96.0 96.0 95.0 95.0 07:21:02 INFO - PROCESS | 22200 | 07:21:02 INFO - PROCESS | 22200 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:57.00 stddev:0.79 (1.4%) stddev-sans-first:0.83 07:21:02 INFO - PROCESS | 22200 | Values: 57.0 56.0 57.0 56.0 57.0 57.0 56.0 58.0 58.0 56.0 07:21:02 INFO - PROCESS | 22200 | 07:21:02 INFO - PROCESS | 22200 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:61.50 stddev:0.84 (1.4%) stddev-sans-first:0.88 07:21:02 INFO - PROCESS | 22200 | Values: 61.0 62.0 60.0 61.0 62.0 61.0 63.0 62.0 61.0 61.0 07:21:02 INFO - PROCESS | 22200 | 07:21:02 INFO - PROCESS | 22200 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:82.00 stddev:8.69 (10.6%) stddev-sans-first:9.21 07:21:02 INFO - PROCESS | 22200 | Values: 85.0 80.0 85.0 81.0 80.0 86.0 83.0 81.0 109.0 81.0 07:21:02 INFO - PROCESS | 22200 | 07:21:02 INFO - PROCESS | 22200 | [#11] stanford-crypto-ccm Cycles:10 Average:129.10 Median:130.50 stddev:5.15 (3.9%) stddev-sans-first:5.42 07:21:02 INFO - PROCESS | 22200 | Values: 131.0 127.0 125.0 123.0 137.0 124.0 137.0 130.0 132.0 125.0 07:21:02 INFO - PROCESS | 22200 | 07:21:02 INFO - PROCESS | 22200 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.00 Median:161.00 stddev:2.26 (1.4%) stddev-sans-first:2.37 07:21:02 INFO - PROCESS | 22200 | Values: 160.0 166.0 159.0 160.0 158.0 160.0 163.0 161.0 161.0 162.0 07:21:02 INFO - PROCESS | 22200 | 07:21:02 INFO - PROCESS | 22200 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:63.50 stddev:1.16 (1.8%) stddev-sans-first:1.20 07:21:02 INFO - PROCESS | 22200 | Values: 64.0 64.0 63.0 63.0 63.0 65.0 65.0 62.0 62.0 62.0 07:21:02 INFO - PROCESS | 22200 | -------- Summary: end -------- 07:21:02 INFO - PROCESS | 22200 | 07:21:03 INFO - TEST-INFO | 22200: exit 0 07:21:03 INFO - TEST-OK | kraken | took 61703ms 07:21:03 INFO - SUITE-END | took 1171s 07:21:03 INFO - Completed test suite (00:19:32) 07:21:03 INFO - javascript benchmark 07:21:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7294.914055769111, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3141.7172454479096, 3184.0, 3191.617005959285, 3198.1045307313952, 3223.403670320991, 5315.840524784253, 5399.649022813514, 5423.783048678053, 5475.6440831345935, 5479.753411096501, 5258.973705131469, 5327.946720532794, 5381.058314794905, 5398.865028374293, 5501.587380946435, 4822.662413631038, 4842.44311904132, 4918.016396720653, 4986.551210391064, 5012.9749351253195, 982.9195474728353, 4812.278158276252, 4863.19757240055, 4902.3626928499425, 4960.776765045582, 4879.33496176826, 4897.559219670229, 4919.163742163841, 4926.852194434173, 4932.7780249888665, 4938.777755000998, 4944.35723355965, 4949.975250123763, 4969.229769385751, 4974.403071631391, 4827.613790896755, 4860.343853579757, 4891.315215869781, 4912.435069966964, 4913.410390753097, 5187.325647665817, 5303.893922121574, 5313.495217954288, 5327.573794096502, 5349.465053494659, 5594.636348637326, 5763.827085187451, 5775.3935836736955, 5789.507891829157, 5794.304683437972, 5842.298924129089, 5888.5877988540815, 5902.734376953047, 5907.054871220584, 5956.821295361103, 5403.756830942617, 5428.321459817523, 5461.836144915619, 5467.261919640838, 5469.808556700496, 5770.913436298459, 5864.296284445893, 5866.266716660418, 6017.2779266488305, 6062.848428789315, 5648.8870222595315, 5684.8010319638615, 5694.886102277931, 5705.600607957486, 5707.6290041147195, 5741.024025915604, 5824.271966004249, 5840.912386314209, 5853.678047707332, 5855.209546711225, 5704.201411802351, 5731.885362292731, 5822.82531524055, 5831.067029275296, 5839.270091238595, 5751.8562035949435, 5796.565257605696, 5801.709914504342, 5808.912866307009, 5858.062709966385, 4463.174312752151, 4467.530909254547, 4472.552744725502, 4479.574440428154, 4489.438820147481, 3878.786666733357, 3944.447777311179, 3964.643182113566, 3980.422838688432, 3993.4209539617173, 5566.415526369754, 5575.191597218381, 5592.916106258409, 5643.717814109278, 5675.1487276907965, 5829.94170058294, 5865.4134586541, 5869.53043756507, 5875.735591898289, 5894.351621321651, 5434.456554344613, 5498.065328894098, 5540.833774986757, 5547.833564992976, 5578.135389014709, 4998.825041123543, 5004.224345226496, 5004.799808007711, 5020.849374518771, 5090.974545127251, 5893.499052580579, 6010.849728756816, 6012.909806352908, 6026.9095963560585, 6039.939600604026, 5839.445252701072, 5865.677387743715, 5878.118282257696, 5906.557008224487, 5943.405659434022, 6158.04550294705, 6163.3836616338, 6172.290186628596, 6175.166352542349, 6181.35095814933, 5529.087700529368, 5633.971830140823, 5737.483626473638, 5742.310922689304, 5750.0512415450985, 5736.0, 5737.540996720336, 5740.339860916049, 5747.971260143672, 5801.1878337033695, 5594.356648985418, 5635.971820140873, 5644.379118297066, 5654.773809047592, 5668.51817595509, 5481.972590137183, 5589.469000444951, 5612.298462692163, 5634.211210430625, 5654.46282603152, 5584.497395234448, 5620.887582248414, 5625.662460252398, 5629.211910332475, 5660.801871934463, 5738.512226460798, 5751.079827227623, 5754.539636829128, 5759.798407055733, 5762.279715035621, 5435.891282174255, 5582.27430434041, 5626.971865140648, 5636.4927156556105, 5656.830295091154], "value": 5326.307021422175, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.9460187856223, 619.0157649337553, 625.0811307378156, 639.0286764118541, 656.9802905912825, 36701.26597468049, 41011.38482922759, 41286.38070428938, 41526.0, 41596.37605435917, 43126.137477250515, 43164.784176079076, 43501.34747978783, 43915.0, 43922.34116488247, 8526.0, 8678.609462574168, 8688.869666955, 8707.825843483126, 8720.084391138902, 8649.178328058824, 8672.8699069514, 8724.607392667345, 8727.301815854717, 8754.430961987482, 8703.825923481527, 8713.520756358397, 8786.956065219665, 8811.77970550735, 8824.117588241188, 8698.47809131451, 8753.737387878375, 8759.781005474882, 8773.210411063003, 8793.20861122502, 8572.357073219533, 8627.137286271385, 8645.783855403603, 8665.306775457948, 8667.306615470747, 33208.833955830065, 39840.0, 40232.195356093005, 40302.19395612101, 40511.7974410129, 3259.282957749291, 3511.0, 3538.31002954424, 3662.212624285765, 3684.889453316405, 32640.83679581587, 33386.0, 33446.33107337864, 33478.497822532685, 34150.82924585361, 4294.592013758688, 4365.825366985317, 4385.868423947287, 4556.838006308403, 4567.771611419449, 347968.0, 355666.0, 356699.0, 356964.0, 357879.0, 55406.0, 61569.0, 63312.366876331565, 63316.68341658262, 69686.0, 68796.312036879, 69054.65472672605, 69182.0, 69275.3072469279, 69599.65200173967, 17040.914795425942, 17395.217215225344, 17468.825311746976, 17576.209070591853, 17593.29626814913, 12707.364631768374, 12794.872051279368, 12811.871881281255, 12921.0, 12995.675108122183, 20337.79662203359, 20733.377998660064, 20816.687749683766, 20907.47731306699, 20946.581068378546, 7235.819104522324, 7567.583782891994, 7660.5403675779635, 7725.575093369806, 7732.8383678111895, 937.7749340158313, 1154.7344110854551, 1156.2253290295523, 1178.3460179600404, 1184.4551506307196, 32560.348793024008, 32977.67022329746, 33099.50350744741, 33221.66778332186, 33752.66247337544, 1101.2291396022815, 1131.5417256011328, 1147.8794726553758, 1231.7967535356565, 1238.5169783784331, 15945.840541594667, 16425.1787410629, 16515.504534863972, 16619.83380166207, 16675.24961376741, 557913.0, 560252.0, 561146.0, 563043.0, 564171.0, 54650.0, 56057.0, 56130.719346403006, 56144.719276404176, 56170.15744763832, 1377.1324065838658, 1380.9585712428843, 1386.8627725265185, 1388.7014291927285, 1394.5328315014583, 29531.409371812013, 30307.848460757556, 30811.987309430093, 30900.0, 31039.68960310368, 49462.75268623634, 50512.0, 50519.74740126276, 50568.49431505638, 50580.747096264284, 511503.0, 514412.0, 515758.0, 516414.0, 516594.0, 27821.582676260277, 28231.57652635253, 28272.43455130927, 28381.0, 28394.290142746595, 44816.0, 47022.29466557936, 47440.28839567478, 48099.0, 48479.75760121177, 40822.387664185655, 40995.590044099175, 41695.42924405995, 42331.7883410581, 42555.3616695756, 40467.59532404756, 40492.39261411022, 40653.796731016155, 41165.0, 41338.379924301764, 40940.79529602333, 41753.373699393924, 42540.787296063325, 42773.71678849639, 44655.55344446644, 33889.0, 37056.0, 37821.43267851039, 39955.0, 40000.799995999834, 28587.28531786722, 28620.856895715388, 29000.0, 29235.122946311643, 29279.707202927697], "value": 20462.95650707382, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.8383678854881, 390.7987386495955, 391.3738019169328, 394.1820722001847, 410.9137081212945, 17553.385631502882, 18295.451136465894, 19221.903890480564, 19240.23039078437, 19362.12870420831, 17838.464846054638, 17945.0, 18109.0, 19172.616547669037, 19300.420987370366, 5468.945310546903, 5486.725663716808, 5675.404082571333, 5714.114312281582, 5792.71036448178, 5689.943100568983, 5710.428957104298, 5713.228714123582, 5730.742116604742, 5778.624389414675, 6512.1208636834135, 6525.4779617630475, 6555.836104097388, 6561.376669216417, 6597.769078082268, 6230.096635987779, 6515.185601799775, 6515.218173819125, 6525.412712855842, 6541.116949211843, 5741.110127930177, 5777.613372790542, 5787.942120578825, 5795.362510123883, 5805.651660900317, 13036.41336139876, 13873.09824861391, 13913.373898174606, 13954.58136255914, 13965.79051314231, 2201.8458707890454, 2211.48162314407, 2297.5404919016264, 2313.4447732544068, 2757.5863620457094, 9243.584038718274, 9621.374610650355, 9738.367006144577, 11495.712607184803, 14445.638859028504, 1908.8663793534458, 1924.2399252295265, 1982.2071171531359, 1988.9900550497155, 2005.6991451282279, 79328.60335698284, 81317.59341203255, 81654.59172704158, 82114.0, 83020.16979830185, 10295.176385889261, 10580.788384232272, 10715.303505272132, 10870.945645271722, 11126.165537584713, 15341.309641065956, 15392.615184620474, 15405.0, 15410.845891540941, 15417.845821541865, 7800.609969501502, 7861.567613781297, 7957.323627491728, 8047.195280472023, 8101.392395570356, 7043.612601306875, 7131.429485641136, 7142.250063743336, 7235.710571577078, 7610.847783044419, 4559.931601025987, 4734.479207287196, 4751.073540659608, 4781.737004464719, 4877.853704379468, 1895.876768010075, 1961.8822870627807, 1979.4358607796996, 1984.5237143085556, 2022.8685135466148, 962.7496850818698, 1045.4720366215165, 1081.3457857995957, 1099.7855418193535, 1113.8607674040745, 18204.726929096076, 18707.438776836716, 18885.772424792343, 18911.905440472983, 19420.902895485433, 971.6842026341467, 1037.6731329631143, 1050.579768092769, 1077.9407132607782, 1083.9945800270948, 10601.204909631655, 10910.127189824794, 10923.836142457869, 10959.342439453658, 11015.614453494089, 550338.0, 568339.0, 568450.0, 569092.0, 572602.0, 94338.0, 94963.52518237365, 95668.52165739126, 95947.52026239964, 97026.51486742521, 990.2424645146468, 1010.5604062232806, 1019.9337043092323, 1039.1323245090282, 1043.337480699761, 16615.750763738313, 16807.579810504834, 16888.324467021674, 17107.743383849003, 17336.826631733522, 38582.0, 39394.01514962149, 39521.60478395294, 40514.0, 41125.0, 59567.0, 59729.40270597238, 60083.699581501816, 60145.0, 60694.393056068875, 8075.475094118863, 8372.455790373606, 8566.229039386486, 8584.270337021173, 8733.475991440533, 9321.580528876353, 11721.41392930333, 11748.29510229389, 12943.02927280439, 13346.06577539563, 11217.831732524182, 11336.0, 11474.311541307214, 11672.649820505398, 11783.941080294544, 11002.614908478485, 11332.603358882729, 11496.770064598828, 11635.76728465409, 11734.002609778265, 5993.670348130895, 9335.833020872391, 11414.258073225214, 11927.403629818647, 11977.401129943642, 8415.70545030921, 8518.574071296534, 8537.487750734976, 8648.740537783877, 8779.25376343018, 10523.368597884151, 10741.194410419093, 11113.110951124052, 11116.277441966246, 11560.190786644855], "value": 9108.329993863887, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1537.8462153784624, 1548.527699051789, 1728.3691452619798, 1791.9014454205014, 1853.4810253129128, 7600.88598671019, 8533.189347012023, 8691.782705432368, 9252.722418327452, 9284.90715092849, 8514.191151840581, 8654.524001179932, 8774.254188393994, 8875.289976801856, 8881.555922203881, 2294.7819957104048, 2345.8240631952585, 2346.108478778062, 2352.9882350588223, 2354.9764502355015, 2310.4339436838, 2347.8708671023173, 2365.8343915925893, 2370.265217782493, 2371.134535894395, 2329.8369114162015, 2331.755165707602, 2352.470694093832, 2355.1639168095335, 2367.964480532785, 2251.977480225193, 2259.9774002260096, 2277.032261288954, 2282.2696737044234, 2324.407276144589, 2246.6854640350366, 2248.347979086063, 2248.5502899420017, 2253.8873056347115, 2253.954920901589, 8834.779130521723, 8892.15524525169, 8912.64349426022, 8927.151920567601, 8934.195922367018, 5260.447652996457, 5332.3601167859715, 5339.813106541253, 5375.43557926416, 5378.408375078739, 3381.408253555618, 3418.7265018798685, 3586.910327241814, 3624.9275014499563, 3626.202235508184, 1129.2716198052292, 1169.625719769674, 1170.7190274334184, 1195.6891208285822, 1198.2091819399243, 12409.317487538181, 12587.118901676886, 12602.55891043809, 12724.745505089939, 12773.936130319289, 4537.115262523842, 4609.124266389375, 4721.763911804396, 4725.763711814464, 4787.497312782178, 10802.297850639683, 10827.24209305341, 10831.566737330577, 10840.945795270973, 10864.619738309279, 5357.223202635674, 5402.6758394496455, 5439.211314359396, 5444.945550544444, 5447.754851031713, 4240.957590424118, 4764.190087685102, 4934.753262336869, 4946.554810067111, 4965.155923492943, 3951.8616848410165, 3991.980040099781, 4017.276890159741, 4103.651189648854, 4147.751134931914, 1237.0907383073434, 1263.3051821498138, 1270.8030255310257, 1273.8471383434048, 1282.3716378974236, 888.8044630181349, 910.8360495110944, 914.3508109242513, 929.330881765128, 931.9970725732993, 6191.133241346215, 6295.842603934847, 6354.809355719336, 6458.321876203025, 6508.544401891822, 456.8789270843229, 471.2671795358251, 475.643267549338, 477.3698717692682, 480.58909632264607, 4061.147159096564, 4161.063760653889, 4176.937345939813, 4178.540360560336, 4255.872323830228, 10814.513346899408, 11084.944575277234, 11255.718607034725, 11316.038136758303, 11317.320960742381, 10903.563857445772, 11003.504842282116, 11056.668299951014, 11166.888331116746, 11277.097832173406, 8348.66605335792, 8365.665373384996, 8421.957890210631, 8435.156484351515, 8457.53483558398, 6065.636061836304, 6157.1072194532435, 6165.568410211422, 6331.05034244867, 6390.616563006234, 9788.559514821707, 10060.597576096874, 10227.181825453798, 10490.685279441628, 10495.0, 10445.373277603368, 10564.683059508227, 10673.679789606324, 10708.946455267675, 10784.352938823695, 6754.358335958076, 7483.176850546327, 7606.04924384452, 7806.570638614704, 8059.919400805917, 8745.825083498166, 8765.298776097768, 8777.210051095431, 8846.95576522139, 8853.203211710977, 7485.588292643957, 7700.537967721954, 7874.56689882062, 7965.402594805529, 8098.554579497949, 7604.8479030420185, 7774.144844067035, 7788.376929845485, 7788.649510772142, 8132.715354962548, 6942.444604431735, 7047.260037695968, 7062.435005199674, 7078.1506219254015, 7111.43108551325, 5254.842354729364, 5323.707196104251, 5385.3268341457315, 5455.972720136374, 5458.153986132156, 5067.41724701664, 5077.086124497626, 5119.48805119485, 5174.275601415729, 5209.374875015023], "value": 4627.962107206401, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.58269997103696, 339.4875828185434, 339.7384014308982, 340.1292690711778, 346.54602470763285, 5355.607542039069, 5432.0, 5508.531774799142, 5612.66324020559, 5618.241537392456, 5472.097103977839, 5496.0931446311415, 5516.503514683678, 5517.724113794315, 5525.696086715229, 4287.614114729674, 4313.223619748444, 4319.848805291816, 4337.178385078275, 4341.39220509129, 4177.871974566865, 4340.131973605276, 4340.891477713067, 4341.305391137403, 4354.281543545311, 4230.323148296273, 4262.126264115849, 4264.33902745075, 4286.314189729644, 4300.290452075404, 4277.337012763011, 4285.335772955197, 4291.9570804292025, 4311.8059687313835, 4320.546342634041, 3551.5383000210068, 3826.545912553212, 3834.482344883433, 3856.1709232515145, 3856.3444214483607, 5325.360956685223, 5344.690550815037, 5347.598930080259, 5349.491798279158, 5368.570514358881, 4883.12103821312, 4887.511248875084, 4907.730074845882, 4934.432540257881, 4946.233333833262, 5531.170324451325, 5767.538596912237, 5772.9711351442975, 5795.536357091422, 5805.5065319447895, 4077.1641813428178, 4083.6528895043957, 4088.9795551022053, 4106.281400754856, 4107.568705285932, 6033.42682445167, 6050.183225264577, 6071.757129714806, 6090.5736598438125, 6107.725152368154, 4140.772257525805, 4160.895977600584, 4194.224068547329, 4204.66362690984, 4238.427812245307, 4235.597618226264, 4239.703220774578, 4242.342436922282, 4257.531671516131, 4264.552222016706, 4883.218685010453, 4894.975525122423, 4900.26496025599, 4900.705957642482, 4901.877453063702, 5560.193771903051, 5816.88366232673, 5836.766529338779, 5850.0, 5866.266716660418, 1459.4381163252224, 1472.2859413184597, 1472.6539263273123, 1476.217604669527, 1477.0, 935.3873213045466, 941.9011003844498, 943.7121677888173, 956.3592393096642, 963.6482683820495, 5038.470960549163, 5051.419086804991, 5062.341895553554, 5089.821856235014, 5115.232715092766, 5265.708931917551, 5280.419153893069, 5286.497782710637, 5291.603129765283, 5419.430959749248, 5046.772895219724, 5071.340725705634, 5081.662435279813, 5284.286621306152, 5746.109353050284, 3164.730997865161, 3167.0182243504587, 3176.396484667952, 3182.315802102513, 3188.8883889064236, 6029.849253768691, 6196.628202307876, 6210.223722034746, 6220.502359811204, 6251.468625166912, 6036.0, 6056.273247210363, 6129.548180727656, 6134.938650613437, 6163.876722465526, 6169.413905678954, 6205.937940620626, 6225.595336303126, 6252.812415627538, 6260.123582698517, 5783.8554036149435, 5957.314908785545, 5973.223480947449, 5979.850503737442, 5988.640681559121, 5824.708764561839, 5860.501857342174, 5924.763009479572, 5931.258592675916, 5940.287165540163, 6074.848128796815, 6203.534734894811, 6232.158658581215, 6232.25212974446, 6251.937480625135, 4136.400221967858, 4171.541130475706, 4172.186423647359, 4201.285781417106, 4228.556001619786, 5936.168936349001, 6010.759569617341, 6033.577649564489, 6061.575689701678, 6084.178635884276, 5544.500994910478, 5780.94219057804, 5822.883542329215, 5839.459834971801, 5861.677607731445, 5822.796202132905, 5835.7373918174635, 5839.620424672383, 5854.502367298657, 5861.472467477947, 5588.86027849307, 5675.2406753906425, 5722.540752108186, 5749.453801888814, 5750.683712395691, 5817.418258174149, 5860.443257890493, 5871.383504731942, 5885.733417953077, 5918.940810592011, 5736.246601631157, 5752.626079305, 5754.251947246831, 5759.531319513498, 5764.279465066867], "value": 4386.757191381908, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [737.7823542055097, 781.5740421470298, 814.4380377539501, 818.1532114261738, 840.096895836975, 14470.638234044141, 14665.560033199008, 14671.853281467182, 14706.705865882675, 15147.166905820175, 14544.345504452298, 14697.77953330701, 14804.185769782685, 14813.407463701466, 14834.851651483483, 680.2890978927021, 792.2236208515658, 819.1480859905691, 822.5763731678161, 824.814416756231, 799.9880001799949, 803.333233416263, 805.8549461097, 806.6612022950375, 809.5587904591982, 860.1785295043219, 862.0861886400436, 862.3101518784978, 863.8013256950906, 863.9740807775777, 853.4111463090447, 857.7341024282492, 858.026140330726, 860.6213266162931, 860.7589874835056, 618.6164577961692, 618.6968385491122, 621.6332363905273, 622.3745136138198, 623.5292354272541, 14294.428222871073, 14300.356483958247, 14330.785038224434, 14331.996760226788, 14369.137851728825, 14576.635584110376, 14960.177190254532, 15100.697986040328, 15274.15992120433, 15363.385464581403, 12261.570845020382, 12298.0, 12360.505579776798, 12520.186187897758, 12554.121211515198, 3817.2938006468894, 3867.671247943928, 3948.309045916953, 4035.7376770509823, 4042.151148258869, 72117.27882721211, 73100.0, 73656.0, 74034.62982685106, 78311.21688783153, 11861.881381186251, 11884.227525210834, 11928.46321915516, 12077.516899324104, 12199.512019519298, 22874.771252287595, 23008.309750707507, 23036.424089397566, 23083.614983101066, 23084.422889427562, 8398.076211616717, 8409.579521024047, 8654.22112009922, 8667.0, 8912.108789121166, 4814.15752243356, 4817.566419022235, 4912.164931961575, 4956.553910148032, 5163.380394352702, 3607.1703508192736, 3715.925681486355, 3735.701143908481, 3749.5875453700073, 3754.6808521276, 607.5413063137391, 615.4211479286414, 623.0591806372411, 637.6492928889093, 640.1773720768883, 636.4526507203893, 702.884024136022, 709.4395427612128, 736.988945165823, 745.9776206713807, 8203.75388738327, 8290.170982901782, 8292.212239837327, 8315.251627353568, 8651.091635378194, 669.5313280703527, 700.2962023166787, 709.5454318646754, 718.4755128756037, 725.26747984536, 3656.1773600939578, 3737.495438115874, 4061.614146656063, 4180.0, 4298.677599180011, 92053.0, 107252.0, 108125.45937270421, 109071.45464272628, 113853.0, 64036.0, 73630.2636973634, 91508.54245728729, 96506.0, 97436.51281743546, 84319.5784021076, 85030.57484712538, 85564.14435855686, 85569.57215213885, 85712.14287857166, 9183.265338773015, 9527.0, 9555.713328600154, 9562.521873906138, 9693.6122555097, 49480.0, 50508.747456262485, 50729.49270507248, 51747.48252517577, 52320.215196771314, 64767.35232647613, 71178.0, 72489.0, 72700.0, 72765.0, 12624.0, 12648.0, 13880.305984700926, 13894.561118480597, 14005.229712365917, 14673.70652586921, 14756.63108422298, 14890.627734306729, 15188.848111518744, 15868.841311586737, 12895.41970611306, 13277.40251688657, 13317.467301308227, 13879.167249965034, 14011.649708757363, 12728.1726687765, 13148.34258287101, 13442.596722098353, 13445.193288402726, 13749.793753093913, 12684.492620295085, 12970.67573310637, 13117.60647180586, 13237.205767653972, 13252.536161234311, 10893.618723344645, 11302.886971130183, 11451.0, 11462.598809041643, 11535.423228838357, 10731.839022414513, 11116.444177790916, 11344.9432752839, 11462.0, 11535.423228838692], "value": 7476.70415015628, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1536.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 107.0, 111.0, 111.0, 110.0, 114.0, 110.0, 112.0, 111.0, 112.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 126.0, 157.0, 178.0, 128.0, 161.0, 157.0, 126.0, 188.0, 132.0], "value": 150.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 166.0, 168.0, 166.0, 162.0, 161.0, 161.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 75.0, 155.0, 77.0, 76.0, 75.0, 75.0, 159.0, 75.0], "value": 91.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 157.0, 83.0, 86.0, 85.0, 142.0, 85.0, 87.0, 139.0], "value": 103.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 148.0, 147.0, 147.0, 148.0, 147.0, 148.0, 147.0, 148.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 97.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 57.0, 56.0, 57.0, 57.0, 56.0, 58.0, 58.0, 56.0], "value": 56.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 60.0, 61.0, 62.0, 61.0, 63.0, 62.0, 61.0, 61.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 80.0, 85.0, 81.0, 80.0, 86.0, 83.0, 81.0, 109.0, 81.0], "value": 85.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 127.0, 125.0, 123.0, 137.0, 124.0, 137.0, 130.0, 132.0, 125.0], "value": 129.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 166.0, 159.0, 160.0, 158.0, 160.0, 163.0, 161.0, 161.0, 162.0], "value": 161.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 63.0, 63.0, 65.0, 65.0, 62.0, 62.0, 62.0], "value": 63.3, "unit": "score"}]}]} 07:21:03 INFO - Return code: 0 07:21:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:21:03 ERROR - # TBPL SUCCESS # 07:21:03 INFO - Running post-action listener: _resource_record_post_action 07:21:03 INFO - ##### 07:21:03 INFO - ##### Finished run-tests step (success) 07:21:03 INFO - ##### 07:21:03 INFO - Running post-run listener: _resource_record_post_run 07:21:03 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 543412224; Read time: 12; Write time: 481248 07:21:03 INFO - TinderboxPrint: CPU usage
13.5% 07:21:03 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 07:21:03 INFO - TinderboxPrint: I/O write bytes / time
543,412,224 / 481,248 07:21:03 INFO - TinderboxPrint: CPU idle
8,214.2 (86.5%) 07:21:03 INFO - TinderboxPrint: CPU user
1,225.3 (12.9%) 07:21:03 INFO - TinderboxPrint: Swap in / out
0 / 0 07:21:03 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 248025088; Read time: 0; Write time: 278724 07:21:04 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295387136; Read time: 12; Write time: 202524 07:21:04 INFO - Running post-run listener: _upload_blobber_files 07:21:04 INFO - Blob upload gear active. 07:21:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:21:04 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 07:21:04 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:21:04 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:21:04 INFO - (blobuploader) - INFO - Open directory for files ... 07:21:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:21:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:21:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:21:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:21:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:21:06 INFO - (blobuploader) - INFO - Done attempting. 07:21:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:21:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:21:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:21:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:21:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:21:08 INFO - (blobuploader) - INFO - Done attempting. 07:21:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:21:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:21:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:21:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:21:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:21:11 INFO - (blobuploader) - INFO - Done attempting. 07:21:11 INFO - (blobuploader) - INFO - Iteration through files over. 07:21:11 INFO - Return code: 0 07:21:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:21:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:21:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3b1aa2526feb13e716729f5fc43398722ec71cbf6df95b172be6391dbeff9310584a94112e46adefd4a9be5c5243a615e97d6d1a458386714e7e4a6ddf7c4165", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7d6f86e31d9769178eaf5367a8e0168105512c16136829371bc1dfa8eb9f9dc67442a722072e0702f67fc49dedd98b43c91ccaa8b3d7c0dcc6be018bc94f1253", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/63a0b85b7ca1633684fc89ac6e70aac78ba7ef8c088a37ad1a30ed849c91d431e71a182cb5d21d2f291e1186e14d7a330e2506c156199754f2253920ea933deb"} 07:21:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:21:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:21:11 INFO - Contents: 07:21:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3b1aa2526feb13e716729f5fc43398722ec71cbf6df95b172be6391dbeff9310584a94112e46adefd4a9be5c5243a615e97d6d1a458386714e7e4a6ddf7c4165", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7d6f86e31d9769178eaf5367a8e0168105512c16136829371bc1dfa8eb9f9dc67442a722072e0702f67fc49dedd98b43c91ccaa8b3d7c0dcc6be018bc94f1253", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/63a0b85b7ca1633684fc89ac6e70aac78ba7ef8c088a37ad1a30ed849c91d431e71a182cb5d21d2f291e1186e14d7a330e2506c156199754f2253920ea933deb"} 07:21:11 INFO - Running post-run listener: copy_logs_to_upload_dir 07:21:11 INFO - Copying logs to upload dir... 07:21:11 INFO - mkdir: /builds/slave/test/build/upload/logs 07:21:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.264637 ========= master_lag: 109.20 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 28 secs) (at 2016-06-07 07:23:00.351032) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 07:23:00.354614) ========= 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=6d15e502d8e29d5d2676d664000001c3-1465307526.595883-331799599 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/Mozilla-Inbound/sha512/3b1aa2526feb13e716729f5fc43398722ec71cbf6df95b172be6391dbeff9310584a94112e46adefd4a9be5c5243a615e97d6d1a458386714e7e4a6ddf7c4165", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7d6f86e31d9769178eaf5367a8e0168105512c16136829371bc1dfa8eb9f9dc67442a722072e0702f67fc49dedd98b43c91ccaa8b3d7c0dcc6be018bc94f1253", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/63a0b85b7ca1633684fc89ac6e70aac78ba7ef8c088a37ad1a30ed849c91d431e71a182cb5d21d2f291e1186e14d7a330e2506c156199754f2253920ea933deb"} build_url:https://queue.taskcluster.net/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011404 build_url: 'https://queue.taskcluster.net/v1/task/fpcl35WPSNO7upkvoxwKoA/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/Mozilla-Inbound/sha512/3b1aa2526feb13e716729f5fc43398722ec71cbf6df95b172be6391dbeff9310584a94112e46adefd4a9be5c5243a615e97d6d1a458386714e7e4a6ddf7c4165", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7d6f86e31d9769178eaf5367a8e0168105512c16136829371bc1dfa8eb9f9dc67442a722072e0702f67fc49dedd98b43c91ccaa8b3d7c0dcc6be018bc94f1253", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/63a0b85b7ca1633684fc89ac6e70aac78ba7ef8c088a37ad1a30ed849c91d431e71a182cb5d21d2f291e1186e14d7a330e2506c156199754f2253920ea933deb"}' ========= master_lag: 0.11 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 07:23:00.474644) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 8 secs) (at 2016-06-07 07:23:00.475016) ========= 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=6d15e502d8e29d5d2676d664000001c3-1465307526.595883-331799599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004484 ========= master_lag: 8.67 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 8 secs) (at 2016-06-07 07:23:09.145116) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 07:23:09.145457) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 07:23:09.301497) ========= ========= Total master_lag: 118.05 =========