builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-025 starttime: 1466245705.66 results: success (0) buildid: 20160618004017 builduid: 5910b6bd6d7548c1b47d7e843ea52500 revision: 541035fe27cb71fd6fdcd273c5190edd688f0731 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-18 03:28:25.659903) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-18 03:28:25.660639) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-18 03:28:25.660989) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-18 03:28:25.724706) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 03:28:25.725021) ========= 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=232498196343f89f466a4a9a000001c8-1466243090.727922-166158960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-18 03:28:26-- 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% 221M=0s 2016-06-18 03:28:26 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114773 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 03:28:25.859359) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 03:28:25.860107) ========= 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=232498196343f89f466a4a9a000001c8-1466243090.727922-166158960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020283 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 03:28:25.914013) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 03:28:25.914885) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 541035fe27cb71fd6fdcd273c5190edd688f0731 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 541035fe27cb71fd6fdcd273c5190edd688f0731 --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=232498196343f89f466a4a9a000001c8-1466243090.727922-166158960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-18 03:28:26,815 truncating revision to first 12 chars 2016-06-18 03:28:26,815 Setting DEBUG logging. 2016-06-18 03:28:26,815 attempt 1/10 2016-06-18 03:28:26,815 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/541035fe27cb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-18 03:28:27,104 unpacking tar archive at: mozilla-aurora-541035fe27cb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.600489 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 03:28:26.533017) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-18 03:28:26.533778) ========= script_repo_revision: 541035fe27cb71fd6fdcd273c5190edd688f0731 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-18 03:28:26.534699) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-18 03:28:26.535118) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-18 03:28:26.546637) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-18 03:28:26.546961) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=232498196343f89f466a4a9a000001c8-1466243090.727922-166158960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:28:27 INFO - MultiFileLogger online at 20160618 03:28:27 in /builds/slave/test 03:28:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:28:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:28:27 INFO - {'append_to_log': False, 03:28:27 INFO - 'base_work_dir': '/builds/slave/test', 03:28:27 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:28:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:28:27 INFO - 'branch': 'Mozilla-Aurora', 03:28:27 INFO - 'buildbot_json_path': 'buildprops.json', 03:28:27 INFO - 'config_files': ('talos/linux_config.py',), 03:28:27 INFO - 'default_actions': ('clobber', 03:28:27 INFO - 'read-buildbot-config', 03:28:27 INFO - 'download-and-extract', 03:28:27 INFO - 'populate-webroot', 03:28:27 INFO - 'create-virtualenv', 03:28:27 INFO - 'install', 03:28:27 INFO - 'run-tests'), 03:28:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:28:27 INFO - 'download_minidump_stackwalk': True, 03:28:27 INFO - 'download_symbols': 'ondemand', 03:28:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:28:27 INFO - 'tooltool.py': '/tools/tooltool.py', 03:28:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:28:27 INFO - '/tools/misc-python/virtualenv.py')}, 03:28:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:28:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:28:27 INFO - 'installer_path': 'installer.exe', 03:28:27 INFO - 'log_level': 'info', 03:28:27 INFO - 'log_name': 'talos', 03:28:27 INFO - 'log_to_console': True, 03:28:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:28:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:28:27 INFO - 'opt_config_files': (), 03:28:27 INFO - 'pip_index': False, 03:28:27 INFO - 'sps_profile': False, 03:28:27 INFO - 'sps_profile_interval': 0, 03:28:27 INFO - 'suite': 'dromaeojs', 03:28:27 INFO - 'system_bits': '32', 03:28:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:28:27 INFO - 'title': 'talos-linux64-ix-025', 03:28:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:28:27 INFO - 'use_talos_json': True, 03:28:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:28:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:28:27 INFO - 'work_dir': 'build'} 03:28:27 INFO - ##### 03:28:27 INFO - ##### Running clobber step. 03:28:27 INFO - ##### 03:28:27 INFO - Running pre-action listener: _resource_record_pre_action 03:28:27 INFO - Running main action method: clobber 03:28:27 INFO - rmtree: /builds/slave/test/build 03:28:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:28:28 INFO - Running post-action listener: _resource_record_post_action 03:28:28 INFO - ##### 03:28:28 INFO - ##### Finished clobber step (success) 03:28:28 INFO - ##### 03:28:28 INFO - ##### 03:28:28 INFO - ##### Running read-buildbot-config step. 03:28:28 INFO - ##### 03:28:28 INFO - Running pre-action listener: _resource_record_pre_action 03:28:28 INFO - Running main action method: read_buildbot_config 03:28:28 INFO - Using buildbot properties: 03:28:28 INFO - { 03:28:28 INFO - "project": "", 03:28:28 INFO - "product": "firefox", 03:28:28 INFO - "script_repo_revision": "production", 03:28:28 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:28:28 INFO - "repository": "", 03:28:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:28:28 INFO - "buildid": "20160618004017", 03:28:28 INFO - "stage_platform": "linux64-pgo", 03:28:28 INFO - "basedir": "/builds/slave/test", 03:28:28 INFO - "nightly_build": "True", 03:28:28 INFO - "buildnumber": 301, 03:28:28 INFO - "slavename": "talos-linux64-ix-025", 03:28:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:28:28 INFO - "platform": "ubuntu64_hw", 03:28:28 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:28:28 INFO - "branch": "mozilla-aurora", 03:28:28 INFO - "repo_path": "releases/mozilla-aurora", 03:28:28 INFO - "revision": "541035fe27cb71fd6fdcd273c5190edd688f0731", 03:28:28 INFO - "pgo_build": "True", 03:28:28 INFO - "builduid": "5910b6bd6d7548c1b47d7e843ea52500", 03:28:28 INFO - "slavebuilddir": "test" 03:28:28 INFO - } 03:28:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/A0x_2Nn7SfC1ZAxF3yC4UA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 03:28:28 INFO - Running post-action listener: _resource_record_post_action 03:28:28 INFO - ##### 03:28:28 INFO - ##### Finished read-buildbot-config step (success) 03:28:28 INFO - ##### 03:28:28 INFO - ##### 03:28:28 INFO - ##### Running download-and-extract step. 03:28:28 INFO - ##### 03:28:28 INFO - Running pre-action listener: _resource_record_pre_action 03:28:28 INFO - Running main action method: download_and_extract 03:28:28 INFO - mkdir: /builds/slave/test/build/tests 03:28:28 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')]} 03:28:28 INFO - https://queue.taskcluster.net/v1/task/A0x_2Nn7SfC1ZAxF3yC4UA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:28:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0x_2Nn7SfC1ZAxF3yC4UA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:28:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0x_2Nn7SfC1ZAxF3yC4UA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:28:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0x_2Nn7SfC1ZAxF3yC4UA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:28:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0x_2Nn7SfC1ZAxF3yC4UA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:28:29 INFO - Downloaded 1361 bytes. 03:28:29 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:28:29 INFO - Using the following test package requirements: 03:28:29 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:28:29 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:28:29 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:28:29 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:28:29 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:28:29 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:28:29 INFO - u'jsshell-linux-x86_64.zip'], 03:28:29 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:28:29 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:28:29 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:28:29 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:28:29 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:28:29 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:28:29 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:28:29 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:28:29 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:28:29 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:28:29 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:28:29 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:28:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:29 INFO - https://queue.taskcluster.net/v1/task/A0x_2Nn7SfC1ZAxF3yC4UA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:28:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0x_2Nn7SfC1ZAxF3yC4UA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:28:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0x_2Nn7SfC1ZAxF3yC4UA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:28:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0x_2Nn7SfC1ZAxF3yC4UA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:28:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0x_2Nn7SfC1ZAxF3yC4UA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:28:30 INFO - Downloaded 24473796 bytes. 03:28:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:28:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:28:32 INFO - Return code: 0 03:28:32 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:28:32 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')]} 03:28:32 INFO - https://queue.taskcluster.net/v1/task/A0x_2Nn7SfC1ZAxF3yC4UA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:28:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0x_2Nn7SfC1ZAxF3yC4UA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:28:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0x_2Nn7SfC1ZAxF3yC4UA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:28:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0x_2Nn7SfC1ZAxF3yC4UA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:28:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0x_2Nn7SfC1ZAxF3yC4UA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:28:33 INFO - Downloaded 24473796 bytes. 03:28:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:28:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:28:35 INFO - Return code: 0 03:28:35 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')]} 03:28:35 INFO - https://queue.taskcluster.net/v1/task/A0x_2Nn7SfC1ZAxF3yC4UA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:28:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0x_2Nn7SfC1ZAxF3yC4UA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:28:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0x_2Nn7SfC1ZAxF3yC4UA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:28:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0x_2Nn7SfC1ZAxF3yC4UA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:28:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0x_2Nn7SfC1ZAxF3yC4UA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:28:36 INFO - Downloaded 10833369 bytes. 03:28:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:28:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:28:36 INFO - Return code: 0 03:28:36 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')]} 03:28:36 INFO - https://queue.taskcluster.net/v1/task/A0x_2Nn7SfC1ZAxF3yC4UA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:28:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0x_2Nn7SfC1ZAxF3yC4UA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:28:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0x_2Nn7SfC1ZAxF3yC4UA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:28:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0x_2Nn7SfC1ZAxF3yC4UA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:28:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0x_2Nn7SfC1ZAxF3yC4UA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:28:39 INFO - Downloaded 63546281 bytes. 03:28:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A0x_2Nn7SfC1ZAxF3yC4UA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:28:39 INFO - mkdir: /builds/slave/test/properties 03:28:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:28:39 INFO - Writing to file /builds/slave/test/properties/build_url 03:28:39 INFO - Contents: 03:28:39 INFO - build_url:https://queue.taskcluster.net/v1/task/A0x_2Nn7SfC1ZAxF3yC4UA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:28:40 INFO - Running post-action listener: _resource_record_post_action 03:28:40 INFO - Running post-action listener: set_extra_try_arguments 03:28:40 INFO - ##### 03:28:40 INFO - ##### Finished download-and-extract step (success) 03:28:40 INFO - ##### 03:28:40 INFO - ##### 03:28:40 INFO - ##### Running populate-webroot step. 03:28:40 INFO - ##### 03:28:40 INFO - Running pre-action listener: _resource_record_pre_action 03:28:40 INFO - Running main action method: populate_webroot 03:28:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:28:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:28:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:28:40 INFO - '--tppagecycles', 03:28:40 INFO - '7'], 03:28:40 INFO - 'tests': ['tsvgm']}}, 03:28:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:28:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:28:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:28:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:28:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:28:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:28:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:40 INFO - 'talos_options': ['--disable-e10s'], 03:28:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:28:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:28:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:40 INFO - 'talos_options': ['--disable-e10s'], 03:28:40 INFO - 'tests': ['damp', 'tps']}, 03:28:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:40 INFO - 'tests': ['damp', 'tps']}, 03:28:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:28:40 INFO - 'tests': ['dromaeo_dom']}, 03:28:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:28:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:28:40 INFO - 'tests': ['a11yr', 03:28:40 INFO - 'ts_paint', 03:28:40 INFO - 'tpaint', 03:28:40 INFO - 'sessionrestore', 03:28:40 INFO - 'sessionrestore_no_auto_restore', 03:28:40 INFO - 'tabpaint']}, 03:28:40 INFO - 'other-e10s': {'tests': ['a11yr', 03:28:40 INFO - 'ts_paint', 03:28:40 INFO - 'tpaint', 03:28:40 INFO - 'sessionrestore', 03:28:40 INFO - 'sessionrestore_no_auto_restore', 03:28:40 INFO - 'tabpaint']}, 03:28:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:28:40 INFO - 'ts_paint', 03:28:40 INFO - 'tpaint', 03:28:40 INFO - 'sessionrestore', 03:28:40 INFO - 'sessionrestore_no_auto_restore', 03:28:40 INFO - 'tabpaint']}, 03:28:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:28:40 INFO - 'ts_paint', 03:28:40 INFO - 'tpaint', 03:28:40 INFO - 'sessionrestore', 03:28:40 INFO - 'sessionrestore_no_auto_restore', 03:28:40 INFO - 'tabpaint']}, 03:28:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:28:40 INFO - 'tests': ['a11yr', 03:28:40 INFO - 'ts_paint', 03:28:40 INFO - 'tpaint', 03:28:40 INFO - 'sessionrestore', 03:28:40 INFO - 'sessionrestore_no_auto_restore', 03:28:40 INFO - 'tabpaint']}, 03:28:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:28:40 INFO - 'tests': ['a11yr', 03:28:40 INFO - 'ts_paint', 03:28:40 INFO - 'tpaint', 03:28:40 INFO - 'sessionrestore', 03:28:40 INFO - 'sessionrestore_no_auto_restore', 03:28:40 INFO - 'tabpaint']}, 03:28:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:28:40 INFO - 'tests': ['tsvgx', 03:28:40 INFO - 'tsvgr_opacity', 03:28:40 INFO - 'tart', 03:28:40 INFO - 'tscrollx', 03:28:40 INFO - 'cart']}, 03:28:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:28:40 INFO - 'tsvgr_opacity', 03:28:40 INFO - 'tart', 03:28:40 INFO - 'tscrollx', 03:28:40 INFO - 'cart']}, 03:28:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:40 INFO - 'talos_options': ['--disable-e10s'], 03:28:40 INFO - 'tests': ['tp5o']}, 03:28:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:40 INFO - 'tests': ['tp5o']}, 03:28:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:40 INFO - 'talos_options': ['--disable-e10s', 03:28:40 INFO - '--xperf_path', 03:28:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:28:40 INFO - 'tests': ['tp5n']}, 03:28:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:40 INFO - 'talos_options': ['--xperf_path', 03:28:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:28:40 INFO - 'tests': ['tp5n']}}, 03:28:40 INFO - 'talos.zip': {'path': '', 03:28:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:28:40 INFO - Running post-action listener: _resource_record_post_action 03:28:40 INFO - ##### 03:28:40 INFO - ##### Finished populate-webroot step (success) 03:28:40 INFO - ##### 03:28:40 INFO - ##### 03:28:40 INFO - ##### Running create-virtualenv step. 03:28:40 INFO - ##### 03:28:40 INFO - Running pre-action listener: _resource_record_pre_action 03:28:40 INFO - Running main action method: create_virtualenv 03:28:40 INFO - Creating virtualenv /builds/slave/test/build/venv 03:28:40 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 03:28:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:28:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:28:40 INFO - Using real prefix '/usr' 03:28:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:28:41 INFO - Installing distribute.............................................................................................................................................................................................done. 03:28:43 INFO - Installing pip.................done. 03:28:43 INFO - Return code: 0 03:28:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:28:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:43 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 0x7f089b8fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27581c0>, '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 0x27590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2759550>, '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': '232498196343f89f466a4a9a000001c8-1466243090.727922-166158960', '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 03:28:43 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 03:28:43 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 03:28:43 INFO - Using env: {'DISPLAY': ':0', 03:28:43 INFO - 'HOME': '/home/cltbld', 03:28:43 INFO - 'LANG': 'en_US.UTF-8', 03:28:43 INFO - 'LANGUAGE': 'en_US:en', 03:28:43 INFO - 'LOGNAME': 'cltbld', 03:28:43 INFO - 'MAIL': '/var/mail/cltbld', 03:28:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:43 INFO - 'MOZ_NO_REMOTE': '1', 03:28:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:43 INFO - 'NO_EM_RESTART': '1', 03:28:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:43 INFO - 'PWD': '/builds/slave/test', 03:28:43 INFO - 'SHELL': '/bin/bash', 03:28:43 INFO - 'SHLVL': '1', 03:28:43 INFO - 'TERM': 'linux', 03:28:43 INFO - 'TMOUT': '86400', 03:28:43 INFO - 'USER': 'cltbld', 03:28:43 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466243090.727922-166158960', 03:28:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:43 INFO - '_': '/tools/buildbot/bin/python'} 03:28:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:43 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 03:28:43 INFO - Cleaning up... 03:28:43 INFO - Return code: 0 03:28:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:28:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:43 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 0x7f089b8fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27581c0>, '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 0x27590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2759550>, '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': '232498196343f89f466a4a9a000001c8-1466243090.727922-166158960', '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 03:28:43 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 03:28:43 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 03:28:43 INFO - Using env: {'DISPLAY': ':0', 03:28:43 INFO - 'HOME': '/home/cltbld', 03:28:43 INFO - 'LANG': 'en_US.UTF-8', 03:28:43 INFO - 'LANGUAGE': 'en_US:en', 03:28:43 INFO - 'LOGNAME': 'cltbld', 03:28:43 INFO - 'MAIL': '/var/mail/cltbld', 03:28:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:43 INFO - 'MOZ_NO_REMOTE': '1', 03:28:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:43 INFO - 'NO_EM_RESTART': '1', 03:28:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:43 INFO - 'PWD': '/builds/slave/test', 03:28:43 INFO - 'SHELL': '/bin/bash', 03:28:43 INFO - 'SHLVL': '1', 03:28:43 INFO - 'TERM': 'linux', 03:28:43 INFO - 'TMOUT': '86400', 03:28:43 INFO - 'USER': 'cltbld', 03:28:43 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466243090.727922-166158960', 03:28:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:43 INFO - '_': '/tools/buildbot/bin/python'} 03:28:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:43 INFO - Downloading/unpacking psutil>=3.1.1 03:28:43 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 03:28:43 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 03:28:43 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 03:28:43 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 03:28:43 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 03:28:43 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 03:28:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:28:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:28:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:28:45 INFO - Installing collected packages: psutil 03:28:45 INFO - Running setup.py install for psutil 03:28:45 INFO - building 'psutil._psutil_linux' extension 03:28:45 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 03:28:45 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 03:28:45 INFO - building 'psutil._psutil_posix' extension 03:28:45 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 03:28:46 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 03:28:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:28:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:28:46 INFO - Successfully installed psutil 03:28:46 INFO - Cleaning up... 03:28:46 INFO - Return code: 0 03:28:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:28:46 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')]} 03:28:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:46 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')]} 03:28:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:46 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 0x7f089b8fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27581c0>, '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 0x27590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2759550>, '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': '232498196343f89f466a4a9a000001c8-1466243090.727922-166158960', '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 03:28:46 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 03:28:46 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 03:28:46 INFO - Using env: {'DISPLAY': ':0', 03:28:46 INFO - 'HOME': '/home/cltbld', 03:28:46 INFO - 'LANG': 'en_US.UTF-8', 03:28:46 INFO - 'LANGUAGE': 'en_US:en', 03:28:46 INFO - 'LOGNAME': 'cltbld', 03:28:46 INFO - 'MAIL': '/var/mail/cltbld', 03:28:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:46 INFO - 'MOZ_NO_REMOTE': '1', 03:28:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:46 INFO - 'NO_EM_RESTART': '1', 03:28:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:46 INFO - 'PWD': '/builds/slave/test', 03:28:46 INFO - 'SHELL': '/bin/bash', 03:28:46 INFO - 'SHLVL': '1', 03:28:46 INFO - 'TERM': 'linux', 03:28:46 INFO - 'TMOUT': '86400', 03:28:46 INFO - 'USER': 'cltbld', 03:28:46 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466243090.727922-166158960', 03:28:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:46 INFO - '_': '/tools/buildbot/bin/python'} 03:28:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:28:46 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 03:28:46 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 03:28:46 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 03:28:46 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 03:28:46 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 03:28:46 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 03:28:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:28:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:28:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:28:48 INFO - Installing collected packages: mozsystemmonitor 03:28:48 INFO - Running setup.py install for mozsystemmonitor 03:28:48 INFO - Successfully installed mozsystemmonitor 03:28:48 INFO - Cleaning up... 03:28:48 INFO - Return code: 0 03:28:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:28:48 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')]} 03:28:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:48 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')]} 03:28:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:48 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 0x7f089b8fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27581c0>, '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 0x27590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2759550>, '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': '232498196343f89f466a4a9a000001c8-1466243090.727922-166158960', '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 03:28:48 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 03:28:48 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 03:28:48 INFO - Using env: {'DISPLAY': ':0', 03:28:48 INFO - 'HOME': '/home/cltbld', 03:28:48 INFO - 'LANG': 'en_US.UTF-8', 03:28:48 INFO - 'LANGUAGE': 'en_US:en', 03:28:48 INFO - 'LOGNAME': 'cltbld', 03:28:48 INFO - 'MAIL': '/var/mail/cltbld', 03:28:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:48 INFO - 'MOZ_NO_REMOTE': '1', 03:28:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:48 INFO - 'NO_EM_RESTART': '1', 03:28:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:48 INFO - 'PWD': '/builds/slave/test', 03:28:48 INFO - 'SHELL': '/bin/bash', 03:28:48 INFO - 'SHLVL': '1', 03:28:48 INFO - 'TERM': 'linux', 03:28:48 INFO - 'TMOUT': '86400', 03:28:48 INFO - 'USER': 'cltbld', 03:28:48 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466243090.727922-166158960', 03:28:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:48 INFO - '_': '/tools/buildbot/bin/python'} 03:28:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:48 INFO - Downloading/unpacking jsonschema==2.5.1 03:28:48 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 03:28:48 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 03:28:48 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 03:28:48 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 03:28:48 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 03:28:48 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 03:28:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:28:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:28:50 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 03:28:50 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 03:28:50 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 03:28:50 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 03:28:50 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 03:28:50 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 03:28:50 INFO - Downloading functools32-3.2.3-2.tar.gz 03:28:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:28:50 INFO - warning: no files found matching '*.txt' 03:28:50 INFO - no previously-included directories found matching 'build' 03:28:50 INFO - no previously-included directories found matching 'dist' 03:28:50 INFO - no previously-included directories found matching '.git*' 03:28:50 INFO - Installing collected packages: jsonschema, functools32 03:28:50 INFO - Running setup.py install for functools32 03:28:51 INFO - warning: no files found matching '*.txt' 03:28:51 INFO - no previously-included directories found matching 'build' 03:28:51 INFO - no previously-included directories found matching 'dist' 03:28:51 INFO - no previously-included directories found matching '.git*' 03:28:51 INFO - Successfully installed jsonschema functools32 03:28:51 INFO - Cleaning up... 03:28:51 INFO - Return code: 0 03:28:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:28: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')]} 03:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28: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')]} 03:28:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28: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', '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 0x7f089b8fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27581c0>, '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 0x27590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2759550>, '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': '232498196343f89f466a4a9a000001c8-1466243090.727922-166158960', '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 03:28: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:28: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 blobuploader==1.2.4 03:28:51 INFO - Using env: {'DISPLAY': ':0', 03:28:51 INFO - 'HOME': '/home/cltbld', 03:28:51 INFO - 'LANG': 'en_US.UTF-8', 03:28:51 INFO - 'LANGUAGE': 'en_US:en', 03:28:51 INFO - 'LOGNAME': 'cltbld', 03:28:51 INFO - 'MAIL': '/var/mail/cltbld', 03:28:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:51 INFO - 'MOZ_NO_REMOTE': '1', 03:28:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:51 INFO - 'NO_EM_RESTART': '1', 03:28:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:51 INFO - 'PWD': '/builds/slave/test', 03:28:51 INFO - 'SHELL': '/bin/bash', 03:28:51 INFO - 'SHLVL': '1', 03:28:51 INFO - 'TERM': 'linux', 03:28:51 INFO - 'TMOUT': '86400', 03:28:51 INFO - 'USER': 'cltbld', 03:28:51 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466243090.727922-166158960', 03:28:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:51 INFO - '_': '/tools/buildbot/bin/python'} 03:28:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:51 INFO - Downloading/unpacking blobuploader==1.2.4 03:28: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 03:28: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 03:28: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 03:28: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 03:28: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 03:28: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 03:28:53 INFO - Downloading blobuploader-1.2.4.tar.gz 03:28:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:28:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:28:53 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 03:28:53 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 03:28:53 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 03:28:53 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 03:28:53 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 03:28:53 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 03:28:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:28:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:28:53 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 03:28:53 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 03:28:53 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 03:28:53 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 03:28:53 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 03:28:53 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 03:28:53 INFO - Downloading docopt-0.6.1.tar.gz 03:28:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:28:53 INFO - Installing collected packages: blobuploader, requests, docopt 03:28:53 INFO - Running setup.py install for blobuploader 03:28:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:28:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:28:54 INFO - Running setup.py install for requests 03:28:54 INFO - Running setup.py install for docopt 03:28:54 INFO - Successfully installed blobuploader requests docopt 03:28:54 INFO - Cleaning up... 03:28:54 INFO - Return code: 0 03:28:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28: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')]} 03:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28: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')]} 03:28:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:54 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 0x7f089b8fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27581c0>, '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 0x27590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2759550>, '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': '232498196343f89f466a4a9a000001c8-1466243090.727922-166158960', '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 03:28:54 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 03:28:54 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 03:28:54 INFO - Using env: {'DISPLAY': ':0', 03:28:54 INFO - 'HOME': '/home/cltbld', 03:28:54 INFO - 'LANG': 'en_US.UTF-8', 03:28:54 INFO - 'LANGUAGE': 'en_US:en', 03:28:54 INFO - 'LOGNAME': 'cltbld', 03:28:54 INFO - 'MAIL': '/var/mail/cltbld', 03:28:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:54 INFO - 'MOZ_NO_REMOTE': '1', 03:28:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:54 INFO - 'NO_EM_RESTART': '1', 03:28:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:54 INFO - 'PWD': '/builds/slave/test', 03:28:54 INFO - 'SHELL': '/bin/bash', 03:28:54 INFO - 'SHLVL': '1', 03:28:54 INFO - 'TERM': 'linux', 03:28:54 INFO - 'TMOUT': '86400', 03:28:54 INFO - 'USER': 'cltbld', 03:28:54 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466243090.727922-166158960', 03:28:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:54 INFO - '_': '/tools/buildbot/bin/python'} 03:28:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:28:54 INFO - Running setup.py (path:/tmp/pip-HSnHrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:28:54 INFO - Running setup.py (path:/tmp/pip-d8QEpr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:28:54 INFO - Running setup.py (path:/tmp/pip-MX3JC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:28:54 INFO - Running setup.py (path:/tmp/pip-TjcpC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:28:55 INFO - Running setup.py (path:/tmp/pip-bBVAG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:28:55 INFO - Running setup.py (path:/tmp/pip-l2Ed0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:28:55 INFO - Running setup.py (path:/tmp/pip-MAMpnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:28:55 INFO - Running setup.py (path:/tmp/pip-3mmghG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:28:55 INFO - Running setup.py (path:/tmp/pip-ZvkAKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:28:55 INFO - Running setup.py (path:/tmp/pip-FlSiYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:28:55 INFO - Running setup.py (path:/tmp/pip-5mlA_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:28:55 INFO - Running setup.py (path:/tmp/pip-DAoNGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:28:55 INFO - Running setup.py (path:/tmp/pip-RNKZeN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:28:55 INFO - Running setup.py (path:/tmp/pip-4Urpe8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:55 INFO - Running setup.py (path:/tmp/pip-OAbheu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:28:55 INFO - Running setup.py (path:/tmp/pip-gzb8CY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:28:55 INFO - Running setup.py (path:/tmp/pip-JElUra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:28:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:28:55 INFO - Running setup.py install for manifestparser 03:28:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:28:56 INFO - Running setup.py install for mozcrash 03:28:56 INFO - Running setup.py install for mozdebug 03:28:56 INFO - Running setup.py install for mozdevice 03:28:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:28:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:28:56 INFO - Running setup.py install for mozfile 03:28:56 INFO - Running setup.py install for mozhttpd 03:28:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:28:56 INFO - Running setup.py install for mozinfo 03:28:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:28:56 INFO - Running setup.py install for mozInstall 03:28:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:28:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:28:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:28:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:28:56 INFO - Running setup.py install for mozleak 03:28:56 INFO - Running setup.py install for mozlog 03:28:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:28:57 INFO - Running setup.py install for moznetwork 03:28:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:28:57 INFO - Running setup.py install for mozprocess 03:28:57 INFO - Running setup.py install for mozprofile 03:28:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:28:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:28:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:28:57 INFO - Running setup.py install for mozrunner 03:28:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:28:57 INFO - Running setup.py install for mozscreenshot 03:28:57 INFO - Running setup.py install for moztest 03:28:57 INFO - Running setup.py install for mozversion 03:28:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:28:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:28:57 INFO - Cleaning up... 03:28:57 INFO - Return code: 0 03:28:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28:57 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')]} 03:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:57 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')]} 03:28:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:57 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 0x7f089b8fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27581c0>, '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 0x27590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2759550>, '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': '232498196343f89f466a4a9a000001c8-1466243090.727922-166158960', '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 03:28:57 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 03:28:57 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 03:28:57 INFO - Using env: {'DISPLAY': ':0', 03:28:57 INFO - 'HOME': '/home/cltbld', 03:28:57 INFO - 'LANG': 'en_US.UTF-8', 03:28:57 INFO - 'LANGUAGE': 'en_US:en', 03:28:57 INFO - 'LOGNAME': 'cltbld', 03:28:57 INFO - 'MAIL': '/var/mail/cltbld', 03:28:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:57 INFO - 'MOZ_NO_REMOTE': '1', 03:28:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:57 INFO - 'NO_EM_RESTART': '1', 03:28:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:57 INFO - 'PWD': '/builds/slave/test', 03:28:57 INFO - 'SHELL': '/bin/bash', 03:28:57 INFO - 'SHLVL': '1', 03:28:57 INFO - 'TERM': 'linux', 03:28:57 INFO - 'TMOUT': '86400', 03:28:57 INFO - 'USER': 'cltbld', 03:28:57 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466243090.727922-166158960', 03:28:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:57 INFO - '_': '/tools/buildbot/bin/python'} 03:28:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:28:58 INFO - Running setup.py (path:/tmp/pip-R7JQaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:28:58 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)) 03:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:28:58 INFO - Running setup.py (path:/tmp/pip-ECQ1dS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:28:58 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)) 03:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:28:58 INFO - Running setup.py (path:/tmp/pip-H7yycd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:28:58 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)) 03:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:28:58 INFO - Running setup.py (path:/tmp/pip-KxJGRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:28:58 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)) 03:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:28:58 INFO - Running setup.py (path:/tmp/pip-HGQxu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:28:58 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)) 03:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:28:58 INFO - Running setup.py (path:/tmp/pip-mUiBhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:28:58 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)) 03:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:28:58 INFO - Running setup.py (path:/tmp/pip-NEhbVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:28:58 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)) 03:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:28:58 INFO - Running setup.py (path:/tmp/pip-lplI6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:28:58 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)) 03:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:28:58 INFO - Running setup.py (path:/tmp/pip-SvAC2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:28:58 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)) 03:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:28:58 INFO - Running setup.py (path:/tmp/pip-b8hBBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:28:58 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)) 03:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:28:58 INFO - Running setup.py (path:/tmp/pip-GR1ybi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:28:58 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)) 03:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:28:58 INFO - Running setup.py (path:/tmp/pip-vZgij0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:28:58 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)) 03:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:28:58 INFO - Running setup.py (path:/tmp/pip-rsBswv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:28:58 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)) 03:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:28:58 INFO - Running setup.py (path:/tmp/pip-RhX6Ax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:28:59 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)) 03:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:59 INFO - Running setup.py (path:/tmp/pip-uzSRGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:59 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)) 03:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:28:59 INFO - Running setup.py (path:/tmp/pip-r_3_yj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:28:59 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)) 03:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:28:59 INFO - Running setup.py (path:/tmp/pip-M8PP79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:28:59 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)) 03:28:59 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)) 03:28:59 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)) 03:28:59 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)) 03:28:59 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)) 03:28:59 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)) 03:28:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:28: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 03:28: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 03:28: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 03:28: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 03:28: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 03:28: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 03:29:01 INFO - Downloading blessings-1.6.tar.gz 03:29:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:29:01 INFO - Installing collected packages: blessings 03:29:01 INFO - Running setup.py install for blessings 03:29:01 INFO - Successfully installed blessings 03:29:01 INFO - Cleaning up... 03:29:01 INFO - Return code: 0 03:29:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:29:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:29:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:29:01 INFO - Reading from file tmpfile_stdout 03:29:01 INFO - Current package versions: 03:29:01 INFO - argparse == 1.2.1 03:29:01 INFO - blessings == 1.6 03:29:01 INFO - blobuploader == 1.2.4 03:29:01 INFO - docopt == 0.6.1 03:29:01 INFO - functools32 == 3.2.3-2 03:29:01 INFO - jsonschema == 2.5.1 03:29:01 INFO - manifestparser == 1.1 03:29:01 INFO - mozInstall == 1.12 03:29:01 INFO - mozcrash == 0.17 03:29:01 INFO - mozdebug == 0.1 03:29:01 INFO - mozdevice == 0.48 03:29:01 INFO - mozfile == 1.2 03:29:01 INFO - mozhttpd == 0.7 03:29:01 INFO - mozinfo == 0.9 03:29:01 INFO - mozleak == 0.1 03:29:01 INFO - mozlog == 3.2 03:29:01 INFO - moznetwork == 0.27 03:29:01 INFO - mozprocess == 0.22 03:29:01 INFO - mozprofile == 0.28 03:29:01 INFO - mozrunner == 6.11 03:29:01 INFO - mozscreenshot == 0.1 03:29:01 INFO - mozsystemmonitor == 0.3 03:29:01 INFO - moztest == 0.7 03:29:01 INFO - mozversion == 1.4 03:29:01 INFO - psutil == 3.1.1 03:29:01 INFO - requests == 1.2.3 03:29:01 INFO - wsgiref == 0.1.2 03:29:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:29:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:29:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:29:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:01 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 0x7f089b8fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27581c0>, '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 0x27590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2759550>, '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': '232498196343f89f466a4a9a000001c8-1466243090.727922-166158960', '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 03:29:01 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 03:29:01 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 03:29:01 INFO - Using env: {'DISPLAY': ':0', 03:29:01 INFO - 'HOME': '/home/cltbld', 03:29:01 INFO - 'LANG': 'en_US.UTF-8', 03:29:01 INFO - 'LANGUAGE': 'en_US:en', 03:29:01 INFO - 'LOGNAME': 'cltbld', 03:29:01 INFO - 'MAIL': '/var/mail/cltbld', 03:29:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:01 INFO - 'MOZ_NO_REMOTE': '1', 03:29:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:01 INFO - 'NO_EM_RESTART': '1', 03:29:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:01 INFO - 'PWD': '/builds/slave/test', 03:29:01 INFO - 'SHELL': '/bin/bash', 03:29:01 INFO - 'SHLVL': '1', 03:29:01 INFO - 'TERM': 'linux', 03:29:01 INFO - 'TMOUT': '86400', 03:29:01 INFO - 'USER': 'cltbld', 03:29:01 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466243090.727922-166158960', 03:29:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:01 INFO - '_': '/tools/buildbot/bin/python'} 03:29:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:01 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)) 03:29:01 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)) 03:29:01 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)) 03:29:01 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)) 03:29:01 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)) 03:29:01 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)) 03:29:01 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)) 03:29:01 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)) 03:29:01 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)) 03:29:01 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)) 03:29:01 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)) 03:29:01 INFO - Cleaning up... 03:29:01 INFO - Return code: 0 03:29:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:29:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:29:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:29:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f089b8fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27581c0>, '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 0x27590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2759550>, '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': '232498196343f89f466a4a9a000001c8-1466243090.727922-166158960', '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 03:29:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:29:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:29:01 INFO - Using env: {'DISPLAY': ':0', 03:29:01 INFO - 'HOME': '/home/cltbld', 03:29:01 INFO - 'LANG': 'en_US.UTF-8', 03:29:01 INFO - 'LANGUAGE': 'en_US:en', 03:29:01 INFO - 'LOGNAME': 'cltbld', 03:29:01 INFO - 'MAIL': '/var/mail/cltbld', 03:29:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:01 INFO - 'MOZ_NO_REMOTE': '1', 03:29:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:01 INFO - 'NO_EM_RESTART': '1', 03:29:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:01 INFO - 'PWD': '/builds/slave/test', 03:29:01 INFO - 'SHELL': '/bin/bash', 03:29:01 INFO - 'SHLVL': '1', 03:29:01 INFO - 'TERM': 'linux', 03:29:01 INFO - 'TMOUT': '86400', 03:29:01 INFO - 'USER': 'cltbld', 03:29:01 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466243090.727922-166158960', 03:29:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:01 INFO - '_': '/tools/buildbot/bin/python'} 03:29:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:29:02 INFO - Cleaning up... 03:29:02 INFO - Return code: 0 03:29:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:29: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')]} 03:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29: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')]} 03:29:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:02 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 0x7f089b8fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27581c0>, '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 0x27590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2759550>, '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': '232498196343f89f466a4a9a000001c8-1466243090.727922-166158960', '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 03:29:02 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 03:29:02 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 03:29:02 INFO - Using env: {'DISPLAY': ':0', 03:29:02 INFO - 'HOME': '/home/cltbld', 03:29:02 INFO - 'LANG': 'en_US.UTF-8', 03:29:02 INFO - 'LANGUAGE': 'en_US:en', 03:29:02 INFO - 'LOGNAME': 'cltbld', 03:29:02 INFO - 'MAIL': '/var/mail/cltbld', 03:29:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:02 INFO - 'MOZ_NO_REMOTE': '1', 03:29:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:02 INFO - 'NO_EM_RESTART': '1', 03:29:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:02 INFO - 'PWD': '/builds/slave/test', 03:29:02 INFO - 'SHELL': '/bin/bash', 03:29:02 INFO - 'SHLVL': '1', 03:29:02 INFO - 'TERM': 'linux', 03:29:02 INFO - 'TMOUT': '86400', 03:29:02 INFO - 'USER': 'cltbld', 03:29:02 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466243090.727922-166158960', 03:29:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:02 INFO - '_': '/tools/buildbot/bin/python'} 03:29:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:02 INFO - Downloading/unpacking flake8 03:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:29:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:29:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:29:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:29:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:29:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:29:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:29:04 INFO - no previously-included directories found matching 'docs/_build' 03:29:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:29:04 INFO - Running setup.py install for pep8 03:29:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:29:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:29:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:29:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:29:05 INFO - no previously-included directories found matching 'docs/_build' 03:29:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:29:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:29:05 INFO - Cleaning up... 03:29:05 INFO - Return code: 0 03:29:05 INFO - Running post-action listener: _resource_record_post_action 03:29:05 INFO - Running post-action listener: _start_resource_monitoring 03:29:05 INFO - Starting resource monitoring. 03:29:05 INFO - ##### 03:29:05 INFO - ##### Finished create-virtualenv step (success) 03:29:05 INFO - ##### 03:29:05 INFO - ##### 03:29:05 INFO - ##### Running install step. 03:29:05 INFO - ##### 03:29:05 INFO - Running pre-action listener: _resource_record_pre_action 03:29:05 INFO - Running main action method: install 03:29:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:29:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:29:05 INFO - Reading from file tmpfile_stdout 03:29:05 INFO - Detecting whether we're running mozinstall >=1.0... 03:29:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:29:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:29:05 INFO - Reading from file tmpfile_stdout 03:29:05 INFO - Output received: 03:29:05 INFO - Usage: mozinstall [options] installer 03:29:05 INFO - Options: 03:29:05 INFO - -h, --help show this help message and exit 03:29:05 INFO - -d DEST, --destination=DEST 03:29:05 INFO - Directory to install application into. [default: 03:29:05 INFO - "/builds/slave/test"] 03:29:05 INFO - --app=APP Application being installed. [default: firefox] 03:29:05 INFO - mkdir: /builds/slave/test/build/application 03:29:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:29:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:29:21 INFO - Reading from file tmpfile_stdout 03:29:21 INFO - Output received: 03:29:21 INFO - /builds/slave/test/build/application/firefox/firefox 03:29:21 INFO - Running post-action listener: _resource_record_post_action 03:29:21 INFO - ##### 03:29:21 INFO - ##### Finished install step (success) 03:29:21 INFO - ##### 03:29:21 INFO - ##### 03:29:21 INFO - ##### Running run-tests step. 03:29:21 INFO - ##### 03:29:21 INFO - Running pre-action listener: _resource_record_pre_action 03:29:21 INFO - Running main action method: run_tests 03:29:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:29:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:29:21 INFO - Python 2.7.3 03:29:21 INFO - Return code: 0 03:29:21 INFO - grabbing minidump binary from tooltool 03:29:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:21 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 0x27581c0>, '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 0x27590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2759550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:29:21 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 03:29:21 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 03:29:21 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 03:29:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:29:21 INFO - Return code: 0 03:29:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:29:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:29:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:29:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:29:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:29:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:29:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:29:22 INFO - Return code: 0 03:29:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A0x_2Nn7SfC1ZAxF3yC4UA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:29:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/A0x_2Nn7SfC1ZAxF3yC4UA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:29:22 INFO - Using env: {'DISPLAY': ':0', 03:29:22 INFO - 'HOME': '/home/cltbld', 03:29:22 INFO - 'LANG': 'en_US.UTF-8', 03:29:22 INFO - 'LANGUAGE': 'en_US:en', 03:29:22 INFO - 'LOGNAME': 'cltbld', 03:29:22 INFO - 'MAIL': '/var/mail/cltbld', 03:29:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:29:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:29:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:22 INFO - 'MOZ_NO_REMOTE': '1', 03:29:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:29:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:22 INFO - 'NO_EM_RESTART': '1', 03:29:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:22 INFO - 'PWD': '/builds/slave/test', 03:29:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:29:22 INFO - 'SHELL': '/bin/bash', 03:29:22 INFO - 'SHLVL': '1', 03:29:22 INFO - 'TERM': 'linux', 03:29:22 INFO - 'TMOUT': '86400', 03:29:22 INFO - 'USER': 'cltbld', 03:29:22 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466243090.727922-166158960', 03:29:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:22 INFO - '_': '/tools/buildbot/bin/python'} 03:29:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A0x_2Nn7SfC1ZAxF3yC4UA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:29:22 INFO - mozversion application_buildid: 20160618004017 03:29:22 INFO - mozversion application_changeset: 541035fe27cb71fd6fdcd273c5190edd688f0731 03:29:22 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:29:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:29:22 INFO - mozversion application_name: Firefox 03:29:22 INFO - mozversion application_remotingname: firefox-dev 03:29:22 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:29:22 INFO - mozversion application_vendor: Mozilla 03:29:22 INFO - mozversion application_version: 49.0a2 03:29:22 INFO - mozversion platform_buildid: 20160618004017 03:29:22 INFO - mozversion platform_changeset: 541035fe27cb71fd6fdcd273c5190edd688f0731 03:29:22 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:29:22 INFO - mozversion platform_version: 49.0a2 03:29:22 INFO - using testdate: 1466245762 03:29:22 INFO - actual date: 1466245762 03:29:22 INFO - starting webserver on 'localhost:55791' 03:29:22 INFO - SUITE-START | Running 2 tests 03:29:22 INFO - TEST-START | dromaeo_css 03:29:22 INFO - operating with platform_type : linux_ 03:29:22 INFO - Initialising browser for dromaeo_css test... 03:29:22 INFO - TEST-INFO | started process 1201 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI89NDE/profile http://localhost:55791/getInfo.html) 03:29:26 INFO - PROCESS | 1201 | __metrics Screen width/height:1600/1200 03:29:26 INFO - PROCESS | 1201 | colorDepth:24 03:29:26 INFO - PROCESS | 1201 | Browser inner width/height: 1024/697 03:29:26 INFO - PROCESS | 1201 | __metrics 03:29:27 ERROR - PROCESS | 1201 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:29:27 INFO - PROCESS | 1201 | console.error: PushService: 03:29:27 INFO - PROCESS | 1201 | stateChangeProcessEnqueue: Error transitioning state 03:29:27 INFO - PROCESS | 1201 | UnknownError 03:29:28 INFO - TEST-INFO | 1201: exit 0 03:29:28 INFO - Browser initialized. 03:29:28 INFO - Running cycle 1/1 for dromaeo_css test... 03:29:28 INFO - TEST-INFO | started process 1306 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI89NDE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:29:39 INFO - PROCESS | 1306 | RSS: Main: 145235968 03:29:39 INFO - PROCESS | 1306 | 03:30:31 INFO - PROCESS | 1306 | 1466245831101 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] 03:32:38 INFO - PROCESS | 1306 | Cycle 1(1): loaded http://localhost:55791/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55791/tests/dromaeo/cssquery-ext.html) 03:32:40 INFO - PROCESS | 1306 | RSS: Main: 254545920 03:32:40 INFO - PROCESS | 1306 | 03:35:42 INFO - PROCESS | 1306 | Cycle 1(1): loaded http://localhost:55791/tests/dromaeo/cssquery-ext.html (next: http://localhost:55791/tests/dromaeo/cssquery-jquery.html) 03:35:43 INFO - PROCESS | 1306 | RSS: Main: 231931904 03:35:43 INFO - PROCESS | 1306 | 03:38:44 INFO - PROCESS | 1306 | Cycle 1(1): loaded http://localhost:55791/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55791/tests/dromaeo/cssquery-mootools.html) 03:38:45 INFO - PROCESS | 1306 | RSS: Main: 230211584 03:38:45 INFO - PROCESS | 1306 | 03:41:47 INFO - PROCESS | 1306 | Cycle 1(1): loaded http://localhost:55791/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55791/tests/dromaeo/cssquery-prototype.html) 03:41:48 INFO - PROCESS | 1306 | RSS: Main: 224698368 03:41:48 INFO - PROCESS | 1306 | 03:44:50 INFO - PROCESS | 1306 | Cycle 1(1): loaded http://localhost:55791/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55791/tests/dromaeo/cssquery-yui.html) 03:44:51 INFO - PROCESS | 1306 | RSS: Main: 208064512 03:44:51 INFO - PROCESS | 1306 | 03:47:53 INFO - PROCESS | 1306 | Cycle 1(1): loaded http://localhost:55791/tests/dromaeo/cssquery-yui.html (next: http://localhost:55791/tests/dromaeo/cssquery-dojo.html) 03:47:53 INFO - PROCESS | 1306 | RSS: Main: 260894720 03:47:53 INFO - PROCESS | 1306 | 03:47:53 INFO - PROCESS | 1306 | __start_tp_report 03:47:53 INFO - PROCESS | 1306 | _x_x_mozilla_page_load 03:47:53 INFO - PROCESS | 1306 | _x_x_mozilla_page_load_details 03:47:53 INFO - PROCESS | 1306 | |i|pagename|runs| 03:47:53 INFO - PROCESS | 1306 | |0;dojo.html;3344.26426186239;3349.899503014909;3361.932761344773;3363.8149901755423;3398.9660103398974;5524.696141712204;5613.354464236614;5617.38208797032;5639.971800140998;5641.125625528045;5509.531689806361;5555.194496797972;5558.388577256498;5563.082091454915;5594.49649531542;4923.876903077416;4968.5528302452685;4985.027919555688;5028.673136246132;5061.721605311706;4876.390451193601;5010.949890501085;5053.115704751672;5060.190369540875;5060.2156665716875;4998.325226094467;5017.272495488152;5045.823396181135;5046.596272298226;5052.040112378655;5131.230315452674;5133.589312854962;5138.023775482684;5149.253358263069;5179.896402071956;4872.878178045542;4962.1812400953795;5003.824866129705;5061.544460998491;5062.797488100471;5407.810726624549;5419.674819510842;5435.972820135874;5469.644473109235;5482.424345443711;5943.108533719977;5979.970100149471;5989.221401217814;5990.430909063632;5992.49063829575;6012.969935150296;6027.21646185993;6032.336442991267;6096;6121.296050954153;5653.971730141364;5683.318001839764;5696.401877802854;5700.914486282709;5711.771529138788;5859.53123750099;6171.166892469549;6201.937980620136;6203.689815509207;6204.038374052029;5751.338596061507;5756.107803290497;5774.393688662714;5808.535317174616;5844.678542680108;5887.735051922674;5941.673207973517;5941.821745347646;5948.702564871739;5954.19618351517;5760.8271751847515;5875.529957603381;5888.146218798336;5890.087036509348;5895.705214739246;5925.05199168131;5982.910256346158;5989.730462129215;5992.041273396236;6022.5784195105925;4559.768862407198;4572.45130584332;4572.9314060289125;4578.542145785462;4602.309653551927;3985.2228815381304;4045.0494133878515;4069;4118.5057793065025;4155.231282212801;5715.914261286084;5733.054046082433;5740.971295143498;5742.167385729046;5752.827415177551;5987.9101813472835;6034.155218269446;6042.365551617105;6042.577019608585;6086.969565152146;5523.447655234444;5653.858653533613;5698.116791897262;5702.287214098238;5725.026745453283;5155;5187.818426355135;5203.713795741271;5207.843764687065;5210.452902445264;6239.06414037898;6254.15568898202;6256.155419018374;6257.624542527463;6265.780697675651;5822.3304320003745;5902.4097590240635;5933.110033495011;5935.7032148391545;5996.610220335664;6161.630302181883;6163.013917773134;6164.445199932027;6164.599301045418;6178.289496707936;5711.029125048669;5852.122181672783;5866.970665146647;5869.530437564899;5869.618474799125;5909.172715819875;5918.053111502311;5934.169216309634;5970.731317090655;5983.9401605983385;5803.361630220588;5828.184054232326;5831.562632802472;5834.679092649775;5837.766489340379;5635.549156067423;5701.572382071278;5766.711664416846;5826.737796799239;5830.329512106162;5598.35618903815;5713.200151978809;5714.485696287354;5716.342620598684;5742.397048310035;5806.738696758741;5821.27234095738;5841.883162336814;5861.1501332307425;5867.383924687846;5496.725163741877;5594.916076258941;5632.183333416713;5669.20631111653;5697.088465845611 03:47:53 INFO - PROCESS | 1306 | |1;ext.html;594.658071608825;632.2792017100506;649.9967500162502;657.7270432770399;667.3426674725398;31963.68036319636;35217.47173792395;35407.4688879667;44736;46098.53901460984;47727.28409073866;48361.274580881225;48371.51628483714;48373.758131209295;48385.51614483854;8930.687425940094;9120.17918387345;9122.77193070172;9124.31567632427;9142.862857057149;8382.371322150833;10541.84187237192;10882.183836212276;10906.781864362709;11185.552577896915;10896.455177241145;11007.394593297366;11010.284331518465;11014.118870490342;11018.44907754613;8456.11210822867;10594.099501542378;10862.61980830671;10967;10973.451327433597;10462.110720588758;10598.52306646195;10964.451777411097;10965.671029869116;10988.340699557972;45408.772956135006;45978.770106149255;46026.30960535595;46093.30860037102;46097.30854037192;3432.9485057724155;3455.1362159460136;3701.4632878232774;3759.605241449663;3929.174873276587;34831.651683483346;35181.6481835181;35334.11664708377;35407.645923540695;35624.64375356239;4355.12897420514;4420.84527041552;4425.712328698624;4474.261746811772;4541.205289074399;377963;380567;380632;380698;381159.09420453;37867.242655147296;67944.3205567938;68769.3123068773;68833.65583172052;68876.6556167226;39609.207815843525;41367.1726565467;41401;41524.58475415207;41530.58469415267;15918.840811591968;15952.122633255283;16057.759133613004;16059.518214453585;16067.955582887309;10885.074768644754;11808.173427859967;11862.822057669142;12495;12685.112042157145;9317.11487408695;9320.673776417792;9338.112879276458;9383.765405864771;9393.389429687048;3550.449680299506;3581.4448760442174;3589.2283159120393;3592.3533763922746;3698.1863989922176;1035.7928414317016;1059.0733108530037;1111.9777604447866;1145.4387350198342;1190.9583164589199;32457.675423245466;34133.31733365319;34216.65783342184;34262.314753704784;34345.141371465914;1100.4277775556666;1146.7763786061805;1158.9420528973517;1166.78414493319;1213.124340289293;17271.88221535876;17778.199981000886;17890.958537048733;18051;18112.45662630123;564521;575465;579437;600577;992407;63600.68199658972;64070.35929640737;64240.35759642437;64424.35575644184;64480;1267.7084270617809;1338.1302153600238;1343.3081962789367;1357.362039841273;1365.7746471832236;30892.53661195039;31409.214769630027;33399;33825.323493530486;34836.65163348334;57636.42363576311;62698;62729.372706272356;62774;62808.68595656993;517784;518032;520643;520944;521161;37918.293676785164;46782.53217467782;47588.762056189495;48204;51045.489545105556;49819.25271120864;50161.74919125527;50860.74569627276;51708.48291517187;51830.222546661076;43920.12159756851;44274.3358849624;44327.77836110799;44429;44545.55454445414;44306.77846610875;44410.777946110065;44523.777381112886;44861.102777944914;45643.77178114088;43414.68766519445;43527.78236108799;44061.559384405744;44072.33891491566;44142.558574413844;37236.627633723314;38152;38860.2227955445;38940.221195576494;39654.2069158621;29608.259793505335;29755.702442975293;29856.552151718177;30229.69770302357;30249.546256806607 03:47:53 INFO - PROCESS | 1306 | |2;jquery.html;430.72433642468826;431.2790829644763;436.33241141054197;438.1740419309601;441.600351681728;20020.299289524868;20772.272970446036;21045.894770526145;21603.67594486084;21707.348779536598;19327.323543675975;19956.30152944647;20310.695339569917;20761.480962975933;20791.584168316625;5869.647821130725;6028.39716028398;6040.1241819936085;6049.727762250709;6064;5578.219049333096;5850.151727999438;5853.678047707374;5938.9703051484685;5943.375945525722;5888.116782482619;5889.705514724246;5895;5900.439458251481;5915.763369465238;5527.143292789624;5660.66036037837;5671.291088613923;5683.062294721366;5716.256886604736;5240.292560504359;5466;5490.917636235459;5491.533219676332;5531.585131115183;13083.542076027294;13108.27904465254;13159.407826647825;13295;13326.733465330735;2386.8925898334614;2428.429319110008;2541.7077036140895;2741.2050505353423;2852.3154442933546;10024.59901603935;10167.23745719074;10468.214883883738;10488.108510776594;10502.527386267637;1954.3648314297768;2070.4616799632054;2075.107703687414;2178.215842296772;2233.7207849018873;74896;78112.99999999943;78278.21721782767;78751.60624196842;78796;10634.840477392845;10929.234953553334;11186.44067796607;11468.13988950832;11862.169648124549;15543.145127018122;15629.296681649354;15652;15659.686806264039;15686.215689215494;7767.300942915052;7810.492317999312;8050.396220283502;8173.918260817434;8178.877316840133;7890.48711833729;7979.202079791974;7991.480553763987;8058.758237252891;8093.352531797442;4494.52807455219;4622.237330840374;4677.462091859412;4839.346688197048;5092.8472145835685;1869.1775618727715;2039.2352867674622;2088.2169186555043;2107.1466056247245;2124.904379302935;862.1550880137501;901.8602116671926;945.2485274207022;946.8769060022153;972.8103019911049;16376.181190940406;16563.6687266254;17208.65582688339;17471.563210919576;17733.911330443265;904.5567671840882;968.8692026576322;1004.2016596805557;1010.6816352848829;1014.1531820929459;9716.659916902874;9982.500874956368;9985.80028399428;10057;10112.393256404639;504209;522428.1802019576;524245;535978;537043;97443.51278243563;100451.49774251228;102472;103092;103671;1015.8425444056184;1031.7059638003134;1045.3362115056993;1059.4543809937888;1061.840723891407;15601.453949112181;15660.68678626444;15901.840981590036;15904;16286;41852;41893.1621367577;42051.57948420477;42306.59947060656;42705.359419609355;58444;59018;59246.40753592581;59986.40013599983;60314.69842650759;8814.579103351325;8863.379563430499;8882.245009174292;8942.86585701228;9122.133397327243;12155;13032.739345212853;13289.933550332187;13537.255450950292;13886.513972010931;11959.581414650445;12177.208481448677;12178.512859485876;12299.50801967947;12414.875851241733;12149.635510934686;12155.270683759003;12337.568185113478;12430.12989090755;12608.306543140216;11925.224860384047;12065.577704780291;12454.56409025716;12476.376181190722;12529.122961392615;8354.916450835413;8504.149585041447;8554.315654747481;8600.09698981623;8723.781905452415;11291.604793832177;11940.76118477643;12072.3360215189;12098.455569499218;12326.383680816103 03:47:53 INFO - PROCESS | 1306 | |3;mootools.html;1193.5345215366003;1556.369670283535;1563.624730064785;1772.8670349723775;1887.7829049659285;9140.908590914089;9547;9549.904500954988;9774.951125244364;9788.216942644589;9488.383255088414;9677.61289548419;9684.467354295528;9692.224622030239;9719.854202186973;2001.549651328454;2393.3179043972473;2452.448199155194;2471.40686235304;2474.1216868011866;2512.786413154884;2528.582783840664;2533.505966336565;2534.4550921551863;2537.860417677027;2447.1801946347996;2530.127106148385;2534.9746502535017;2538.504991526653;2539.809514286436;2043.1010355443632;2336.0655737704883;2397.3886658902043;2404.5551572959057;2408.1932552594903;2263.694401255826;2273.499830037389;2279.2364557872966;2281.1559722902634;2289.8740569268684;9736.561854716554;9741.31810773246;9741.805163896683;9778.119969202806;9783.41299522031;5572.247746554244;5699.173619825102;5707.058335374658;5709.115087161455;5709.914351284692;3423.5720534933134;3426.3318652862704;3507.4563442666426;3522.7181825453904;3565.53648025755;1076.838474228864;1078.1267173589417;1139.2367114033618;1146.1232157399595;1171.2503997441645;13835.30823458833;13858.792118118236;13917.58247252584;13928.51250206248;13939;4923.310736496894;4952.158133117378;4998.1503144464805;5019.799208031711;5064.645474816801;11260.211785175123;11320.320780753182;11325.773484530428;11341.489632966372;11369;5585.832425027255;5619.831405057855;5623.184638227434;5629.7185140742795;5631.971840140773;4085.571015043437;5039.44566097729;5234.712090834964;5235.502627250481;5237.973810131001;4309.181255561433;4311.655067594585;4375.584319489643;4398.626116780046;4497.280435130363;1305.3147097773556;1305.921644701302;1308.5943357559188;1316.6642506161058;1336.2583766009957;903.1375036839802;977.731123940922;981.3768257156756;1019.6329321444274;1029.505837198149;6162.938370616326;6291.087792270187;6382.521310901701;6397.912354899679;6434.7104380303;468.5689165967318;477.9808807647655;482.007065445184;490.5119406190863;495.4549995005537;4306.569343065668;4328.8268469260875;4347.130573885172;4361.040571074359;4400.977995110068;11920.642380728592;12041.819372709417;12169.756604867853;12229.571964981184;12341.876581234252;11464.4840982156;11916.225445346025;11918.046556275478;12027.759444811054;12057.758844823054;8747.300215982707;8842.381033327734;8876.733697989072;8882.511461869659;8917.42036767608;6480.125183100221;6499.902501462388;6525.3148419417175;6602.8349291268105;6604.735810567524;10536.525856336637;10791.190660700322;10908.890911090788;10990.670279891616;10998.230123891251;11040.668779936615;11061.391623460788;11069.833952490559;11175.664730057786;11205.103591712481;7099.716011359487;7299.671514781741;7302.56184628924;7918.841623167619;8410.411271210956;7872.685092596232;8860.113988601088;9154.908450915673;9162.312826537904;9448.574814133242;8017.959910200411;8131.566469516655;8374.413791034569;8423.70517031901;8478.321734261368;8106.756797296091;8190.754277371689;8225.95887020561;8290.046644635944;8306.958465207636;7167.390771784457;7172.748953786592;7184.676689549087;7207;7216.96391518039;5075.11185542536;5137.17805151174;5241.947580524146;5375.543078838343;5453.345598528202;5435.103207970798;5500.642458240201;5548.223248745098;5578.219049333178;5612.186232996274 03:47:53 INFO - PROCESS | 1306 | |4;prototype.html;343.2311621966795;353.7134920714222;354.16947258678397;357.98747043853473;364.34236203652415;5483.232347471352;5492.901419716063;5529.225908372821;5532.28499165259;5570.888582228358;5419.810306639269;5431.782728690848;5450.781968721247;5457;5505.834824955257;3986.6810655147665;4059.878203653895;4303.870883873489;4309.547497512755;4320.092780516095;4220.620144187023;4248.830046798124;4249.3625956106525;4251.2135254977775;4291.549387314334;4227.4927008759;4230.661547076242;4246.660267178634;4263.722858014219;4274.700770946035;4061.79691015451;4158.272302347107;4269.331667707683;4280.250956082704;4305.203537345601;3786.8106594670157;3790.564085130218;3805.5813860475328;3806.2577797329254;3807.961920380816;5264.894702105975;5302.761375738101;5322.77576157486;5329.307190065306;5361.624686271963;4935.777889994959;4937.308776771255;4939.604831613498;4973.229149481836;5003.249512573107;5719.71401429931;5759.884802303931;5778;5778.3643799182055;5793.159991801207;4069;4085.44846445729;4098.938515922264;4196.475440569929;4213.852515161954;5902.675352855591;5951.464368206882;5980.641161530322;6003.849903752397;6015.669138197398;4247.405363249148;4265.274903266452;4265.53079161292;4270.167317373082;4285.057287396768;4058.6550143238155;4237.385579091015;4237.512686041145;4246.702730808814;4262.403263543107;4807.927881081787;4832.540908613676;4857.247126695368;4878.121938051114;4898.510148985073;5721.313442386941;5751.482366587027;5771.336296325976;5792.623479473821;5810.622309549865;1421.3532842556613;1480.2672677024727;1481.8071452480856;1485.9405623775144;1500.2498750624688;940.2431043010306;945.8202941441242;956.583886009588;965.7199412170391;966.2656381150235;4982.829035176731;5008.774605142778;5010.044073996287;5040.445550989388;5047.798088076436;5242;5256.316678831728;5267.209918512254;5280.762365693553;5289.656172348785;4725.29120631908;5017.498250174954;5058.3929928408825;5067.125163689385;5067.239914012927;2785.610014597958;2815.549512078058;2816.845073520976;2824.8587570621385;2826.321682796155;5454.699991500426;5455.5908306877145;5466.332768505644;5471.562275017989;5496.395396506381;5079.720615366116;5231.231621042749;5283.498067683564;5295.867603309948;5344.278522399504;5298.986385173609;5336.4129945705945;5337.706426146521;5421.322334708161;5445.782168713207;5234.764435600483;5675.432456754292;5700.543956483389;5902.704864756831;5920.720522598916;5843.386444423444;5849.59609693679;5853.2976042875125;5886.764529418947;5894.440028197314;5778.150991682621;6056.757729690763;6082.90875636857;6096.634201947897;6134.018557030854;4208.326667733148;4216.325387937915;4231.788410579397;4254.574542545721;4271.359296105609;5908.704564771659;5956.391774221022;5968.373320801427;5996.5502587307;5998.190244316961;5547.251121098761;5794.565407594363;5803.622764520293;5869.325027621878;5880.059190529495;5830.2420685310635;5841.50347220491;5856.970715146397;5888.587798854039;5904.409559044061;5564.273505982121;5663.461971112738;5676.4323567642905;5817.272840894888;5829.300483941955;5784.4504772046585;5836.153757705194;5839.8540036497725;5877.882442351214;5879.676617786063;5693.601447898607;5700.743466543932;5706.885862282814;5717.485426311486;5743.655380677173 03:47:53 INFO - PROCESS | 1306 | |5;yui.html;769.86142494351;780.102881686061;829.8713699376596;883.5758835758836;887;15575;15888.602784930383;15892.84107158928;15894.602634934132;15897.1256580888;16105.597360065974;16134.75797863033;16197.83802161978;16211.83788162118;16323.10222937738;835.3734698975768;855.8117214212863;869.0874581689201;869.678219058949;871.8779370888049;866.8829707989436;869.3045563549167;871.4292138649195;872.2455076358935;873.1094283830489;911.0661571888834;912.2929729459655;912.3157631776168;912.5163663258451;913.0641092879819;905.2803021597846;908.9454632722058;909.8726178335038;910.1035480052143;911.5305617606938;662.8906230471966;666.7066490744057;668.1614573710011;669.4945316286221;669.7856685860527;14718.411263549446;14761.335739891623;14790.778138327934;14808.407663693548;14835.406583736638;15497.147656878868;15825.762613560806;15866.841331586651;15942.043477391393;15964.76052859208;12239.816402753966;12328.815067773901;12395.318257495834;13278.800817987738;14092.436302547885;4711.882202944919;4742.810287588492;4782.115308667908;4804.159272127398;4902.48523904992;78579.99999999943;78771;79315;80228;80254.19745802526;11183.496742646601;11420.657380278604;11477.770444591062;12344.321062341658;12428.56500022495;21093.156273749184;21138.577228455346;21141;21242.25652102169;21342;9434.528273586293;9508.619655213852;9600.32797704168;9628.566714497865;9677;5077.619178561623;5078.960088901756;5106.846794596168;5350.464953504618;5385.353757549041;3610.2779444111284;3719.4606782017;3727.3849814780256;3729.627037296303;3733.3466643337306;659.0279337976542;663.0584569910739;671.9966400167967;675.152683382352;678.6606696651675;530.6895466152345;580.6516090345759;617.4350469320611;626.8464226264504;639;9764.51177441125;9893.109620134222;9930.2055835533;9960.153386962189;10015.248856335804;585.5871610514577;661.675778868351;684.7671791590883;691.4813889582813;698.7763915546976;4449.822007119744;4506.977465112654;4611.262198048296;4680.438347398334;4751.714897106184;105056.47471762745;112050.43974780074;112482;120418.98952526081;120641;96652.51673741586;99744;99928.5003574992;100972.49513752385;101015;87530.56234718785;90707;90734.54632726795;91557;91707.5414622936;9505.66730164441;9525.14273715369;9614.423134611945;9676.806463870824;9714.611415543299;51707;52512;53004.73497632487;53951.730241348545;55052.449475504734;72229.27770722436;76418.6179069101;77100;77268;77293.61353193199;11638.185327027028;12464.750704985669;12528.686782830502;12706.491740330282;13045.804312935503;13503.932480337535;13558.661033474242;13761.105528140639;13945.721085578434;14305.57083287503;12929.870701292866;13643.727125457634;13692.863071369158;13694.246816425193;13927.094738841943;14433.061850979653;14569.271536423348;14589.142894068273;14751;14779.704405911607;13714.725705486035;14137;14323.85676143267;14465.927670361581;14714.705705886037;11301.773964520828;11798.587049453228;12205.389730513616;12366;12626.179298345945;11562.653120406401;11878;12027.639170824888;12244.326562039174;12368.1960672556 03:47:53 INFO - PROCESS | 1306 | __end_tp_report 03:47:53 INFO - PROCESS | 1306 | __start_cc_report 03:47:53 INFO - PROCESS | 1306 | _x_x_mozilla_cycle_collect,953 03:47:53 INFO - PROCESS | 1306 | __end_cc_report 03:47:53 INFO - PROCESS | 1306 | __startTimestamp1466246873956__endTimestamp 03:47:53 INFO - PROCESS | 1306 | 03:47:53 INFO - PROCESS | 1306 | ------- Summary: start ------- 03:47:53 INFO - PROCESS | 1306 | Number of tests: 6 03:47:53 INFO - PROCESS | 1306 | 03:47:53 INFO - PROCESS | 1306 | [#0] dojo.html Cycles:165 Average:5536.33 Median:5725.03 stddev:617.33 (10.8%) stddev-sans-first:594.79 03:47:53 INFO - PROCESS | 1306 | Values: 3344.3 3349.9 3361.9 3363.8 3399.0 5524.7 5613.4 5617.4 5640.0 5641.1 5509.5 5555.2 5558.4 5563.1 5594.5 4923.9 4968.6 4985.0 5028.7 5061.7 4876.4 5010.9 5053.1 5060.2 5060.2 4998.3 5017.3 5045.8 5046.6 5052.0 5131.2 5133.6 5138.0 5149.3 5179.9 4872.9 4962.2 5003.8 5061.5 5062.8 5407.8 5419.7 5436.0 5469.6 5482.4 5943.1 5980.0 5989.2 5990.4 5992.5 6013.0 6027.2 6032.3 6096.0 6121.3 5654.0 5683.3 5696.4 5700.9 5711.8 5859.5 6171.2 6201.9 6203.7 6204.0 5751.3 5756.1 5774.4 5808.5 5844.7 5887.7 5941.7 5941.8 5948.7 5954.2 5760.8 5875.5 5888.1 5890.1 5895.7 5925.1 5982.9 5989.7 5992.0 6022.6 4559.8 4572.5 4572.9 4578.5 4602.3 3985.2 4045.0 4069.0 4118.5 4155.2 5715.9 5733.1 5741.0 5742.2 5752.8 5987.9 6034.2 6042.4 6042.6 6087.0 5523.4 5653.9 5698.1 5702.3 5725.0 5155.0 5187.8 5203.7 5207.8 5210.5 6239.1 6254.2 6256.2 6257.6 6265.8 5822.3 5902.4 5933.1 5935.7 5996.6 6161.6 6163.0 6164.4 6164.6 6178.3 5711.0 5852.1 5867.0 5869.5 5869.6 5909.2 5918.1 5934.2 5970.7 5983.9 5803.4 5828.2 5831.6 5834.7 5837.8 5635.5 5701.6 5766.7 5826.7 5830.3 5598.4 5713.2 5714.5 5716.3 5742.4 5806.7 5821.3 5841.9 5861.2 5867.4 5496.7 5594.9 5632.2 5669.2 5697.1 03:47:53 INFO - PROCESS | 1306 | 03:47:53 INFO - PROCESS | 1306 | [#1] ext.html Cycles:180 Average:67999.91 Median:21434.70 stddev:144929.07 (676.1%) stddev-sans-first:145247.27 03:47:53 INFO - PROCESS | 1306 | Values: 594.7 632.3 650.0 657.7 667.3 31963.7 35217.5 35407.5 44736.0 46098.5 47727.3 48361.3 48371.5 48373.8 48385.5 8930.7 9120.2 9122.8 9124.3 9142.9 8382.4 10541.8 10882.2 10906.8 11185.6 10896.5 11007.4 11010.3 11014.1 11018.4 8456.1 10594.1 10862.6 10967.0 10973.5 10462.1 10598.5 10964.5 10965.7 10988.3 45408.8 45978.8 46026.3 46093.3 46097.3 3432.9 3455.1 3701.5 3759.6 3929.2 34831.7 35181.6 35334.1 35407.6 35624.6 4355.1 4420.8 4425.7 4474.3 4541.2 377963.0 380567.0 380632.0 380698.0 381159.1 37867.2 67944.3 68769.3 68833.7 68876.7 39609.2 41367.2 41401.0 41524.6 41530.6 15918.8 15952.1 16057.8 16059.5 16068.0 10885.1 11808.2 11862.8 12495.0 12685.1 9317.1 9320.7 9338.1 9383.8 9393.4 3550.4 3581.4 3589.2 3592.4 3698.2 1035.8 1059.1 1112.0 1145.4 1191.0 32457.7 34133.3 34216.7 34262.3 34345.1 1100.4 1146.8 1158.9 1166.8 1213.1 17271.9 17778.2 17891.0 18051.0 18112.5 564521.0 575465.0 579437.0 600577.0 992407.0 63600.7 64070.4 64240.4 64424.4 64480.0 1267.7 1338.1 1343.3 1357.4 1365.8 30892.5 31409.2 33399.0 33825.3 34836.7 57636.4 62698.0 62729.4 62774.0 62808.7 517784.0 518032.0 520643.0 520944.0 521161.0 37918.3 46782.5 47588.8 48204.0 51045.5 49819.3 50161.7 50860.7 51708.5 51830.2 43920.1 44274.3 44327.8 44429.0 44545.6 44306.8 44410.8 44523.8 44861.1 45643.8 43414.7 43527.8 44061.6 44072.3 44142.6 37236.6 38152.0 38860.2 38940.2 39654.2 29608.3 29755.7 29856.6 30229.7 30249.5 03:47:53 INFO - PROCESS | 1306 | 03:47:53 INFO - PROCESS | 1306 | [#2] jquery.html Cycles:180 Average:29978.30 Median:2485.07 stddev:86559.88 (3483.2%) stddev-sans-first:86774.27 03:47:53 INFO - PROCESS | 1306 | Values: 430.7 431.3 436.3 438.2 441.6 20020.3 20772.3 21045.9 21603.7 21707.3 19327.3 19956.3 20310.7 20761.5 20791.6 5869.6 6028.4 6040.1 6049.7 6064.0 5578.2 5850.2 5853.7 5939.0 5943.4 5888.1 5889.7 5895.0 5900.4 5915.8 5527.1 5660.7 5671.3 5683.1 5716.3 5240.3 5466.0 5490.9 5491.5 5531.6 13083.5 13108.3 13159.4 13295.0 13326.7 2386.9 2428.4 2541.7 2741.2 2852.3 10024.6 10167.2 10468.2 10488.1 10502.5 1954.4 2070.5 2075.1 2178.2 2233.7 74896.0 78113.0 78278.2 78751.6 78796.0 10634.8 10929.2 11186.4 11468.1 11862.2 15543.1 15629.3 15652.0 15659.7 15686.2 7767.3 7810.5 8050.4 8173.9 8178.9 7890.5 7979.2 7991.5 8058.8 8093.4 4494.5 4622.2 4677.5 4839.3 5092.8 1869.2 2039.2 2088.2 2107.1 2124.9 862.2 901.9 945.2 946.9 972.8 16376.2 16563.7 17208.7 17471.6 17733.9 904.6 968.9 1004.2 1010.7 1014.2 9716.7 9982.5 9985.8 10057.0 10112.4 504209.0 522428.2 524245.0 535978.0 537043.0 97443.5 100451.5 102472.0 103092.0 103671.0 1015.8 1031.7 1045.3 1059.5 1061.8 15601.5 15660.7 15901.8 15904.0 16286.0 41852.0 41893.2 42051.6 42306.6 42705.4 58444.0 59018.0 59246.4 59986.4 60314.7 8814.6 8863.4 8882.2 8942.9 9122.1 12155.0 13032.7 13289.9 13537.3 13886.5 11959.6 12177.2 12178.5 12299.5 12414.9 12149.6 12155.3 12337.6 12430.1 12608.3 11925.2 12065.6 12454.6 12476.4 12529.1 8354.9 8504.1 8554.3 8600.1 8723.8 11291.6 11940.8 12072.3 12098.5 12326.4 03:47:53 INFO - PROCESS | 1306 | 03:47:53 INFO - PROCESS | 1306 | [#3] mootools.html Cycles:180 Average:6218.29 Median:486.26 stddev:3675.11 (755.8%) stddev-sans-first:3666.01 03:47:53 INFO - PROCESS | 1306 | Values: 1193.5 1556.4 1563.6 1772.9 1887.8 9140.9 9547.0 9549.9 9775.0 9788.2 9488.4 9677.6 9684.5 9692.2 9719.9 2001.5 2393.3 2452.4 2471.4 2474.1 2512.8 2528.6 2533.5 2534.5 2537.9 2447.2 2530.1 2535.0 2538.5 2539.8 2043.1 2336.1 2397.4 2404.6 2408.2 2263.7 2273.5 2279.2 2281.2 2289.9 9736.6 9741.3 9741.8 9778.1 9783.4 5572.2 5699.2 5707.1 5709.1 5709.9 3423.6 3426.3 3507.5 3522.7 3565.5 1076.8 1078.1 1139.2 1146.1 1171.3 13835.3 13858.8 13917.6 13928.5 13939.0 4923.3 4952.2 4998.2 5019.8 5064.6 11260.2 11320.3 11325.8 11341.5 11369.0 5585.8 5619.8 5623.2 5629.7 5632.0 4085.6 5039.4 5234.7 5235.5 5238.0 4309.2 4311.7 4375.6 4398.6 4497.3 1305.3 1305.9 1308.6 1316.7 1336.3 903.1 977.7 981.4 1019.6 1029.5 6162.9 6291.1 6382.5 6397.9 6434.7 468.6 478.0 482.0 490.5 495.5 4306.6 4328.8 4347.1 4361.0 4401.0 11920.6 12041.8 12169.8 12229.6 12341.9 11464.5 11916.2 11918.0 12027.8 12057.8 8747.3 8842.4 8876.7 8882.5 8917.4 6480.1 6499.9 6525.3 6602.8 6604.7 10536.5 10791.2 10908.9 10990.7 10998.2 11040.7 11061.4 11069.8 11175.7 11205.1 7099.7 7299.7 7302.6 7918.8 8410.4 7872.7 8860.1 9154.9 9162.3 9448.6 8018.0 8131.6 8374.4 8423.7 8478.3 8106.8 8190.8 8226.0 8290.0 8307.0 7167.4 7172.7 7184.7 7207.0 7217.0 5075.1 5137.2 5241.9 5375.5 5453.3 5435.1 5500.6 5548.2 5578.2 5612.2 03:47:53 INFO - PROCESS | 1306 | 03:47:53 INFO - PROCESS | 1306 | [#4] prototype.html Cycles:180 Average:4738.23 Median:5297.43 stddev:1385.27 (26.1%) stddev-sans-first:1349.31 03:47:53 INFO - PROCESS | 1306 | Values: 343.2 353.7 354.2 358.0 364.3 5483.2 5492.9 5529.2 5532.3 5570.9 5419.8 5431.8 5450.8 5457.0 5505.8 3986.7 4059.9 4303.9 4309.5 4320.1 4220.6 4248.8 4249.4 4251.2 4291.5 4227.5 4230.7 4246.7 4263.7 4274.7 4061.8 4158.3 4269.3 4280.3 4305.2 3786.8 3790.6 3805.6 3806.3 3808.0 5264.9 5302.8 5322.8 5329.3 5361.6 4935.8 4937.3 4939.6 4973.2 5003.2 5719.7 5759.9 5778.0 5778.4 5793.2 4069.0 4085.4 4098.9 4196.5 4213.9 5902.7 5951.5 5980.6 6003.8 6015.7 4247.4 4265.3 4265.5 4270.2 4285.1 4058.7 4237.4 4237.5 4246.7 4262.4 4807.9 4832.5 4857.2 4878.1 4898.5 5721.3 5751.5 5771.3 5792.6 5810.6 1421.4 1480.3 1481.8 1485.9 1500.2 940.2 945.8 956.6 965.7 966.3 4982.8 5008.8 5010.0 5040.4 5047.8 5242.0 5256.3 5267.2 5280.8 5289.7 4725.3 5017.5 5058.4 5067.1 5067.2 2785.6 2815.5 2816.8 2824.9 2826.3 5454.7 5455.6 5466.3 5471.6 5496.4 5079.7 5231.2 5283.5 5295.9 5344.3 5299.0 5336.4 5337.7 5421.3 5445.8 5234.8 5675.4 5700.5 5902.7 5920.7 5843.4 5849.6 5853.3 5886.8 5894.4 5778.2 6056.8 6082.9 6096.6 6134.0 4208.3 4216.3 4231.8 4254.6 4271.4 5908.7 5956.4 5968.4 5996.6 5998.2 5547.3 5794.6 5803.6 5869.3 5880.1 5830.2 5841.5 5857.0 5888.6 5904.4 5564.3 5663.5 5676.4 5817.3 5829.3 5784.5 5836.2 5839.9 5877.9 5879.7 5693.6 5700.7 5706.9 5717.5 5743.7 03:47:53 INFO - PROCESS | 1306 | 03:47:53 INFO - PROCESS | 1306 | [#5] yui.html Cycles:180 Average:21351.07 Median:4793.14 stddev:30383.63 (633.9%) stddev-sans-first:30429.56 03:47:53 INFO - PROCESS | 1306 | Values: 769.9 780.1 829.9 883.6 887.0 15575.0 15888.6 15892.8 15894.6 15897.1 16105.6 16134.8 16197.8 16211.8 16323.1 835.4 855.8 869.1 869.7 871.9 866.9 869.3 871.4 872.2 873.1 911.1 912.3 912.3 912.5 913.1 905.3 908.9 909.9 910.1 911.5 662.9 666.7 668.2 669.5 669.8 14718.4 14761.3 14790.8 14808.4 14835.4 15497.1 15825.8 15866.8 15942.0 15964.8 12239.8 12328.8 12395.3 13278.8 14092.4 4711.9 4742.8 4782.1 4804.2 4902.5 78580.0 78771.0 79315.0 80228.0 80254.2 11183.5 11420.7 11477.8 12344.3 12428.6 21093.2 21138.6 21141.0 21242.3 21342.0 9434.5 9508.6 9600.3 9628.6 9677.0 5077.6 5079.0 5106.8 5350.5 5385.4 3610.3 3719.5 3727.4 3729.6 3733.3 659.0 663.1 672.0 675.2 678.7 530.7 580.7 617.4 626.8 639.0 9764.5 9893.1 9930.2 9960.2 10015.2 585.6 661.7 684.8 691.5 698.8 4449.8 4507.0 4611.3 4680.4 4751.7 105056.5 112050.4 112482.0 120419.0 120641.0 96652.5 99744.0 99928.5 100972.5 101015.0 87530.6 90707.0 90734.5 91557.0 91707.5 9505.7 9525.1 9614.4 9676.8 9714.6 51707.0 52512.0 53004.7 53951.7 55052.4 72229.3 76418.6 77100.0 77268.0 77293.6 11638.2 12464.8 12528.7 12706.5 13045.8 13503.9 13558.7 13761.1 13945.7 14305.6 12929.9 13643.7 13692.9 13694.2 13927.1 14433.1 14569.3 14589.1 14751.0 14779.7 13714.7 14137.0 14323.9 14465.9 14714.7 11301.8 11798.6 12205.4 12366.0 12626.2 11562.7 11878.0 12027.6 12244.3 12368.2 03:47:53 INFO - PROCESS | 1306 | -------- Summary: end -------- 03:47:53 INFO - PROCESS | 1306 | 03:47:54 INFO - TEST-INFO | 1306: exit 0 03:47:54 INFO - TEST-OK | dromaeo_css | took 1112147ms 03:47:54 INFO - TEST-START | kraken 03:47:54 INFO - operating with platform_type : linux_ 03:47:54 INFO - Initialising browser for kraken test... 03:47:54 INFO - TEST-INFO | started process 1499 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPEl2Qi/profile http://localhost:55791/getInfo.html) 03:47:58 INFO - PROCESS | 1499 | __metrics Screen width/height:1600/1200 03:47:58 INFO - PROCESS | 1499 | colorDepth:24 03:47:58 INFO - PROCESS | 1499 | Browser inner width/height: 1024/697 03:47:58 INFO - PROCESS | 1499 | __metrics 03:47:59 ERROR - PROCESS | 1499 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:47:59 INFO - PROCESS | 1499 | console.error: PushService: 03:47:59 INFO - PROCESS | 1499 | stateChangeProcessEnqueue: Error transitioning state 03:47:59 INFO - PROCESS | 1499 | UnknownError 03:48:00 INFO - TEST-INFO | 1499: exit 0 03:48:00 INFO - Browser initialized. 03:48:00 INFO - Running cycle 1/1 for kraken test... 03:48:00 INFO - TEST-INFO | started process 1589 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPEl2Qi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:48:12 INFO - PROCESS | 1589 | RSS: Main: 145436672 03:48:12 INFO - PROCESS | 1589 | 03:48:14 INFO - PROCESS | 1589 | Cycle 1(1): loaded http://localhost:55791/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55791/tests/kraken/driver.html?testName=audio-beat-detection) 03:48:15 INFO - PROCESS | 1589 | RSS: Main: 194478080 03:48:15 INFO - PROCESS | 1589 | 03:48:17 INFO - PROCESS | 1589 | Cycle 1(1): loaded http://localhost:55791/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55791/tests/kraken/driver.html?testName=audio-dft) 03:48:18 INFO - PROCESS | 1589 | RSS: Main: 193208320 03:48:18 INFO - PROCESS | 1589 | 03:48:21 INFO - PROCESS | 1589 | Cycle 1(1): loaded http://localhost:55791/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55791/tests/kraken/driver.html?testName=audio-fft) 03:48:21 INFO - PROCESS | 1589 | RSS: Main: 278261760 03:48:21 INFO - PROCESS | 1589 | 03:48:24 INFO - PROCESS | 1589 | Cycle 1(1): loaded http://localhost:55791/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55791/tests/kraken/driver.html?testName=audio-oscillator) 03:48:24 INFO - PROCESS | 1589 | RSS: Main: 187383808 03:48:24 INFO - PROCESS | 1589 | 03:48:26 INFO - PROCESS | 1589 | Cycle 1(1): loaded http://localhost:55791/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55791/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:48:27 INFO - PROCESS | 1589 | RSS: Main: 187797504 03:48:27 INFO - PROCESS | 1589 | 03:48:30 INFO - PROCESS | 1589 | Cycle 1(1): loaded http://localhost:55791/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55791/tests/kraken/driver.html?testName=imaging-darkroom) 03:48:31 INFO - PROCESS | 1589 | RSS: Main: 222613504 03:48:31 INFO - PROCESS | 1589 | 03:48:34 INFO - PROCESS | 1589 | Cycle 1(1): loaded http://localhost:55791/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55791/tests/kraken/driver.html?testName=imaging-desaturate) 03:48:34 INFO - PROCESS | 1589 | RSS: Main: 223268864 03:48:34 INFO - PROCESS | 1589 | 03:48:37 INFO - PROCESS | 1589 | Cycle 1(1): loaded http://localhost:55791/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55791/tests/kraken/driver.html?testName=json-parse-financial) 03:48:38 INFO - PROCESS | 1589 | RSS: Main: 222056448 03:48:38 INFO - PROCESS | 1589 | 03:48:39 INFO - PROCESS | 1589 | Cycle 1(1): loaded http://localhost:55791/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55791/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:48:40 INFO - PROCESS | 1589 | RSS: Main: 200491008 03:48:40 INFO - PROCESS | 1589 | 03:48:42 INFO - PROCESS | 1589 | Cycle 1(1): loaded http://localhost:55791/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55791/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:48:42 INFO - PROCESS | 1589 | RSS: Main: 203177984 03:48:42 INFO - PROCESS | 1589 | 03:48:44 INFO - PROCESS | 1589 | Cycle 1(1): loaded http://localhost:55791/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55791/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:48:45 INFO - PROCESS | 1589 | RSS: Main: 210169856 03:48:45 INFO - PROCESS | 1589 | 03:48:47 INFO - PROCESS | 1589 | Cycle 1(1): loaded http://localhost:55791/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55791/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:48:48 INFO - PROCESS | 1589 | RSS: Main: 212623360 03:48:48 INFO - PROCESS | 1589 | 03:48:51 INFO - PROCESS | 1589 | Cycle 1(1): loaded http://localhost:55791/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55791/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:48:51 INFO - PROCESS | 1589 | RSS: Main: 212717568 03:48:51 INFO - PROCESS | 1589 | 03:48:53 INFO - PROCESS | 1589 | Cycle 1(1): loaded http://localhost:55791/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55791/tests/kraken/driver.html?testName=ai-astar) 03:48:53 INFO - PROCESS | 1589 | RSS: Main: 255709184 03:48:53 INFO - PROCESS | 1589 | 03:48:53 INFO - PROCESS | 1589 | __start_tp_report 03:48:53 INFO - PROCESS | 1589 | _x_x_mozilla_page_load 03:48:53 INFO - PROCESS | 1589 | _x_x_mozilla_page_load_details 03:48:53 INFO - PROCESS | 1589 | |i|pagename|runs| 03:48:53 INFO - PROCESS | 1589 | |0;ai-astar;112;102;111;110;113;110;111;110;108;111 03:48:53 INFO - PROCESS | 1589 | |1;audio-beat-detection;147;123;125;174;124;128;155;124;154;124 03:48:53 INFO - PROCESS | 1589 | |2;audio-dft;161;162;160;162;161;161;161;161;160;161 03:48:53 INFO - PROCESS | 1589 | |3;audio-fft;75;75;75;133;75;76;77;76;98;75 03:48:53 INFO - PROCESS | 1589 | |4;audio-oscillator;84;84;123;84;84;85;112;90;84;135 03:48:53 INFO - PROCESS | 1589 | |5;imaging-gaussian-blur;117;117;117;116;116;117;117;116;117;117 03:48:53 INFO - PROCESS | 1589 | |6;imaging-darkroom;145;145;146;145;146;147;146;146;146;145 03:48:53 INFO - PROCESS | 1589 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 03:48:53 INFO - PROCESS | 1589 | |8;json-parse-financial;49;50;50;51;51;51;51;51;51;51 03:48:53 INFO - PROCESS | 1589 | |9;json-stringify-tinderbox;61;62;60;60;60;60;60;60;63;60 03:48:53 INFO - PROCESS | 1589 | |10;stanford-crypto-aes;81;75;76;77;78;76;77;77;103;83 03:48:53 INFO - PROCESS | 1589 | |11;stanford-crypto-ccm;121;118;132;123;126;115;117;125;122;135 03:48:53 INFO - PROCESS | 1589 | |12;stanford-crypto-pbkdf2;157;160;161;158;153;153;153;154;153;151 03:48:53 INFO - PROCESS | 1589 | |13;stanford-crypto-sha256-iterative;65;62;62;60;62;61;61;61;63;60 03:48:53 INFO - PROCESS | 1589 | __end_tp_report 03:48:53 INFO - PROCESS | 1589 | __start_cc_report 03:48:53 INFO - PROCESS | 1589 | _x_x_mozilla_cycle_collect,1584 03:48:53 INFO - PROCESS | 1589 | __end_cc_report 03:48:53 INFO - PROCESS | 1589 | __startTimestamp1466246933606__endTimestamp 03:48:53 INFO - PROCESS | 1589 | 03:48:53 INFO - PROCESS | 1589 | ------- Summary: start ------- 03:48:53 INFO - PROCESS | 1589 | Number of tests: 14 03:48:53 INFO - PROCESS | 1589 | 03:48:53 INFO - PROCESS | 1589 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.00 stddev:3.05 (2.7%) stddev-sans-first:3.13 03:48:53 INFO - PROCESS | 1589 | Values: 112.0 102.0 111.0 110.0 113.0 110.0 111.0 110.0 108.0 111.0 03:48:53 INFO - PROCESS | 1589 | 03:48:53 INFO - PROCESS | 1589 | [#1] audio-beat-detection Cycles:10 Average:137.80 Median:137.50 stddev:18.27 (13.3%) stddev-sans-first:19.07 03:48:53 INFO - PROCESS | 1589 | Values: 147.0 123.0 125.0 174.0 124.0 128.0 155.0 124.0 154.0 124.0 03:48:53 INFO - PROCESS | 1589 | 03:48:53 INFO - PROCESS | 1589 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 03:48:53 INFO - PROCESS | 1589 | Values: 161.0 162.0 160.0 162.0 161.0 161.0 161.0 161.0 160.0 161.0 03:48:53 INFO - PROCESS | 1589 | 03:48:53 INFO - PROCESS | 1589 | [#3] audio-fft Cycles:10 Average:83.50 Median:75.50 stddev:18.79 (24.9%) stddev-sans-first:19.67 03:48:53 INFO - PROCESS | 1589 | Values: 75.0 75.0 75.0 133.0 75.0 76.0 77.0 76.0 98.0 75.0 03:48:53 INFO - PROCESS | 1589 | 03:48:53 INFO - PROCESS | 1589 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:84.00 stddev:19.38 (23.1%) stddev-sans-first:20.02 03:48:53 INFO - PROCESS | 1589 | Values: 84.0 84.0 123.0 84.0 84.0 85.0 112.0 90.0 84.0 135.0 03:48:53 INFO - PROCESS | 1589 | 03:48:53 INFO - PROCESS | 1589 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 03:48:53 INFO - PROCESS | 1589 | Values: 117.0 117.0 117.0 116.0 116.0 117.0 117.0 116.0 117.0 117.0 03:48:53 INFO - PROCESS | 1589 | 03:48:53 INFO - PROCESS | 1589 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 03:48:53 INFO - PROCESS | 1589 | Values: 145.0 145.0 146.0 145.0 146.0 147.0 146.0 146.0 146.0 145.0 03:48:53 INFO - PROCESS | 1589 | 03:48:53 INFO - PROCESS | 1589 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 03:48:53 INFO - PROCESS | 1589 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 03:48:53 INFO - PROCESS | 1589 | 03:48:53 INFO - PROCESS | 1589 | [#8] json-parse-financial Cycles:10 Average:50.60 Median:51.00 stddev:0.70 (1.4%) stddev-sans-first:0.44 03:48:53 INFO - PROCESS | 1589 | Values: 49.0 50.0 50.0 51.0 51.0 51.0 51.0 51.0 51.0 51.0 03:48:53 INFO - PROCESS | 1589 | 03:48:53 INFO - PROCESS | 1589 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:60.00 stddev:1.07 (1.8%) stddev-sans-first:1.13 03:48:53 INFO - PROCESS | 1589 | Values: 61.0 62.0 60.0 60.0 60.0 60.0 60.0 60.0 63.0 60.0 03:48:53 INFO - PROCESS | 1589 | 03:48:53 INFO - PROCESS | 1589 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:77.00 stddev:8.34 (10.8%) stddev-sans-first:8.84 03:48:53 INFO - PROCESS | 1589 | Values: 81.0 75.0 76.0 77.0 78.0 76.0 77.0 77.0 103.0 83.0 03:48:53 INFO - PROCESS | 1589 | 03:48:53 INFO - PROCESS | 1589 | [#11] stanford-crypto-ccm Cycles:10 Average:123.40 Median:124.00 stddev:6.38 (5.1%) stddev-sans-first:6.71 03:48:53 INFO - PROCESS | 1589 | Values: 121.0 118.0 132.0 123.0 126.0 115.0 117.0 125.0 122.0 135.0 03:48:53 INFO - PROCESS | 1589 | 03:48:53 INFO - PROCESS | 1589 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.30 Median:155.50 stddev:3.43 (2.2%) stddev-sans-first:3.59 03:48:53 INFO - PROCESS | 1589 | Values: 157.0 160.0 161.0 158.0 153.0 153.0 153.0 154.0 153.0 151.0 03:48:53 INFO - PROCESS | 1589 | 03:48:53 INFO - PROCESS | 1589 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.70 Median:62.00 stddev:1.49 (2.4%) stddev-sans-first:1.00 03:48:53 INFO - PROCESS | 1589 | Values: 65.0 62.0 62.0 60.0 62.0 61.0 61.0 61.0 63.0 60.0 03:48:53 INFO - PROCESS | 1589 | -------- Summary: end -------- 03:48:53 INFO - PROCESS | 1589 | 03:48:54 INFO - TEST-INFO | 1589: exit 0 03:48:54 INFO - TEST-OK | kraken | took 60020ms 03:48:54 INFO - SUITE-END | took 1172s 03:48:54 INFO - Completed test suite (00:19:32) 03:48:54 INFO - javascript benchmark 03:48:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3344.26426186239, 3349.899503014909, 3361.932761344773, 3363.8149901755423, 3398.9660103398974, 5524.696141712204, 5613.354464236614, 5617.38208797032, 5639.971800140998, 5641.125625528045, 5509.531689806361, 5555.194496797972, 5558.388577256498, 5563.082091454915, 5594.49649531542, 4923.876903077416, 4968.5528302452685, 4985.027919555688, 5028.673136246132, 5061.721605311706, 4876.390451193601, 5010.949890501085, 5053.115704751672, 5060.190369540875, 5060.2156665716875, 4998.325226094467, 5017.272495488152, 5045.823396181135, 5046.596272298226, 5052.040112378655, 5131.230315452674, 5133.589312854962, 5138.023775482684, 5149.253358263069, 5179.896402071956, 4872.878178045542, 4962.1812400953795, 5003.824866129705, 5061.544460998491, 5062.797488100471, 5407.810726624549, 5419.674819510842, 5435.972820135874, 5469.644473109235, 5482.424345443711, 5943.108533719977, 5979.970100149471, 5989.221401217814, 5990.430909063632, 5992.49063829575, 6012.969935150296, 6027.21646185993, 6032.336442991267, 6096.0, 6121.296050954153, 5653.971730141364, 5683.318001839764, 5696.401877802854, 5700.914486282709, 5711.771529138788, 5859.53123750099, 6171.166892469549, 6201.937980620136, 6203.689815509207, 6204.038374052029, 5751.338596061507, 5756.107803290497, 5774.393688662714, 5808.535317174616, 5844.678542680108, 5887.735051922674, 5941.673207973517, 5941.821745347646, 5948.702564871739, 5954.19618351517, 5760.8271751847515, 5875.529957603381, 5888.146218798336, 5890.087036509348, 5895.705214739246, 5925.05199168131, 5982.910256346158, 5989.730462129215, 5992.041273396236, 6022.5784195105925, 4559.768862407198, 4572.45130584332, 4572.9314060289125, 4578.542145785462, 4602.309653551927, 3985.2228815381304, 4045.0494133878515, 4069.0, 4118.5057793065025, 4155.231282212801, 5715.914261286084, 5733.054046082433, 5740.971295143498, 5742.167385729046, 5752.827415177551, 5987.9101813472835, 6034.155218269446, 6042.365551617105, 6042.577019608585, 6086.969565152146, 5523.447655234444, 5653.858653533613, 5698.116791897262, 5702.287214098238, 5725.026745453283, 5155.0, 5187.818426355135, 5203.713795741271, 5207.843764687065, 5210.452902445264, 6239.06414037898, 6254.15568898202, 6256.155419018374, 6257.624542527463, 6265.780697675651, 5822.3304320003745, 5902.4097590240635, 5933.110033495011, 5935.7032148391545, 5996.610220335664, 6161.630302181883, 6163.013917773134, 6164.445199932027, 6164.599301045418, 6178.289496707936, 5711.029125048669, 5852.122181672783, 5866.970665146647, 5869.530437564899, 5869.618474799125, 5909.172715819875, 5918.053111502311, 5934.169216309634, 5970.731317090655, 5983.9401605983385, 5803.361630220588, 5828.184054232326, 5831.562632802472, 5834.679092649775, 5837.766489340379, 5635.549156067423, 5701.572382071278, 5766.711664416846, 5826.737796799239, 5830.329512106162, 5598.35618903815, 5713.200151978809, 5714.485696287354, 5716.342620598684, 5742.397048310035, 5806.738696758741, 5821.27234095738, 5841.883162336814, 5861.1501332307425, 5867.383924687846, 5496.725163741877, 5594.916076258941, 5632.183333416713, 5669.20631111653, 5697.088465845611], "value": 5496.269897162582, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.658071608825, 632.2792017100506, 649.9967500162502, 657.7270432770399, 667.3426674725398, 31963.68036319636, 35217.47173792395, 35407.4688879667, 44736.0, 46098.53901460984, 47727.28409073866, 48361.274580881225, 48371.51628483714, 48373.758131209295, 48385.51614483854, 8930.687425940094, 9120.17918387345, 9122.77193070172, 9124.31567632427, 9142.862857057149, 8382.371322150833, 10541.84187237192, 10882.183836212276, 10906.781864362709, 11185.552577896915, 10896.455177241145, 11007.394593297366, 11010.284331518465, 11014.118870490342, 11018.44907754613, 8456.11210822867, 10594.099501542378, 10862.61980830671, 10967.0, 10973.451327433597, 10462.110720588758, 10598.52306646195, 10964.451777411097, 10965.671029869116, 10988.340699557972, 45408.772956135006, 45978.770106149255, 46026.30960535595, 46093.30860037102, 46097.30854037192, 3432.9485057724155, 3455.1362159460136, 3701.4632878232774, 3759.605241449663, 3929.174873276587, 34831.651683483346, 35181.6481835181, 35334.11664708377, 35407.645923540695, 35624.64375356239, 4355.12897420514, 4420.84527041552, 4425.712328698624, 4474.261746811772, 4541.205289074399, 377963.0, 380567.0, 380632.0, 380698.0, 381159.09420453, 37867.242655147296, 67944.3205567938, 68769.3123068773, 68833.65583172052, 68876.6556167226, 39609.207815843525, 41367.1726565467, 41401.0, 41524.58475415207, 41530.58469415267, 15918.840811591968, 15952.122633255283, 16057.759133613004, 16059.518214453585, 16067.955582887309, 10885.074768644754, 11808.173427859967, 11862.822057669142, 12495.0, 12685.112042157145, 9317.11487408695, 9320.673776417792, 9338.112879276458, 9383.765405864771, 9393.389429687048, 3550.449680299506, 3581.4448760442174, 3589.2283159120393, 3592.3533763922746, 3698.1863989922176, 1035.7928414317016, 1059.0733108530037, 1111.9777604447866, 1145.4387350198342, 1190.9583164589199, 32457.675423245466, 34133.31733365319, 34216.65783342184, 34262.314753704784, 34345.141371465914, 1100.4277775556666, 1146.7763786061805, 1158.9420528973517, 1166.78414493319, 1213.124340289293, 17271.88221535876, 17778.199981000886, 17890.958537048733, 18051.0, 18112.45662630123, 564521.0, 575465.0, 579437.0, 600577.0, 992407.0, 63600.68199658972, 64070.35929640737, 64240.35759642437, 64424.35575644184, 64480.0, 1267.7084270617809, 1338.1302153600238, 1343.3081962789367, 1357.362039841273, 1365.7746471832236, 30892.53661195039, 31409.214769630027, 33399.0, 33825.323493530486, 34836.65163348334, 57636.42363576311, 62698.0, 62729.372706272356, 62774.0, 62808.68595656993, 517784.0, 518032.0, 520643.0, 520944.0, 521161.0, 37918.293676785164, 46782.53217467782, 47588.762056189495, 48204.0, 51045.489545105556, 49819.25271120864, 50161.74919125527, 50860.74569627276, 51708.48291517187, 51830.222546661076, 43920.12159756851, 44274.3358849624, 44327.77836110799, 44429.0, 44545.55454445414, 44306.77846610875, 44410.777946110065, 44523.777381112886, 44861.102777944914, 45643.77178114088, 43414.68766519445, 43527.78236108799, 44061.559384405744, 44072.33891491566, 44142.558574413844, 37236.627633723314, 38152.0, 38860.2227955445, 38940.221195576494, 39654.2069158621, 29608.259793505335, 29755.702442975293, 29856.552151718177, 30229.69770302357, 30249.546256806607], "value": 20736.28242934247, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [430.72433642468826, 431.2790829644763, 436.33241141054197, 438.1740419309601, 441.600351681728, 20020.299289524868, 20772.272970446036, 21045.894770526145, 21603.67594486084, 21707.348779536598, 19327.323543675975, 19956.30152944647, 20310.695339569917, 20761.480962975933, 20791.584168316625, 5869.647821130725, 6028.39716028398, 6040.1241819936085, 6049.727762250709, 6064.0, 5578.219049333096, 5850.151727999438, 5853.678047707374, 5938.9703051484685, 5943.375945525722, 5888.116782482619, 5889.705514724246, 5895.0, 5900.439458251481, 5915.763369465238, 5527.143292789624, 5660.66036037837, 5671.291088613923, 5683.062294721366, 5716.256886604736, 5240.292560504359, 5466.0, 5490.917636235459, 5491.533219676332, 5531.585131115183, 13083.542076027294, 13108.27904465254, 13159.407826647825, 13295.0, 13326.733465330735, 2386.8925898334614, 2428.429319110008, 2541.7077036140895, 2741.2050505353423, 2852.3154442933546, 10024.59901603935, 10167.23745719074, 10468.214883883738, 10488.108510776594, 10502.527386267637, 1954.3648314297768, 2070.4616799632054, 2075.107703687414, 2178.215842296772, 2233.7207849018873, 74896.0, 78112.99999999943, 78278.21721782767, 78751.60624196842, 78796.0, 10634.840477392845, 10929.234953553334, 11186.44067796607, 11468.13988950832, 11862.169648124549, 15543.145127018122, 15629.296681649354, 15652.0, 15659.686806264039, 15686.215689215494, 7767.300942915052, 7810.492317999312, 8050.396220283502, 8173.918260817434, 8178.877316840133, 7890.48711833729, 7979.202079791974, 7991.480553763987, 8058.758237252891, 8093.352531797442, 4494.52807455219, 4622.237330840374, 4677.462091859412, 4839.346688197048, 5092.8472145835685, 1869.1775618727715, 2039.2352867674622, 2088.2169186555043, 2107.1466056247245, 2124.904379302935, 862.1550880137501, 901.8602116671926, 945.2485274207022, 946.8769060022153, 972.8103019911049, 16376.181190940406, 16563.6687266254, 17208.65582688339, 17471.563210919576, 17733.911330443265, 904.5567671840882, 968.8692026576322, 1004.2016596805557, 1010.6816352848829, 1014.1531820929459, 9716.659916902874, 9982.500874956368, 9985.80028399428, 10057.0, 10112.393256404639, 504209.0, 522428.1802019576, 524245.0, 535978.0, 537043.0, 97443.51278243563, 100451.49774251228, 102472.0, 103092.0, 103671.0, 1015.8425444056184, 1031.7059638003134, 1045.3362115056993, 1059.4543809937888, 1061.840723891407, 15601.453949112181, 15660.68678626444, 15901.840981590036, 15904.0, 16286.0, 41852.0, 41893.1621367577, 42051.57948420477, 42306.59947060656, 42705.359419609355, 58444.0, 59018.0, 59246.40753592581, 59986.40013599983, 60314.69842650759, 8814.579103351325, 8863.379563430499, 8882.245009174292, 8942.86585701228, 9122.133397327243, 12155.0, 13032.739345212853, 13289.933550332187, 13537.255450950292, 13886.513972010931, 11959.581414650445, 12177.208481448677, 12178.512859485876, 12299.50801967947, 12414.875851241733, 12149.635510934686, 12155.270683759003, 12337.568185113478, 12430.12989090755, 12608.306543140216, 11925.224860384047, 12065.577704780291, 12454.56409025716, 12476.376181190722, 12529.122961392615, 8354.916450835413, 8504.149585041447, 8554.315654747481, 8600.09698981623, 8723.781905452415, 11291.604793832177, 11940.76118477643, 12072.3360215189, 12098.455569499218, 12326.383680816103], "value": 9232.716267280279, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1193.5345215366003, 1556.369670283535, 1563.624730064785, 1772.8670349723775, 1887.7829049659285, 9140.908590914089, 9547.0, 9549.904500954988, 9774.951125244364, 9788.216942644589, 9488.383255088414, 9677.61289548419, 9684.467354295528, 9692.224622030239, 9719.854202186973, 2001.549651328454, 2393.3179043972473, 2452.448199155194, 2471.40686235304, 2474.1216868011866, 2512.786413154884, 2528.582783840664, 2533.505966336565, 2534.4550921551863, 2537.860417677027, 2447.1801946347996, 2530.127106148385, 2534.9746502535017, 2538.504991526653, 2539.809514286436, 2043.1010355443632, 2336.0655737704883, 2397.3886658902043, 2404.5551572959057, 2408.1932552594903, 2263.694401255826, 2273.499830037389, 2279.2364557872966, 2281.1559722902634, 2289.8740569268684, 9736.561854716554, 9741.31810773246, 9741.805163896683, 9778.119969202806, 9783.41299522031, 5572.247746554244, 5699.173619825102, 5707.058335374658, 5709.115087161455, 5709.914351284692, 3423.5720534933134, 3426.3318652862704, 3507.4563442666426, 3522.7181825453904, 3565.53648025755, 1076.838474228864, 1078.1267173589417, 1139.2367114033618, 1146.1232157399595, 1171.2503997441645, 13835.30823458833, 13858.792118118236, 13917.58247252584, 13928.51250206248, 13939.0, 4923.310736496894, 4952.158133117378, 4998.1503144464805, 5019.799208031711, 5064.645474816801, 11260.211785175123, 11320.320780753182, 11325.773484530428, 11341.489632966372, 11369.0, 5585.832425027255, 5619.831405057855, 5623.184638227434, 5629.7185140742795, 5631.971840140773, 4085.571015043437, 5039.44566097729, 5234.712090834964, 5235.502627250481, 5237.973810131001, 4309.181255561433, 4311.655067594585, 4375.584319489643, 4398.626116780046, 4497.280435130363, 1305.3147097773556, 1305.921644701302, 1308.5943357559188, 1316.6642506161058, 1336.2583766009957, 903.1375036839802, 977.731123940922, 981.3768257156756, 1019.6329321444274, 1029.505837198149, 6162.938370616326, 6291.087792270187, 6382.521310901701, 6397.912354899679, 6434.7104380303, 468.5689165967318, 477.9808807647655, 482.007065445184, 490.5119406190863, 495.4549995005537, 4306.569343065668, 4328.8268469260875, 4347.130573885172, 4361.040571074359, 4400.977995110068, 11920.642380728592, 12041.819372709417, 12169.756604867853, 12229.571964981184, 12341.876581234252, 11464.4840982156, 11916.225445346025, 11918.046556275478, 12027.759444811054, 12057.758844823054, 8747.300215982707, 8842.381033327734, 8876.733697989072, 8882.511461869659, 8917.42036767608, 6480.125183100221, 6499.902501462388, 6525.3148419417175, 6602.8349291268105, 6604.735810567524, 10536.525856336637, 10791.190660700322, 10908.890911090788, 10990.670279891616, 10998.230123891251, 11040.668779936615, 11061.391623460788, 11069.833952490559, 11175.664730057786, 11205.103591712481, 7099.716011359487, 7299.671514781741, 7302.56184628924, 7918.841623167619, 8410.411271210956, 7872.685092596232, 8860.113988601088, 9154.908450915673, 9162.312826537904, 9448.574814133242, 8017.959910200411, 8131.566469516655, 8374.413791034569, 8423.70517031901, 8478.321734261368, 8106.756797296091, 8190.754277371689, 8225.95887020561, 8290.046644635944, 8306.958465207636, 7167.390771784457, 7172.748953786592, 7184.676689549087, 7207.0, 7216.96391518039, 5075.11185542536, 5137.17805151174, 5241.947580524146, 5375.543078838343, 5453.345598528202, 5435.103207970798, 5500.642458240201, 5548.223248745098, 5578.219049333178, 5612.186232996274], "value": 4826.076135696127, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.2311621966795, 353.7134920714222, 354.16947258678397, 357.98747043853473, 364.34236203652415, 5483.232347471352, 5492.901419716063, 5529.225908372821, 5532.28499165259, 5570.888582228358, 5419.810306639269, 5431.782728690848, 5450.781968721247, 5457.0, 5505.834824955257, 3986.6810655147665, 4059.878203653895, 4303.870883873489, 4309.547497512755, 4320.092780516095, 4220.620144187023, 4248.830046798124, 4249.3625956106525, 4251.2135254977775, 4291.549387314334, 4227.4927008759, 4230.661547076242, 4246.660267178634, 4263.722858014219, 4274.700770946035, 4061.79691015451, 4158.272302347107, 4269.331667707683, 4280.250956082704, 4305.203537345601, 3786.8106594670157, 3790.564085130218, 3805.5813860475328, 3806.2577797329254, 3807.961920380816, 5264.894702105975, 5302.761375738101, 5322.77576157486, 5329.307190065306, 5361.624686271963, 4935.777889994959, 4937.308776771255, 4939.604831613498, 4973.229149481836, 5003.249512573107, 5719.71401429931, 5759.884802303931, 5778.0, 5778.3643799182055, 5793.159991801207, 4069.0, 4085.44846445729, 4098.938515922264, 4196.475440569929, 4213.852515161954, 5902.675352855591, 5951.464368206882, 5980.641161530322, 6003.849903752397, 6015.669138197398, 4247.405363249148, 4265.274903266452, 4265.53079161292, 4270.167317373082, 4285.057287396768, 4058.6550143238155, 4237.385579091015, 4237.512686041145, 4246.702730808814, 4262.403263543107, 4807.927881081787, 4832.540908613676, 4857.247126695368, 4878.121938051114, 4898.510148985073, 5721.313442386941, 5751.482366587027, 5771.336296325976, 5792.623479473821, 5810.622309549865, 1421.3532842556613, 1480.2672677024727, 1481.8071452480856, 1485.9405623775144, 1500.2498750624688, 940.2431043010306, 945.8202941441242, 956.583886009588, 965.7199412170391, 966.2656381150235, 4982.829035176731, 5008.774605142778, 5010.044073996287, 5040.445550989388, 5047.798088076436, 5242.0, 5256.316678831728, 5267.209918512254, 5280.762365693553, 5289.656172348785, 4725.29120631908, 5017.498250174954, 5058.3929928408825, 5067.125163689385, 5067.239914012927, 2785.610014597958, 2815.549512078058, 2816.845073520976, 2824.8587570621385, 2826.321682796155, 5454.699991500426, 5455.5908306877145, 5466.332768505644, 5471.562275017989, 5496.395396506381, 5079.720615366116, 5231.231621042749, 5283.498067683564, 5295.867603309948, 5344.278522399504, 5298.986385173609, 5336.4129945705945, 5337.706426146521, 5421.322334708161, 5445.782168713207, 5234.764435600483, 5675.432456754292, 5700.543956483389, 5902.704864756831, 5920.720522598916, 5843.386444423444, 5849.59609693679, 5853.2976042875125, 5886.764529418947, 5894.440028197314, 5778.150991682621, 6056.757729690763, 6082.90875636857, 6096.634201947897, 6134.018557030854, 4208.326667733148, 4216.325387937915, 4231.788410579397, 4254.574542545721, 4271.359296105609, 5908.704564771659, 5956.391774221022, 5968.373320801427, 5996.5502587307, 5998.190244316961, 5547.251121098761, 5794.565407594363, 5803.622764520293, 5869.325027621878, 5880.059190529495, 5830.2420685310635, 5841.50347220491, 5856.970715146397, 5888.587798854039, 5904.409559044061, 5564.273505982121, 5663.461971112738, 5676.4323567642905, 5817.272840894888, 5829.300483941955, 5784.4504772046585, 5836.153757705194, 5839.8540036497725, 5877.882442351214, 5879.676617786063, 5693.601447898607, 5700.743466543932, 5706.885862282814, 5717.485426311486, 5743.655380677173], "value": 4301.763157165813, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [769.86142494351, 780.102881686061, 829.8713699376596, 883.5758835758836, 887.0, 15575.0, 15888.602784930383, 15892.84107158928, 15894.602634934132, 15897.1256580888, 16105.597360065974, 16134.75797863033, 16197.83802161978, 16211.83788162118, 16323.10222937738, 835.3734698975768, 855.8117214212863, 869.0874581689201, 869.678219058949, 871.8779370888049, 866.8829707989436, 869.3045563549167, 871.4292138649195, 872.2455076358935, 873.1094283830489, 911.0661571888834, 912.2929729459655, 912.3157631776168, 912.5163663258451, 913.0641092879819, 905.2803021597846, 908.9454632722058, 909.8726178335038, 910.1035480052143, 911.5305617606938, 662.8906230471966, 666.7066490744057, 668.1614573710011, 669.4945316286221, 669.7856685860527, 14718.411263549446, 14761.335739891623, 14790.778138327934, 14808.407663693548, 14835.406583736638, 15497.147656878868, 15825.762613560806, 15866.841331586651, 15942.043477391393, 15964.76052859208, 12239.816402753966, 12328.815067773901, 12395.318257495834, 13278.800817987738, 14092.436302547885, 4711.882202944919, 4742.810287588492, 4782.115308667908, 4804.159272127398, 4902.48523904992, 78579.99999999943, 78771.0, 79315.0, 80228.0, 80254.19745802526, 11183.496742646601, 11420.657380278604, 11477.770444591062, 12344.321062341658, 12428.56500022495, 21093.156273749184, 21138.577228455346, 21141.0, 21242.25652102169, 21342.0, 9434.528273586293, 9508.619655213852, 9600.32797704168, 9628.566714497865, 9677.0, 5077.619178561623, 5078.960088901756, 5106.846794596168, 5350.464953504618, 5385.353757549041, 3610.2779444111284, 3719.4606782017, 3727.3849814780256, 3729.627037296303, 3733.3466643337306, 659.0279337976542, 663.0584569910739, 671.9966400167967, 675.152683382352, 678.6606696651675, 530.6895466152345, 580.6516090345759, 617.4350469320611, 626.8464226264504, 639.0, 9764.51177441125, 9893.109620134222, 9930.2055835533, 9960.153386962189, 10015.248856335804, 585.5871610514577, 661.675778868351, 684.7671791590883, 691.4813889582813, 698.7763915546976, 4449.822007119744, 4506.977465112654, 4611.262198048296, 4680.438347398334, 4751.714897106184, 105056.47471762745, 112050.43974780074, 112482.0, 120418.98952526081, 120641.0, 96652.51673741586, 99744.0, 99928.5003574992, 100972.49513752385, 101015.0, 87530.56234718785, 90707.0, 90734.54632726795, 91557.0, 91707.5414622936, 9505.66730164441, 9525.14273715369, 9614.423134611945, 9676.806463870824, 9714.611415543299, 51707.0, 52512.0, 53004.73497632487, 53951.730241348545, 55052.449475504734, 72229.27770722436, 76418.6179069101, 77100.0, 77268.0, 77293.61353193199, 11638.185327027028, 12464.750704985669, 12528.686782830502, 12706.491740330282, 13045.804312935503, 13503.932480337535, 13558.661033474242, 13761.105528140639, 13945.721085578434, 14305.57083287503, 12929.870701292866, 13643.727125457634, 13692.863071369158, 13694.246816425193, 13927.094738841943, 14433.061850979653, 14569.271536423348, 14589.142894068273, 14751.0, 14779.704405911607, 13714.725705486035, 14137.0, 14323.85676143267, 14465.927670361581, 14714.705705886037, 11301.773964520828, 11798.587049453228, 12205.389730513616, 12366.0, 12626.179298345945, 11562.653120406401, 11878.0, 12027.639170824888, 12244.326562039174, 12368.1960672556], "value": 7846.231169826873, "unit": "score"}], "name": "dromaeo_css", "value": 7453.249257966157, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 102.0, 111.0, 110.0, 113.0, 110.0, 111.0, 110.0, 108.0, 111.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 123.0, 125.0, 174.0, 124.0, 128.0, 155.0, 124.0, 154.0, 124.0], "value": 137.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 162.0, 161.0, 161.0, 161.0, 161.0, 160.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 133.0, 75.0, 76.0, 77.0, 76.0, 98.0, 75.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 123.0, 84.0, 84.0, 85.0, 112.0, 90.0, 84.0, 135.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 145.0, 146.0, 147.0, 146.0, 146.0, 146.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 50.0, 50.0, 51.0, 51.0, 51.0, 51.0, 51.0, 51.0, 51.0], "value": 50.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 63.0, 60.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 75.0, 76.0, 77.0, 78.0, 76.0, 77.0, 77.0, 103.0, 83.0], "value": 80.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 118.0, 132.0, 123.0, 126.0, 115.0, 117.0, 125.0, 122.0, 135.0], "value": 123.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 160.0, 161.0, 158.0, 153.0, 153.0, 153.0, 154.0, 153.0, 151.0], "value": 155.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 62.0, 60.0, 62.0, 61.0, 61.0, 61.0, 63.0, 60.0], "value": 61.7, "unit": "score"}], "name": "kraken", "value": 1477.9, "alertThreshold": 2.0}]} 03:48:54 INFO - Return code: 0 03:48:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:48:54 ERROR - # TBPL SUCCESS # 03:48:54 INFO - Running post-action listener: _resource_record_post_action 03:48:54 INFO - ##### 03:48:54 INFO - ##### Finished run-tests step (success) 03:48:54 INFO - ##### 03:48:54 INFO - Running post-run listener: _resource_record_post_run 03:48:54 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 266240; Write bytes: 519086080; Read time: 24; Write time: 534252 03:48:54 INFO - TinderboxPrint: CPU usage
13.1% 03:48:54 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 24 03:48:54 INFO - TinderboxPrint: I/O write bytes / time
519,086,080 / 534,252 03:48:54 INFO - TinderboxPrint: CPU idle
8,244.7 (86.9%) 03:48:54 INFO - TinderboxPrint: CPU user
1,200.8 (12.7%) 03:48:54 INFO - TinderboxPrint: Swap in / out
0 / 0 03:48:54 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 265334784; Read time: 0; Write time: 377952 03:48:55 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 266240; Write bytes: 253751296; Read time: 24; Write time: 156300 03:48:55 INFO - Running post-run listener: _upload_blobber_files 03:48:55 INFO - Blob upload gear active. 03:48:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:48:55 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 03:48:55 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:48:55 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:48:55 INFO - (blobuploader) - INFO - Open directory for files ... 03:48:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:48:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:48:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:48:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:48:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:48:56 INFO - (blobuploader) - INFO - Done attempting. 03:48:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:48:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:48:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:49:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:00 INFO - (blobuploader) - INFO - Done attempting. 03:49:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:49:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:49:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:00 INFO - (blobuploader) - INFO - Done attempting. 03:49:00 INFO - (blobuploader) - INFO - Iteration through files over. 03:49:00 INFO - Return code: 0 03:49:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:49:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:49:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cb376c6f988b89f2bd6f3fc0d13c759e3cb100f22137ea68c149f8a8ef971d904a63a942c8f93ff77329b6434cf54cd8da1abf55e9aac6ff0184e83aed0787ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5352f7beb052c7df17a6a085e6e242d72c5db44868780c672b0b555c42a6fd8c94a52c507673ca42dc2d21cbeb295c9047edde214d5f350cd379f08a80a030b1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/03a857edac8d71faade3f5a3859cd4b5b44689c5db3920c0ac8e94b67784a0b72acfeb969f0d097bd01c3a5476926d45a94003d41f0a881c7bba31df17ce4365"} 03:49:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:49:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:49:00 INFO - Contents: 03:49:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cb376c6f988b89f2bd6f3fc0d13c759e3cb100f22137ea68c149f8a8ef971d904a63a942c8f93ff77329b6434cf54cd8da1abf55e9aac6ff0184e83aed0787ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5352f7beb052c7df17a6a085e6e242d72c5db44868780c672b0b555c42a6fd8c94a52c507673ca42dc2d21cbeb295c9047edde214d5f350cd379f08a80a030b1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/03a857edac8d71faade3f5a3859cd4b5b44689c5db3920c0ac8e94b67784a0b72acfeb969f0d097bd01c3a5476926d45a94003d41f0a881c7bba31df17ce4365"} 03:49:00 INFO - Running post-run listener: copy_logs_to_upload_dir 03:49:00 INFO - Copying logs to upload dir... 03:49:00 INFO - mkdir: /builds/slave/test/build/upload/logs 03:49:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.331173 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-18 03:48:59.884176) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-18 03:48:59.888063) ========= 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=232498196343f89f466a4a9a000001c8-1466243090.727922-166158960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cb376c6f988b89f2bd6f3fc0d13c759e3cb100f22137ea68c149f8a8ef971d904a63a942c8f93ff77329b6434cf54cd8da1abf55e9aac6ff0184e83aed0787ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5352f7beb052c7df17a6a085e6e242d72c5db44868780c672b0b555c42a6fd8c94a52c507673ca42dc2d21cbeb295c9047edde214d5f350cd379f08a80a030b1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/03a857edac8d71faade3f5a3859cd4b5b44689c5db3920c0ac8e94b67784a0b72acfeb969f0d097bd01c3a5476926d45a94003d41f0a881c7bba31df17ce4365"} build_url:https://queue.taskcluster.net/v1/task/A0x_2Nn7SfC1ZAxF3yC4UA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011249 build_url: 'https://queue.taskcluster.net/v1/task/A0x_2Nn7SfC1ZAxF3yC4UA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cb376c6f988b89f2bd6f3fc0d13c759e3cb100f22137ea68c149f8a8ef971d904a63a942c8f93ff77329b6434cf54cd8da1abf55e9aac6ff0184e83aed0787ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5352f7beb052c7df17a6a085e6e242d72c5db44868780c672b0b555c42a6fd8c94a52c507673ca42dc2d21cbeb295c9047edde214d5f350cd379f08a80a030b1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/03a857edac8d71faade3f5a3859cd4b5b44689c5db3920c0ac8e94b67784a0b72acfeb969f0d097bd01c3a5476926d45a94003d41f0a881c7bba31df17ce4365"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-18 03:48:59.913887) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 03:48:59.914224) ========= 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=232498196343f89f466a4a9a000001c8-1466243090.727922-166158960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004431 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 03:48:59.999356) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-18 03:48:59.999698) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-18 03:49:00.000004) ========= ========= Total master_lag: 0.17 =========