builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-053 starttime: 1467365886.19 results: success (0) buildid: 20160630235217 builduid: 1812abf176084fe79a2d0e92bc2ce71f revision: ab7833ced02512db316393e8186982172159af79 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 02:38:06.192150) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 02:38:06.192845) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 02:38:06.193457) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 02:38:06.206911) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 02:38:06.207333) ========= 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=920470bf432669ad7e3a5387000001ca-1467365884.471784-514542912 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-01 02:38:06-- 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% 44.0M=0s 2016-07-01 02:38:06 (44.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.081395 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 02:38:06.301545) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 02:38:06.301870) ========= 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=920470bf432669ad7e3a5387000001ca-1467365884.471784-514542912 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020096 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 02:38:06.352921) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 02:38:06.353536) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ab7833ced02512db316393e8186982172159af79 --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 ab7833ced02512db316393e8186982172159af79 --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=920470bf432669ad7e3a5387000001ca-1467365884.471784-514542912 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-01 02:38:06,571 truncating revision to first 12 chars 2016-07-01 02:38:06,571 Setting DEBUG logging. 2016-07-01 02:38:06,571 attempt 1/10 2016-07-01 02:38:06,571 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ab7833ced025?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-01 02:38:06,852 unpacking tar archive at: mozilla-aurora-ab7833ced025/testing/mozharness/ program finished with exit code 0 elapsedTime=0.608854 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 02:38:06.979437) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 02:38:06.979992) ========= script_repo_revision: ab7833ced02512db316393e8186982172159af79 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 02:38:06.980578) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 02:38:06.981011) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 02:38:06.992414) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-01 02:38:06.992875) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=920470bf432669ad7e3a5387000001ca-1467365884.471784-514542912 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:38:07 INFO - MultiFileLogger online at 20160701 02:38:07 in /builds/slave/test 02:38:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:38:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:38:07 INFO - {'append_to_log': False, 02:38:07 INFO - 'base_work_dir': '/builds/slave/test', 02:38:07 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:38:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:38:07 INFO - 'branch': 'Mozilla-Aurora', 02:38:07 INFO - 'buildbot_json_path': 'buildprops.json', 02:38:07 INFO - 'config_files': ('talos/linux_config.py',), 02:38:07 INFO - 'default_actions': ('clobber', 02:38:07 INFO - 'read-buildbot-config', 02:38:07 INFO - 'download-and-extract', 02:38:07 INFO - 'populate-webroot', 02:38:07 INFO - 'create-virtualenv', 02:38:07 INFO - 'install', 02:38:07 INFO - 'run-tests'), 02:38:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:38:07 INFO - 'download_minidump_stackwalk': True, 02:38:07 INFO - 'download_symbols': 'ondemand', 02:38:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:38:07 INFO - 'tooltool.py': '/tools/tooltool.py', 02:38:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:38:07 INFO - '/tools/misc-python/virtualenv.py')}, 02:38:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:38:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:38:07 INFO - 'installer_path': 'installer.exe', 02:38:07 INFO - 'log_level': 'info', 02:38:07 INFO - 'log_name': 'talos', 02:38:07 INFO - 'log_to_console': True, 02:38:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:38:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:38:07 INFO - 'opt_config_files': (), 02:38:07 INFO - 'pip_index': False, 02:38:07 INFO - 'sps_profile': False, 02:38:07 INFO - 'sps_profile_interval': 0, 02:38:07 INFO - 'suite': 'dromaeojs-e10s', 02:38:07 INFO - 'system_bits': '32', 02:38:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:38:07 INFO - 'title': 'talos-linux64-ix-053', 02:38:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:38:07 INFO - 'use_talos_json': True, 02:38:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:38:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:38:07 INFO - 'work_dir': 'build'} 02:38:07 INFO - ##### 02:38:07 INFO - ##### Running clobber step. 02:38:07 INFO - ##### 02:38:07 INFO - Running pre-action listener: _resource_record_pre_action 02:38:07 INFO - Running main action method: clobber 02:38:07 INFO - rmtree: /builds/slave/test/build 02:38:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:38:08 INFO - Running post-action listener: _resource_record_post_action 02:38:08 INFO - ##### 02:38:08 INFO - ##### Finished clobber step (success) 02:38:08 INFO - ##### 02:38:08 INFO - ##### 02:38:08 INFO - ##### Running read-buildbot-config step. 02:38:08 INFO - ##### 02:38:08 INFO - Running pre-action listener: _resource_record_pre_action 02:38:08 INFO - Running main action method: read_buildbot_config 02:38:08 INFO - Using buildbot properties: 02:38:08 INFO - { 02:38:08 INFO - "project": "", 02:38:08 INFO - "product": "firefox", 02:38:08 INFO - "script_repo_revision": "production", 02:38:08 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 02:38:08 INFO - "repository": "", 02:38:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 02:38:08 INFO - "buildid": "20160630235217", 02:38:08 INFO - "pgo_build": "True", 02:38:08 INFO - "basedir": "/builds/slave/test", 02:38:08 INFO - "buildnumber": 426, 02:38:08 INFO - "slavename": "talos-linux64-ix-053", 02:38:08 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:38:08 INFO - "platform": "ubuntu64_hw", 02:38:08 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 02:38:08 INFO - "branch": "mozilla-aurora", 02:38:08 INFO - "repo_path": "releases/mozilla-aurora", 02:38:08 INFO - "revision": "ab7833ced02512db316393e8186982172159af79", 02:38:08 INFO - "stage_platform": "linux64-pgo", 02:38:08 INFO - "builduid": "1812abf176084fe79a2d0e92bc2ce71f", 02:38:08 INFO - "slavebuilddir": "test" 02:38:08 INFO - } 02:38:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/JuVP5SfKQfC3CpVEuJcD_w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 02:38:08 INFO - Running post-action listener: _resource_record_post_action 02:38:08 INFO - ##### 02:38:08 INFO - ##### Finished read-buildbot-config step (success) 02:38:08 INFO - ##### 02:38:08 INFO - ##### 02:38:08 INFO - ##### Running download-and-extract step. 02:38:08 INFO - ##### 02:38:08 INFO - Running pre-action listener: _resource_record_pre_action 02:38:08 INFO - Running main action method: download_and_extract 02:38:08 INFO - mkdir: /builds/slave/test/build/tests 02:38:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:08 INFO - https://queue.taskcluster.net/v1/task/JuVP5SfKQfC3CpVEuJcD_w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:38:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuVP5SfKQfC3CpVEuJcD_w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 02:38:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuVP5SfKQfC3CpVEuJcD_w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 02:38:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuVP5SfKQfC3CpVEuJcD_w/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 02:38:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuVP5SfKQfC3CpVEuJcD_w/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 02:38:12 INFO - Downloaded 1361 bytes. 02:38:12 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 02:38:12 INFO - Using the following test package requirements: 02:38:12 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 02:38:12 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:38:12 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 02:38:12 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:38:12 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 02:38:12 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:38:12 INFO - u'jsshell-linux-x86_64.zip'], 02:38:12 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:38:12 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 02:38:12 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 02:38:12 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:38:12 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 02:38:12 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:38:12 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 02:38:12 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:38:12 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 02:38:12 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:38:12 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 02:38:12 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:38:12 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')]} 02:38:12 INFO - https://queue.taskcluster.net/v1/task/JuVP5SfKQfC3CpVEuJcD_w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:38:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuVP5SfKQfC3CpVEuJcD_w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 02:38:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuVP5SfKQfC3CpVEuJcD_w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 02:38:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuVP5SfKQfC3CpVEuJcD_w/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 02:38:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuVP5SfKQfC3CpVEuJcD_w/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 02:38:14 INFO - Downloaded 24525430 bytes. 02:38:14 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'] 02:38:14 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 02:38:15 INFO - Return code: 0 02:38:15 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 02:38:15 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')]} 02:38:15 INFO - https://queue.taskcluster.net/v1/task/JuVP5SfKQfC3CpVEuJcD_w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:38:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuVP5SfKQfC3CpVEuJcD_w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 02:38:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuVP5SfKQfC3CpVEuJcD_w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 02:38:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuVP5SfKQfC3CpVEuJcD_w/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 02:38:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuVP5SfKQfC3CpVEuJcD_w/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 02:38:17 INFO - Downloaded 24525430 bytes. 02:38:17 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'] 02:38:17 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 02:38:19 INFO - Return code: 0 02:38:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:19 INFO - https://queue.taskcluster.net/v1/task/JuVP5SfKQfC3CpVEuJcD_w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:38:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuVP5SfKQfC3CpVEuJcD_w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 02:38:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuVP5SfKQfC3CpVEuJcD_w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 02:38:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuVP5SfKQfC3CpVEuJcD_w/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 02:38:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuVP5SfKQfC3CpVEuJcD_w/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 02:38:20 INFO - Downloaded 10833369 bytes. 02:38:20 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'] 02:38:20 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 02:38:20 INFO - Return code: 0 02:38:20 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')]} 02:38:20 INFO - https://queue.taskcluster.net/v1/task/JuVP5SfKQfC3CpVEuJcD_w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:38:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuVP5SfKQfC3CpVEuJcD_w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 02:38:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuVP5SfKQfC3CpVEuJcD_w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 02:38:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuVP5SfKQfC3CpVEuJcD_w/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 02:38:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuVP5SfKQfC3CpVEuJcD_w/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 02:38:24 INFO - Downloaded 63615940 bytes. 02:38:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JuVP5SfKQfC3CpVEuJcD_w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 02:38:24 INFO - mkdir: /builds/slave/test/properties 02:38:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:38:24 INFO - Writing to file /builds/slave/test/properties/build_url 02:38:24 INFO - Contents: 02:38:24 INFO - build_url:https://queue.taskcluster.net/v1/task/JuVP5SfKQfC3CpVEuJcD_w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 02:38:25 INFO - Running post-action listener: _resource_record_post_action 02:38:25 INFO - Running post-action listener: set_extra_try_arguments 02:38:25 INFO - ##### 02:38:25 INFO - ##### Finished download-and-extract step (success) 02:38:25 INFO - ##### 02:38:25 INFO - ##### 02:38:25 INFO - ##### Running populate-webroot step. 02:38:25 INFO - ##### 02:38:25 INFO - Running pre-action listener: _resource_record_pre_action 02:38:25 INFO - Running main action method: populate_webroot 02:38:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:38:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:38:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:38:25 INFO - '--tppagecycles', 02:38:25 INFO - '7'], 02:38:25 INFO - 'tests': ['tsvgm']}}, 02:38:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:38:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:38:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:38:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:38:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:38:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:38:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:25 INFO - 'talos_options': ['--disable-e10s'], 02:38:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:38:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:38:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:25 INFO - 'talos_options': ['--disable-e10s'], 02:38:25 INFO - 'tests': ['damp', 'tps']}, 02:38:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:25 INFO - 'tests': ['damp', 'tps']}, 02:38:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:38:25 INFO - 'tests': ['dromaeo_dom']}, 02:38:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:38:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:38:25 INFO - 'tests': ['a11yr', 02:38:25 INFO - 'ts_paint', 02:38:25 INFO - 'tpaint', 02:38:25 INFO - 'sessionrestore', 02:38:25 INFO - 'sessionrestore_no_auto_restore', 02:38:25 INFO - 'tabpaint']}, 02:38:25 INFO - 'other-e10s': {'tests': ['a11yr', 02:38:25 INFO - 'ts_paint', 02:38:25 INFO - 'tpaint', 02:38:25 INFO - 'sessionrestore', 02:38:25 INFO - 'sessionrestore_no_auto_restore', 02:38:25 INFO - 'tabpaint']}, 02:38:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:38:25 INFO - 'ts_paint', 02:38:25 INFO - 'tpaint', 02:38:25 INFO - 'sessionrestore', 02:38:25 INFO - 'sessionrestore_no_auto_restore', 02:38:25 INFO - 'tabpaint']}, 02:38:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:38:25 INFO - 'ts_paint', 02:38:25 INFO - 'tpaint', 02:38:25 INFO - 'sessionrestore', 02:38:25 INFO - 'sessionrestore_no_auto_restore', 02:38:25 INFO - 'tabpaint']}, 02:38:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:38:25 INFO - 'tests': ['a11yr', 02:38:25 INFO - 'ts_paint', 02:38:25 INFO - 'tpaint', 02:38:25 INFO - 'sessionrestore', 02:38:25 INFO - 'sessionrestore_no_auto_restore', 02:38:25 INFO - 'tabpaint']}, 02:38:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:38:25 INFO - 'tests': ['a11yr', 02:38:25 INFO - 'ts_paint', 02:38:25 INFO - 'tpaint', 02:38:25 INFO - 'sessionrestore', 02:38:25 INFO - 'sessionrestore_no_auto_restore', 02:38:25 INFO - 'tabpaint']}, 02:38:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:38:25 INFO - 'tests': ['tsvgx', 02:38:25 INFO - 'tsvgr_opacity', 02:38:25 INFO - 'tart', 02:38:25 INFO - 'tscrollx', 02:38:25 INFO - 'cart']}, 02:38:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:38:25 INFO - 'tsvgr_opacity', 02:38:25 INFO - 'tart', 02:38:25 INFO - 'tscrollx', 02:38:25 INFO - 'cart']}, 02:38:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:25 INFO - 'talos_options': ['--disable-e10s'], 02:38:25 INFO - 'tests': ['tp5o']}, 02:38:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:25 INFO - 'tests': ['tp5o']}, 02:38:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:25 INFO - 'talos_options': ['--disable-e10s', 02:38:25 INFO - '--xperf_path', 02:38:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:38:25 INFO - 'tests': ['tp5n']}, 02:38:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:25 INFO - 'talos_options': ['--xperf_path', 02:38:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:38:25 INFO - 'tests': ['tp5n']}}, 02:38:25 INFO - 'talos.zip': {'path': '', 02:38:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:38:25 INFO - Running post-action listener: _resource_record_post_action 02:38:25 INFO - ##### 02:38:25 INFO - ##### Finished populate-webroot step (success) 02:38:25 INFO - ##### 02:38:25 INFO - ##### 02:38:25 INFO - ##### Running create-virtualenv step. 02:38:25 INFO - ##### 02:38:25 INFO - Running pre-action listener: _resource_record_pre_action 02:38:25 INFO - Running main action method: create_virtualenv 02:38:25 INFO - Creating virtualenv /builds/slave/test/build/venv 02:38:25 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 02:38:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:38:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:38:25 INFO - Using real prefix '/usr' 02:38:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:38:25 INFO - Installing distribute.............................................................................................................................................................................................done. 02:38:27 INFO - Installing pip.................done. 02:38:27 INFO - Return code: 0 02:38:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:38:27 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')]} 02:38:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:27 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')]} 02:38:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:27 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 0x7f5432012f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2390350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241f1c0>, '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 0x24200c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2420550>, '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': '920470bf432669ad7e3a5387000001ca-1467365884.471784-514542912', '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 02:38:27 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 02:38:27 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 02:38:27 INFO - Using env: {'DISPLAY': ':0', 02:38:27 INFO - 'HOME': '/home/cltbld', 02:38:27 INFO - 'LANG': 'en_US.UTF-8', 02:38:27 INFO - 'LANGUAGE': 'en_US:en', 02:38:27 INFO - 'LOGNAME': 'cltbld', 02:38:27 INFO - 'MAIL': '/var/mail/cltbld', 02:38:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:27 INFO - 'MOZ_NO_REMOTE': '1', 02:38:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:27 INFO - 'NO_EM_RESTART': '1', 02:38:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:27 INFO - 'PWD': '/builds/slave/test', 02:38:27 INFO - 'SHELL': '/bin/bash', 02:38:27 INFO - 'SHLVL': '1', 02:38:27 INFO - 'TERM': 'linux', 02:38:27 INFO - 'TMOUT': '86400', 02:38:27 INFO - 'USER': 'cltbld', 02:38:27 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467365884.471784-514542912', 02:38:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:27 INFO - '_': '/tools/buildbot/bin/python'} 02:38:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:28 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 02:38:28 INFO - Cleaning up... 02:38:28 INFO - Return code: 0 02:38:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:38: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')]} 02:38:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38: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')]} 02:38:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:28 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 0x7f5432012f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2390350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241f1c0>, '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 0x24200c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2420550>, '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': '920470bf432669ad7e3a5387000001ca-1467365884.471784-514542912', '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 02:38:28 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 02:38:28 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 02:38:28 INFO - Using env: {'DISPLAY': ':0', 02:38:28 INFO - 'HOME': '/home/cltbld', 02:38:28 INFO - 'LANG': 'en_US.UTF-8', 02:38:28 INFO - 'LANGUAGE': 'en_US:en', 02:38:28 INFO - 'LOGNAME': 'cltbld', 02:38:28 INFO - 'MAIL': '/var/mail/cltbld', 02:38:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:28 INFO - 'MOZ_NO_REMOTE': '1', 02:38:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:28 INFO - 'NO_EM_RESTART': '1', 02:38:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:28 INFO - 'PWD': '/builds/slave/test', 02:38:28 INFO - 'SHELL': '/bin/bash', 02:38:28 INFO - 'SHLVL': '1', 02:38:28 INFO - 'TERM': 'linux', 02:38:28 INFO - 'TMOUT': '86400', 02:38:28 INFO - 'USER': 'cltbld', 02:38:28 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467365884.471784-514542912', 02:38:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:28 INFO - '_': '/tools/buildbot/bin/python'} 02:38:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:28 INFO - Downloading/unpacking psutil>=3.1.1 02:38:28 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 02:38:28 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 02:38:28 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 02:38:28 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 02:38:28 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 02:38:28 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 02:38:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:38:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:38:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:38:30 INFO - Installing collected packages: psutil 02:38:30 INFO - Running setup.py install for psutil 02:38:30 INFO - building 'psutil._psutil_linux' extension 02:38:30 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 02:38:30 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 02:38:30 INFO - building 'psutil._psutil_posix' extension 02:38:30 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 02:38:30 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 02:38:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:38:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:38:30 INFO - Successfully installed psutil 02:38:30 INFO - Cleaning up... 02:38:30 INFO - Return code: 0 02:38:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:38:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:30 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 0x7f5432012f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2390350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241f1c0>, '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 0x24200c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2420550>, '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': '920470bf432669ad7e3a5387000001ca-1467365884.471784-514542912', '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 02:38:30 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 02:38:30 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 02:38:30 INFO - Using env: {'DISPLAY': ':0', 02:38:30 INFO - 'HOME': '/home/cltbld', 02:38:30 INFO - 'LANG': 'en_US.UTF-8', 02:38:30 INFO - 'LANGUAGE': 'en_US:en', 02:38:30 INFO - 'LOGNAME': 'cltbld', 02:38:30 INFO - 'MAIL': '/var/mail/cltbld', 02:38:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:30 INFO - 'MOZ_NO_REMOTE': '1', 02:38:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:30 INFO - 'NO_EM_RESTART': '1', 02:38:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:30 INFO - 'PWD': '/builds/slave/test', 02:38:30 INFO - 'SHELL': '/bin/bash', 02:38:30 INFO - 'SHLVL': '1', 02:38:30 INFO - 'TERM': 'linux', 02:38:30 INFO - 'TMOUT': '86400', 02:38:30 INFO - 'USER': 'cltbld', 02:38:30 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467365884.471784-514542912', 02:38:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:30 INFO - '_': '/tools/buildbot/bin/python'} 02:38:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:38:31 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 02:38:31 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 02:38:31 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 02:38:31 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 02:38:31 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 02:38:31 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 02:38:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:38:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:38:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:38:33 INFO - Installing collected packages: mozsystemmonitor 02:38:33 INFO - Running setup.py install for mozsystemmonitor 02:38:33 INFO - Successfully installed mozsystemmonitor 02:38:33 INFO - Cleaning up... 02:38:33 INFO - Return code: 0 02:38:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:38:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:33 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 0x7f5432012f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2390350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241f1c0>, '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 0x24200c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2420550>, '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': '920470bf432669ad7e3a5387000001ca-1467365884.471784-514542912', '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 02:38:33 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 02:38:33 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 02:38:33 INFO - Using env: {'DISPLAY': ':0', 02:38:33 INFO - 'HOME': '/home/cltbld', 02:38:33 INFO - 'LANG': 'en_US.UTF-8', 02:38:33 INFO - 'LANGUAGE': 'en_US:en', 02:38:33 INFO - 'LOGNAME': 'cltbld', 02:38:33 INFO - 'MAIL': '/var/mail/cltbld', 02:38:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:33 INFO - 'MOZ_NO_REMOTE': '1', 02:38:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:33 INFO - 'NO_EM_RESTART': '1', 02:38:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:33 INFO - 'PWD': '/builds/slave/test', 02:38:33 INFO - 'SHELL': '/bin/bash', 02:38:33 INFO - 'SHLVL': '1', 02:38:33 INFO - 'TERM': 'linux', 02:38:33 INFO - 'TMOUT': '86400', 02:38:33 INFO - 'USER': 'cltbld', 02:38:33 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467365884.471784-514542912', 02:38:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:33 INFO - '_': '/tools/buildbot/bin/python'} 02:38:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:33 INFO - Downloading/unpacking jsonschema==2.5.1 02:38:33 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 02:38:33 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 02:38:33 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 02:38:33 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 02:38:33 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 02:38:33 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 02:38:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:38:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:38:35 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 02:38:35 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 02:38:35 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 02:38:35 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 02:38:35 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 02:38:35 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 02:38:35 INFO - Downloading functools32-3.2.3-2.tar.gz 02:38:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:38:35 INFO - warning: no files found matching '*.txt' 02:38:35 INFO - no previously-included directories found matching 'build' 02:38:35 INFO - no previously-included directories found matching 'dist' 02:38:35 INFO - no previously-included directories found matching '.git*' 02:38:35 INFO - Installing collected packages: jsonschema, functools32 02:38:35 INFO - Running setup.py install for functools32 02:38:35 INFO - warning: no files found matching '*.txt' 02:38:35 INFO - no previously-included directories found matching 'build' 02:38:35 INFO - no previously-included directories found matching 'dist' 02:38:35 INFO - no previously-included directories found matching '.git*' 02:38:35 INFO - Successfully installed jsonschema functools32 02:38:35 INFO - Cleaning up... 02:38:35 INFO - Return code: 0 02:38:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:38: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')]} 02:38:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38: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')]} 02:38:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:35 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 0x7f5432012f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2390350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241f1c0>, '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 0x24200c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2420550>, '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': '920470bf432669ad7e3a5387000001ca-1467365884.471784-514542912', '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 02:38:35 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 02:38:35 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 02:38:35 INFO - Using env: {'DISPLAY': ':0', 02:38:35 INFO - 'HOME': '/home/cltbld', 02:38:35 INFO - 'LANG': 'en_US.UTF-8', 02:38:35 INFO - 'LANGUAGE': 'en_US:en', 02:38:35 INFO - 'LOGNAME': 'cltbld', 02:38:35 INFO - 'MAIL': '/var/mail/cltbld', 02:38:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:35 INFO - 'MOZ_NO_REMOTE': '1', 02:38:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:35 INFO - 'NO_EM_RESTART': '1', 02:38:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:35 INFO - 'PWD': '/builds/slave/test', 02:38:35 INFO - 'SHELL': '/bin/bash', 02:38:35 INFO - 'SHLVL': '1', 02:38:35 INFO - 'TERM': 'linux', 02:38:35 INFO - 'TMOUT': '86400', 02:38:35 INFO - 'USER': 'cltbld', 02:38:35 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467365884.471784-514542912', 02:38:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:35 INFO - '_': '/tools/buildbot/bin/python'} 02:38:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:36 INFO - Downloading/unpacking blobuploader==1.2.4 02:38:36 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 02:38:36 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 02:38:36 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 02:38:36 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 02:38:36 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 02:38:36 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 02:38:38 INFO - Downloading blobuploader-1.2.4.tar.gz 02:38:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:38:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:38:39 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 02:38:39 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 02:38:39 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 02:38:39 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 02:38:39 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 02:38:39 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 02:38:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:38:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:38:39 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 02:38:39 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 02:38:39 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 02:38:39 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 02:38:39 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 02:38:39 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 02:38:39 INFO - Downloading docopt-0.6.1.tar.gz 02:38:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:38:39 INFO - Installing collected packages: blobuploader, requests, docopt 02:38:39 INFO - Running setup.py install for blobuploader 02:38:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:38:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:38:39 INFO - Running setup.py install for requests 02:38:40 INFO - Running setup.py install for docopt 02:38:40 INFO - Successfully installed blobuploader requests docopt 02:38:40 INFO - Cleaning up... 02:38:40 INFO - Return code: 0 02:38:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:38:40 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')]} 02:38:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:40 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')]} 02:38:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:40 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 0x7f5432012f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2390350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241f1c0>, '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 0x24200c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2420550>, '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': '920470bf432669ad7e3a5387000001ca-1467365884.471784-514542912', '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 02:38:40 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 02:38:40 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 02:38:40 INFO - Using env: {'DISPLAY': ':0', 02:38:40 INFO - 'HOME': '/home/cltbld', 02:38:40 INFO - 'LANG': 'en_US.UTF-8', 02:38:40 INFO - 'LANGUAGE': 'en_US:en', 02:38:40 INFO - 'LOGNAME': 'cltbld', 02:38:40 INFO - 'MAIL': '/var/mail/cltbld', 02:38:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:40 INFO - 'MOZ_NO_REMOTE': '1', 02:38:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:40 INFO - 'NO_EM_RESTART': '1', 02:38:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:40 INFO - 'PWD': '/builds/slave/test', 02:38:40 INFO - 'SHELL': '/bin/bash', 02:38:40 INFO - 'SHLVL': '1', 02:38:40 INFO - 'TERM': 'linux', 02:38:40 INFO - 'TMOUT': '86400', 02:38:40 INFO - 'USER': 'cltbld', 02:38:40 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467365884.471784-514542912', 02:38:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:40 INFO - '_': '/tools/buildbot/bin/python'} 02:38:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:38:40 INFO - Running setup.py (path:/tmp/pip-P2NxgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:38:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:38:40 INFO - Running setup.py (path:/tmp/pip-vX7aJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:38:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:38:40 INFO - Running setup.py (path:/tmp/pip-hGLX81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:38:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:38:40 INFO - Running setup.py (path:/tmp/pip-0QNJ0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:38:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:38:40 INFO - Running setup.py (path:/tmp/pip-O37EZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:38:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:38:40 INFO - Running setup.py (path:/tmp/pip-IhGIDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:38:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:38:40 INFO - Running setup.py (path:/tmp/pip-8I6_oS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:38:41 INFO - Running setup.py (path:/tmp/pip-hz7DG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:38:41 INFO - Running setup.py (path:/tmp/pip-nHUoSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:38:41 INFO - Running setup.py (path:/tmp/pip-6jRdeW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:38:41 INFO - Running setup.py (path:/tmp/pip-aMAVwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:38:41 INFO - Running setup.py (path:/tmp/pip-C1kSx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:38:41 INFO - Running setup.py (path:/tmp/pip-ugUHGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:38:41 INFO - Running setup.py (path:/tmp/pip-_FWdWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:38:41 INFO - Running setup.py (path:/tmp/pip-O756nm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:38:41 INFO - Running setup.py (path:/tmp/pip-6pWjFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:38:41 INFO - Running setup.py (path:/tmp/pip-MgcHeJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:38:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:38:41 INFO - Running setup.py install for manifestparser 02:38:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:38:41 INFO - Running setup.py install for mozcrash 02:38:41 INFO - Running setup.py install for mozdebug 02:38:42 INFO - Running setup.py install for mozdevice 02:38:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:38:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:38:42 INFO - Running setup.py install for mozfile 02:38:42 INFO - Running setup.py install for mozhttpd 02:38:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:38:42 INFO - Running setup.py install for mozinfo 02:38:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:38:42 INFO - Running setup.py install for mozInstall 02:38:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:38:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:38:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:38:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:38:42 INFO - Running setup.py install for mozleak 02:38:42 INFO - Running setup.py install for mozlog 02:38:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:38:42 INFO - Running setup.py install for moznetwork 02:38:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:38:42 INFO - Running setup.py install for mozprocess 02:38:42 INFO - Running setup.py install for mozprofile 02:38:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:38:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:38:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:38:43 INFO - Running setup.py install for mozrunner 02:38:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:38:43 INFO - Running setup.py install for mozscreenshot 02:38:43 INFO - Running setup.py install for moztest 02:38:43 INFO - Running setup.py install for mozversion 02:38:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:38:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:38:43 INFO - Cleaning up... 02:38:43 INFO - Return code: 0 02:38:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:38: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')]} 02:38:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38: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')]} 02:38:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:43 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 0x7f5432012f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2390350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241f1c0>, '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 0x24200c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2420550>, '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': '920470bf432669ad7e3a5387000001ca-1467365884.471784-514542912', '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 02:38:43 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 02:38:43 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 02:38:43 INFO - Using env: {'DISPLAY': ':0', 02:38:43 INFO - 'HOME': '/home/cltbld', 02:38:43 INFO - 'LANG': 'en_US.UTF-8', 02:38:43 INFO - 'LANGUAGE': 'en_US:en', 02:38:43 INFO - 'LOGNAME': 'cltbld', 02:38:43 INFO - 'MAIL': '/var/mail/cltbld', 02:38:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:43 INFO - 'MOZ_NO_REMOTE': '1', 02:38:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:43 INFO - 'NO_EM_RESTART': '1', 02:38:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:43 INFO - 'PWD': '/builds/slave/test', 02:38:43 INFO - 'SHELL': '/bin/bash', 02:38:43 INFO - 'SHLVL': '1', 02:38:43 INFO - 'TERM': 'linux', 02:38:43 INFO - 'TMOUT': '86400', 02:38:43 INFO - 'USER': 'cltbld', 02:38:43 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467365884.471784-514542912', 02:38:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:43 INFO - '_': '/tools/buildbot/bin/python'} 02:38:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:38:43 INFO - Running setup.py (path:/tmp/pip-IBknqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:38:43 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)) 02:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:38:43 INFO - Running setup.py (path:/tmp/pip-krMy5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:38:43 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)) 02:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:38:43 INFO - Running setup.py (path:/tmp/pip-e3bAlS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:38:43 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)) 02:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:38:43 INFO - Running setup.py (path:/tmp/pip-GugDtU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:38:44 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)) 02:38:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:38:44 INFO - Running setup.py (path:/tmp/pip-Gx9eGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:38:44 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)) 02:38:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:38:44 INFO - Running setup.py (path:/tmp/pip-SrQYYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:38:44 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)) 02:38:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:38:44 INFO - Running setup.py (path:/tmp/pip-LGJZZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:38:44 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)) 02:38:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:38:44 INFO - Running setup.py (path:/tmp/pip-_PoVES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:38:44 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)) 02:38:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:38:44 INFO - Running setup.py (path:/tmp/pip-nAn0V4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:38:44 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)) 02:38:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:38:44 INFO - Running setup.py (path:/tmp/pip-gxji5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:38:44 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)) 02:38:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:38:44 INFO - Running setup.py (path:/tmp/pip-w8EpWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:38:44 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)) 02:38:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:38:44 INFO - Running setup.py (path:/tmp/pip-Qpjhy6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:38:44 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)) 02:38:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:38:44 INFO - Running setup.py (path:/tmp/pip-unEQPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:38:44 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)) 02:38:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:38:44 INFO - Running setup.py (path:/tmp/pip-wDYB5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:38:44 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)) 02:38:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:38:44 INFO - Running setup.py (path:/tmp/pip-HmJeXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:38:44 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)) 02:38:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:38:44 INFO - Running setup.py (path:/tmp/pip-y0hEyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:38:44 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)) 02:38:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:38:44 INFO - Running setup.py (path:/tmp/pip-KbPZJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:38:44 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)) 02:38:44 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)) 02:38:44 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)) 02:38:44 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)) 02:38:44 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)) 02:38:44 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)) 02:38:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:38:44 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 02:38:44 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 02:38:44 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 02:38:44 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 02:38:44 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 02:38:44 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 02:38:46 INFO - Downloading blessings-1.6.tar.gz 02:38:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:38:46 INFO - Installing collected packages: blessings 02:38:46 INFO - Running setup.py install for blessings 02:38:47 INFO - Successfully installed blessings 02:38:47 INFO - Cleaning up... 02:38:47 INFO - Return code: 0 02:38:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:38:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:38:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:38:47 INFO - Reading from file tmpfile_stdout 02:38:47 INFO - Current package versions: 02:38:47 INFO - argparse == 1.2.1 02:38:47 INFO - blessings == 1.6 02:38:47 INFO - blobuploader == 1.2.4 02:38:47 INFO - docopt == 0.6.1 02:38:47 INFO - functools32 == 3.2.3-2 02:38:47 INFO - jsonschema == 2.5.1 02:38:47 INFO - manifestparser == 1.1 02:38:47 INFO - mozInstall == 1.12 02:38:47 INFO - mozcrash == 0.17 02:38:47 INFO - mozdebug == 0.1 02:38:47 INFO - mozdevice == 0.48 02:38:47 INFO - mozfile == 1.2 02:38:47 INFO - mozhttpd == 0.7 02:38:47 INFO - mozinfo == 0.9 02:38:47 INFO - mozleak == 0.1 02:38:47 INFO - mozlog == 3.2 02:38:47 INFO - moznetwork == 0.27 02:38:47 INFO - mozprocess == 0.22 02:38:47 INFO - mozprofile == 0.28 02:38:47 INFO - mozrunner == 6.11 02:38:47 INFO - mozscreenshot == 0.1 02:38:47 INFO - mozsystemmonitor == 0.3 02:38:47 INFO - moztest == 0.7 02:38:47 INFO - mozversion == 1.4 02:38:47 INFO - psutil == 3.1.1 02:38:47 INFO - requests == 1.2.3 02:38:47 INFO - wsgiref == 0.1.2 02:38:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:38:47 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')]} 02:38:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:47 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')]} 02:38:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:47 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 0x7f5432012f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2390350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241f1c0>, '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 0x24200c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2420550>, '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': '920470bf432669ad7e3a5387000001ca-1467365884.471784-514542912', '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 02:38:47 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 02:38:47 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 02:38:47 INFO - Using env: {'DISPLAY': ':0', 02:38:47 INFO - 'HOME': '/home/cltbld', 02:38:47 INFO - 'LANG': 'en_US.UTF-8', 02:38:47 INFO - 'LANGUAGE': 'en_US:en', 02:38:47 INFO - 'LOGNAME': 'cltbld', 02:38:47 INFO - 'MAIL': '/var/mail/cltbld', 02:38:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:47 INFO - 'MOZ_NO_REMOTE': '1', 02:38:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:47 INFO - 'NO_EM_RESTART': '1', 02:38:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:47 INFO - 'PWD': '/builds/slave/test', 02:38:47 INFO - 'SHELL': '/bin/bash', 02:38:47 INFO - 'SHLVL': '1', 02:38:47 INFO - 'TERM': 'linux', 02:38:47 INFO - 'TMOUT': '86400', 02:38:47 INFO - 'USER': 'cltbld', 02:38:47 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467365884.471784-514542912', 02:38:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:47 INFO - '_': '/tools/buildbot/bin/python'} 02:38:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:47 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)) 02:38:47 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)) 02:38:47 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)) 02:38:47 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)) 02:38:47 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)) 02:38:47 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)) 02:38:47 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)) 02:38:47 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)) 02:38:47 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)) 02:38:47 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)) 02:38:47 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)) 02:38:47 INFO - Cleaning up... 02:38:47 INFO - Return code: 0 02:38:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:38:47 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')]} 02:38:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:47 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')]} 02:38:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:47 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 0x7f5432012f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2390350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241f1c0>, '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 0x24200c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2420550>, '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': '920470bf432669ad7e3a5387000001ca-1467365884.471784-514542912', '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 02:38:47 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 02:38:47 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 02:38:47 INFO - Using env: {'DISPLAY': ':0', 02:38:47 INFO - 'HOME': '/home/cltbld', 02:38:47 INFO - 'LANG': 'en_US.UTF-8', 02:38:47 INFO - 'LANGUAGE': 'en_US:en', 02:38:47 INFO - 'LOGNAME': 'cltbld', 02:38:47 INFO - 'MAIL': '/var/mail/cltbld', 02:38:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:47 INFO - 'MOZ_NO_REMOTE': '1', 02:38:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:47 INFO - 'NO_EM_RESTART': '1', 02:38:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:47 INFO - 'PWD': '/builds/slave/test', 02:38:47 INFO - 'SHELL': '/bin/bash', 02:38:47 INFO - 'SHLVL': '1', 02:38:47 INFO - 'TERM': 'linux', 02:38:47 INFO - 'TMOUT': '86400', 02:38:47 INFO - 'USER': 'cltbld', 02:38:47 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467365884.471784-514542912', 02:38:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:47 INFO - '_': '/tools/buildbot/bin/python'} 02:38:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:38:47 INFO - Cleaning up... 02:38:47 INFO - Return code: 0 02:38:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:38:47 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')]} 02:38:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:47 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')]} 02:38:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:47 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 0x7f5432012f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2390350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241f1c0>, '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 0x24200c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2420550>, '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': '920470bf432669ad7e3a5387000001ca-1467365884.471784-514542912', '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 02:38:47 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 02:38:47 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 02:38:47 INFO - Using env: {'DISPLAY': ':0', 02:38:47 INFO - 'HOME': '/home/cltbld', 02:38:47 INFO - 'LANG': 'en_US.UTF-8', 02:38:47 INFO - 'LANGUAGE': 'en_US:en', 02:38:47 INFO - 'LOGNAME': 'cltbld', 02:38:47 INFO - 'MAIL': '/var/mail/cltbld', 02:38:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:47 INFO - 'MOZ_NO_REMOTE': '1', 02:38:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:47 INFO - 'NO_EM_RESTART': '1', 02:38:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:47 INFO - 'PWD': '/builds/slave/test', 02:38:47 INFO - 'SHELL': '/bin/bash', 02:38:47 INFO - 'SHLVL': '1', 02:38:47 INFO - 'TERM': 'linux', 02:38:47 INFO - 'TMOUT': '86400', 02:38:47 INFO - 'USER': 'cltbld', 02:38:47 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467365884.471784-514542912', 02:38:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:47 INFO - '_': '/tools/buildbot/bin/python'} 02:38:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:48 INFO - Downloading/unpacking flake8 02:38: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 02:38: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 02:38: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 02:38: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 02:38: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 02:38: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 02:38:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:38:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:38:49 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 02:38:49 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 02:38:49 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 02:38:49 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 02:38:49 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 02:38:49 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 02:38:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:38:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:38: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 02:38: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 02:38: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 02:38: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 02:38: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 02:38: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 02:38:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:38: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 02:38: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 02:38: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 02:38: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 02:38: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 02:38: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 02:38:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:38:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:38:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:38:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:38:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:38:50 INFO - no previously-included directories found matching 'docs/_build' 02:38:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:38:50 INFO - Running setup.py install for pep8 02:38:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:38:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:38:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:38:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:38:50 INFO - no previously-included directories found matching 'docs/_build' 02:38:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:38:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:38:50 INFO - Cleaning up... 02:38:50 INFO - Return code: 0 02:38:50 INFO - Running post-action listener: _resource_record_post_action 02:38:50 INFO - Running post-action listener: _start_resource_monitoring 02:38:50 INFO - Starting resource monitoring. 02:38:50 INFO - ##### 02:38:50 INFO - ##### Finished create-virtualenv step (success) 02:38:50 INFO - ##### 02:38:50 INFO - ##### 02:38:50 INFO - ##### Running install step. 02:38:50 INFO - ##### 02:38:50 INFO - Running pre-action listener: _resource_record_pre_action 02:38:50 INFO - Running main action method: install 02:38:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:38:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:38:51 INFO - Reading from file tmpfile_stdout 02:38:51 INFO - Detecting whether we're running mozinstall >=1.0... 02:38:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:38:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:38:51 INFO - Reading from file tmpfile_stdout 02:38:51 INFO - Output received: 02:38:51 INFO - Usage: mozinstall [options] installer 02:38:51 INFO - Options: 02:38:51 INFO - -h, --help show this help message and exit 02:38:51 INFO - -d DEST, --destination=DEST 02:38:51 INFO - Directory to install application into. [default: 02:38:51 INFO - "/builds/slave/test"] 02:38:51 INFO - --app=APP Application being installed. [default: firefox] 02:38:51 INFO - mkdir: /builds/slave/test/build/application 02:38:51 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'] 02:38:51 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 02:39:07 INFO - Reading from file tmpfile_stdout 02:39:07 INFO - Output received: 02:39:07 INFO - /builds/slave/test/build/application/firefox/firefox 02:39:07 INFO - Running post-action listener: _resource_record_post_action 02:39:07 INFO - ##### 02:39:07 INFO - ##### Finished install step (success) 02:39:07 INFO - ##### 02:39:07 INFO - ##### 02:39:07 INFO - ##### Running run-tests step. 02:39:07 INFO - ##### 02:39:07 INFO - Running pre-action listener: _resource_record_pre_action 02:39:07 INFO - Running main action method: run_tests 02:39:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:39:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:39:07 INFO - Python 2.7.3 02:39:07 INFO - Return code: 0 02:39:07 INFO - grabbing minidump binary from tooltool 02:39:07 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')]} 02:39:07 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 0x241f1c0>, '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 0x24200c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2420550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:39:07 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 02:39:07 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 02:39:07 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 02:39:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:39:07 INFO - Return code: 0 02:39:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:39:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:39:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:39:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:39:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:39:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:39:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:39:08 INFO - Return code: 0 02:39:08 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JuVP5SfKQfC3CpVEuJcD_w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:39:08 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JuVP5SfKQfC3CpVEuJcD_w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:39:08 INFO - Using env: {'DISPLAY': ':0', 02:39:08 INFO - 'HOME': '/home/cltbld', 02:39:08 INFO - 'LANG': 'en_US.UTF-8', 02:39:08 INFO - 'LANGUAGE': 'en_US:en', 02:39:08 INFO - 'LOGNAME': 'cltbld', 02:39:08 INFO - 'MAIL': '/var/mail/cltbld', 02:39:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:39:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:39:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:08 INFO - 'MOZ_NO_REMOTE': '1', 02:39:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:39:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:08 INFO - 'NO_EM_RESTART': '1', 02:39:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:08 INFO - 'PWD': '/builds/slave/test', 02:39:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:39:08 INFO - 'SHELL': '/bin/bash', 02:39:08 INFO - 'SHLVL': '1', 02:39:08 INFO - 'TERM': 'linux', 02:39:08 INFO - 'TMOUT': '86400', 02:39:08 INFO - 'USER': 'cltbld', 02:39:08 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467365884.471784-514542912', 02:39:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:08 INFO - '_': '/tools/buildbot/bin/python'} 02:39:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JuVP5SfKQfC3CpVEuJcD_w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:39:08 INFO - mozversion application_buildid: 20160630235217 02:39:08 INFO - mozversion application_changeset: ab7833ced02512db316393e8186982172159af79 02:39:08 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:39:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:39:08 INFO - mozversion application_name: Firefox 02:39:08 INFO - mozversion application_remotingname: firefox-dev 02:39:08 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:39:08 INFO - mozversion application_vendor: Mozilla 02:39:08 INFO - mozversion application_version: 49.0a2 02:39:08 INFO - mozversion platform_buildid: 20160630235217 02:39:08 INFO - mozversion platform_changeset: ab7833ced02512db316393e8186982172159af79 02:39:08 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:39:08 INFO - mozversion platform_version: 49.0a2 02:39:08 INFO - using testdate: 1467365948 02:39:08 INFO - actual date: 1467365948 02:39:08 INFO - starting webserver on 'localhost:51250' 02:39:08 INFO - SUITE-START | Running 2 tests 02:39:08 INFO - TEST-START | dromaeo_css 02:39:08 INFO - operating with platform_type : linux_ 02:39:08 INFO - Initialising browser for dromaeo_css test... 02:39:08 INFO - TEST-INFO | started process 20240 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiEWT67/profile http://localhost:51250/getInfo.html) 02:39:13 INFO - PROCESS | 20240 | __metrics Screen width/height:1600/1200 02:39:13 INFO - PROCESS | 20240 | colorDepth:24 02:39:13 INFO - PROCESS | 20240 | Browser inner width/height: 1024/697 02:39:13 INFO - PROCESS | 20240 | __metrics 02:39:14 ERROR - PROCESS | 20240 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 02:39:14 INFO - TEST-INFO | 20240: exit 0 02:39:14 INFO - Browser initialized. 02:39:14 INFO - Running cycle 1/1 for dromaeo_css test... 02:39:14 INFO - TEST-INFO | started process 20369 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiEWT67/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:39:26 INFO - PROCESS | 20369 | RSS: Main: 156409856 02:39:26 INFO - PROCESS | 20369 | 02:40:16 INFO - PROCESS | 20369 | 1467366016287 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] 02:42:24 INFO - PROCESS | 20369 | Cycle 1(1): loaded http://localhost:51250/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51250/tests/dromaeo/cssquery-ext.html) 02:42:25 INFO - PROCESS | 20369 | RSS: Main: 159473664 02:42:25 INFO - PROCESS | 20369 | 02:45:27 INFO - PROCESS | 20369 | Cycle 1(1): loaded http://localhost:51250/tests/dromaeo/cssquery-ext.html (next: http://localhost:51250/tests/dromaeo/cssquery-jquery.html) 02:45:28 INFO - PROCESS | 20369 | RSS: Main: 157503488 02:45:28 INFO - PROCESS | 20369 | 02:48:29 INFO - PROCESS | 20369 | Cycle 1(1): loaded http://localhost:51250/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51250/tests/dromaeo/cssquery-mootools.html) 02:48:30 INFO - PROCESS | 20369 | RSS: Main: 157507584 02:48:30 INFO - PROCESS | 20369 | 02:51:32 INFO - PROCESS | 20369 | Cycle 1(1): loaded http://localhost:51250/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51250/tests/dromaeo/cssquery-prototype.html) 02:51:32 INFO - PROCESS | 20369 | RSS: Main: 157073408 02:51:32 INFO - PROCESS | 20369 | 02:54:35 INFO - PROCESS | 20369 | Cycle 1(1): loaded http://localhost:51250/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51250/tests/dromaeo/cssquery-yui.html) 02:54:35 INFO - PROCESS | 20369 | RSS: Main: 159150080 02:54:35 INFO - PROCESS | 20369 | 02:57:38 INFO - PROCESS | 20369 | Cycle 1(1): loaded http://localhost:51250/tests/dromaeo/cssquery-yui.html (next: http://localhost:51250/tests/dromaeo/cssquery-dojo.html) 02:57:38 INFO - PROCESS | 20369 | RSS: Main: 159211520 02:57:38 INFO - PROCESS | 20369 | 02:57:38 INFO - PROCESS | 20369 | __start_tp_report 02:57:38 INFO - PROCESS | 20369 | _x_x_mozilla_page_load 02:57:38 INFO - PROCESS | 20369 | _x_x_mozilla_page_load_details 02:57:38 INFO - PROCESS | 20369 | |i|pagename|runs| 02:57:38 INFO - PROCESS | 20369 | |0;dojo.html;3431.502432147339;3442.363162814881;3464.8960531184075;3477.878274260401;3480.269143479869;5783.624064435809;5829.650220986744;5838.532917366611;5878.588498805086;5931.762729490815;5887.35239123696;5895.35151133375;5920.911186332209;5950.910736338948;5972.432618901208;5262.657927234727;5322.999999999981;5361.839144825662;5379.38137114233;5384;5244.501772331622;5342.786288548454;5354.625176237665;5410.134378499441;5411.404745477994;5334.839954801362;5344.198370244475;5352.304200453936;5352.759125839347;5487.259220005308;5358.169483730028;5401.135818269097;5415.998040362526;5430.266913966603;5434.184872269171;5154.845354639367;5209.0363282792805;5259.973700131475;5323.1749078892835;5428.565714742811;5638.774449022034;5685.516731077863;5735.713214339308;5753.482186603184;5765.711714414305;6249.750009999594;6282.340354262782;6294.496440284766;6307.085472606446;6317.368263173692;6122.154209354583;6259.749610015594;6298.905516417258;6367.586106903036;6368.490520758328;5989.3711160327975;5995.370486098984;5997.130416089686;6002.129691194796;6018.337982821886;6509.7396104155305;6540.967295163494;6548.443382312556;6557.278699343068;6559.8360040998405;5995;6088.634681919099;6112.381899552462;6125.418085281891;6275.497960163176;6278.434940855253;6304;6318.336574659686;6323.747050118036;6341.397567231105;6207.503399728102;6302.65335406557;6303.432691057827;6323.683815809191;6329.177206963157;6096.634201947897;6112.480439162721;6137.232845894263;6145.723442445101;6263.342349053375;4726.220173671374;4738.8341408050555;4738.8341408050555;4762.666613337103;4767.475577686451;4152.501699796044;4221.97889010553;4237.194932962789;4243.511996120424;4245.936310955338;5837;5909.172715819703;5945.672987985616;5950.166976623276;5961.880762384728;6235.469985051231;6266.216722909637;6377.840553986188;6380.904286435707;6393.584417012879;5795.8551036224435;6067.908981365283;6073.331933487313;6078.270607527036;6087.3303936566945;5365.865853353697;5386.703731294817;5419.160030195248;5450.264214331015;5468;6615.470762339001;6625.0724898514245;6655.334466553403;6659.200895892427;6660.966695166493;6054.424829641177;6171.814845554641;6408.711607977652;6420.165378500765;6422.839429014125;6378.521610879296;6502.187226596676;6528.347165283433;6537.7058032389605;6555.6066636002;6142.907856382247;6152.630842149485;6163.907541386972;6185.226846644169;6196.81409557714;6102.084687296941;6160.414760597736;6190.721417536131;6251.843703907439;6274.498040156685;6172.506199504119;6178.9382106180165;6198.845028874314;6204.875902482016;6208.068789681584;6188;6195.907061394173;6198;6198.566100372931;6211.9068213977735;5817.680027598353;5897.3807750187325;5910;5946.583739138218;5995.6702381367695;6085.056816193497;6119.541034422347;6150.261968563801;6195.721192546436;6211.689415529296;6059.09113632941;6060.424259695322;6064.818055458343;6069.878602428015;6074.817755467343 02:57:38 INFO - PROCESS | 20369 | |1;ext.html;591.6657088744859;648.4520580109811;653.7907869481767;667.3060017581714;667.9365460281272;46569.76715116424;47754.52245477544;47839.521604783986;47869.760651196695;51419.22871156926;49469;50206;50258.49741502584;50264.99470010598;50270.245946310744;9150;9301.906980930205;9305.581248843784;9348.766280843;9350.485723285217;9138.588763505624;9224.215941644969;9227.400218985778;9228.67699630513;9256.907430925705;9215.585298661576;9235.215006724404;9237;9269.304802139866;9272.072792720708;9207.907920920772;9213.0786921308;9224.354295199339;9237.445753254759;9239.122283383102;9222;9235.584398702074;9286.628534858597;9299.53502324881;9327.953360233223;44731.329030064575;44851.55148448539;45084.323735144;45086.774566127286;45208;3728.925421491555;4321.308590625516;4340.58764417383;4430.9556904430865;4651.093036857814;34235.486467703005;34591.82704086489;34902.65097349019;35028.82485587581;35666.821665891504;4728.456227533843;4753.643476739258;4769.523047695237;4788.95211047892;4875.219964805614;254448;255014;255128;255653;256586;65147.348526515074;65582.67208663926;65644;65660.6716966412;65817.6709116461;39709.20581588352;40314.1937161261;40553.18893622111;43026.35460468096;43030;17563.0340331283;17618.2071806769;17626.294948202183;17640.823591763918;17778.733319000225;12868.099233053596;12967.286799225945;12991.545295914597;13018;13054.738905222031;21683.783162168176;21874.671879921814;21930.45173870666;21974.340769776933;22048.44878878009;7836.84326313482;8016.639251233709;8069.596520173968;8146.67413303473;8273.958630206811;1019.3832731197518;1035.49260862177;1103.586155191803;1108.3848464102339;1170.104869774623;32775.836120819244;33418.83290583531;33540.49689254663;33551.664483355344;33782.15544611404;1106.778644271149;1133.2237417369129;1164.3770582738193;1214.6295379909213;1226.1355744200318;17680.734788978174;17804.91097544504;17925.551861203312;17944.37194698179;18008.639827203384;648152;904576;915098;921497;961269;62168;62278.68860655758;62633;62761.686191569665;62767.372326277065;1497.5507347795835;1498.8950773445754;1505.826829914552;1517.7343964806114;1518.089146512106;31841.840790795897;32462.188445289055;32663;32692.930652114515;33034;53980;54027.459725403816;54438;54600;54761;416562;416803;419997;420792;423586;30171.396572068876;30513.389732205676;30550;30617.693823061483;31215.84392078025;48439.5156048435;49542.75228623978;49623.50376496189;49624.751876240385;49667.50332496629;39735;41375.172496550505;41628;42422;42988.14023719571;40440;40656.79671601623;40731.59268407278;41258;41370.37944430776;41621.79189104035;41649.375259371736;42374.576254237065;42382;42707.145857083306;36014.819925901254;36243.45634815533;36995.815020924725;37133.25733485369;37406.438903415925;27627.447451050466;27945.860270698515;28118.578221326286;28318.292042699097;28369.716302836707 02:57:38 INFO - PROCESS | 20369 | |2;jquery.html;432.1982722050596;437.5056186509244;438.3424862705941;441.1375760388441;445.12088624965696;18688.532786680338;19386.806131938694;20109.095090720934;20173.495662608442;20278.18887244512;18553.16510757016;19146.521336966583;19192.32826851057;19325.710114348298;19582.902085489553;5357.330333708277;5511.421300763423;5558.44415558443;5561.916571251434;5563.833085007456;4092.1611069730634;5446.210299506569;5492;5756.74094665739;6111.480524155452;6116.877662446748;6162.907556386658;6166.4450199482035;6166.506679465632;6170.228721409824;6024.343305590954;6538.836529086763;6565.606063636197;6567.441767449773;6588.2752897181035;5670.631408958446;5799.797007104773;5838.7372568234105;5856.15085812559;5985.670788106652;14390.928045359811;14860.62848428787;14919.104853708812;14987.475438359605;15017.399304027935;2321.3964369263945;2368.526294741059;2419.6249581314746;2442.487077713682;2513.1078467144084;10348.22388320879;10500.632477863315;10660.880607536252;10723.410212438313;14287.285635718172;1975.1803001754254;2112.8837913914726;2123.638981373155;2174.597699425611;2215.1803832581886;77813.99999999943;78328.60835695785;79261.20738792596;79986.60006699988;83740.58129709313;11510.654680359603;11550.711232219093;12022.398880055962;12149.149559530748;12555.623331300076;16722;16768.245428955724;16795.91602041982;16818.411355602497;16940.322387104625;7911.446198766146;7925.920740792633;7956.363490920712;8287.046989596274;8519.233269005696;8248.216419440143;8780.473171609596;8856.202941735146;8865.468071915706;8939.240164585954;4937.876553086202;5137.768800403991;5198.92201616976;5201.921971170435;5226.477352264819;1750.6586215688073;1986.9900650496945;2013.285283724286;2126.3195777351407;2128.957420851605;1002.5688953749958;1016.0246163682947;1031.200819364998;1045.4197920154388;1087.532361084741;17956.820431795513;19055.142518586697;19474.707879381822;20201.79798201999;20821.167153313698;1054.8154073037342;1074.8925107489345;1081.6863109698256;1088.1023155896416;1125.971850703739;10969.396683182502;11425.143114266462;11489.71275718097;11495.88504114965;11547.422628868522;475409;498284;506519;507656;509896;99855;100955.49522252342;102354;103208.48395757974;103512.48243758733;511.3991060503967;534.8689571055116;535.8285348688461;537.8305833662462;539.3420027566362;11031.889681103086;11539.134564907834;11633.418329083343;11968.401579920795;12164;41492;42471.362929555464;43055.354169686856;43208.78395608128;43394.349084763126;58805;59324.703376482845;59747.103793442264;60320.69839650774;60690;8956;8979.10208979097;9268.536573171179;9414.2468602513;9666;10337.948310258702;13752.449902003807;14128.364223610168;14313.499027533986;14630;11968.46141923598;12097.637070887888;12100.636980890587;12208;12258.448369823202;12119.272843629411;12378.257304561756;12416.565420210249;12700.555480558136;12737.108402411743;12440.19138755978;12770.61688149357;12845.614631561068;13027.544035958696;13039.152455090769;9281.814363712823;9397.295202859676;9446.95276523613;9530.714078577654;9695.9030409695;9792.363496372713;12656.6835829105;12698.428570714525;12737.745245095231;12758.553450629184 02:57:38 INFO - PROCESS | 20369 | |3;mootools.html;1601.3194392383239;1620.0713270319475;1856.3317205805909;1927.7975812539692;1943.543267332176;8872.600732967016;9535.380200286976;9582.5687844047;10159.390436573802;10222;9644.27667924905;9934.850977235346;10012.098911097999;10063.29556931015;10100.797984040333;2514.1828905605707;2546.1088618983395;2548.5412625727363;2565.12785652878;2571.3571607098224;2504.912328068518;2590.5337039332912;2592.611108333746;2598.116640342283;2598.7531184537534;2514.1326242446416;2554.6040363743555;2580.6129080637866;2581.4191806843496;2592.4296654735926;2483.4412257242157;2484.478259565484;2495.15164843953;2514.886830092632;2514.9622755658497;2469.0247352295924;2518.2822895474883;2519.395345117177;2519.8614076225986;2538.352720056374;9890.505474726308;9984.700458986243;9993.10062094415;9996.70009899697;10072.093511583993;5926.318473375574;6057.969710151465;6080.0575910733905;6084.5436592255755;6107.877842443127;3566.8394922228563;3734.6638802507905;3755.4366844973474;3778.4332350147424;3865.5361356637104;1173.9647810565696;1219.5853409840697;1220.816877468378;1243.7761202983459;1280.5006047641334;14252.21612811295;14347.42610295587;14390.496332628307;14481.42074317026;14492.42030318786;5286.735663216824;5290.153575427913;5295.311609490742;5346.4118946915805;5404.91892621611;11818.231814932002;11819.645410637695;11857.169998100222;11895.76208475843;11926.284422934652;5932.49573786233;6033.245844269466;6041.516678665784;6048.546359023003;6059.606125601822;4892.8532144035735;5431;5542.11326187808;5579.776808927598;5625.746841392147;4512.52618475062;4544.091181763661;4557.248054071108;4581.083783243364;4620.283856002325;1387.5975966969668;1404.5926681262524;1411;1423.3381477612959;1425.4227038049607;904.6155383961922;1091.3288327678579;1097.025354362145;1116.4752566293828;1120.1151090638305;6715.630640314732;6794.898076528856;6828.146481689789;6895.172579290517;6918.8616227676175;468.2110643565535;480.19327529750353;504.26881022517495;510.178612433981;516.0581937963232;4640.907181856412;4647.047355292157;4647.512011238839;4678.415198100238;4687.015726697364;11809.350485723367;12196.634100976986;12617.306048167438;12625.494980200872;12668.176568523017;12369.814452783216;12671.113022088366;12724.363781811058;12826.102172847997;12861.356932153354;9172.44965302084;9350.812983740287;9377.343585948918;9395.859062114074;9425.340226184238;6767.830804229934;6966.094407726963;6966.651667416711;7004;7085.433165346863;11383.829242561535;11429.828552571551;11668.591599293984;11788.23376480526;11852.229605075643;11120.388378638929;11604.30374177552;11609.767804644029;11689.064874809825;11871.703207419883;7556.319931206218;8777.517236551796;8911.15344042315;9074.954625226832;9353.719388418358;9000.234980026771;9250.861237081584;9254.12085851843;9289.117533834275;9330.860037099314;8591.914080859111;8790.472571645721;8820.64717411322;8911.2425443838;8923.41997770143;8374.413791034569;8437.620307086074;8565.871511927202;8592.3555733319;8694.260987816106;7409.184989651242;7427.851442971219;7432.554046756995;7498.062742157231;7502.887456688045;5573.219749235192;5762.855928601818;5791.507721843691;5935.0503919372695;5997.740474500404;5601.159826026129;5705.771769129188;5750.9712451439145;5851.239338885917;5954.10688396744 02:57:38 INFO - PROCESS | 20369 | |4;prototype.html;359.1434428887105;363.1520399866312;367.9908002299942;368.7824183731599;381.03787935462935;5691.06097493913;5773.422657734224;5826.82519524415;5844.211031510745;5925.733341999609;5716.771329146829;5767.509761670263;5768.163616275638;5795.884082318351;5815;4495.213337665904;4529;4536.455625324966;4553.4991150973365;4572;4486.798094085774;4500.302453119772;4521.683482156251;4531.229690952546;4577.214886194371;4455.398521199629;4467.664925130612;4468.128714900596;4485.7888370140045;4509.255972764507;4510.458744950611;4520.88697782558;4528.6150677192645;4549.09018196362;4573;3881.7670939743707;4028.3756017817286;4043.8584649537124;4068.6338229559483;4071.7353372030725;5581.302337207849;5629.183768353607;5629.971850140764;5656.632318899258;5673.943260567383;5138.537531622134;5178.378594568639;5211.7394130293715;5217.165253559412;5283.365996080456;5924.6149000314845;6023.969880150571;6138.416850399205;6144.385561443864;6188.87622247557;4389.73661580303;4420.557944205586;4431.268840641323;4457.866264012085;4466.3747075409465;6258.405451482102;6307.463865571432;6366.631174297549;6377.617342959437;6400.39196276353;4546.568076032771;4551.7724113794175;4555.612772914273;4573.3368661544555;4576.222042252825;4600.95399046012;4606.700564463366;4606.95393046072;4610.608098311681;4620.699654522446;5084.56781173597;5155.896882062338;5174.24973378858;5200.76596553156;5246.7638956247065;5997.1304160896425;6098.847528811815;6115.571909966259;6149.3235744068115;6196.256449226032;1536.2165295699274;1547.9303431345616;1554.2539581001183;1559.165846272239;1560.5942454961792;962.6197651927449;982.0277924854486;982.2338575910801;989.3766926836047;999.6651121874254;5362;5363.275957745733;5405.945940540544;5407.972960135174;5428.891422171613;5494.313210848644;5551.362348107318;5615.321964113512;5647.802326918621;5672.404397538282;5026.271190677405;5284.233786101071;5308.193769846376;5316.680999140064;5363.544098751572;2986.850657467118;2993.685663005353;3014.849257537114;3044.6346438427086;3060.510318349098;5543.556515478752;5815.534757219412;5831.679257640785;5839.357670656224;5885.793997210163;5653.886922261532;5656.745446454919;5709.400512946164;5731.598788084877;5736.196932429463;5642.435756424325;5730.455606717355;5730.5129064030025;5731.168980497888;5733.31200255972;5278.656887302313;5521.631804599271;5590.944090559043;5650.971745141413;5666.688332141772;5498.80754173602;5525.038611292933;5554.50009499147;5562.527185189142;5572.777088916398;5686.914696279642;5714.914166308388;5801.419858014165;5802.709864506842;5810.7094645266725;4131.855385061508;4460.821567137278;4470.418845550058;4502.122086193161;4509.210888094636;6024.518038556993;6193.907091393723;6276.372362763687;6283.685815709105;6310.337414571588;6141.723622436912;6177.36299880541;6201.348858369806;6203.193584833943;6247.187865577627;6060.393960603904;6075.483583895419;6151.72317245716;6159.505400312881;6163.96918015407;5971.701414929149;6000.5799594028;6015.187949626919;6018.969905150446;6073.696315184311;6108.664023478574;6147.723352449061;6210.608915567449;6243.629459378362;6255.37446255389;5820.272465941757;5893.823185304448;6025.367336429612;6046.788362407295;6068.332483426908 02:57:38 INFO - PROCESS | 20369 | |5;yui.html;752.6537792615396;755.1693137548697;791.2048391366677;800.9719659811905;815.4780940198278;13554.118982266158;14333.426662933496;14397.136171829685;14400.06399584029;14411.639709007268;14696.971212015163;14830.777538336906;14844.109353438802;14876.776848347256;14991.700165996674;711.4059760100322;840.4537050916891;856.3962406503431;865.0484467086218;865.1435079271539;867.761365624452;870.7344260000697;871.6731225790329;875.7197696737015;876.583622779178;921.4793641592512;923.0354279777615;927.0868194828089;927.8700981862545;928.2295694573488;915.940463869853;916.3493919317293;917.8347897378469;918.0865039285886;919.8758167647349;669.4778073102988;674.0361283364787;676.5433332500543;678.6606696651675;679.0934102972537;15376.077435353915;15433.228338583025;15458.61353466161;15492.612684682861;15502.9224853875;14499.56501304952;14524.636884077878;14721.779173312409;15091.54725358241;15640;13939.790903136462;14116.294185290695;14280.500182493563;14547.490837820626;14616.853831461656;4704.270838020112;4758.619310455155;4795.6403269754555;4852.684575502581;4892.486288939681;61285.693571532305;63592.36407635911;78371.21628783696;79933.60033199855;80873.19126808716;12065.819012714815;12202.32887191213;12209.65656625694;12337.198082124632;12554.874451255371;21142.78857211439;21207.363779086652;21217.893910530347;21232.469188270417;21319.8934005329;9487.952560237154;9586.712398628053;9643.517824108907;9675.854862177073;9700.078492543196;5179;5190.8183213587345;5276.472352764693;5341.252224688546;5446.373667028263;3857.228554289153;3924.843006279717;3963.8612648557164;3964.484616999772;3978.3236849735613;699.0353312428815;705.1960764728213;705.8552996635677;713.1976526407791;718.2458418660385;810.6271115287034;815.3477218225396;815.8205194857122;821.8150916043962;822.1860358245294;9825.164860986895;10029.64896228643;10046.447445390428;10171.237157213238;10175.185985121172;655.7606473637088;716.3517017099533;825.9050209226016;836.1304243586724;854.418032665443;4849;4877.804887804519;4895.632827537949;4928.137575924199;4965.478624744422;70286.64856675787;98231;100721;102278.48860755649;114156.42921785504;64262.357376426575;65004.67497662576;106988.87464905939;107702;111759.44120279346;91956.54021729983;97693.99999999857;100478.4976075115;100622.49688751657;101306.49346753219;10241.020817470177;10444.529996150344;10556.524956376828;10623.946880265548;10713.196510261918;39980.600193997685;40710.59289407068;46148.76925615351;46513.767431162625;57381.42618573761;75195;76318.61840690984;76462;76694;77802.2219777795;13311.80032299497;13828.446862125402;13914.443422262995;13997.650058748613;14153.08004979673;14938.626534336729;14959.925200374364;15006.774898376314;16028.278727457526;16029;14162.575122746333;14635.195064271142;14699.485518006819;14924.104553726811;14925.850741492446;13382.392479810262;13540.366518078257;13714.38285277145;13734.107283026571;13959.581212563638;13420.328983550588;13573.321333933462;14004.509842155476;14211.715765684836;14529.418823247375;10885.401302928414;10991.450427478754;11119.944400277947;11135.220534562503;11778.116641252112;12042.21725587834;12279.386030698608;12334.938325308316;12592.370381481072;12673.683157921127 02:57:38 INFO - PROCESS | 20369 | __end_tp_report 02:57:38 INFO - PROCESS | 20369 | __start_cc_report 02:57:38 INFO - PROCESS | 20369 | _x_x_mozilla_cycle_collect,343 02:57:38 INFO - PROCESS | 20369 | __end_cc_report 02:57:38 INFO - PROCESS | 20369 | __startTimestamp1467367058416__endTimestamp 02:57:38 INFO - PROCESS | 20369 | 02:57:38 INFO - PROCESS | 20369 | ------- Summary: start ------- 02:57:38 INFO - PROCESS | 20369 | Number of tests: 6 02:57:38 INFO - PROCESS | 20369 | 02:57:38 INFO - PROCESS | 20369 | [#0] dojo.html Cycles:165 Average:5838.88 Median:6069.88 stddev:670.31 (11.0%) stddev-sans-first:645.21 02:57:38 INFO - PROCESS | 20369 | Values: 3431.5 3442.4 3464.9 3477.9 3480.3 5783.6 5829.7 5838.5 5878.6 5931.8 5887.4 5895.4 5920.9 5950.9 5972.4 5262.7 5323.0 5361.8 5379.4 5384.0 5244.5 5342.8 5354.6 5410.1 5411.4 5334.8 5344.2 5352.3 5352.8 5487.3 5358.2 5401.1 5416.0 5430.3 5434.2 5154.8 5209.0 5260.0 5323.2 5428.6 5638.8 5685.5 5735.7 5753.5 5765.7 6249.8 6282.3 6294.5 6307.1 6317.4 6122.2 6259.7 6298.9 6367.6 6368.5 5989.4 5995.4 5997.1 6002.1 6018.3 6509.7 6541.0 6548.4 6557.3 6559.8 5995.0 6088.6 6112.4 6125.4 6275.5 6278.4 6304.0 6318.3 6323.7 6341.4 6207.5 6302.7 6303.4 6323.7 6329.2 6096.6 6112.5 6137.2 6145.7 6263.3 4726.2 4738.8 4738.8 4762.7 4767.5 4152.5 4222.0 4237.2 4243.5 4245.9 5837.0 5909.2 5945.7 5950.2 5961.9 6235.5 6266.2 6377.8 6380.9 6393.6 5795.9 6067.9 6073.3 6078.3 6087.3 5365.9 5386.7 5419.2 5450.3 5468.0 6615.5 6625.1 6655.3 6659.2 6661.0 6054.4 6171.8 6408.7 6420.2 6422.8 6378.5 6502.2 6528.3 6537.7 6555.6 6142.9 6152.6 6163.9 6185.2 6196.8 6102.1 6160.4 6190.7 6251.8 6274.5 6172.5 6178.9 6198.8 6204.9 6208.1 6188.0 6195.9 6198.0 6198.6 6211.9 5817.7 5897.4 5910.0 5946.6 5995.7 6085.1 6119.5 6150.3 6195.7 6211.7 6059.1 6060.4 6064.8 6069.9 6074.8 02:57:38 INFO - PROCESS | 20369 | 02:57:38 INFO - PROCESS | 20369 | [#1] ext.html Cycles:180 Average:67242.52 Median:42402.00 stddev:157131.01 (370.6%) stddev-sans-first:157492.12 02:57:38 INFO - PROCESS | 20369 | Values: 591.7 648.5 653.8 667.3 667.9 46569.8 47754.5 47839.5 47869.8 51419.2 49469.0 50206.0 50258.5 50265.0 50270.2 9150.0 9301.9 9305.6 9348.8 9350.5 9138.6 9224.2 9227.4 9228.7 9256.9 9215.6 9235.2 9237.0 9269.3 9272.1 9207.9 9213.1 9224.4 9237.4 9239.1 9222.0 9235.6 9286.6 9299.5 9328.0 44731.3 44851.6 45084.3 45086.8 45208.0 3728.9 4321.3 4340.6 4431.0 4651.1 34235.5 34591.8 34902.7 35028.8 35666.8 4728.5 4753.6 4769.5 4789.0 4875.2 254448.0 255014.0 255128.0 255653.0 256586.0 65147.3 65582.7 65644.0 65660.7 65817.7 39709.2 40314.2 40553.2 43026.4 43030.0 17563.0 17618.2 17626.3 17640.8 17778.7 12868.1 12967.3 12991.5 13018.0 13054.7 21683.8 21874.7 21930.5 21974.3 22048.4 7836.8 8016.6 8069.6 8146.7 8274.0 1019.4 1035.5 1103.6 1108.4 1170.1 32775.8 33418.8 33540.5 33551.7 33782.2 1106.8 1133.2 1164.4 1214.6 1226.1 17680.7 17804.9 17925.6 17944.4 18008.6 648152.0 904576.0 915098.0 921497.0 961269.0 62168.0 62278.7 62633.0 62761.7 62767.4 1497.6 1498.9 1505.8 1517.7 1518.1 31841.8 32462.2 32663.0 32692.9 33034.0 53980.0 54027.5 54438.0 54600.0 54761.0 416562.0 416803.0 419997.0 420792.0 423586.0 30171.4 30513.4 30550.0 30617.7 31215.8 48439.5 49542.8 49623.5 49624.8 49667.5 39735.0 41375.2 41628.0 42422.0 42988.1 40440.0 40656.8 40731.6 41258.0 41370.4 41621.8 41649.4 42374.6 42382.0 42707.1 36014.8 36243.5 36995.8 37133.3 37406.4 27627.4 27945.9 28118.6 28318.3 28369.7 02:57:38 INFO - PROCESS | 20369 | 02:57:38 INFO - PROCESS | 20369 | [#2] jquery.html Cycles:180 Average:29524.32 Median:2151.78 stddev:82560.99 (3836.9%) stddev-sans-first:82763.70 02:57:38 INFO - PROCESS | 20369 | Values: 432.2 437.5 438.3 441.1 445.1 18688.5 19386.8 20109.1 20173.5 20278.2 18553.2 19146.5 19192.3 19325.7 19582.9 5357.3 5511.4 5558.4 5561.9 5563.8 4092.2 5446.2 5492.0 5756.7 6111.5 6116.9 6162.9 6166.4 6166.5 6170.2 6024.3 6538.8 6565.6 6567.4 6588.3 5670.6 5799.8 5838.7 5856.2 5985.7 14390.9 14860.6 14919.1 14987.5 15017.4 2321.4 2368.5 2419.6 2442.5 2513.1 10348.2 10500.6 10660.9 10723.4 14287.3 1975.2 2112.9 2123.6 2174.6 2215.2 77814.0 78328.6 79261.2 79986.6 83740.6 11510.7 11550.7 12022.4 12149.1 12555.6 16722.0 16768.2 16795.9 16818.4 16940.3 7911.4 7925.9 7956.4 8287.0 8519.2 8248.2 8780.5 8856.2 8865.5 8939.2 4937.9 5137.8 5198.9 5201.9 5226.5 1750.7 1987.0 2013.3 2126.3 2129.0 1002.6 1016.0 1031.2 1045.4 1087.5 17956.8 19055.1 19474.7 20201.8 20821.2 1054.8 1074.9 1081.7 1088.1 1126.0 10969.4 11425.1 11489.7 11495.9 11547.4 475409.0 498284.0 506519.0 507656.0 509896.0 99855.0 100955.5 102354.0 103208.5 103512.5 511.4 534.9 535.8 537.8 539.3 11031.9 11539.1 11633.4 11968.4 12164.0 41492.0 42471.4 43055.4 43208.8 43394.3 58805.0 59324.7 59747.1 60320.7 60690.0 8956.0 8979.1 9268.5 9414.2 9666.0 10337.9 13752.4 14128.4 14313.5 14630.0 11968.5 12097.6 12100.6 12208.0 12258.4 12119.3 12378.3 12416.6 12700.6 12737.1 12440.2 12770.6 12845.6 13027.5 13039.2 9281.8 9397.3 9447.0 9530.7 9695.9 9792.4 12656.7 12698.4 12737.7 12758.6 02:57:38 INFO - PROCESS | 20369 | 02:57:38 INFO - PROCESS | 20369 | [#3] mootools.html Cycles:180 Average:6557.98 Median:4643.98 stddev:3814.92 (82.1%) stddev-sans-first:3807.44 02:57:38 INFO - PROCESS | 20369 | Values: 1601.3 1620.1 1856.3 1927.8 1943.5 8872.6 9535.4 9582.6 10159.4 10222.0 9644.3 9934.9 10012.1 10063.3 10100.8 2514.2 2546.1 2548.5 2565.1 2571.4 2504.9 2590.5 2592.6 2598.1 2598.8 2514.1 2554.6 2580.6 2581.4 2592.4 2483.4 2484.5 2495.2 2514.9 2515.0 2469.0 2518.3 2519.4 2519.9 2538.4 9890.5 9984.7 9993.1 9996.7 10072.1 5926.3 6058.0 6080.1 6084.5 6107.9 3566.8 3734.7 3755.4 3778.4 3865.5 1174.0 1219.6 1220.8 1243.8 1280.5 14252.2 14347.4 14390.5 14481.4 14492.4 5286.7 5290.2 5295.3 5346.4 5404.9 11818.2 11819.6 11857.2 11895.8 11926.3 5932.5 6033.2 6041.5 6048.5 6059.6 4892.9 5431.0 5542.1 5579.8 5625.7 4512.5 4544.1 4557.2 4581.1 4620.3 1387.6 1404.6 1411.0 1423.3 1425.4 904.6 1091.3 1097.0 1116.5 1120.1 6715.6 6794.9 6828.1 6895.2 6918.9 468.2 480.2 504.3 510.2 516.1 4640.9 4647.0 4647.5 4678.4 4687.0 11809.4 12196.6 12617.3 12625.5 12668.2 12369.8 12671.1 12724.4 12826.1 12861.4 9172.4 9350.8 9377.3 9395.9 9425.3 6767.8 6966.1 6966.7 7004.0 7085.4 11383.8 11429.8 11668.6 11788.2 11852.2 11120.4 11604.3 11609.8 11689.1 11871.7 7556.3 8777.5 8911.2 9075.0 9353.7 9000.2 9250.9 9254.1 9289.1 9330.9 8591.9 8790.5 8820.6 8911.2 8923.4 8374.4 8437.6 8565.9 8592.4 8694.3 7409.2 7427.9 7432.6 7498.1 7502.9 5573.2 5762.9 5791.5 5935.1 5997.7 5601.2 5705.8 5751.0 5851.2 5954.1 02:57:38 INFO - PROCESS | 20369 | 02:57:38 INFO - PROCESS | 20369 | [#4] prototype.html Cycles:180 Average:4977.09 Median:5586.12 stddev:1430.89 (25.6%) stddev-sans-first:1392.29 02:57:38 INFO - PROCESS | 20369 | Values: 359.1 363.2 368.0 368.8 381.0 5691.1 5773.4 5826.8 5844.2 5925.7 5716.8 5767.5 5768.2 5795.9 5815.0 4495.2 4529.0 4536.5 4553.5 4572.0 4486.8 4500.3 4521.7 4531.2 4577.2 4455.4 4467.7 4468.1 4485.8 4509.3 4510.5 4520.9 4528.6 4549.1 4573.0 3881.8 4028.4 4043.9 4068.6 4071.7 5581.3 5629.2 5630.0 5656.6 5673.9 5138.5 5178.4 5211.7 5217.2 5283.4 5924.6 6024.0 6138.4 6144.4 6188.9 4389.7 4420.6 4431.3 4457.9 4466.4 6258.4 6307.5 6366.6 6377.6 6400.4 4546.6 4551.8 4555.6 4573.3 4576.2 4601.0 4606.7 4607.0 4610.6 4620.7 5084.6 5155.9 5174.2 5200.8 5246.8 5997.1 6098.8 6115.6 6149.3 6196.3 1536.2 1547.9 1554.3 1559.2 1560.6 962.6 982.0 982.2 989.4 999.7 5362.0 5363.3 5405.9 5408.0 5428.9 5494.3 5551.4 5615.3 5647.8 5672.4 5026.3 5284.2 5308.2 5316.7 5363.5 2986.9 2993.7 3014.8 3044.6 3060.5 5543.6 5815.5 5831.7 5839.4 5885.8 5653.9 5656.7 5709.4 5731.6 5736.2 5642.4 5730.5 5730.5 5731.2 5733.3 5278.7 5521.6 5590.9 5651.0 5666.7 5498.8 5525.0 5554.5 5562.5 5572.8 5686.9 5714.9 5801.4 5802.7 5810.7 4131.9 4460.8 4470.4 4502.1 4509.2 6024.5 6193.9 6276.4 6283.7 6310.3 6141.7 6177.4 6201.3 6203.2 6247.2 6060.4 6075.5 6151.7 6159.5 6164.0 5971.7 6000.6 6015.2 6019.0 6073.7 6108.7 6147.7 6210.6 6243.6 6255.4 5820.3 5893.8 6025.4 6046.8 6068.3 02:57:38 INFO - PROCESS | 20369 | 02:57:38 INFO - PROCESS | 20369 | [#5] yui.html Cycles:180 Average:20579.38 Median:3964.17 stddev:28785.05 (726.1%) stddev-sans-first:28827.30 02:57:38 INFO - PROCESS | 20369 | Values: 752.7 755.2 791.2 801.0 815.5 13554.1 14333.4 14397.1 14400.1 14411.6 14697.0 14830.8 14844.1 14876.8 14991.7 711.4 840.5 856.4 865.0 865.1 867.8 870.7 871.7 875.7 876.6 921.5 923.0 927.1 927.9 928.2 915.9 916.3 917.8 918.1 919.9 669.5 674.0 676.5 678.7 679.1 15376.1 15433.2 15458.6 15492.6 15502.9 14499.6 14524.6 14721.8 15091.5 15640.0 13939.8 14116.3 14280.5 14547.5 14616.9 4704.3 4758.6 4795.6 4852.7 4892.5 61285.7 63592.4 78371.2 79933.6 80873.2 12065.8 12202.3 12209.7 12337.2 12554.9 21142.8 21207.4 21217.9 21232.5 21319.9 9488.0 9586.7 9643.5 9675.9 9700.1 5179.0 5190.8 5276.5 5341.3 5446.4 3857.2 3924.8 3963.9 3964.5 3978.3 699.0 705.2 705.9 713.2 718.2 810.6 815.3 815.8 821.8 822.2 9825.2 10029.6 10046.4 10171.2 10175.2 655.8 716.4 825.9 836.1 854.4 4849.0 4877.8 4895.6 4928.1 4965.5 70286.6 98231.0 100721.0 102278.5 114156.4 64262.4 65004.7 106988.9 107702.0 111759.4 91956.5 97694.0 100478.5 100622.5 101306.5 10241.0 10444.5 10556.5 10623.9 10713.2 39980.6 40710.6 46148.8 46513.8 57381.4 75195.0 76318.6 76462.0 76694.0 77802.2 13311.8 13828.4 13914.4 13997.7 14153.1 14938.6 14959.9 15006.8 16028.3 16029.0 14162.6 14635.2 14699.5 14924.1 14925.9 13382.4 13540.4 13714.4 13734.1 13959.6 13420.3 13573.3 14004.5 14211.7 14529.4 10885.4 10991.5 11119.9 11135.2 11778.1 12042.2 12279.4 12334.9 12592.4 12673.7 02:57:38 INFO - PROCESS | 20369 | -------- Summary: end -------- 02:57:38 INFO - PROCESS | 20369 | 02:57:39 INFO - TEST-INFO | 20369: exit 0 02:57:39 INFO - TEST-OK | dromaeo_css | took 1110838ms 02:57:39 INFO - TEST-START | kraken 02:57:39 INFO - operating with platform_type : linux_ 02:57:39 INFO - Initialising browser for kraken test... 02:57:39 INFO - TEST-INFO | started process 20613 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgeoD4o/profile http://localhost:51250/getInfo.html) 02:57:43 INFO - PROCESS | 20613 | __metrics Screen width/height:1600/1200 02:57:43 INFO - PROCESS | 20613 | colorDepth:24 02:57:43 INFO - PROCESS | 20613 | Browser inner width/height: 1024/697 02:57:43 INFO - PROCESS | 20613 | __metrics 02:57:44 ERROR - PROCESS | 20613 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 02:57:45 INFO - TEST-INFO | 20613: exit 0 02:57:45 INFO - Browser initialized. 02:57:45 INFO - Running cycle 1/1 for kraken test... 02:57:45 INFO - TEST-INFO | started process 20741 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgeoD4o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:57:57 INFO - PROCESS | 20741 | RSS: Main: 155979776 02:57:57 INFO - PROCESS | 20741 | 02:57:59 INFO - PROCESS | 20741 | Cycle 1(1): loaded http://localhost:51250/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51250/tests/kraken/driver.html?testName=audio-beat-detection) 02:58:00 INFO - PROCESS | 20741 | RSS: Main: 160964608 02:58:00 INFO - PROCESS | 20741 | 02:58:03 INFO - PROCESS | 20741 | Cycle 1(1): loaded http://localhost:51250/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51250/tests/kraken/driver.html?testName=audio-dft) 02:58:03 INFO - PROCESS | 20741 | RSS: Main: 160653312 02:58:03 INFO - PROCESS | 20741 | 02:58:06 INFO - PROCESS | 20741 | Cycle 1(1): loaded http://localhost:51250/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51250/tests/kraken/driver.html?testName=audio-fft) 02:58:07 INFO - PROCESS | 20741 | RSS: Main: 161476608 02:58:07 INFO - PROCESS | 20741 | 02:58:09 INFO - PROCESS | 20741 | Cycle 1(1): loaded http://localhost:51250/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51250/tests/kraken/driver.html?testName=audio-oscillator) 02:58:10 INFO - PROCESS | 20741 | RSS: Main: 161439744 02:58:10 INFO - PROCESS | 20741 | 02:58:12 INFO - PROCESS | 20741 | Cycle 1(1): loaded http://localhost:51250/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51250/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:58:12 INFO - PROCESS | 20741 | RSS: Main: 161181696 02:58:12 INFO - PROCESS | 20741 | 02:58:15 INFO - PROCESS | 20741 | Cycle 1(1): loaded http://localhost:51250/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51250/tests/kraken/driver.html?testName=imaging-darkroom) 02:58:16 INFO - PROCESS | 20741 | RSS: Main: 160485376 02:58:16 INFO - PROCESS | 20741 | 02:58:19 INFO - PROCESS | 20741 | Cycle 1(1): loaded http://localhost:51250/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51250/tests/kraken/driver.html?testName=imaging-desaturate) 02:58:20 INFO - PROCESS | 20741 | RSS: Main: 158109696 02:58:20 INFO - PROCESS | 20741 | 02:58:23 INFO - PROCESS | 20741 | Cycle 1(1): loaded http://localhost:51250/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51250/tests/kraken/driver.html?testName=json-parse-financial) 02:58:24 INFO - PROCESS | 20741 | RSS: Main: 158900224 02:58:24 INFO - PROCESS | 20741 | 02:58:25 INFO - PROCESS | 20741 | Cycle 1(1): loaded http://localhost:51250/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51250/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:58:26 INFO - PROCESS | 20741 | RSS: Main: 159531008 02:58:26 INFO - PROCESS | 20741 | 02:58:28 INFO - PROCESS | 20741 | Cycle 1(1): loaded http://localhost:51250/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51250/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:58:28 INFO - PROCESS | 20741 | RSS: Main: 159309824 02:58:28 INFO - PROCESS | 20741 | 02:58:30 INFO - PROCESS | 20741 | Cycle 1(1): loaded http://localhost:51250/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51250/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:58:31 INFO - PROCESS | 20741 | RSS: Main: 160157696 02:58:31 INFO - PROCESS | 20741 | 02:58:33 INFO - PROCESS | 20741 | Cycle 1(1): loaded http://localhost:51250/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:58:34 INFO - PROCESS | 20741 | RSS: Main: 160104448 02:58:34 INFO - PROCESS | 20741 | 02:58:37 INFO - PROCESS | 20741 | Cycle 1(1): loaded http://localhost:51250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:58:37 INFO - PROCESS | 20741 | RSS: Main: 159764480 02:58:37 INFO - PROCESS | 20741 | 02:58:39 INFO - PROCESS | 20741 | Cycle 1(1): loaded http://localhost:51250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51250/tests/kraken/driver.html?testName=ai-astar) 02:58:39 INFO - PROCESS | 20741 | RSS: Main: 160956416 02:58:39 INFO - PROCESS | 20741 | 02:58:39 INFO - PROCESS | 20741 | __start_tp_report 02:58:39 INFO - PROCESS | 20741 | _x_x_mozilla_page_load 02:58:39 INFO - PROCESS | 20741 | _x_x_mozilla_page_load_details 02:58:39 INFO - PROCESS | 20741 | |i|pagename|runs| 02:58:39 INFO - PROCESS | 20741 | |0;ai-astar;114;107;108;110;113;111;109;109;109;111 02:58:39 INFO - PROCESS | 20741 | |1;audio-beat-detection;160;122;155;181;144;155;155;125;180;126 02:58:39 INFO - PROCESS | 20741 | |2;audio-dft;164;169;161;162;162;161;166;161;160;161 02:58:39 INFO - PROCESS | 20741 | |3;audio-fft;76;75;76;167;75;76;76;77;183;75 02:58:39 INFO - PROCESS | 20741 | |4;audio-oscillator;83;84;150;84;84;84;137;84;86;142 02:58:39 INFO - PROCESS | 20741 | |5;imaging-gaussian-blur;117;117;117;119;121;118;117;117;117;117 02:58:39 INFO - PROCESS | 20741 | |6;imaging-darkroom;146;148;146;147;151;150;146;146;147;147 02:58:39 INFO - PROCESS | 20741 | |7;imaging-desaturate;95;97;96;96;95;95;94;95;96;96 02:58:39 INFO - PROCESS | 20741 | |8;json-parse-financial;55;53;53;56;53;53;53;59;54;53 02:58:39 INFO - PROCESS | 20741 | |9;json-stringify-tinderbox;59;59;59;62;59;60;59;59;61;59 02:58:39 INFO - PROCESS | 20741 | |10;stanford-crypto-aes;77;80;80;79;77;76;79;77;103;77 02:58:39 INFO - PROCESS | 20741 | |11;stanford-crypto-ccm;120;120;115;118;118;116;134;126;131;137 02:58:39 INFO - PROCESS | 20741 | |12;stanford-crypto-pbkdf2;156;160;157;158;154;154;154;153;153;150 02:58:39 INFO - PROCESS | 20741 | |13;stanford-crypto-sha256-iterative;62;65;62;62;63;61;64;60;59;60 02:58:39 INFO - PROCESS | 20741 | __end_tp_report 02:58:39 INFO - PROCESS | 20741 | __start_cc_report 02:58:39 INFO - PROCESS | 20741 | _x_x_mozilla_cycle_collect,898 02:58:39 INFO - PROCESS | 20741 | __end_cc_report 02:58:39 INFO - PROCESS | 20741 | __startTimestamp1467367119671__endTimestamp 02:58:39 INFO - PROCESS | 20741 | 02:58:39 INFO - PROCESS | 20741 | ------- Summary: start ------- 02:58:39 INFO - PROCESS | 20741 | Number of tests: 14 02:58:39 INFO - PROCESS | 20741 | 02:58:39 INFO - PROCESS | 20741 | [#0] ai-astar Cycles:10 Average:110.10 Median:110.50 stddev:2.18 (2.0%) stddev-sans-first:1.80 02:58:39 INFO - PROCESS | 20741 | Values: 114.0 107.0 108.0 110.0 113.0 111.0 109.0 109.0 109.0 111.0 02:58:39 INFO - PROCESS | 20741 | 02:58:39 INFO - PROCESS | 20741 | [#1] audio-beat-detection Cycles:10 Average:150.30 Median:155.00 stddev:21.23 (13.7%) stddev-sans-first:22.22 02:58:39 INFO - PROCESS | 20741 | Values: 160.0 122.0 155.0 181.0 144.0 155.0 155.0 125.0 180.0 126.0 02:58:39 INFO - PROCESS | 20741 | 02:58:39 INFO - PROCESS | 20741 | [#2] audio-dft Cycles:10 Average:162.70 Median:162.00 stddev:2.83 (1.7%) stddev-sans-first:2.96 02:58:39 INFO - PROCESS | 20741 | Values: 164.0 169.0 161.0 162.0 162.0 161.0 166.0 161.0 160.0 161.0 02:58:39 INFO - PROCESS | 20741 | 02:58:39 INFO - PROCESS | 20741 | [#3] audio-fft Cycles:10 Average:95.60 Median:76.00 stddev:42.02 (55.3%) stddev-sans-first:43.97 02:58:39 INFO - PROCESS | 20741 | Values: 76.0 75.0 76.0 167.0 75.0 76.0 76.0 77.0 183.0 75.0 02:58:39 INFO - PROCESS | 20741 | 02:58:39 INFO - PROCESS | 20741 | [#4] audio-oscillator Cycles:10 Average:101.80 Median:84.00 stddev:28.61 (34.1%) stddev-sans-first:29.52 02:58:39 INFO - PROCESS | 20741 | Values: 83.0 84.0 150.0 84.0 84.0 84.0 137.0 84.0 86.0 142.0 02:58:39 INFO - PROCESS | 20741 | 02:58:39 INFO - PROCESS | 20741 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:117.00 stddev:1.34 (1.1%) stddev-sans-first:1.39 02:58:39 INFO - PROCESS | 20741 | Values: 117.0 117.0 117.0 119.0 121.0 118.0 117.0 117.0 117.0 117.0 02:58:39 INFO - PROCESS | 20741 | 02:58:39 INFO - PROCESS | 20741 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.00 stddev:1.78 (1.2%) stddev-sans-first:1.81 02:58:39 INFO - PROCESS | 20741 | Values: 146.0 148.0 146.0 147.0 151.0 150.0 146.0 146.0 147.0 147.0 02:58:39 INFO - PROCESS | 20741 | 02:58:39 INFO - PROCESS | 20741 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.85 (0.9%) stddev-sans-first:0.88 02:58:39 INFO - PROCESS | 20741 | Values: 95.0 97.0 96.0 96.0 95.0 95.0 94.0 95.0 96.0 96.0 02:58:39 INFO - PROCESS | 20741 | 02:58:39 INFO - PROCESS | 20741 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:53.50 stddev:1.99 (3.7%) stddev-sans-first:2.09 02:58:39 INFO - PROCESS | 20741 | Values: 55.0 53.0 53.0 56.0 53.0 53.0 53.0 59.0 54.0 53.0 02:58:39 INFO - PROCESS | 20741 | 02:58:39 INFO - PROCESS | 20741 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:59.00 stddev:1.07 (1.8%) stddev-sans-first:1.12 02:58:39 INFO - PROCESS | 20741 | Values: 59.0 59.0 59.0 62.0 59.0 60.0 59.0 59.0 61.0 59.0 02:58:39 INFO - PROCESS | 20741 | 02:58:39 INFO - PROCESS | 20741 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:78.00 stddev:8.03 (10.3%) stddev-sans-first:8.42 02:58:39 INFO - PROCESS | 20741 | Values: 77.0 80.0 80.0 79.0 77.0 76.0 79.0 77.0 103.0 77.0 02:58:39 INFO - PROCESS | 20741 | 02:58:39 INFO - PROCESS | 20741 | [#11] stanford-crypto-ccm Cycles:10 Average:123.50 Median:123.00 stddev:7.95 (6.5%) stddev-sans-first:8.33 02:58:39 INFO - PROCESS | 20741 | Values: 120.0 120.0 115.0 118.0 118.0 116.0 134.0 126.0 131.0 137.0 02:58:39 INFO - PROCESS | 20741 | 02:58:39 INFO - PROCESS | 20741 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.90 Median:155.00 stddev:2.88 (1.9%) stddev-sans-first:3.03 02:58:39 INFO - PROCESS | 20741 | Values: 156.0 160.0 157.0 158.0 154.0 154.0 154.0 153.0 153.0 150.0 02:58:39 INFO - PROCESS | 20741 | 02:58:39 INFO - PROCESS | 20741 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.80 Median:62.00 stddev:1.87 (3.0%) stddev-sans-first:1.99 02:58:39 INFO - PROCESS | 20741 | Values: 62.0 65.0 62.0 62.0 63.0 61.0 64.0 60.0 59.0 60.0 02:58:39 INFO - PROCESS | 20741 | -------- Summary: end -------- 02:58:39 INFO - PROCESS | 20741 | 02:58:40 INFO - TEST-INFO | 20741: exit 0 02:58:40 INFO - TEST-OK | kraken | took 61506ms 02:58:40 INFO - SUITE-END | took 1172s 02:58:40 INFO - Completed test suite (00:19:32) 02:58:40 INFO - javascript benchmark 02:58:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7700.166367873666, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3431.502432147339, 3442.363162814881, 3464.8960531184075, 3477.878274260401, 3480.269143479869, 5783.624064435809, 5829.650220986744, 5838.532917366611, 5878.588498805086, 5931.762729490815, 5887.35239123696, 5895.35151133375, 5920.911186332209, 5950.910736338948, 5972.432618901208, 5262.657927234727, 5322.999999999981, 5361.839144825662, 5379.38137114233, 5384.0, 5244.501772331622, 5342.786288548454, 5354.625176237665, 5410.134378499441, 5411.404745477994, 5334.839954801362, 5344.198370244475, 5352.304200453936, 5352.759125839347, 5487.259220005308, 5358.169483730028, 5401.135818269097, 5415.998040362526, 5430.266913966603, 5434.184872269171, 5154.845354639367, 5209.0363282792805, 5259.973700131475, 5323.1749078892835, 5428.565714742811, 5638.774449022034, 5685.516731077863, 5735.713214339308, 5753.482186603184, 5765.711714414305, 6249.750009999594, 6282.340354262782, 6294.496440284766, 6307.085472606446, 6317.368263173692, 6122.154209354583, 6259.749610015594, 6298.905516417258, 6367.586106903036, 6368.490520758328, 5989.3711160327975, 5995.370486098984, 5997.130416089686, 6002.129691194796, 6018.337982821886, 6509.7396104155305, 6540.967295163494, 6548.443382312556, 6557.278699343068, 6559.8360040998405, 5995.0, 6088.634681919099, 6112.381899552462, 6125.418085281891, 6275.497960163176, 6278.434940855253, 6304.0, 6318.336574659686, 6323.747050118036, 6341.397567231105, 6207.503399728102, 6302.65335406557, 6303.432691057827, 6323.683815809191, 6329.177206963157, 6096.634201947897, 6112.480439162721, 6137.232845894263, 6145.723442445101, 6263.342349053375, 4726.220173671374, 4738.8341408050555, 4738.8341408050555, 4762.666613337103, 4767.475577686451, 4152.501699796044, 4221.97889010553, 4237.194932962789, 4243.511996120424, 4245.936310955338, 5837.0, 5909.172715819703, 5945.672987985616, 5950.166976623276, 5961.880762384728, 6235.469985051231, 6266.216722909637, 6377.840553986188, 6380.904286435707, 6393.584417012879, 5795.8551036224435, 6067.908981365283, 6073.331933487313, 6078.270607527036, 6087.3303936566945, 5365.865853353697, 5386.703731294817, 5419.160030195248, 5450.264214331015, 5468.0, 6615.470762339001, 6625.0724898514245, 6655.334466553403, 6659.200895892427, 6660.966695166493, 6054.424829641177, 6171.814845554641, 6408.711607977652, 6420.165378500765, 6422.839429014125, 6378.521610879296, 6502.187226596676, 6528.347165283433, 6537.7058032389605, 6555.6066636002, 6142.907856382247, 6152.630842149485, 6163.907541386972, 6185.226846644169, 6196.81409557714, 6102.084687296941, 6160.414760597736, 6190.721417536131, 6251.843703907439, 6274.498040156685, 6172.506199504119, 6178.9382106180165, 6198.845028874314, 6204.875902482016, 6208.068789681584, 6188.0, 6195.907061394173, 6198.0, 6198.566100372931, 6211.9068213977735, 5817.680027598353, 5897.3807750187325, 5910.0, 5946.583739138218, 5995.6702381367695, 6085.056816193497, 6119.541034422347, 6150.261968563801, 6195.721192546436, 6211.689415529296, 6059.09113632941, 6060.424259695322, 6064.818055458343, 6069.878602428015, 6074.817755467343], "value": 5793.5884450557305, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.6657088744859, 648.4520580109811, 653.7907869481767, 667.3060017581714, 667.9365460281272, 46569.76715116424, 47754.52245477544, 47839.521604783986, 47869.760651196695, 51419.22871156926, 49469.0, 50206.0, 50258.49741502584, 50264.99470010598, 50270.245946310744, 9150.0, 9301.906980930205, 9305.581248843784, 9348.766280843, 9350.485723285217, 9138.588763505624, 9224.215941644969, 9227.400218985778, 9228.67699630513, 9256.907430925705, 9215.585298661576, 9235.215006724404, 9237.0, 9269.304802139866, 9272.072792720708, 9207.907920920772, 9213.0786921308, 9224.354295199339, 9237.445753254759, 9239.122283383102, 9222.0, 9235.584398702074, 9286.628534858597, 9299.53502324881, 9327.953360233223, 44731.329030064575, 44851.55148448539, 45084.323735144, 45086.774566127286, 45208.0, 3728.925421491555, 4321.308590625516, 4340.58764417383, 4430.9556904430865, 4651.093036857814, 34235.486467703005, 34591.82704086489, 34902.65097349019, 35028.82485587581, 35666.821665891504, 4728.456227533843, 4753.643476739258, 4769.523047695237, 4788.95211047892, 4875.219964805614, 254448.0, 255014.0, 255128.0, 255653.0, 256586.0, 65147.348526515074, 65582.67208663926, 65644.0, 65660.6716966412, 65817.6709116461, 39709.20581588352, 40314.1937161261, 40553.18893622111, 43026.35460468096, 43030.0, 17563.0340331283, 17618.2071806769, 17626.294948202183, 17640.823591763918, 17778.733319000225, 12868.099233053596, 12967.286799225945, 12991.545295914597, 13018.0, 13054.738905222031, 21683.783162168176, 21874.671879921814, 21930.45173870666, 21974.340769776933, 22048.44878878009, 7836.84326313482, 8016.639251233709, 8069.596520173968, 8146.67413303473, 8273.958630206811, 1019.3832731197518, 1035.49260862177, 1103.586155191803, 1108.3848464102339, 1170.104869774623, 32775.836120819244, 33418.83290583531, 33540.49689254663, 33551.664483355344, 33782.15544611404, 1106.778644271149, 1133.2237417369129, 1164.3770582738193, 1214.6295379909213, 1226.1355744200318, 17680.734788978174, 17804.91097544504, 17925.551861203312, 17944.37194698179, 18008.639827203384, 648152.0, 904576.0, 915098.0, 921497.0, 961269.0, 62168.0, 62278.68860655758, 62633.0, 62761.686191569665, 62767.372326277065, 1497.5507347795835, 1498.8950773445754, 1505.826829914552, 1517.7343964806114, 1518.089146512106, 31841.840790795897, 32462.188445289055, 32663.0, 32692.930652114515, 33034.0, 53980.0, 54027.459725403816, 54438.0, 54600.0, 54761.0, 416562.0, 416803.0, 419997.0, 420792.0, 423586.0, 30171.396572068876, 30513.389732205676, 30550.0, 30617.693823061483, 31215.84392078025, 48439.5156048435, 49542.75228623978, 49623.50376496189, 49624.751876240385, 49667.50332496629, 39735.0, 41375.172496550505, 41628.0, 42422.0, 42988.14023719571, 40440.0, 40656.79671601623, 40731.59268407278, 41258.0, 41370.37944430776, 41621.79189104035, 41649.375259371736, 42374.576254237065, 42382.0, 42707.145857083306, 36014.819925901254, 36243.45634815533, 36995.815020924725, 37133.25733485369, 37406.438903415925, 27627.447451050466, 27945.860270698515, 28118.578221326286, 28318.292042699097, 28369.716302836707], "value": 21129.007693008607, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [432.1982722050596, 437.5056186509244, 438.3424862705941, 441.1375760388441, 445.12088624965696, 18688.532786680338, 19386.806131938694, 20109.095090720934, 20173.495662608442, 20278.18887244512, 18553.16510757016, 19146.521336966583, 19192.32826851057, 19325.710114348298, 19582.902085489553, 5357.330333708277, 5511.421300763423, 5558.44415558443, 5561.916571251434, 5563.833085007456, 4092.1611069730634, 5446.210299506569, 5492.0, 5756.74094665739, 6111.480524155452, 6116.877662446748, 6162.907556386658, 6166.4450199482035, 6166.506679465632, 6170.228721409824, 6024.343305590954, 6538.836529086763, 6565.606063636197, 6567.441767449773, 6588.2752897181035, 5670.631408958446, 5799.797007104773, 5838.7372568234105, 5856.15085812559, 5985.670788106652, 14390.928045359811, 14860.62848428787, 14919.104853708812, 14987.475438359605, 15017.399304027935, 2321.3964369263945, 2368.526294741059, 2419.6249581314746, 2442.487077713682, 2513.1078467144084, 10348.22388320879, 10500.632477863315, 10660.880607536252, 10723.410212438313, 14287.285635718172, 1975.1803001754254, 2112.8837913914726, 2123.638981373155, 2174.597699425611, 2215.1803832581886, 77813.99999999943, 78328.60835695785, 79261.20738792596, 79986.60006699988, 83740.58129709313, 11510.654680359603, 11550.711232219093, 12022.398880055962, 12149.149559530748, 12555.623331300076, 16722.0, 16768.245428955724, 16795.91602041982, 16818.411355602497, 16940.322387104625, 7911.446198766146, 7925.920740792633, 7956.363490920712, 8287.046989596274, 8519.233269005696, 8248.216419440143, 8780.473171609596, 8856.202941735146, 8865.468071915706, 8939.240164585954, 4937.876553086202, 5137.768800403991, 5198.92201616976, 5201.921971170435, 5226.477352264819, 1750.6586215688073, 1986.9900650496945, 2013.285283724286, 2126.3195777351407, 2128.957420851605, 1002.5688953749958, 1016.0246163682947, 1031.200819364998, 1045.4197920154388, 1087.532361084741, 17956.820431795513, 19055.142518586697, 19474.707879381822, 20201.79798201999, 20821.167153313698, 1054.8154073037342, 1074.8925107489345, 1081.6863109698256, 1088.1023155896416, 1125.971850703739, 10969.396683182502, 11425.143114266462, 11489.71275718097, 11495.88504114965, 11547.422628868522, 475409.0, 498284.0, 506519.0, 507656.0, 509896.0, 99855.0, 100955.49522252342, 102354.0, 103208.48395757974, 103512.48243758733, 511.3991060503967, 534.8689571055116, 535.8285348688461, 537.8305833662462, 539.3420027566362, 11031.889681103086, 11539.134564907834, 11633.418329083343, 11968.401579920795, 12164.0, 41492.0, 42471.362929555464, 43055.354169686856, 43208.78395608128, 43394.349084763126, 58805.0, 59324.703376482845, 59747.103793442264, 60320.69839650774, 60690.0, 8956.0, 8979.10208979097, 9268.536573171179, 9414.2468602513, 9666.0, 10337.948310258702, 13752.449902003807, 14128.364223610168, 14313.499027533986, 14630.0, 11968.46141923598, 12097.637070887888, 12100.636980890587, 12208.0, 12258.448369823202, 12119.272843629411, 12378.257304561756, 12416.565420210249, 12700.555480558136, 12737.108402411743, 12440.19138755978, 12770.61688149357, 12845.614631561068, 13027.544035958696, 13039.152455090769, 9281.814363712823, 9397.295202859676, 9446.95276523613, 9530.714078577654, 9695.9030409695, 9792.363496372713, 12656.6835829105, 12698.428570714525, 12737.745245095231, 12758.553450629184], "value": 9266.268602455344, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1601.3194392383239, 1620.0713270319475, 1856.3317205805909, 1927.7975812539692, 1943.543267332176, 8872.600732967016, 9535.380200286976, 9582.5687844047, 10159.390436573802, 10222.0, 9644.27667924905, 9934.850977235346, 10012.098911097999, 10063.29556931015, 10100.797984040333, 2514.1828905605707, 2546.1088618983395, 2548.5412625727363, 2565.12785652878, 2571.3571607098224, 2504.912328068518, 2590.5337039332912, 2592.611108333746, 2598.116640342283, 2598.7531184537534, 2514.1326242446416, 2554.6040363743555, 2580.6129080637866, 2581.4191806843496, 2592.4296654735926, 2483.4412257242157, 2484.478259565484, 2495.15164843953, 2514.886830092632, 2514.9622755658497, 2469.0247352295924, 2518.2822895474883, 2519.395345117177, 2519.8614076225986, 2538.352720056374, 9890.505474726308, 9984.700458986243, 9993.10062094415, 9996.70009899697, 10072.093511583993, 5926.318473375574, 6057.969710151465, 6080.0575910733905, 6084.5436592255755, 6107.877842443127, 3566.8394922228563, 3734.6638802507905, 3755.4366844973474, 3778.4332350147424, 3865.5361356637104, 1173.9647810565696, 1219.5853409840697, 1220.816877468378, 1243.7761202983459, 1280.5006047641334, 14252.21612811295, 14347.42610295587, 14390.496332628307, 14481.42074317026, 14492.42030318786, 5286.735663216824, 5290.153575427913, 5295.311609490742, 5346.4118946915805, 5404.91892621611, 11818.231814932002, 11819.645410637695, 11857.169998100222, 11895.76208475843, 11926.284422934652, 5932.49573786233, 6033.245844269466, 6041.516678665784, 6048.546359023003, 6059.606125601822, 4892.8532144035735, 5431.0, 5542.11326187808, 5579.776808927598, 5625.746841392147, 4512.52618475062, 4544.091181763661, 4557.248054071108, 4581.083783243364, 4620.283856002325, 1387.5975966969668, 1404.5926681262524, 1411.0, 1423.3381477612959, 1425.4227038049607, 904.6155383961922, 1091.3288327678579, 1097.025354362145, 1116.4752566293828, 1120.1151090638305, 6715.630640314732, 6794.898076528856, 6828.146481689789, 6895.172579290517, 6918.8616227676175, 468.2110643565535, 480.19327529750353, 504.26881022517495, 510.178612433981, 516.0581937963232, 4640.907181856412, 4647.047355292157, 4647.512011238839, 4678.415198100238, 4687.015726697364, 11809.350485723367, 12196.634100976986, 12617.306048167438, 12625.494980200872, 12668.176568523017, 12369.814452783216, 12671.113022088366, 12724.363781811058, 12826.102172847997, 12861.356932153354, 9172.44965302084, 9350.812983740287, 9377.343585948918, 9395.859062114074, 9425.340226184238, 6767.830804229934, 6966.094407726963, 6966.651667416711, 7004.0, 7085.433165346863, 11383.829242561535, 11429.828552571551, 11668.591599293984, 11788.23376480526, 11852.229605075643, 11120.388378638929, 11604.30374177552, 11609.767804644029, 11689.064874809825, 11871.703207419883, 7556.319931206218, 8777.517236551796, 8911.15344042315, 9074.954625226832, 9353.719388418358, 9000.234980026771, 9250.861237081584, 9254.12085851843, 9289.117533834275, 9330.860037099314, 8591.914080859111, 8790.472571645721, 8820.64717411322, 8911.2425443838, 8923.41997770143, 8374.413791034569, 8437.620307086074, 8565.871511927202, 8592.3555733319, 8694.260987816106, 7409.184989651242, 7427.851442971219, 7432.554046756995, 7498.062742157231, 7502.887456688045, 5573.219749235192, 5762.855928601818, 5791.507721843691, 5935.0503919372695, 5997.740474500404, 5601.159826026129, 5705.771769129188, 5750.9712451439145, 5851.239338885917, 5954.10688396744], "value": 5119.002384241544, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.1434428887105, 363.1520399866312, 367.9908002299942, 368.7824183731599, 381.03787935462935, 5691.06097493913, 5773.422657734224, 5826.82519524415, 5844.211031510745, 5925.733341999609, 5716.771329146829, 5767.509761670263, 5768.163616275638, 5795.884082318351, 5815.0, 4495.213337665904, 4529.0, 4536.455625324966, 4553.4991150973365, 4572.0, 4486.798094085774, 4500.302453119772, 4521.683482156251, 4531.229690952546, 4577.214886194371, 4455.398521199629, 4467.664925130612, 4468.128714900596, 4485.7888370140045, 4509.255972764507, 4510.458744950611, 4520.88697782558, 4528.6150677192645, 4549.09018196362, 4573.0, 3881.7670939743707, 4028.3756017817286, 4043.8584649537124, 4068.6338229559483, 4071.7353372030725, 5581.302337207849, 5629.183768353607, 5629.971850140764, 5656.632318899258, 5673.943260567383, 5138.537531622134, 5178.378594568639, 5211.7394130293715, 5217.165253559412, 5283.365996080456, 5924.6149000314845, 6023.969880150571, 6138.416850399205, 6144.385561443864, 6188.87622247557, 4389.73661580303, 4420.557944205586, 4431.268840641323, 4457.866264012085, 4466.3747075409465, 6258.405451482102, 6307.463865571432, 6366.631174297549, 6377.617342959437, 6400.39196276353, 4546.568076032771, 4551.7724113794175, 4555.612772914273, 4573.3368661544555, 4576.222042252825, 4600.95399046012, 4606.700564463366, 4606.95393046072, 4610.608098311681, 4620.699654522446, 5084.56781173597, 5155.896882062338, 5174.24973378858, 5200.76596553156, 5246.7638956247065, 5997.1304160896425, 6098.847528811815, 6115.571909966259, 6149.3235744068115, 6196.256449226032, 1536.2165295699274, 1547.9303431345616, 1554.2539581001183, 1559.165846272239, 1560.5942454961792, 962.6197651927449, 982.0277924854486, 982.2338575910801, 989.3766926836047, 999.6651121874254, 5362.0, 5363.275957745733, 5405.945940540544, 5407.972960135174, 5428.891422171613, 5494.313210848644, 5551.362348107318, 5615.321964113512, 5647.802326918621, 5672.404397538282, 5026.271190677405, 5284.233786101071, 5308.193769846376, 5316.680999140064, 5363.544098751572, 2986.850657467118, 2993.685663005353, 3014.849257537114, 3044.6346438427086, 3060.510318349098, 5543.556515478752, 5815.534757219412, 5831.679257640785, 5839.357670656224, 5885.793997210163, 5653.886922261532, 5656.745446454919, 5709.400512946164, 5731.598788084877, 5736.196932429463, 5642.435756424325, 5730.455606717355, 5730.5129064030025, 5731.168980497888, 5733.31200255972, 5278.656887302313, 5521.631804599271, 5590.944090559043, 5650.971745141413, 5666.688332141772, 5498.80754173602, 5525.038611292933, 5554.50009499147, 5562.527185189142, 5572.777088916398, 5686.914696279642, 5714.914166308388, 5801.419858014165, 5802.709864506842, 5810.7094645266725, 4131.855385061508, 4460.821567137278, 4470.418845550058, 4502.122086193161, 4509.210888094636, 6024.518038556993, 6193.907091393723, 6276.372362763687, 6283.685815709105, 6310.337414571588, 6141.723622436912, 6177.36299880541, 6201.348858369806, 6203.193584833943, 6247.187865577627, 6060.393960603904, 6075.483583895419, 6151.72317245716, 6159.505400312881, 6163.96918015407, 5971.701414929149, 6000.5799594028, 6015.187949626919, 6018.969905150446, 6073.696315184311, 6108.664023478574, 6147.723352449061, 6210.608915567449, 6243.629459378362, 6255.37446255389, 5820.272465941757, 5893.823185304448, 6025.367336429612, 6046.788362407295, 6068.332483426908], "value": 4521.898167156607, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.6537792615396, 755.1693137548697, 791.2048391366677, 800.9719659811905, 815.4780940198278, 13554.118982266158, 14333.426662933496, 14397.136171829685, 14400.06399584029, 14411.639709007268, 14696.971212015163, 14830.777538336906, 14844.109353438802, 14876.776848347256, 14991.700165996674, 711.4059760100322, 840.4537050916891, 856.3962406503431, 865.0484467086218, 865.1435079271539, 867.761365624452, 870.7344260000697, 871.6731225790329, 875.7197696737015, 876.583622779178, 921.4793641592512, 923.0354279777615, 927.0868194828089, 927.8700981862545, 928.2295694573488, 915.940463869853, 916.3493919317293, 917.8347897378469, 918.0865039285886, 919.8758167647349, 669.4778073102988, 674.0361283364787, 676.5433332500543, 678.6606696651675, 679.0934102972537, 15376.077435353915, 15433.228338583025, 15458.61353466161, 15492.612684682861, 15502.9224853875, 14499.56501304952, 14524.636884077878, 14721.779173312409, 15091.54725358241, 15640.0, 13939.790903136462, 14116.294185290695, 14280.500182493563, 14547.490837820626, 14616.853831461656, 4704.270838020112, 4758.619310455155, 4795.6403269754555, 4852.684575502581, 4892.486288939681, 61285.693571532305, 63592.36407635911, 78371.21628783696, 79933.60033199855, 80873.19126808716, 12065.819012714815, 12202.32887191213, 12209.65656625694, 12337.198082124632, 12554.874451255371, 21142.78857211439, 21207.363779086652, 21217.893910530347, 21232.469188270417, 21319.8934005329, 9487.952560237154, 9586.712398628053, 9643.517824108907, 9675.854862177073, 9700.078492543196, 5179.0, 5190.8183213587345, 5276.472352764693, 5341.252224688546, 5446.373667028263, 3857.228554289153, 3924.843006279717, 3963.8612648557164, 3964.484616999772, 3978.3236849735613, 699.0353312428815, 705.1960764728213, 705.8552996635677, 713.1976526407791, 718.2458418660385, 810.6271115287034, 815.3477218225396, 815.8205194857122, 821.8150916043962, 822.1860358245294, 9825.164860986895, 10029.64896228643, 10046.447445390428, 10171.237157213238, 10175.185985121172, 655.7606473637088, 716.3517017099533, 825.9050209226016, 836.1304243586724, 854.418032665443, 4849.0, 4877.804887804519, 4895.632827537949, 4928.137575924199, 4965.478624744422, 70286.64856675787, 98231.0, 100721.0, 102278.48860755649, 114156.42921785504, 64262.357376426575, 65004.67497662576, 106988.87464905939, 107702.0, 111759.44120279346, 91956.54021729983, 97693.99999999857, 100478.4976075115, 100622.49688751657, 101306.49346753219, 10241.020817470177, 10444.529996150344, 10556.524956376828, 10623.946880265548, 10713.196510261918, 39980.600193997685, 40710.59289407068, 46148.76925615351, 46513.767431162625, 57381.42618573761, 75195.0, 76318.61840690984, 76462.0, 76694.0, 77802.2219777795, 13311.80032299497, 13828.446862125402, 13914.443422262995, 13997.650058748613, 14153.08004979673, 14938.626534336729, 14959.925200374364, 15006.774898376314, 16028.278727457526, 16029.0, 14162.575122746333, 14635.195064271142, 14699.485518006819, 14924.104553726811, 14925.850741492446, 13382.392479810262, 13540.366518078257, 13714.38285277145, 13734.107283026571, 13959.581212563638, 13420.328983550588, 13573.321333933462, 14004.509842155476, 14211.715765684836, 14529.418823247375, 10885.401302928414, 10991.450427478754, 11119.944400277947, 11135.220534562503, 11778.116641252112, 12042.21725587834, 12279.386030698608, 12334.938325308316, 12592.370381481072, 12673.683157921127], "value": 7938.224050692253, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1515.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 107.0, 108.0, 110.0, 113.0, 111.0, 109.0, 109.0, 109.0, 111.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 122.0, 155.0, 181.0, 144.0, 155.0, 155.0, 125.0, 180.0, 126.0], "value": 150.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 169.0, 161.0, 162.0, 162.0, 161.0, 166.0, 161.0, 160.0, 161.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 167.0, 75.0, 76.0, 76.0, 77.0, 183.0, 75.0], "value": 95.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 150.0, 84.0, 84.0, 84.0, 137.0, 84.0, 86.0, 142.0], "value": 101.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 119.0, 121.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 146.0, 147.0, 151.0, 150.0, 146.0, 146.0, 147.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 96.0, 96.0, 95.0, 95.0, 94.0, 95.0, 96.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 53.0, 56.0, 53.0, 53.0, 53.0, 59.0, 54.0, 53.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 62.0, 59.0, 60.0, 59.0, 59.0, 61.0, 59.0], "value": 59.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 80.0, 80.0, 79.0, 77.0, 76.0, 79.0, 77.0, 103.0, 77.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 120.0, 115.0, 118.0, 118.0, 116.0, 134.0, 126.0, 131.0, 137.0], "value": 123.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 160.0, 157.0, 158.0, 154.0, 154.0, 154.0, 153.0, 153.0, 150.0], "value": 154.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 62.0, 62.0, 63.0, 61.0, 64.0, 60.0, 59.0, 60.0], "value": 61.8, "unit": "score"}]}]} 02:58:40 INFO - Return code: 0 02:58:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:58:41 ERROR - # TBPL SUCCESS # 02:58:41 INFO - Running post-action listener: _resource_record_post_action 02:58:41 INFO - ##### 02:58:41 INFO - ##### Finished run-tests step (success) 02:58:41 INFO - ##### 02:58:41 INFO - Running post-run listener: _resource_record_post_run 02:58:41 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 290816; Write bytes: 504168448; Read time: 60; Write time: 468852 02:58:41 INFO - TinderboxPrint: CPU usage
13.5% 02:58:41 INFO - TinderboxPrint: I/O read bytes / time
290,816 / 60 02:58:41 INFO - TinderboxPrint: I/O write bytes / time
504,168,448 / 468,852 02:58:41 INFO - TinderboxPrint: CPU idle
8,216.4 (86.5%) 02:58:41 INFO - TinderboxPrint: CPU user
1,219.8 (12.8%) 02:58:41 INFO - TinderboxPrint: Swap in / out
0 / 0 02:58:41 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252493824; Read time: 0; Write time: 269636 02:58:41 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 266240; Write bytes: 251674624; Read time: 44; Write time: 199216 02:58:41 INFO - Running post-run listener: _upload_blobber_files 02:58:41 INFO - Blob upload gear active. 02:58:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:58:41 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 02:58:41 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'] 02:58:41 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 02:58:42 INFO - (blobuploader) - INFO - Open directory for files ... 02:58:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:58:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:58:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:58:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:58:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:58:42 INFO - (blobuploader) - INFO - Done attempting. 02:58:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:58:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:58:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:58:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:58:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:58:43 INFO - (blobuploader) - INFO - Done attempting. 02:58:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:58:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:58:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:58:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:58:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:58:47 INFO - (blobuploader) - INFO - Done attempting. 02:58:47 INFO - (blobuploader) - INFO - Iteration through files over. 02:58:47 INFO - Return code: 0 02:58:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:58:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:58:47 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/27834a76664862ae29b4bbe14fd743ed660ab8c9943e8e7cb9fdc57268e89b9fded334875553194956a96b125e85693df588e7cdb2cd632cab3d38206d189372", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/58ecae33f278e7ffaf7ac5f7fa26cdcdc77eb7bab0562c48b2dda9ba3dbbb1f02e6ee6139b42d35240ed7479dddc4141f0a96dadd0ce1bf315a3402841683d49", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/314e9cb541396b1a3d66250141cb4c167b4e9df7ef900f5d109628f6d6253015bd71dafa8e01755ef7a5f213080dc28ad37b96bb5cc255b9800e99534311b269"} 02:58:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:58:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:58:47 INFO - Contents: 02:58:47 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/27834a76664862ae29b4bbe14fd743ed660ab8c9943e8e7cb9fdc57268e89b9fded334875553194956a96b125e85693df588e7cdb2cd632cab3d38206d189372", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/58ecae33f278e7ffaf7ac5f7fa26cdcdc77eb7bab0562c48b2dda9ba3dbbb1f02e6ee6139b42d35240ed7479dddc4141f0a96dadd0ce1bf315a3402841683d49", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/314e9cb541396b1a3d66250141cb4c167b4e9df7ef900f5d109628f6d6253015bd71dafa8e01755ef7a5f213080dc28ad37b96bb5cc255b9800e99534311b269"} 02:58:47 INFO - Running post-run listener: copy_logs_to_upload_dir 02:58:47 INFO - Copying logs to upload dir... 02:58:47 INFO - mkdir: /builds/slave/test/build/upload/logs 02:58:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.960619 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-01 02:58:46.963937) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 02:58:46.967480) ========= 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=920470bf432669ad7e3a5387000001ca-1467365884.471784-514542912 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/27834a76664862ae29b4bbe14fd743ed660ab8c9943e8e7cb9fdc57268e89b9fded334875553194956a96b125e85693df588e7cdb2cd632cab3d38206d189372", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/58ecae33f278e7ffaf7ac5f7fa26cdcdc77eb7bab0562c48b2dda9ba3dbbb1f02e6ee6139b42d35240ed7479dddc4141f0a96dadd0ce1bf315a3402841683d49", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/314e9cb541396b1a3d66250141cb4c167b4e9df7ef900f5d109628f6d6253015bd71dafa8e01755ef7a5f213080dc28ad37b96bb5cc255b9800e99534311b269"} build_url:https://queue.taskcluster.net/v1/task/JuVP5SfKQfC3CpVEuJcD_w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011285 build_url: 'https://queue.taskcluster.net/v1/task/JuVP5SfKQfC3CpVEuJcD_w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/27834a76664862ae29b4bbe14fd743ed660ab8c9943e8e7cb9fdc57268e89b9fded334875553194956a96b125e85693df588e7cdb2cd632cab3d38206d189372", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/58ecae33f278e7ffaf7ac5f7fa26cdcdc77eb7bab0562c48b2dda9ba3dbbb1f02e6ee6139b42d35240ed7479dddc4141f0a96dadd0ce1bf315a3402841683d49", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/314e9cb541396b1a3d66250141cb4c167b4e9df7ef900f5d109628f6d6253015bd71dafa8e01755ef7a5f213080dc28ad37b96bb5cc255b9800e99534311b269"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 02:58:46.993210) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 02:58:46.993593) ========= 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=920470bf432669ad7e3a5387000001ca-1467365884.471784-514542912 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004410 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 02:58:47.079248) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 02:58:47.079599) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 02:58:47.079921) ========= ========= Total master_lag: 0.17 =========