builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-051 starttime: 1466647645.52 results: success (0) buildid: 20160622163024 builduid: 66a3d7d7e0764b48aa4c96c55a48ccc7 revision: 08127897283dd05ae78e32ed71ce727bdb39285c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 19:07:25.518798) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 19:07:25.519302) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 19:07:25.519639) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 19:07:25.571097) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 19:07:25.571415) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1466646474.545788-1916508181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-22 19:07:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 110M=0s 2016-06-22 19:07:25 (110 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095145 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 19:07:25.704092) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 19:07:25.704417) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1466646474.545788-1916508181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023169 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 19:07:25.772559) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 19:07:25.772971) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 08127897283dd05ae78e32ed71ce727bdb39285c --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 08127897283dd05ae78e32ed71ce727bdb39285c --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=5ac5dba3e01a12f1ff77ab15000001b1-1466646474.545788-1916508181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-22 19:07:25,850 truncating revision to first 12 chars 2016-06-22 19:07:25,850 Setting DEBUG logging. 2016-06-22 19:07:25,850 attempt 1/10 2016-06-22 19:07:25,850 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/08127897283d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-22 19:07:26,174 unpacking tar archive at: mozilla-aurora-08127897283d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.669015 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 19:07:26.456222) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 19:07:26.456580) ========= script_repo_revision: 08127897283dd05ae78e32ed71ce727bdb39285c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 19:07:26.457022) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 19:07:26.457329) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 19:07:26.467253) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-22 19:07:26.467595) ========= /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=5ac5dba3e01a12f1ff77ab15000001b1-1466646474.545788-1916508181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:07:26 INFO - MultiFileLogger online at 20160622 19:07:26 in /builds/slave/test 19:07:26 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 19:07:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:07:26 INFO - {'append_to_log': False, 19:07:26 INFO - 'base_work_dir': '/builds/slave/test', 19:07:26 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 19:07:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:07:26 INFO - 'branch': 'Mozilla-Aurora', 19:07:26 INFO - 'buildbot_json_path': 'buildprops.json', 19:07:26 INFO - 'config_files': ('talos/linux_config.py',), 19:07:26 INFO - 'default_actions': ('clobber', 19:07:26 INFO - 'read-buildbot-config', 19:07:26 INFO - 'download-and-extract', 19:07:26 INFO - 'populate-webroot', 19:07:26 INFO - 'create-virtualenv', 19:07:26 INFO - 'install', 19:07:26 INFO - 'run-tests'), 19:07:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:07:26 INFO - 'download_minidump_stackwalk': True, 19:07:26 INFO - 'download_symbols': 'ondemand', 19:07:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:07:26 INFO - 'tooltool.py': '/tools/tooltool.py', 19:07:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:07:26 INFO - '/tools/misc-python/virtualenv.py')}, 19:07:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:07:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:07:26 INFO - 'installer_path': 'installer.exe', 19:07:26 INFO - 'log_level': 'info', 19:07:26 INFO - 'log_name': 'talos', 19:07:26 INFO - 'log_to_console': True, 19:07:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:07:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:07:26 INFO - 'opt_config_files': (), 19:07:26 INFO - 'pip_index': False, 19:07:26 INFO - 'sps_profile': False, 19:07:26 INFO - 'sps_profile_interval': 0, 19:07:26 INFO - 'suite': 'dromaeojs-e10s', 19:07:26 INFO - 'system_bits': '32', 19:07:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:07:26 INFO - 'title': 'talos-linux64-ix-051', 19:07:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:07:26 INFO - 'use_talos_json': True, 19:07:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:07:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:07:26 INFO - 'work_dir': 'build'} 19:07:26 INFO - ##### 19:07:26 INFO - ##### Running clobber step. 19:07:26 INFO - ##### 19:07:26 INFO - Running pre-action listener: _resource_record_pre_action 19:07:26 INFO - Running main action method: clobber 19:07:26 INFO - rmtree: /builds/slave/test/build 19:07:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:07:27 INFO - Running post-action listener: _resource_record_post_action 19:07:27 INFO - ##### 19:07:27 INFO - ##### Finished clobber step (success) 19:07:27 INFO - ##### 19:07:27 INFO - ##### 19:07:27 INFO - ##### Running read-buildbot-config step. 19:07:27 INFO - ##### 19:07:27 INFO - Running pre-action listener: _resource_record_pre_action 19:07:27 INFO - Running main action method: read_buildbot_config 19:07:27 INFO - Using buildbot properties: 19:07:27 INFO - { 19:07:27 INFO - "project": "", 19:07:27 INFO - "product": "firefox", 19:07:27 INFO - "script_repo_revision": "production", 19:07:27 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 19:07:27 INFO - "repository": "", 19:07:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 19:07:27 INFO - "buildid": "20160622163024", 19:07:27 INFO - "pgo_build": "True", 19:07:27 INFO - "basedir": "/builds/slave/test", 19:07:27 INFO - "buildnumber": 364, 19:07:27 INFO - "slavename": "talos-linux64-ix-051", 19:07:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:07:27 INFO - "platform": "ubuntu64_hw", 19:07:27 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 19:07:27 INFO - "branch": "mozilla-aurora", 19:07:27 INFO - "repo_path": "releases/mozilla-aurora", 19:07:27 INFO - "revision": "08127897283dd05ae78e32ed71ce727bdb39285c", 19:07:27 INFO - "stage_platform": "linux64-pgo", 19:07:27 INFO - "builduid": "66a3d7d7e0764b48aa4c96c55a48ccc7", 19:07:27 INFO - "slavebuilddir": "test" 19:07:27 INFO - } 19:07:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/fgIu4NmDTTaf5NWKDiiBXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 19:07:27 INFO - Running post-action listener: _resource_record_post_action 19:07:27 INFO - ##### 19:07:27 INFO - ##### Finished read-buildbot-config step (success) 19:07:27 INFO - ##### 19:07:27 INFO - ##### 19:07:27 INFO - ##### Running download-and-extract step. 19:07:27 INFO - ##### 19:07:27 INFO - Running pre-action listener: _resource_record_pre_action 19:07:27 INFO - Running main action method: download_and_extract 19:07:27 INFO - mkdir: /builds/slave/test/build/tests 19:07: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')]} 19:07:27 INFO - https://queue.taskcluster.net/v1/task/fgIu4NmDTTaf5NWKDiiBXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:07:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fgIu4NmDTTaf5NWKDiiBXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 19:07:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fgIu4NmDTTaf5NWKDiiBXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 19:07:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fgIu4NmDTTaf5NWKDiiBXw/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 19:07:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fgIu4NmDTTaf5NWKDiiBXw/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 19:07:35 INFO - Downloaded 1361 bytes. 19:07:35 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 19:07:35 INFO - Using the following test package requirements: 19:07:35 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 19:07:35 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 19:07:35 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 19:07:35 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 19:07:35 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 19:07:35 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 19:07:35 INFO - u'jsshell-linux-x86_64.zip'], 19:07:35 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 19:07:35 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 19:07:35 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 19:07:35 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 19:07:35 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 19:07:35 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 19:07:35 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 19:07:35 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 19:07:35 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 19:07:35 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 19:07:35 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 19:07:35 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:07: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')]} 19:07:35 INFO - https://queue.taskcluster.net/v1/task/fgIu4NmDTTaf5NWKDiiBXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:07:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fgIu4NmDTTaf5NWKDiiBXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 19:07:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fgIu4NmDTTaf5NWKDiiBXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 19:07:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fgIu4NmDTTaf5NWKDiiBXw/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 19:07:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fgIu4NmDTTaf5NWKDiiBXw/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 19:07:38 INFO - Downloaded 24474555 bytes. 19:07:38 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'] 19:07:38 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 19:07:39 INFO - Return code: 0 19:07:39 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 19:07:39 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')]} 19:07:39 INFO - https://queue.taskcluster.net/v1/task/fgIu4NmDTTaf5NWKDiiBXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:07:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fgIu4NmDTTaf5NWKDiiBXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 19:07:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fgIu4NmDTTaf5NWKDiiBXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 19:07:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fgIu4NmDTTaf5NWKDiiBXw/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 19:07:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fgIu4NmDTTaf5NWKDiiBXw/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 19:07:41 INFO - Downloaded 24474555 bytes. 19:07:41 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'] 19:07:41 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 19:07:43 INFO - Return code: 0 19:07: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')]} 19:07:43 INFO - https://queue.taskcluster.net/v1/task/fgIu4NmDTTaf5NWKDiiBXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:07:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fgIu4NmDTTaf5NWKDiiBXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 19:07:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fgIu4NmDTTaf5NWKDiiBXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 19:07:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fgIu4NmDTTaf5NWKDiiBXw/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 19:07:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fgIu4NmDTTaf5NWKDiiBXw/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 19:07:44 INFO - Downloaded 10833369 bytes. 19:07:44 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'] 19:07:44 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 19:07:45 INFO - Return code: 0 19:07:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:45 INFO - https://queue.taskcluster.net/v1/task/fgIu4NmDTTaf5NWKDiiBXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:07:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fgIu4NmDTTaf5NWKDiiBXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 19:07:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fgIu4NmDTTaf5NWKDiiBXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 19:07:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fgIu4NmDTTaf5NWKDiiBXw/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 19:07:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fgIu4NmDTTaf5NWKDiiBXw/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 19:07:46 INFO - Downloaded 63620781 bytes. 19:07:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fgIu4NmDTTaf5NWKDiiBXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 19:07:46 INFO - mkdir: /builds/slave/test/properties 19:07:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:07:46 INFO - Writing to file /builds/slave/test/properties/build_url 19:07:46 INFO - Contents: 19:07:46 INFO - build_url:https://queue.taskcluster.net/v1/task/fgIu4NmDTTaf5NWKDiiBXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 19:07:47 INFO - Running post-action listener: _resource_record_post_action 19:07:47 INFO - Running post-action listener: set_extra_try_arguments 19:07:47 INFO - ##### 19:07:47 INFO - ##### Finished download-and-extract step (success) 19:07:47 INFO - ##### 19:07:47 INFO - ##### 19:07:47 INFO - ##### Running populate-webroot step. 19:07:47 INFO - ##### 19:07:47 INFO - Running pre-action listener: _resource_record_pre_action 19:07:47 INFO - Running main action method: populate_webroot 19:07:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:07:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:07:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:07:47 INFO - '--tppagecycles', 19:07:47 INFO - '7'], 19:07:47 INFO - 'tests': ['tsvgm']}}, 19:07:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:07:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:07:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:07:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:07:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:07:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:07:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:47 INFO - 'talos_options': ['--disable-e10s'], 19:07:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:07:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:07:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:47 INFO - 'talos_options': ['--disable-e10s'], 19:07:47 INFO - 'tests': ['damp', 'tps']}, 19:07:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:47 INFO - 'tests': ['damp', 'tps']}, 19:07:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:07:47 INFO - 'tests': ['dromaeo_dom']}, 19:07:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:07:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:07:47 INFO - 'tests': ['a11yr', 19:07:47 INFO - 'ts_paint', 19:07:47 INFO - 'tpaint', 19:07:47 INFO - 'sessionrestore', 19:07:47 INFO - 'sessionrestore_no_auto_restore', 19:07:47 INFO - 'tabpaint']}, 19:07:47 INFO - 'other-e10s': {'tests': ['a11yr', 19:07:47 INFO - 'ts_paint', 19:07:47 INFO - 'tpaint', 19:07:47 INFO - 'sessionrestore', 19:07:47 INFO - 'sessionrestore_no_auto_restore', 19:07:47 INFO - 'tabpaint']}, 19:07:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:07:47 INFO - 'ts_paint', 19:07:47 INFO - 'tpaint', 19:07:47 INFO - 'sessionrestore', 19:07:47 INFO - 'sessionrestore_no_auto_restore', 19:07:47 INFO - 'tabpaint']}, 19:07:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:07:47 INFO - 'ts_paint', 19:07:47 INFO - 'tpaint', 19:07:47 INFO - 'sessionrestore', 19:07:47 INFO - 'sessionrestore_no_auto_restore', 19:07:47 INFO - 'tabpaint']}, 19:07:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:07:47 INFO - 'tests': ['a11yr', 19:07:47 INFO - 'ts_paint', 19:07:47 INFO - 'tpaint', 19:07:47 INFO - 'sessionrestore', 19:07:47 INFO - 'sessionrestore_no_auto_restore', 19:07:47 INFO - 'tabpaint']}, 19:07:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:07:47 INFO - 'tests': ['a11yr', 19:07:47 INFO - 'ts_paint', 19:07:47 INFO - 'tpaint', 19:07:47 INFO - 'sessionrestore', 19:07:47 INFO - 'sessionrestore_no_auto_restore', 19:07:47 INFO - 'tabpaint']}, 19:07:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:07:47 INFO - 'tests': ['tsvgx', 19:07:47 INFO - 'tsvgr_opacity', 19:07:47 INFO - 'tart', 19:07:47 INFO - 'tscrollx', 19:07:47 INFO - 'cart']}, 19:07:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:07:47 INFO - 'tsvgr_opacity', 19:07:47 INFO - 'tart', 19:07:47 INFO - 'tscrollx', 19:07:47 INFO - 'cart']}, 19:07:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:47 INFO - 'talos_options': ['--disable-e10s'], 19:07:47 INFO - 'tests': ['tp5o']}, 19:07:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:47 INFO - 'tests': ['tp5o']}, 19:07:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:47 INFO - 'talos_options': ['--disable-e10s', 19:07:47 INFO - '--xperf_path', 19:07:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:07:47 INFO - 'tests': ['tp5n']}, 19:07:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:47 INFO - 'talos_options': ['--xperf_path', 19:07:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:07:47 INFO - 'tests': ['tp5n']}}, 19:07:47 INFO - 'talos.zip': {'path': '', 19:07:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:07:47 INFO - Running post-action listener: _resource_record_post_action 19:07:47 INFO - ##### 19:07:47 INFO - ##### Finished populate-webroot step (success) 19:07:47 INFO - ##### 19:07:47 INFO - ##### 19:07:47 INFO - ##### Running create-virtualenv step. 19:07:47 INFO - ##### 19:07:47 INFO - Running pre-action listener: _resource_record_pre_action 19:07:47 INFO - Running main action method: create_virtualenv 19:07:47 INFO - Creating virtualenv /builds/slave/test/build/venv 19:07:47 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 19:07:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:07:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:07:47 INFO - Using real prefix '/usr' 19:07:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:07:47 INFO - Installing distribute.............................................................................................................................................................................................done. 19:07:49 INFO - Installing pip.................done. 19:07:49 INFO - Return code: 0 19:07:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:07:49 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')]} 19:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:49 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')]} 19:07:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:49 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 0x7fe879231f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29461c0>, '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 0x29470c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2947550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466646474.545788-1916508181', '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 19:07:49 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 19:07:49 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 19:07:49 INFO - Using env: {'DISPLAY': ':0', 19:07:49 INFO - 'HOME': '/home/cltbld', 19:07:49 INFO - 'LANG': 'en_US.UTF-8', 19:07:49 INFO - 'LANGUAGE': 'en_US:en', 19:07:49 INFO - 'LOGNAME': 'cltbld', 19:07:49 INFO - 'MAIL': '/var/mail/cltbld', 19:07:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:49 INFO - 'MOZ_NO_REMOTE': '1', 19:07:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:49 INFO - 'NO_EM_RESTART': '1', 19:07:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:49 INFO - 'PWD': '/builds/slave/test', 19:07:49 INFO - 'SHELL': '/bin/bash', 19:07:49 INFO - 'SHLVL': '1', 19:07:49 INFO - 'TERM': 'linux', 19:07:49 INFO - 'TMOUT': '86400', 19:07:49 INFO - 'USER': 'cltbld', 19:07:49 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466646474.545788-1916508181', 19:07:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:49 INFO - '_': '/tools/buildbot/bin/python'} 19:07:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:50 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 19:07:50 INFO - Cleaning up... 19:07:50 INFO - Return code: 0 19:07:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:07:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:50 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 0x7fe879231f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29461c0>, '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 0x29470c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2947550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466646474.545788-1916508181', '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 19:07:50 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 19:07:50 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 19:07:50 INFO - Using env: {'DISPLAY': ':0', 19:07:50 INFO - 'HOME': '/home/cltbld', 19:07:50 INFO - 'LANG': 'en_US.UTF-8', 19:07:50 INFO - 'LANGUAGE': 'en_US:en', 19:07:50 INFO - 'LOGNAME': 'cltbld', 19:07:50 INFO - 'MAIL': '/var/mail/cltbld', 19:07:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:50 INFO - 'MOZ_NO_REMOTE': '1', 19:07:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:50 INFO - 'NO_EM_RESTART': '1', 19:07:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:50 INFO - 'PWD': '/builds/slave/test', 19:07:50 INFO - 'SHELL': '/bin/bash', 19:07:50 INFO - 'SHLVL': '1', 19:07:50 INFO - 'TERM': 'linux', 19:07:50 INFO - 'TMOUT': '86400', 19:07:50 INFO - 'USER': 'cltbld', 19:07:50 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466646474.545788-1916508181', 19:07:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:50 INFO - '_': '/tools/buildbot/bin/python'} 19:07:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:50 INFO - Downloading/unpacking psutil>=3.1.1 19:07: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 19:07: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 19:07: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 19:07: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 19:07: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 19:07: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 19:07:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:07:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:07:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:07:52 INFO - Installing collected packages: psutil 19:07:52 INFO - Running setup.py install for psutil 19:07:52 INFO - building 'psutil._psutil_linux' extension 19:07:52 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 19:07:52 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 19:07:52 INFO - building 'psutil._psutil_posix' extension 19:07:52 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 19:07:52 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 19:07:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:07:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:07:52 INFO - Successfully installed psutil 19:07:52 INFO - Cleaning up... 19:07:52 INFO - Return code: 0 19:07:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:07:52 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')]} 19:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:52 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')]} 19:07:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:52 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 0x7fe879231f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29461c0>, '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 0x29470c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2947550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466646474.545788-1916508181', '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 19:07:52 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 19:07:52 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 19:07:52 INFO - Using env: {'DISPLAY': ':0', 19:07:52 INFO - 'HOME': '/home/cltbld', 19:07:52 INFO - 'LANG': 'en_US.UTF-8', 19:07:52 INFO - 'LANGUAGE': 'en_US:en', 19:07:52 INFO - 'LOGNAME': 'cltbld', 19:07:52 INFO - 'MAIL': '/var/mail/cltbld', 19:07:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:52 INFO - 'MOZ_NO_REMOTE': '1', 19:07:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:52 INFO - 'NO_EM_RESTART': '1', 19:07:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:52 INFO - 'PWD': '/builds/slave/test', 19:07:52 INFO - 'SHELL': '/bin/bash', 19:07:52 INFO - 'SHLVL': '1', 19:07:52 INFO - 'TERM': 'linux', 19:07:52 INFO - 'TMOUT': '86400', 19:07:52 INFO - 'USER': 'cltbld', 19:07:52 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466646474.545788-1916508181', 19:07:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:52 INFO - '_': '/tools/buildbot/bin/python'} 19:07:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:07:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:07:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:07:55 INFO - Installing collected packages: mozsystemmonitor 19:07:55 INFO - Running setup.py install for mozsystemmonitor 19:07:55 INFO - Successfully installed mozsystemmonitor 19:07:55 INFO - Cleaning up... 19:07:55 INFO - Return code: 0 19:07:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:07:55 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')]} 19:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:55 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')]} 19:07:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:55 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 0x7fe879231f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29461c0>, '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 0x29470c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2947550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466646474.545788-1916508181', '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 19:07:55 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 19:07:55 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 19:07:55 INFO - Using env: {'DISPLAY': ':0', 19:07:55 INFO - 'HOME': '/home/cltbld', 19:07:55 INFO - 'LANG': 'en_US.UTF-8', 19:07:55 INFO - 'LANGUAGE': 'en_US:en', 19:07:55 INFO - 'LOGNAME': 'cltbld', 19:07:55 INFO - 'MAIL': '/var/mail/cltbld', 19:07:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:55 INFO - 'MOZ_NO_REMOTE': '1', 19:07:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:55 INFO - 'NO_EM_RESTART': '1', 19:07:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:55 INFO - 'PWD': '/builds/slave/test', 19:07:55 INFO - 'SHELL': '/bin/bash', 19:07:55 INFO - 'SHLVL': '1', 19:07:55 INFO - 'TERM': 'linux', 19:07:55 INFO - 'TMOUT': '86400', 19:07:55 INFO - 'USER': 'cltbld', 19:07:55 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466646474.545788-1916508181', 19:07:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:55 INFO - '_': '/tools/buildbot/bin/python'} 19:07:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:55 INFO - Downloading/unpacking jsonschema==2.5.1 19:07:55 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 19:07:55 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 19:07:55 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 19:07:55 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 19:07:55 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 19:07:55 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 19:07:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:07:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:07:57 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 19:07:57 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 19:07:57 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 19:07:57 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 19:07:57 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 19:07:57 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 19:07:57 INFO - Downloading functools32-3.2.3-2.tar.gz 19:07:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:07:57 INFO - warning: no files found matching '*.txt' 19:07:57 INFO - no previously-included directories found matching 'build' 19:07:57 INFO - no previously-included directories found matching 'dist' 19:07:57 INFO - no previously-included directories found matching '.git*' 19:07:57 INFO - Installing collected packages: jsonschema, functools32 19:07:57 INFO - Running setup.py install for functools32 19:07:57 INFO - warning: no files found matching '*.txt' 19:07:57 INFO - no previously-included directories found matching 'build' 19:07:57 INFO - no previously-included directories found matching 'dist' 19:07:57 INFO - no previously-included directories found matching '.git*' 19:07:57 INFO - Successfully installed jsonschema functools32 19:07:57 INFO - Cleaning up... 19:07:57 INFO - Return code: 0 19:07:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:57 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 0x7fe879231f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29461c0>, '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 0x29470c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2947550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466646474.545788-1916508181', '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 19:07:57 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 19:07:57 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 19:07:57 INFO - Using env: {'DISPLAY': ':0', 19:07:57 INFO - 'HOME': '/home/cltbld', 19:07:57 INFO - 'LANG': 'en_US.UTF-8', 19:07:57 INFO - 'LANGUAGE': 'en_US:en', 19:07:57 INFO - 'LOGNAME': 'cltbld', 19:07:57 INFO - 'MAIL': '/var/mail/cltbld', 19:07:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:57 INFO - 'MOZ_NO_REMOTE': '1', 19:07:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:57 INFO - 'NO_EM_RESTART': '1', 19:07:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:57 INFO - 'PWD': '/builds/slave/test', 19:07:57 INFO - 'SHELL': '/bin/bash', 19:07:57 INFO - 'SHLVL': '1', 19:07:57 INFO - 'TERM': 'linux', 19:07:57 INFO - 'TMOUT': '86400', 19:07:57 INFO - 'USER': 'cltbld', 19:07:57 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466646474.545788-1916508181', 19:07:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:57 INFO - '_': '/tools/buildbot/bin/python'} 19:07:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:57 INFO - Downloading/unpacking blobuploader==1.2.4 19:07:57 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 19:07:57 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 19:07:57 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 19:07:57 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 19:07:57 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 19:07:57 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 19:07:59 INFO - Downloading blobuploader-1.2.4.tar.gz 19:07:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:07:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:08:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:08:00 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 19:08:00 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 19:08:00 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 19:08:00 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 19:08:00 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 19:08:00 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 19:08:00 INFO - Downloading docopt-0.6.1.tar.gz 19:08:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:08:00 INFO - Installing collected packages: blobuploader, requests, docopt 19:08:00 INFO - Running setup.py install for blobuploader 19:08:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:08:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:08:00 INFO - Running setup.py install for requests 19:08:01 INFO - Running setup.py install for docopt 19:08:01 INFO - Successfully installed blobuploader requests docopt 19:08:01 INFO - Cleaning up... 19:08:01 INFO - Return code: 0 19:08:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:08:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:01 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 0x7fe879231f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29461c0>, '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 0x29470c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2947550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466646474.545788-1916508181', '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 19:08:01 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 19:08:01 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 19:08:01 INFO - Using env: {'DISPLAY': ':0', 19:08:01 INFO - 'HOME': '/home/cltbld', 19:08:01 INFO - 'LANG': 'en_US.UTF-8', 19:08:01 INFO - 'LANGUAGE': 'en_US:en', 19:08:01 INFO - 'LOGNAME': 'cltbld', 19:08:01 INFO - 'MAIL': '/var/mail/cltbld', 19:08:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:01 INFO - 'MOZ_NO_REMOTE': '1', 19:08:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:01 INFO - 'NO_EM_RESTART': '1', 19:08:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:01 INFO - 'PWD': '/builds/slave/test', 19:08:01 INFO - 'SHELL': '/bin/bash', 19:08:01 INFO - 'SHLVL': '1', 19:08:01 INFO - 'TERM': 'linux', 19:08:01 INFO - 'TMOUT': '86400', 19:08:01 INFO - 'USER': 'cltbld', 19:08:01 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466646474.545788-1916508181', 19:08:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:01 INFO - '_': '/tools/buildbot/bin/python'} 19:08:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:08:01 INFO - Running setup.py (path:/tmp/pip-26Y_ze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:08:01 INFO - Running setup.py (path:/tmp/pip-NI4urj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:08:01 INFO - Running setup.py (path:/tmp/pip-7ZkVun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:08:01 INFO - Running setup.py (path:/tmp/pip-t69MBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:08:01 INFO - Running setup.py (path:/tmp/pip-B8TfZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:08:01 INFO - Running setup.py (path:/tmp/pip-inj9lc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:08:01 INFO - Running setup.py (path:/tmp/pip-gT4a8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:08:01 INFO - Running setup.py (path:/tmp/pip-a03CJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:08:02 INFO - Running setup.py (path:/tmp/pip-K1HJhx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:08:02 INFO - Running setup.py (path:/tmp/pip-9DBElU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:08:02 INFO - Running setup.py (path:/tmp/pip-qhoDVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:08:02 INFO - Running setup.py (path:/tmp/pip-oWrfNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:08:02 INFO - Running setup.py (path:/tmp/pip-IvVRRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:08:02 INFO - Running setup.py (path:/tmp/pip-YMSpjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:02 INFO - Running setup.py (path:/tmp/pip-AMMiQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:08:02 INFO - Running setup.py (path:/tmp/pip-_CelD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:08:02 INFO - Running setup.py (path:/tmp/pip-w4vWzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:08:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:08:02 INFO - Running setup.py install for manifestparser 19:08:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:08:02 INFO - Running setup.py install for mozcrash 19:08:02 INFO - Running setup.py install for mozdebug 19:08:02 INFO - Running setup.py install for mozdevice 19:08:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:08:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:08:03 INFO - Running setup.py install for mozfile 19:08:03 INFO - Running setup.py install for mozhttpd 19:08:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:08:03 INFO - Running setup.py install for mozinfo 19:08:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:08:03 INFO - Running setup.py install for mozInstall 19:08:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:08:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:08:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:08:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:08:03 INFO - Running setup.py install for mozleak 19:08:03 INFO - Running setup.py install for mozlog 19:08:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:08:03 INFO - Running setup.py install for moznetwork 19:08:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:08:03 INFO - Running setup.py install for mozprocess 19:08:03 INFO - Running setup.py install for mozprofile 19:08:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:08:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:08:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:08:04 INFO - Running setup.py install for mozrunner 19:08:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:08:04 INFO - Running setup.py install for mozscreenshot 19:08:04 INFO - Running setup.py install for moztest 19:08:04 INFO - Running setup.py install for mozversion 19:08:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:08:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:08:04 INFO - Cleaning up... 19:08:04 INFO - Return code: 0 19:08:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:08:04 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')]} 19:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:04 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')]} 19:08:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:04 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 0x7fe879231f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29461c0>, '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 0x29470c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2947550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466646474.545788-1916508181', '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 19:08:04 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 19:08:04 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 19:08:04 INFO - Using env: {'DISPLAY': ':0', 19:08:04 INFO - 'HOME': '/home/cltbld', 19:08:04 INFO - 'LANG': 'en_US.UTF-8', 19:08:04 INFO - 'LANGUAGE': 'en_US:en', 19:08:04 INFO - 'LOGNAME': 'cltbld', 19:08:04 INFO - 'MAIL': '/var/mail/cltbld', 19:08:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:04 INFO - 'MOZ_NO_REMOTE': '1', 19:08:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:04 INFO - 'NO_EM_RESTART': '1', 19:08:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:04 INFO - 'PWD': '/builds/slave/test', 19:08:04 INFO - 'SHELL': '/bin/bash', 19:08:04 INFO - 'SHLVL': '1', 19:08:04 INFO - 'TERM': 'linux', 19:08:04 INFO - 'TMOUT': '86400', 19:08:04 INFO - 'USER': 'cltbld', 19:08:04 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466646474.545788-1916508181', 19:08:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:04 INFO - '_': '/tools/buildbot/bin/python'} 19:08:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:08:04 INFO - Running setup.py (path:/tmp/pip-7LBxkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:08:04 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)) 19:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:08:04 INFO - Running setup.py (path:/tmp/pip-Wq4XMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:08:04 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)) 19:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:08:04 INFO - Running setup.py (path:/tmp/pip-xe4LO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:08:04 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)) 19:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:08:04 INFO - Running setup.py (path:/tmp/pip-0jMCfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:08:05 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)) 19:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:08:05 INFO - Running setup.py (path:/tmp/pip-A6mEZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:08:05 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)) 19:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:08:05 INFO - Running setup.py (path:/tmp/pip-J955RF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:08:05 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)) 19:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:08:05 INFO - Running setup.py (path:/tmp/pip-O9I7wJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:08:05 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)) 19:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:08:05 INFO - Running setup.py (path:/tmp/pip-QfGeje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:08:05 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)) 19:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:08:05 INFO - Running setup.py (path:/tmp/pip-Y_1KVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:08:05 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)) 19:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:08:05 INFO - Running setup.py (path:/tmp/pip-MTjYAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:08:05 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)) 19:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:08:05 INFO - Running setup.py (path:/tmp/pip-BUI4ZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:08:05 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)) 19:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:08:05 INFO - Running setup.py (path:/tmp/pip-S_MamY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:08:05 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)) 19:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:08:05 INFO - Running setup.py (path:/tmp/pip-qZfKoC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:08:05 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)) 19:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:08:05 INFO - Running setup.py (path:/tmp/pip-MNuWfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:08:05 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)) 19:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:05 INFO - Running setup.py (path:/tmp/pip-BLaHvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:05 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)) 19:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:08:05 INFO - Running setup.py (path:/tmp/pip-11Dr_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:08:05 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)) 19:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:08:05 INFO - Running setup.py (path:/tmp/pip-KxzF_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:08:05 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)) 19:08:05 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)) 19:08:05 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)) 19:08:05 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)) 19:08:05 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)) 19:08:05 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)) 19:08:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:07 INFO - Downloading blessings-1.6.tar.gz 19:08:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:08:07 INFO - Installing collected packages: blessings 19:08:07 INFO - Running setup.py install for blessings 19:08:08 INFO - Successfully installed blessings 19:08:08 INFO - Cleaning up... 19:08:08 INFO - Return code: 0 19:08:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:08:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:08:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:08:08 INFO - Reading from file tmpfile_stdout 19:08:08 INFO - Current package versions: 19:08:08 INFO - argparse == 1.2.1 19:08:08 INFO - blessings == 1.6 19:08:08 INFO - blobuploader == 1.2.4 19:08:08 INFO - docopt == 0.6.1 19:08:08 INFO - functools32 == 3.2.3-2 19:08:08 INFO - jsonschema == 2.5.1 19:08:08 INFO - manifestparser == 1.1 19:08:08 INFO - mozInstall == 1.12 19:08:08 INFO - mozcrash == 0.17 19:08:08 INFO - mozdebug == 0.1 19:08:08 INFO - mozdevice == 0.48 19:08:08 INFO - mozfile == 1.2 19:08:08 INFO - mozhttpd == 0.7 19:08:08 INFO - mozinfo == 0.9 19:08:08 INFO - mozleak == 0.1 19:08:08 INFO - mozlog == 3.2 19:08:08 INFO - moznetwork == 0.27 19:08:08 INFO - mozprocess == 0.22 19:08:08 INFO - mozprofile == 0.28 19:08:08 INFO - mozrunner == 6.11 19:08:08 INFO - mozscreenshot == 0.1 19:08:08 INFO - mozsystemmonitor == 0.3 19:08:08 INFO - moztest == 0.7 19:08:08 INFO - mozversion == 1.4 19:08:08 INFO - psutil == 3.1.1 19:08:08 INFO - requests == 1.2.3 19:08:08 INFO - wsgiref == 0.1.2 19:08:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:08: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')]} 19:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08: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')]} 19:08:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:08 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 0x7fe879231f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29461c0>, '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 0x29470c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2947550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466646474.545788-1916508181', '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 19:08:08 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 19:08:08 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 19:08:08 INFO - Using env: {'DISPLAY': ':0', 19:08:08 INFO - 'HOME': '/home/cltbld', 19:08:08 INFO - 'LANG': 'en_US.UTF-8', 19:08:08 INFO - 'LANGUAGE': 'en_US:en', 19:08:08 INFO - 'LOGNAME': 'cltbld', 19:08:08 INFO - 'MAIL': '/var/mail/cltbld', 19:08:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:08 INFO - 'MOZ_NO_REMOTE': '1', 19:08:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:08 INFO - 'NO_EM_RESTART': '1', 19:08:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:08 INFO - 'PWD': '/builds/slave/test', 19:08:08 INFO - 'SHELL': '/bin/bash', 19:08:08 INFO - 'SHLVL': '1', 19:08:08 INFO - 'TERM': 'linux', 19:08:08 INFO - 'TMOUT': '86400', 19:08:08 INFO - 'USER': 'cltbld', 19:08:08 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466646474.545788-1916508181', 19:08:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:08 INFO - '_': '/tools/buildbot/bin/python'} 19:08:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:08 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)) 19:08:08 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)) 19:08:08 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)) 19:08:08 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)) 19:08:08 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)) 19:08:08 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)) 19:08:08 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)) 19:08:08 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)) 19:08:08 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)) 19:08:08 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)) 19:08:08 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)) 19:08:08 INFO - Cleaning up... 19:08:08 INFO - Return code: 0 19:08:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:08: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')]} 19:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08: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')]} 19:08:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe879231f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29461c0>, '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 0x29470c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2947550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466646474.545788-1916508181', '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 19:08:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:08:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:08:08 INFO - Using env: {'DISPLAY': ':0', 19:08:08 INFO - 'HOME': '/home/cltbld', 19:08:08 INFO - 'LANG': 'en_US.UTF-8', 19:08:08 INFO - 'LANGUAGE': 'en_US:en', 19:08:08 INFO - 'LOGNAME': 'cltbld', 19:08:08 INFO - 'MAIL': '/var/mail/cltbld', 19:08:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:08 INFO - 'MOZ_NO_REMOTE': '1', 19:08:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:08 INFO - 'NO_EM_RESTART': '1', 19:08:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:08 INFO - 'PWD': '/builds/slave/test', 19:08:08 INFO - 'SHELL': '/bin/bash', 19:08:08 INFO - 'SHLVL': '1', 19:08:08 INFO - 'TERM': 'linux', 19:08:08 INFO - 'TMOUT': '86400', 19:08:08 INFO - 'USER': 'cltbld', 19:08:08 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466646474.545788-1916508181', 19:08:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:08 INFO - '_': '/tools/buildbot/bin/python'} 19:08:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:08:08 INFO - Cleaning up... 19:08:08 INFO - Return code: 0 19:08:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:08: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')]} 19:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08: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')]} 19:08:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe879231f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29461c0>, '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 0x29470c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2947550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466646474.545788-1916508181', '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 19:08:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 19:08:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:08:08 INFO - Using env: {'DISPLAY': ':0', 19:08:08 INFO - 'HOME': '/home/cltbld', 19:08:08 INFO - 'LANG': 'en_US.UTF-8', 19:08:08 INFO - 'LANGUAGE': 'en_US:en', 19:08:08 INFO - 'LOGNAME': 'cltbld', 19:08:08 INFO - 'MAIL': '/var/mail/cltbld', 19:08:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:08 INFO - 'MOZ_NO_REMOTE': '1', 19:08:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:08 INFO - 'NO_EM_RESTART': '1', 19:08:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:08 INFO - 'PWD': '/builds/slave/test', 19:08:08 INFO - 'SHELL': '/bin/bash', 19:08:08 INFO - 'SHLVL': '1', 19:08:08 INFO - 'TERM': 'linux', 19:08:08 INFO - 'TMOUT': '86400', 19:08:08 INFO - 'USER': 'cltbld', 19:08:08 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466646474.545788-1916508181', 19:08:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:08 INFO - '_': '/tools/buildbot/bin/python'} 19:08:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:08 INFO - Downloading/unpacking flake8 19:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:08:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:08:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:08:11 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 19:08:11 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 19:08:11 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 19:08:11 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 19:08:11 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 19:08:11 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 19:08:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:08:11 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 19:08:11 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 19:08:11 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 19:08:11 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 19:08:11 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 19:08:11 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 19:08:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:08:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:08:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:08:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:08:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:08:11 INFO - no previously-included directories found matching 'docs/_build' 19:08:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:08:11 INFO - Running setup.py install for pep8 19:08:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:08:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:08:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:08:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:08:11 INFO - no previously-included directories found matching 'docs/_build' 19:08:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:08:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:08:11 INFO - Cleaning up... 19:08:11 INFO - Return code: 0 19:08:11 INFO - Running post-action listener: _resource_record_post_action 19:08:11 INFO - Running post-action listener: _start_resource_monitoring 19:08:11 INFO - Starting resource monitoring. 19:08:11 INFO - ##### 19:08:11 INFO - ##### Finished create-virtualenv step (success) 19:08:11 INFO - ##### 19:08:11 INFO - ##### 19:08:11 INFO - ##### Running install step. 19:08:11 INFO - ##### 19:08:11 INFO - Running pre-action listener: _resource_record_pre_action 19:08:11 INFO - Running main action method: install 19:08:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:08:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:08:11 INFO - Reading from file tmpfile_stdout 19:08:12 INFO - Detecting whether we're running mozinstall >=1.0... 19:08:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:08:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:08:12 INFO - Reading from file tmpfile_stdout 19:08:12 INFO - Output received: 19:08:12 INFO - Usage: mozinstall [options] installer 19:08:12 INFO - Options: 19:08:12 INFO - -h, --help show this help message and exit 19:08:12 INFO - -d DEST, --destination=DEST 19:08:12 INFO - Directory to install application into. [default: 19:08:12 INFO - "/builds/slave/test"] 19:08:12 INFO - --app=APP Application being installed. [default: firefox] 19:08:12 INFO - mkdir: /builds/slave/test/build/application 19:08:12 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'] 19:08:12 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 19:08:27 INFO - Reading from file tmpfile_stdout 19:08:27 INFO - Output received: 19:08:27 INFO - /builds/slave/test/build/application/firefox/firefox 19:08:27 INFO - Running post-action listener: _resource_record_post_action 19:08:27 INFO - ##### 19:08:27 INFO - ##### Finished install step (success) 19:08:27 INFO - ##### 19:08:27 INFO - ##### 19:08:27 INFO - ##### Running run-tests step. 19:08:27 INFO - ##### 19:08:27 INFO - Running pre-action listener: _resource_record_pre_action 19:08:27 INFO - Running main action method: run_tests 19:08:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:08:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:08:27 INFO - Python 2.7.3 19:08:27 INFO - Return code: 0 19:08:27 INFO - grabbing minidump binary from tooltool 19:08: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')]} 19:08:27 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 0x29461c0>, '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 0x29470c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2947550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:08:27 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 19:08:27 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 19:08:27 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 19:08:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:08:27 INFO - Return code: 0 19:08:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:08:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:08:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:08:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:08:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:08:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:08:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:08:28 INFO - Return code: 0 19:08:28 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/fgIu4NmDTTaf5NWKDiiBXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 19:08:28 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/fgIu4NmDTTaf5NWKDiiBXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 19:08:28 INFO - Using env: {'DISPLAY': ':0', 19:08:28 INFO - 'HOME': '/home/cltbld', 19:08:28 INFO - 'LANG': 'en_US.UTF-8', 19:08:28 INFO - 'LANGUAGE': 'en_US:en', 19:08:28 INFO - 'LOGNAME': 'cltbld', 19:08:28 INFO - 'MAIL': '/var/mail/cltbld', 19:08:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:08:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:08:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:28 INFO - 'MOZ_NO_REMOTE': '1', 19:08:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:08:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:28 INFO - 'NO_EM_RESTART': '1', 19:08:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:28 INFO - 'PWD': '/builds/slave/test', 19:08:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:08:28 INFO - 'SHELL': '/bin/bash', 19:08:28 INFO - 'SHLVL': '1', 19:08:28 INFO - 'TERM': 'linux', 19:08:28 INFO - 'TMOUT': '86400', 19:08:28 INFO - 'USER': 'cltbld', 19:08:28 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466646474.545788-1916508181', 19:08:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:28 INFO - '_': '/tools/buildbot/bin/python'} 19:08:28 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/fgIu4NmDTTaf5NWKDiiBXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 19:08:29 INFO - mozversion application_buildid: 20160622163024 19:08:29 INFO - mozversion application_changeset: 08127897283dd05ae78e32ed71ce727bdb39285c 19:08:29 INFO - mozversion application_display_name: FirefoxDeveloperEdition 19:08:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:08:29 INFO - mozversion application_name: Firefox 19:08:29 INFO - mozversion application_remotingname: firefox-dev 19:08:29 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:08:29 INFO - mozversion application_vendor: Mozilla 19:08:29 INFO - mozversion application_version: 49.0a2 19:08:29 INFO - mozversion platform_buildid: 20160622163024 19:08:29 INFO - mozversion platform_changeset: 08127897283dd05ae78e32ed71ce727bdb39285c 19:08:29 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:08:29 INFO - mozversion platform_version: 49.0a2 19:08:29 INFO - using testdate: 1466647709 19:08:29 INFO - actual date: 1466647709 19:08:29 INFO - starting webserver on 'localhost:51247' 19:08:29 INFO - SUITE-START | Running 2 tests 19:08:29 INFO - TEST-START | dromaeo_css 19:08:29 INFO - operating with platform_type : linux_ 19:08:29 INFO - Initialising browser for dromaeo_css test... 19:08:29 INFO - TEST-INFO | started process 5416 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpywy5GC/profile http://localhost:51247/getInfo.html) 19:08:33 INFO - PROCESS | 5416 | __metrics Screen width/height:1600/1200 19:08:33 INFO - PROCESS | 5416 | colorDepth:24 19:08:33 INFO - PROCESS | 5416 | Browser inner width/height: 1024/697 19:08:33 INFO - PROCESS | 5416 | __metrics 19:08:34 ERROR - PROCESS | 5416 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 19:08:35 INFO - TEST-INFO | 5416: exit 0 19:08:35 INFO - Browser initialized. 19:08:35 INFO - Running cycle 1/1 for dromaeo_css test... 19:08:35 INFO - TEST-INFO | started process 5543 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpywy5GC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:08:46 INFO - PROCESS | 5543 | RSS: Main: 156405760 19:08:46 INFO - PROCESS | 5543 | 19:09:36 INFO - PROCESS | 5543 | 1466647776359 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] 19:11:44 INFO - PROCESS | 5543 | Cycle 1(1): loaded http://localhost:51247/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51247/tests/dromaeo/cssquery-ext.html) 19:11:45 INFO - PROCESS | 5543 | RSS: Main: 160145408 19:11:45 INFO - PROCESS | 5543 | 19:14:47 INFO - PROCESS | 5543 | Cycle 1(1): loaded http://localhost:51247/tests/dromaeo/cssquery-ext.html (next: http://localhost:51247/tests/dromaeo/cssquery-jquery.html) 19:14:48 INFO - PROCESS | 5543 | RSS: Main: 157556736 19:14:48 INFO - PROCESS | 5543 | 19:17:50 INFO - PROCESS | 5543 | Cycle 1(1): loaded http://localhost:51247/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51247/tests/dromaeo/cssquery-mootools.html) 19:17:50 INFO - PROCESS | 5543 | RSS: Main: 157065216 19:17:50 INFO - PROCESS | 5543 | 19:20:52 INFO - PROCESS | 5543 | Cycle 1(1): loaded http://localhost:51247/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51247/tests/dromaeo/cssquery-prototype.html) 19:20:53 INFO - PROCESS | 5543 | RSS: Main: 157102080 19:20:53 INFO - PROCESS | 5543 | 19:23:55 INFO - PROCESS | 5543 | Cycle 1(1): loaded http://localhost:51247/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51247/tests/dromaeo/cssquery-yui.html) 19:23:56 INFO - PROCESS | 5543 | RSS: Main: 159043584 19:23:56 INFO - PROCESS | 5543 | 19:26:58 INFO - PROCESS | 5543 | Cycle 1(1): loaded http://localhost:51247/tests/dromaeo/cssquery-yui.html (next: http://localhost:51247/tests/dromaeo/cssquery-dojo.html) 19:26:58 INFO - PROCESS | 5543 | RSS: Main: 159477760 19:26:58 INFO - PROCESS | 5543 | 19:26:58 INFO - PROCESS | 5543 | __start_tp_report 19:26:58 INFO - PROCESS | 5543 | _x_x_mozilla_page_load 19:26:58 INFO - PROCESS | 5543 | _x_x_mozilla_page_load_details 19:26:58 INFO - PROCESS | 5543 | |i|pagename|runs| 19:26:58 INFO - PROCESS | 5543 | |0;dojo.html;3424.7088997435217;3472.8263586820653;3492.7904325740456;3499.685028347448;3502.6497350264976;5752.453516915892;5819.738111784969;5905.468507834299;5932.080527518231;5939.7921072762465;5885.32318783339;5904.675242861641;5932.851678708034;5941.613795103326;5989.341172471025;5306.177542480922;5371.113766228567;5399.757010934517;5439.3200849893765;5442.12925931851;5216.765245563959;5229.346331708536;5445.047116754552;5449.809256676017;5486.890262194754;5287.814926477574;5304.124819404813;5321.3348331458565;5343.118385466393;5387.730613469331;5327.653702509344;5391.218273350342;5401.297831281908;5412.025835349636;5431.755570999275;5189.870253243661;5275.894482110375;5321.600879934021;5350.464953504657;5362.195670649434;5642.238297829782;5698.344690360579;5730.169125476824;5787.797427090031;5792.275965504312;6307.779227727054;6334.113224148623;6336.524760642924;6346.904796428011;6350.841228969267;6168.25980882297;6266.310705822356;6350.110984462179;6403.103565500834;6407.8398040048905;5884.764609415618;5928.644281343133;5931.58478906481;5960.314563825129;5965.761369545213;6464.127342808754;6499.545031847725;6517.608943463408;6525.836854078686;6548.770793022317;6077.604955677955;6114.905704492704;6147.784827531015;6269.686515674198;6283.654399008098;6301.432871041537;6365.522585806083;6367.42693157618;6371.426571608485;6389.2652344980925;6310.1796766420075;6317;6318.7472501100365;6321.589096708699;6334.239891213084;6153.077038444179;6235.563510554218;6254.499640028877;6277.340879207709;6314.589551679126;4812.326274321597;4827.08285425768;4830.492798256203;4834.854954351375;4859.125357435625;4268.359746038119;4300.075483771005;4304.182205380967;4315.223259813264;4320.1143765527995;5800.216970708901;5909.2908850938165;5981.790637327673;6000.129981152709;6063.787767428119;6183.783567575113;6239.282482514569;6284.717187726564;6289.276733175743;6291.465225455888;6062;6082.148499210114;6108.1143234230785;6119.602225855305;6126.448619624166;5255.553277971415;5404.891902162013;5423.159410291411;5454.3454785426;5523.6409633373705;6587.077809106729;6645.202575690948;6658.667066646648;6670;6706.765263215764;6173.938260617516;6488.188976377953;6514.250861150934;6517.152770140041;6519.641419721961;6475.158229430144;6557.901631475436;6573.934260657524;6606.174228221473;6682.632455214815;6318.968405157945;6356.491480681442;6357.046443033397;6360.077788720702;6371.74513019474;6149.815505534841;6217.253929528486;6440.645764482999;6457.644829534421;6472.5145614080075;6106.358832322542;6185.628862268279;6257.56197066201;6274.152989346379;6276.340984196594;6188.752449902134;6242.781502647385;6252.374762523711;6272.09054687077;6279.71741271653;5952.345242023461;6008.579399442172;6013.609115407485;6197.101420293942;6207;6230.7507699693315;6239.594426362272;6248;6266;6272.40412160844;6064.211652485149;6089.086637004485;6100.0849872519475;6115.480184184395;6121.84695382619 19:26:58 INFO - PROCESS | 5543 | |1;ext.html;603.9758409663614;625.3121566277094;645.4803882874285;647.5046589359141;657.6120089147404;45442.77278613606;46658.06683866321;46973.76513117438;47027;50886.74556627212;46679.29981050279;47189.0562188756;47291;47323.290150647765;47413.28880066793;9314.580843862042;9439.103285187895;9470.66852660157;9480.715578532656;9490.383125096847;9253.167214950654;9253.259739220879;9255.537223138816;9329.860052099224;9331.393459425115;9316.534173291342;9346.485943273117;9400.482973436458;9425.104615061558;9435.103665151799;9235.538223088852;9242.445453272792;9263.305252106085;9306.929703084164;9400.529973501298;9206;9211.493367864765;9221.17009469151;9240.815183696288;9313.580888860017;45129;45146.32280515795;45277.54722452766;45278.77360613209;45284.547154528365;3459.4983727359645;3588.7129029677562;3627.854885804591;3641.3445579795625;3658.652428019334;34015.489767653504;34116;35046;35079.29841403183;35518.64481355179;4717.1980763269985;4817.494163112893;4854.514548545152;4891.877703057452;4933.062718083553;265215;265402.9999999981;266068;266256;267139;37076.25847483035;38077.428838567444;38388.232235355696;62718;63532.68233658802;38364.42453363202;38390;38531.22937541233;38584.80707596444;38690.80654596709;15450.459233926758;15588.142652154014;15599.766003509956;15608.14155221451;15612.375504979673;12560.623181304576;12585.24488530691;12593.496260149492;12626.55807046749;12628.368581570885;9297.72106836796;9304.767380815534;9348.1119293667;9368.484733339596;9446.669366572138;3496.3881320768764;3515.1721105025244;3566.233259849093;3571.1250743567994;3589.7128229741556;1076.9138468922467;1089.743910181107;1107.3521989635992;1172.6013155527162;1215.6899990502366;32625.673743262738;33391.833040835125;33406.164845878564;33560;33813.49279760806;1083.6803143072812;1118.3513562133942;1131.179894576442;1184.5261895241972;1214.7084699672191;16692.081935493665;16721.498355049367;16996.575085622957;17006.489805305613;17098.914505427394;619020;623711;625201;629270;635023;62591.374086259464;62984.37015629877;63119.36880631227;63156.68421657862;63171.36828631747;1427.215031732543;1433.5699290212895;1435.9138451692932;1455.7889106079558;1456.8907331950147;30756.077317680505;30976.84511577428;31375.686243137276;31715.84142079275;32238;52630.73684631706;53382.19926701025;53569.46430535801;53618.73190634022;53625;498670;504030;505647;506010;507423;30255;30700.232494187825;30930.53604195984;30950;31095;50525.74737126291;52711.472885270654;53220.73389633027;56446;57380.713096435924;43747.3514176451;44002.779986099864;44844.55155448404;45301.32048019217;45488.772556138334;42784;43814.56185438105;45010;45250;45899.311510326705;38994;43397;43632.78183609062;44645.55354446414;45265.09469810651;36065;38446.2310753789;39101.6089839098;39757;39889.601103988585;28793.280167995967;29031.85484072566;30302;30772.69227307788;32243.35513289674 19:26:58 INFO - PROCESS | 5543 | |2;jquery.html;425.29401194017936;426.3540735785286;429.52322921557044;431.335742955848;442.7918878127279;18387.264509419623;19472.415827525198;19720.90139549302;21055;21286.148554057858;18002.09989500523;18538.53653658659;18669.813301866976;18732.438026859218;18816.623667526674;5559.277293951791;5837.299524057098;5987.55093367997;5988.940110598882;5990.8801823963495;5848.736806843681;5885.49973252272;5926.081457374114;5938.346781853993;5949.970250148744;5675.3757086720425;5867.8533036674;5897.587168898179;5905.143754155645;5912.556558258127;5684.658920464785;5876.618019828718;5885.705714714269;5903.173555702205;5905.881882362329;5271.789128434858;5291.126964050927;5295.179247216687;5336;5336.786528538853;17932.282708691637;22089;22204.222852200095;23723.05107795686;23887.402814929766;2482.3049546127113;2555.7572030657057;2601.8308809927294;2842.1757690269797;2946.9410611787644;14708.705825883422;14872.851271487363;14999.550013499613;15038.097714137186;15083;2012.0945574491536;2054.815066644009;2077.2314243729766;2136.156218293781;2141.154244073582;62171.37828621701;77706;79304.60347698283;81652;82761;11151.107911367071;11432.657020289405;11588.478518466689;11748.177627565989;11794.351310677823;16367.427140050278;16462.094584797953;16502.2573984171;16537.255823487732;16562.917185413997;8226.218509241613;8396.118407567239;8399.580020999048;8500.74497765068;8602.483850968962;8007.639656215484;8008.439409241297;8052.396475901756;8157.67369305233;8175.305099066527;6999.510034297652;7014.438844892396;7047.577145371294;7105.076340075757;7115.644217789089;2094.9790502094784;2103.5161912759845;2112.7359080114984;2117.915283388678;2142.6678864775986;989.604158336671;1033.333499892565;1045.7385653586603;1075.3547871277171;1187.1927089578996;19642.508937276398;19973.900130499544;20182.596348072955;20504;20659.896700516703;1072.4798472740715;1079.400932482464;1109.0406798119568;1143.1654891928938;1171.2738102376582;10821.569678559255;11885.405729713653;11893.22694024903;11910.46402911871;11989.400529973467;512693;514606;527087;528920;536904;76592.61703691445;85566.57216713877;99542.50228748955;99801.50099249458;101668;1072.383379556758;1091.6997825597866;1109.0905457524752;1117.3631030312806;1121.243160866412;17748.55628609295;18153.364632237808;18182;18222.72665909986;18362.632747345244;43127.35308970305;45364.54635453603;45417.31874021958;45663;46101.07797843957;63323.6833815828;64141.35858641354;64563.67718161567;65983.34016659964;66067.33932660612;8613.870791938001;8640.956795215983;8739.868901966349;8897.644094236159;8979.865302020606;11106.833782452726;12858.164219325714;13398.330083495592;13649.727005460034;13716.794248086486;11695;12050.337231452355;12104.82113219629;12131.575394861138;12312.26126432417;11142.888571114185;11622;11670.066394688574;11689.88310116922;11956.103292252941;11778.234414763014;11783.175177737476;12049.698757531132;12330.63008109758;12381.876181238433;7577.962110189414;8633.223009929137;8840.867386989328;8912.86630700527;8946.37375383717;10176.440295783803;11776.234544754563;11860.169788115094;11942.701432464259;12133.69665758363 19:26:58 INFO - PROCESS | 5543 | |3;mootools.html;1610.1949025487256;1623.9188040597971;1862;1921.375552945293;1953.5799803042335;8339.416240863142;9404.670836520723;9592.376495527786;10253.077223049933;10260.435676037814;9737.367071140388;10077.899221007807;10135.49322533874;10141;10156.187504999582;2570.3445621366573;2607.9348016299555;2608.686957565095;2609.4128821015215;2611.4124322027487;2533.8226324157226;2604.0495219244935;2605.8957641694406;2607.4785042991384;2610.8172427930053;2577.098015694501;2597.2467984284535;2618.751218634227;2632.5919482480244;2640;2452.1172377943926;2498.675172227617;2589.184406911826;2590.7020692620404;2596.1302963507246;2480.838745481538;2499.0503608628605;2499.125306142854;2520.5841036229;2528.7850532704742;9783.119519243302;9978.700638980843;10004.449755263458;10019.799604007952;10021.348612340247;5726.79956201531;5850.970745146247;5874.148248503943;5878.882422351572;5882.029465138247;3751.3247615429486;3786.826083913968;3903.355946268862;3972.245273398074;4044.4539987101953;1271.1419791640606;1279.993600031994;1289.8129771183126;1312.875276848698;1341.0947610362966;14501.33234678015;14560.344784484618;14573.70852582953;14621.122732636077;14628.341724622418;5282.735863206901;5330.413654498002;5443.836684899459;5454.945450545523;5478;11929;12030.518779248732;12045.217060891015;12102.636920892388;12111.394430278451;5976.820695379146;5992.0712289595185;5997.610155339889;6015.037593984942;6019.578629495893;4690.882727931761;5323.680579165185;5374.48942350476;5488.259085023471;5491.148871924858;4571.062932098978;4586.220342541776;4599.931001034987;4663.953360466419;4810.037992401533;1453.5130731205165;1465.5237047959242;1467.6697743007737;1474.6903150338549;1489.2107183192925;836.824266903957;974.2400927276735;985.7042887133831;991.0386924683046;995.4823491784232;6164.660943648142;6319.873602528016;6450.419462248326;6458;6490.2536208335705;517.2164171280513;519.5350161605342;1062.3148069495287;1087.0977089016098;1093.4696672114019;4378.014946636981;4404.933925991113;4418.204723149864;4422.889427764331;4467.7319360838455;12545.121841471191;12764.489420423264;12852.293123878277;12853.421596028014;12962.675933101747;12129.87870121305;12503.937480312541;12546.937265313614;13015.609531714064;13021.934890325489;9077.228435583049;9278.67524636648;9307.11582399671;9374.390664606779;9399.90600094004;6285.96857015712;6502.317256687979;6537.249376397035;6655.567388119756;6685.997100434974;11509.53961841517;11748.118891083031;11825.467853946766;11869.169158158846;11934.880651193376;11700.648980530597;11950.641480755592;12009.099317551394;12071.336076515876;12312.445939932904;7317.26827317264;8051.677932882619;8284.212999765012;8352.665893364441;8491.405601608076;9613.423194608346;9620.422774633544;9643.951780241054;9678.95160524193;9752.366096203725;8308.70919517814;8428.831423371375;8531.061583225715;8589.613467393858;8599.22606965351;8061.87907181381;8176.591170441573;8372.497650141011;8439.578021099043;8472.788180295542;7359.411247100112;7414.740484083031;7512.5492470451945;7523.88714169277;7524.209957954336;5322.707251101072;5411.83764487066;5456.699881506555;5581.553475721851;5598.580106492111;5601.439856014529;5620.297462817148;5651.378348381757;5757.337906140848;5857.970710146422 19:26:58 INFO - PROCESS | 5543 | |4;prototype.html;348.18177283384034;348.75238580607765;349.08887802834596;352.01611495869076;353.7947990165703;5881.294244690633;5887.85280367991;5892.9705351473185;5909.468147866696;5982.611130276529;5765.423457654243;5778.59549831512;5794.188813566104;5798.492391978084;5821.970890145543;4164.29207034804;4466.8883277917985;4508.61676757476;4514.458265008204;4516.728996260218;4492.079123779634;4518.412606361168;4523.547645235483;4526.79629416677;4551.431071116111;4503.144402563519;4529.573184446888;4537.863864084083;4544.5682660147395;4575.611073058794;4344.131173765244;4459.910801783946;4496.145732310851;4514.864554063367;4515.480719717241;3890.3386424307937;3939.074317535377;3947.388154836005;3957.8021098945223;3968.6626636735914;5602.439756024406;5620.437956204388;5621.522170615503;5643.435656434323;5653.473562138241;4994.475580064113;5118.488151184889;5133.409657889353;5141.820036298749;5176.534111929945;5991.2325863870265;6057.545684073712;6090.360512146205;6095.299040610343;6135.570510064253;4329.7618630975285;4360.760158191299;4376.190404775095;4431.556844315575;4432.224360736858;6283.748650053993;6350.587211831216;6384.265809431929;6387.776427825004;6410.67946602668;4463.152001119842;4467.548046884775;4468.977655111768;4479.484859241164;4488.102379524108;4414.470263568328;4475.433598240655;4520.728756274634;4526.117407105648;4536;5098.08234517783;5128.717920514333;5134.127198376285;5142.845714628493;5156.458571849902;6022.5483088768515;6096.939030609726;6099.237595300588;6138.1713468681155;6147.262328520606;1522.444307827635;1552.2161308539116;1572.1746083306355;1579.518246934696;1584.2870708181365;1006.6828948881079;1006.9244806639531;1115.5537784885948;1124.6232512108372;1143.9771204576027;5819.82540523785;5913.822585322448;5936.851578710481;5992.820215393545;6002.309734380602;6087.147799308101;6200.751969921243;6221.906671399933;6261.373862613702;6280.654563999024;5779.543693930063;5844.707764611838;5893.469587737039;5933.795750294878;5977.073553599199;3259.5599594054975;3335.983320083433;3350.2964377481003;3368.7473439491646;3373.7807042542645;6184.907226391608;6377;6397.424231819158;6417.326180751047;6441.420272175526;6250.124982502453;6271.498280137578;6342.302346741854;6378.712957916812;6390.4248617624635;6173.876522469525;6418.646974416359;6487.22153341602;6493.188351456068;6642.27300901769;6325.936740632535;6355.491560675227;6356;6379.840503987251;6381.234251889803;5931.288245410406;6330.987042073246;6337.556371053982;6342.619442833445;6395.5203359747275;6490.740370385321;6525.967370163119;6526.641034743135;6558.409743123142;6597.373249541286;4305.138972205634;4329.783510824509;4347.478302603708;4352.368906508602;4378.562143785596;6032.4570788629235;6313.305536391085;6360.713767880549;6364.554481186273;6385.595169062799;6146.723397447215;6190.226221722285;6213.2233470816145;6216;6222.62664240147;6000.729967151401;6138.447539721446;6171.197744293393;6196.876062478816;6197.349278325892;5928.940710593011;6054.606450580698;6062.818115456544;6078.574499784972;6099.695015249308;6118.969405152946;6132.172156758959;6172.321044685171;6185.41238582334;6203.596766210182;5963.880722385441;6067.362926892612;6086.969565152146;6112.524427606826;6142.938570614237 19:26:58 INFO - PROCESS | 5543 | |5;yui.html;716.3051839715474;724.3770357492559;859.4113032572687;889.0842432294738;892.317377206437;14553;15145.545633630994;15168.848311516895;15206.923965380158;15209.847901520981;14229.857701422983;14239.216843073627;14371.568852934402;14394.424223031067;14408.063475874062;726.5640615630606;833.7040350675513;853.9743807685779;854.4275335525182;870.225499305617;854.692310768123;859.8237361340941;863.4301361101643;863.7063398444527;864.567716141929;903.1239697493421;907.3013779389865;911.1071150272737;911.8449863523217;913.0367462327242;903.5437104262338;903.8870141232346;904.2449554621833;904.2720609909021;907.1654078248027;664.4119953840885;666.540087339734;666.5400873397389;667.1560475997867;668.5554106519158;14567.635809104751;14639.780403293958;14680.119192848357;14680.412783488648;14759.114453132739;14202.85797142036;15259.542213733606;15350.155741434217;15370.538883833391;15509.922450387789;12393.318367489876;12409.937950310281;12485.50057997679;12703.809442858364;12746.362681865963;4798.640101992364;4810.735409552473;4824.734639594821;4827.300041493999;4865.099956508022;77333.61333193355;77611.6119419405;79804;80426;80539.19460805434;10873.456327183609;11327.5840519935;11388.373639449745;11598.536058557564;11718.94140529309;20293.086811093537;20349.186032558533;20377.083031263628;20378.388648340573;20902.790972090388;8765.948086229693;8938.50838203905;9006.63973441055;9063.91233052038;9081.500517471603;4995.100881841231;5092.796288148433;5137.588992880561;5144.6398752087;5265.078611243017;3761.153740408386;3930.390789427643;3933.252681990413;3940.9605903941165;3955.2287303976022;634.7302396481477;656.1044174701593;697.5326531224092;703.1737708192853;703.6094967293201;810.5784991804229;830.8961379827522;833.2459124492223;851.1148405658047;867.7657032601162;9891.258155638212;10439.37363758177;10471.37171769681;10494.475276236157;10536.68291463567;667.6194569095569;709.8651256261294;718.3606590134784;808.4785313472895;839.4291881520625;4898.240772680169;5023.572996295283;5058.898822023539;5134.717590532557;5198.532132108053;81232.59383703161;132409.33795331154;132487.33756331156;134201;135373;66558;68396.6580167096;98751.50624246833;114251;114265.4286728561;92651.53674231586;93546.53226733959;94335.056649434;95612.52193738987;100251.98992040382;9955.352902061633;9969;10048;10186.236032297458;10222.795544089226;44872.55127448814;47119.52880471152;52941.7352913233;54058.45941540534;56498;51647.483525164265;51854.74072629613;52022.739886300325;52070;67402.32597673961;13264.204147751167;13492.595222142958;13687.931560342135;14169;14173.43306267779;15013.699726005638;15281.770773438186;15407;15722.528324150293;16307.918460408097;13357.332133393485;13653.180809151483;13914.930425347808;13918.791218131939;14199.219042952736;13821.654458638615;13829.930850345683;13911.234882081582;13925.791113133513;14175.929120354333;11918.284902905853;12983.935080324916;13237.602871913858;13349.66625834362;13639.522616708367;11069.889301107209;11558.653240402802;11633.88366116328;11803.763924721286;11987.34069626144;11141;12061.939690301493;12065;12198.085143614442;12361.876381236072 19:26:58 INFO - PROCESS | 5543 | __end_tp_report 19:26:58 INFO - PROCESS | 5543 | __start_cc_report 19:26:58 INFO - PROCESS | 5543 | _x_x_mozilla_cycle_collect,343 19:26:58 INFO - PROCESS | 5543 | __end_cc_report 19:26:58 INFO - PROCESS | 5543 | __startTimestamp1466648818750__endTimestamp 19:26:58 INFO - PROCESS | 5543 | 19:26:58 INFO - PROCESS | 5543 | ------- Summary: start ------- 19:26:58 INFO - PROCESS | 5543 | Number of tests: 6 19:26:58 INFO - PROCESS | 5543 | 19:26:58 INFO - PROCESS | 5543 | [#0] dojo.html Cycles:165 Average:5882.31 Median:6115.48 stddev:677.99 (11.1%) stddev-sans-first:652.08 19:26:58 INFO - PROCESS | 5543 | Values: 3424.7 3472.8 3492.8 3499.7 3502.6 5752.5 5819.7 5905.5 5932.1 5939.8 5885.3 5904.7 5932.9 5941.6 5989.3 5306.2 5371.1 5399.8 5439.3 5442.1 5216.8 5229.3 5445.0 5449.8 5486.9 5287.8 5304.1 5321.3 5343.1 5387.7 5327.7 5391.2 5401.3 5412.0 5431.8 5189.9 5275.9 5321.6 5350.5 5362.2 5642.2 5698.3 5730.2 5787.8 5792.3 6307.8 6334.1 6336.5 6346.9 6350.8 6168.3 6266.3 6350.1 6403.1 6407.8 5884.8 5928.6 5931.6 5960.3 5965.8 6464.1 6499.5 6517.6 6525.8 6548.8 6077.6 6114.9 6147.8 6269.7 6283.7 6301.4 6365.5 6367.4 6371.4 6389.3 6310.2 6317.0 6318.7 6321.6 6334.2 6153.1 6235.6 6254.5 6277.3 6314.6 4812.3 4827.1 4830.5 4834.9 4859.1 4268.4 4300.1 4304.2 4315.2 4320.1 5800.2 5909.3 5981.8 6000.1 6063.8 6183.8 6239.3 6284.7 6289.3 6291.5 6062.0 6082.1 6108.1 6119.6 6126.4 5255.6 5404.9 5423.2 5454.3 5523.6 6587.1 6645.2 6658.7 6670.0 6706.8 6173.9 6488.2 6514.3 6517.2 6519.6 6475.2 6557.9 6573.9 6606.2 6682.6 6319.0 6356.5 6357.0 6360.1 6371.7 6149.8 6217.3 6440.6 6457.6 6472.5 6106.4 6185.6 6257.6 6274.2 6276.3 6188.8 6242.8 6252.4 6272.1 6279.7 5952.3 6008.6 6013.6 6197.1 6207.0 6230.8 6239.6 6248.0 6266.0 6272.4 6064.2 6089.1 6100.1 6115.5 6121.8 19:26:58 INFO - PROCESS | 5543 | 19:26:58 INFO - PROCESS | 5543 | [#1] ext.html Cycles:180 Average:62292.51 Median:44745.05 stddev:130737.75 (292.2%) stddev-sans-first:131022.46 19:26:58 INFO - PROCESS | 5543 | Values: 604.0 625.3 645.5 647.5 657.6 45442.8 46658.1 46973.8 47027.0 50886.7 46679.3 47189.1 47291.0 47323.3 47413.3 9314.6 9439.1 9470.7 9480.7 9490.4 9253.2 9253.3 9255.5 9329.9 9331.4 9316.5 9346.5 9400.5 9425.1 9435.1 9235.5 9242.4 9263.3 9306.9 9400.5 9206.0 9211.5 9221.2 9240.8 9313.6 45129.0 45146.3 45277.5 45278.8 45284.5 3459.5 3588.7 3627.9 3641.3 3658.7 34015.5 34116.0 35046.0 35079.3 35518.6 4717.2 4817.5 4854.5 4891.9 4933.1 265215.0 265403.0 266068.0 266256.0 267139.0 37076.3 38077.4 38388.2 62718.0 63532.7 38364.4 38390.0 38531.2 38584.8 38690.8 15450.5 15588.1 15599.8 15608.1 15612.4 12560.6 12585.2 12593.5 12626.6 12628.4 9297.7 9304.8 9348.1 9368.5 9446.7 3496.4 3515.2 3566.2 3571.1 3589.7 1076.9 1089.7 1107.4 1172.6 1215.7 32625.7 33391.8 33406.2 33560.0 33813.5 1083.7 1118.4 1131.2 1184.5 1214.7 16692.1 16721.5 16996.6 17006.5 17098.9 619020.0 623711.0 625201.0 629270.0 635023.0 62591.4 62984.4 63119.4 63156.7 63171.4 1427.2 1433.6 1435.9 1455.8 1456.9 30756.1 30976.8 31375.7 31715.8 32238.0 52630.7 53382.2 53569.5 53618.7 53625.0 498670.0 504030.0 505647.0 506010.0 507423.0 30255.0 30700.2 30930.5 30950.0 31095.0 50525.7 52711.5 53220.7 56446.0 57380.7 43747.4 44002.8 44844.6 45301.3 45488.8 42784.0 43814.6 45010.0 45250.0 45899.3 38994.0 43397.0 43632.8 44645.6 45265.1 36065.0 38446.2 39101.6 39757.0 39889.6 28793.3 29031.9 30302.0 30772.7 32243.4 19:26:58 INFO - PROCESS | 5543 | 19:26:58 INFO - PROCESS | 5543 | [#2] jquery.html Cycles:180 Average:30483.84 Median:12115.83 stddev:86214.14 (711.6%) stddev-sans-first:86426.45 19:26:58 INFO - PROCESS | 5543 | Values: 425.3 426.4 429.5 431.3 442.8 18387.3 19472.4 19720.9 21055.0 21286.1 18002.1 18538.5 18669.8 18732.4 18816.6 5559.3 5837.3 5987.6 5988.9 5990.9 5848.7 5885.5 5926.1 5938.3 5950.0 5675.4 5867.9 5897.6 5905.1 5912.6 5684.7 5876.6 5885.7 5903.2 5905.9 5271.8 5291.1 5295.2 5336.0 5336.8 17932.3 22089.0 22204.2 23723.1 23887.4 2482.3 2555.8 2601.8 2842.2 2946.9 14708.7 14872.9 14999.6 15038.1 15083.0 2012.1 2054.8 2077.2 2136.2 2141.2 62171.4 77706.0 79304.6 81652.0 82761.0 11151.1 11432.7 11588.5 11748.2 11794.4 16367.4 16462.1 16502.3 16537.3 16562.9 8226.2 8396.1 8399.6 8500.7 8602.5 8007.6 8008.4 8052.4 8157.7 8175.3 6999.5 7014.4 7047.6 7105.1 7115.6 2095.0 2103.5 2112.7 2117.9 2142.7 989.6 1033.3 1045.7 1075.4 1187.2 19642.5 19973.9 20182.6 20504.0 20659.9 1072.5 1079.4 1109.0 1143.2 1171.3 10821.6 11885.4 11893.2 11910.5 11989.4 512693.0 514606.0 527087.0 528920.0 536904.0 76592.6 85566.6 99542.5 99801.5 101668.0 1072.4 1091.7 1109.1 1117.4 1121.2 17748.6 18153.4 18182.0 18222.7 18362.6 43127.4 45364.5 45417.3 45663.0 46101.1 63323.7 64141.4 64563.7 65983.3 66067.3 8613.9 8641.0 8739.9 8897.6 8979.9 11106.8 12858.2 13398.3 13649.7 13716.8 11695.0 12050.3 12104.8 12131.6 12312.3 11142.9 11622.0 11670.1 11689.9 11956.1 11778.2 11783.2 12049.7 12330.6 12381.9 7578.0 8633.2 8840.9 8912.9 8946.4 10176.4 11776.2 11860.2 11942.7 12133.7 19:26:58 INFO - PROCESS | 5543 | 19:26:58 INFO - PROCESS | 5543 | [#3] mootools.html Cycles:180 Average:6542.39 Median:4445.31 stddev:3844.57 (86.5%) stddev-sans-first:3837.49 19:26:58 INFO - PROCESS | 5543 | Values: 1610.2 1623.9 1862.0 1921.4 1953.6 8339.4 9404.7 9592.4 10253.1 10260.4 9737.4 10077.9 10135.5 10141.0 10156.2 2570.3 2607.9 2608.7 2609.4 2611.4 2533.8 2604.0 2605.9 2607.5 2610.8 2577.1 2597.2 2618.8 2632.6 2640.0 2452.1 2498.7 2589.2 2590.7 2596.1 2480.8 2499.1 2499.1 2520.6 2528.8 9783.1 9978.7 10004.4 10019.8 10021.3 5726.8 5851.0 5874.1 5878.9 5882.0 3751.3 3786.8 3903.4 3972.2 4044.5 1271.1 1280.0 1289.8 1312.9 1341.1 14501.3 14560.3 14573.7 14621.1 14628.3 5282.7 5330.4 5443.8 5454.9 5478.0 11929.0 12030.5 12045.2 12102.6 12111.4 5976.8 5992.1 5997.6 6015.0 6019.6 4690.9 5323.7 5374.5 5488.3 5491.1 4571.1 4586.2 4599.9 4664.0 4810.0 1453.5 1465.5 1467.7 1474.7 1489.2 836.8 974.2 985.7 991.0 995.5 6164.7 6319.9 6450.4 6458.0 6490.3 517.2 519.5 1062.3 1087.1 1093.5 4378.0 4404.9 4418.2 4422.9 4467.7 12545.1 12764.5 12852.3 12853.4 12962.7 12129.9 12503.9 12546.9 13015.6 13021.9 9077.2 9278.7 9307.1 9374.4 9399.9 6286.0 6502.3 6537.2 6655.6 6686.0 11509.5 11748.1 11825.5 11869.2 11934.9 11700.6 11950.6 12009.1 12071.3 12312.4 7317.3 8051.7 8284.2 8352.7 8491.4 9613.4 9620.4 9644.0 9679.0 9752.4 8308.7 8428.8 8531.1 8589.6 8599.2 8061.9 8176.6 8372.5 8439.6 8472.8 7359.4 7414.7 7512.5 7523.9 7524.2 5322.7 5411.8 5456.7 5581.6 5598.6 5601.4 5620.3 5651.4 5757.3 5858.0 19:26:58 INFO - PROCESS | 5543 | 19:26:58 INFO - PROCESS | 5543 | [#4] prototype.html Cycles:180 Average:5146.77 Median:5893.22 stddev:1524.66 (25.9%) stddev-sans-first:1485.79 19:26:58 INFO - PROCESS | 5543 | Values: 348.2 348.8 349.1 352.0 353.8 5881.3 5887.9 5893.0 5909.5 5982.6 5765.4 5778.6 5794.2 5798.5 5822.0 4164.3 4466.9 4508.6 4514.5 4516.7 4492.1 4518.4 4523.5 4526.8 4551.4 4503.1 4529.6 4537.9 4544.6 4575.6 4344.1 4459.9 4496.1 4514.9 4515.5 3890.3 3939.1 3947.4 3957.8 3968.7 5602.4 5620.4 5621.5 5643.4 5653.5 4994.5 5118.5 5133.4 5141.8 5176.5 5991.2 6057.5 6090.4 6095.3 6135.6 4329.8 4360.8 4376.2 4431.6 4432.2 6283.7 6350.6 6384.3 6387.8 6410.7 4463.2 4467.5 4469.0 4479.5 4488.1 4414.5 4475.4 4520.7 4526.1 4536.0 5098.1 5128.7 5134.1 5142.8 5156.5 6022.5 6096.9 6099.2 6138.2 6147.3 1522.4 1552.2 1572.2 1579.5 1584.3 1006.7 1006.9 1115.6 1124.6 1144.0 5819.8 5913.8 5936.9 5992.8 6002.3 6087.1 6200.8 6221.9 6261.4 6280.7 5779.5 5844.7 5893.5 5933.8 5977.1 3259.6 3336.0 3350.3 3368.7 3373.8 6184.9 6377.0 6397.4 6417.3 6441.4 6250.1 6271.5 6342.3 6378.7 6390.4 6173.9 6418.6 6487.2 6493.2 6642.3 6325.9 6355.5 6356.0 6379.8 6381.2 5931.3 6331.0 6337.6 6342.6 6395.5 6490.7 6526.0 6526.6 6558.4 6597.4 4305.1 4329.8 4347.5 4352.4 4378.6 6032.5 6313.3 6360.7 6364.6 6385.6 6146.7 6190.2 6213.2 6216.0 6222.6 6000.7 6138.4 6171.2 6196.9 6197.3 5928.9 6054.6 6062.8 6078.6 6099.7 6119.0 6132.2 6172.3 6185.4 6203.6 5963.9 6067.4 6087.0 6112.5 6142.9 19:26:58 INFO - PROCESS | 5543 | 19:26:58 INFO - PROCESS | 5543 | [#5] yui.html Cycles:180 Average:20803.26 Median:25959.08 stddev:30496.44 (117.5%) stddev-sans-first:30544.69 19:26:58 INFO - PROCESS | 5543 | Values: 716.3 724.4 859.4 889.1 892.3 14553.0 15145.5 15168.8 15206.9 15209.8 14229.9 14239.2 14371.6 14394.4 14408.1 726.6 833.7 854.0 854.4 870.2 854.7 859.8 863.4 863.7 864.6 903.1 907.3 911.1 911.8 913.0 903.5 903.9 904.2 904.3 907.2 664.4 666.5 666.5 667.2 668.6 14567.6 14639.8 14680.1 14680.4 14759.1 14202.9 15259.5 15350.2 15370.5 15509.9 12393.3 12409.9 12485.5 12703.8 12746.4 4798.6 4810.7 4824.7 4827.3 4865.1 77333.6 77611.6 79804.0 80426.0 80539.2 10873.5 11327.6 11388.4 11598.5 11718.9 20293.1 20349.2 20377.1 20378.4 20902.8 8765.9 8938.5 9006.6 9063.9 9081.5 4995.1 5092.8 5137.6 5144.6 5265.1 3761.2 3930.4 3933.3 3941.0 3955.2 634.7 656.1 697.5 703.2 703.6 810.6 830.9 833.2 851.1 867.8 9891.3 10439.4 10471.4 10494.5 10536.7 667.6 709.9 718.4 808.5 839.4 4898.2 5023.6 5058.9 5134.7 5198.5 81232.6 132409.3 132487.3 134201.0 135373.0 66558.0 68396.7 98751.5 114251.0 114265.4 92651.5 93546.5 94335.1 95612.5 100252.0 9955.4 9969.0 10048.0 10186.2 10222.8 44872.6 47119.5 52941.7 54058.5 56498.0 51647.5 51854.7 52022.7 52070.0 67402.3 13264.2 13492.6 13687.9 14169.0 14173.4 15013.7 15281.8 15407.0 15722.5 16307.9 13357.3 13653.2 13914.9 13918.8 14199.2 13821.7 13829.9 13911.2 13925.8 14175.9 11918.3 12983.9 13237.6 13349.7 13639.5 11069.9 11558.7 11633.9 11803.8 11987.3 11141.0 12061.9 12065.0 12198.1 12361.9 19:26:58 INFO - PROCESS | 5543 | -------- Summary: end -------- 19:26:58 INFO - PROCESS | 5543 | 19:26:59 INFO - TEST-INFO | 5543: exit 0 19:26:59 INFO - TEST-OK | dromaeo_css | took 1110283ms 19:26:59 INFO - TEST-START | kraken 19:26:59 INFO - operating with platform_type : linux_ 19:26:59 INFO - Initialising browser for kraken test... 19:26:59 INFO - TEST-INFO | started process 5794 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFz4agz/profile http://localhost:51247/getInfo.html) 19:27:03 INFO - PROCESS | 5794 | __metrics Screen width/height:1600/1200 19:27:03 INFO - PROCESS | 5794 | colorDepth:24 19:27:03 INFO - PROCESS | 5794 | Browser inner width/height: 1024/697 19:27:03 INFO - PROCESS | 5794 | __metrics 19:27:04 ERROR - PROCESS | 5794 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 19:27:05 INFO - TEST-INFO | 5794: exit 0 19:27:05 INFO - Browser initialized. 19:27:05 INFO - Running cycle 1/1 for kraken test... 19:27:05 INFO - TEST-INFO | started process 5922 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFz4agz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:27:16 INFO - PROCESS | 5922 | RSS: Main: 156225536 19:27:16 INFO - PROCESS | 5922 | 19:27:19 INFO - PROCESS | 5922 | Cycle 1(1): loaded http://localhost:51247/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51247/tests/kraken/driver.html?testName=audio-beat-detection) 19:27:20 INFO - PROCESS | 5922 | RSS: Main: 161828864 19:27:20 INFO - PROCESS | 5922 | 19:27:22 INFO - PROCESS | 5922 | Cycle 1(1): loaded http://localhost:51247/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51247/tests/kraken/driver.html?testName=audio-dft) 19:27:23 INFO - PROCESS | 5922 | RSS: Main: 160817152 19:27:23 INFO - PROCESS | 5922 | 19:27:26 INFO - PROCESS | 5922 | Cycle 1(1): loaded http://localhost:51247/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51247/tests/kraken/driver.html?testName=audio-fft) 19:27:26 INFO - PROCESS | 5922 | RSS: Main: 161222656 19:27:26 INFO - PROCESS | 5922 | 19:27:29 INFO - PROCESS | 5922 | Cycle 1(1): loaded http://localhost:51247/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51247/tests/kraken/driver.html?testName=audio-oscillator) 19:27:29 INFO - PROCESS | 5922 | RSS: Main: 161091584 19:27:29 INFO - PROCESS | 5922 | 19:27:31 INFO - PROCESS | 5922 | Cycle 1(1): loaded http://localhost:51247/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51247/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:27:32 INFO - PROCESS | 5922 | RSS: Main: 161214464 19:27:32 INFO - PROCESS | 5922 | 19:27:35 INFO - PROCESS | 5922 | Cycle 1(1): loaded http://localhost:51247/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51247/tests/kraken/driver.html?testName=imaging-darkroom) 19:27:36 INFO - PROCESS | 5922 | RSS: Main: 160792576 19:27:36 INFO - PROCESS | 5922 | 19:27:39 INFO - PROCESS | 5922 | Cycle 1(1): loaded http://localhost:51247/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51247/tests/kraken/driver.html?testName=imaging-desaturate) 19:27:40 INFO - PROCESS | 5922 | RSS: Main: 161742848 19:27:40 INFO - PROCESS | 5922 | 19:27:42 INFO - PROCESS | 5922 | Cycle 1(1): loaded http://localhost:51247/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51247/tests/kraken/driver.html?testName=json-parse-financial) 19:27:43 INFO - PROCESS | 5922 | RSS: Main: 161644544 19:27:43 INFO - PROCESS | 5922 | 19:27:45 INFO - PROCESS | 5922 | Cycle 1(1): loaded http://localhost:51247/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51247/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:27:45 INFO - PROCESS | 5922 | RSS: Main: 161185792 19:27:45 INFO - PROCESS | 5922 | 19:27:47 INFO - PROCESS | 5922 | Cycle 1(1): loaded http://localhost:51247/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51247/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:27:48 INFO - PROCESS | 5922 | RSS: Main: 161439744 19:27:48 INFO - PROCESS | 5922 | 19:27:50 INFO - PROCESS | 5922 | Cycle 1(1): loaded http://localhost:51247/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51247/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:27:50 INFO - PROCESS | 5922 | RSS: Main: 161640448 19:27:50 INFO - PROCESS | 5922 | 19:27:53 INFO - PROCESS | 5922 | Cycle 1(1): loaded http://localhost:51247/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:27:53 INFO - PROCESS | 5922 | RSS: Main: 161861632 19:27:53 INFO - PROCESS | 5922 | 19:27:56 INFO - PROCESS | 5922 | Cycle 1(1): loaded http://localhost:51247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:27:57 INFO - PROCESS | 5922 | RSS: Main: 161648640 19:27:57 INFO - PROCESS | 5922 | 19:27:58 INFO - PROCESS | 5922 | Cycle 1(1): loaded http://localhost:51247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51247/tests/kraken/driver.html?testName=ai-astar) 19:27:59 INFO - PROCESS | 5922 | RSS: Main: 162430976 19:27:59 INFO - PROCESS | 5922 | 19:27:59 INFO - PROCESS | 5922 | __start_tp_report 19:27:59 INFO - PROCESS | 5922 | _x_x_mozilla_page_load 19:27:59 INFO - PROCESS | 5922 | _x_x_mozilla_page_load_details 19:27:59 INFO - PROCESS | 5922 | |i|pagename|runs| 19:27:59 INFO - PROCESS | 5922 | |0;ai-astar;111;104;109;109;109;112;110;107;109;110 19:27:59 INFO - PROCESS | 5922 | |1;audio-beat-detection;152;124;156;181;126;157;150;128;191;124 19:27:59 INFO - PROCESS | 5922 | |2;audio-dft;162;163;163;162;161;164;163;162;163;162 19:27:59 INFO - PROCESS | 5922 | |3;audio-fft;75;74;77;182;76;76;74;76;166;75 19:27:59 INFO - PROCESS | 5922 | |4;audio-oscillator;85;84;150;85;84;84;142;85;85;138 19:27:59 INFO - PROCESS | 5922 | |5;imaging-gaussian-blur;118;117;117;117;118;118;118;118;117;117 19:27:59 INFO - PROCESS | 5922 | |6;imaging-darkroom;146;147;146;146;146;148;146;147;146;147 19:27:59 INFO - PROCESS | 5922 | |7;imaging-desaturate;95;95;95;95;96;95;95;95;94;95 19:27:59 INFO - PROCESS | 5922 | |8;json-parse-financial;56;52;53;52;53;55;54;57;53;54 19:27:59 INFO - PROCESS | 5922 | |9;json-stringify-tinderbox;61;61;61;61;61;62;61;61;61;61 19:27:59 INFO - PROCESS | 5922 | |10;stanford-crypto-aes;75;77;76;77;77;78;84;76;109;78 19:27:59 INFO - PROCESS | 5922 | |11;stanford-crypto-ccm;132;116;115;116;126;114;126;126;132;121 19:27:59 INFO - PROCESS | 5922 | |12;stanford-crypto-pbkdf2;150;151;148;150;164;158;151;149;153;148 19:27:59 INFO - PROCESS | 5922 | |13;stanford-crypto-sha256-iterative;62;61;62;65;61;60;63;61;61;62 19:27:59 INFO - PROCESS | 5922 | __end_tp_report 19:27:59 INFO - PROCESS | 5922 | __start_cc_report 19:27:59 INFO - PROCESS | 5922 | _x_x_mozilla_cycle_collect,872 19:27:59 INFO - PROCESS | 5922 | __end_cc_report 19:27:59 INFO - PROCESS | 5922 | __startTimestamp1466648879031__endTimestamp 19:27:59 INFO - PROCESS | 5922 | 19:27:59 INFO - PROCESS | 5922 | ------- Summary: start ------- 19:27:59 INFO - PROCESS | 5922 | Number of tests: 14 19:27:59 INFO - PROCESS | 5922 | 19:27:59 INFO - PROCESS | 5922 | [#0] ai-astar Cycles:10 Average:109.00 Median:109.50 stddev:2.21 (2.0%) stddev-sans-first:2.22 19:27:59 INFO - PROCESS | 5922 | Values: 111.0 104.0 109.0 109.0 109.0 112.0 110.0 107.0 109.0 110.0 19:27:59 INFO - PROCESS | 5922 | 19:27:59 INFO - PROCESS | 5922 | [#1] audio-beat-detection Cycles:10 Average:148.90 Median:154.00 stddev:23.88 (15.5%) stddev-sans-first:25.30 19:27:59 INFO - PROCESS | 5922 | Values: 152.0 124.0 156.0 181.0 126.0 157.0 150.0 128.0 191.0 124.0 19:27:59 INFO - PROCESS | 5922 | 19:27:59 INFO - PROCESS | 5922 | [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 19:27:59 INFO - PROCESS | 5922 | Values: 162.0 163.0 163.0 162.0 161.0 164.0 163.0 162.0 163.0 162.0 19:27:59 INFO - PROCESS | 5922 | 19:27:59 INFO - PROCESS | 5922 | [#3] audio-fft Cycles:10 Average:95.10 Median:75.50 stddev:41.77 (55.3%) stddev-sans-first:43.66 19:27:59 INFO - PROCESS | 5922 | Values: 75.0 74.0 77.0 182.0 76.0 76.0 74.0 76.0 166.0 75.0 19:27:59 INFO - PROCESS | 5922 | 19:27:59 INFO - PROCESS | 5922 | [#4] audio-oscillator Cycles:10 Average:102.20 Median:84.50 stddev:28.53 (33.8%) stddev-sans-first:29.58 19:27:59 INFO - PROCESS | 5922 | Values: 85.0 84.0 150.0 85.0 84.0 84.0 142.0 85.0 85.0 138.0 19:27:59 INFO - PROCESS | 5922 | 19:27:59 INFO - PROCESS | 5922 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 19:27:59 INFO - PROCESS | 5922 | Values: 118.0 117.0 117.0 117.0 118.0 118.0 118.0 118.0 117.0 117.0 19:27:59 INFO - PROCESS | 5922 | 19:27:59 INFO - PROCESS | 5922 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 19:27:59 INFO - PROCESS | 5922 | Values: 146.0 147.0 146.0 146.0 146.0 148.0 146.0 147.0 146.0 147.0 19:27:59 INFO - PROCESS | 5922 | 19:27:59 INFO - PROCESS | 5922 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 19:27:59 INFO - PROCESS | 5922 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 94.0 95.0 19:27:59 INFO - PROCESS | 5922 | 19:27:59 INFO - PROCESS | 5922 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:1.66 (3.1%) stddev-sans-first:1.58 19:27:59 INFO - PROCESS | 5922 | Values: 56.0 52.0 53.0 52.0 53.0 55.0 54.0 57.0 53.0 54.0 19:27:59 INFO - PROCESS | 5922 | 19:27:59 INFO - PROCESS | 5922 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 19:27:59 INFO - PROCESS | 5922 | Values: 61.0 61.0 61.0 61.0 61.0 62.0 61.0 61.0 61.0 61.0 19:27:59 INFO - PROCESS | 5922 | 19:27:59 INFO - PROCESS | 5922 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:77.00 stddev:10.24 (13.3%) stddev-sans-first:10.65 19:27:59 INFO - PROCESS | 5922 | Values: 75.0 77.0 76.0 77.0 77.0 78.0 84.0 76.0 109.0 78.0 19:27:59 INFO - PROCESS | 5922 | 19:27:59 INFO - PROCESS | 5922 | [#11] stanford-crypto-ccm Cycles:10 Average:122.40 Median:126.00 stddev:6.93 (5.5%) stddev-sans-first:6.42 19:27:59 INFO - PROCESS | 5922 | Values: 132.0 116.0 115.0 116.0 126.0 114.0 126.0 126.0 132.0 121.0 19:27:59 INFO - PROCESS | 5922 | 19:27:59 INFO - PROCESS | 5922 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.20 Median:151.00 stddev:5.07 (3.4%) stddev-sans-first:5.32 19:27:59 INFO - PROCESS | 5922 | Values: 150.0 151.0 148.0 150.0 164.0 158.0 151.0 149.0 153.0 148.0 19:27:59 INFO - PROCESS | 5922 | 19:27:59 INFO - PROCESS | 5922 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.80 Median:62.00 stddev:1.40 (2.3%) stddev-sans-first:1.48 19:27:59 INFO - PROCESS | 5922 | Values: 62.0 61.0 62.0 65.0 61.0 60.0 63.0 61.0 61.0 62.0 19:27:59 INFO - PROCESS | 5922 | -------- Summary: end -------- 19:27:59 INFO - PROCESS | 5922 | 19:27:59 INFO - TEST-INFO | 5922: exit 0 19:27:59 INFO - TEST-OK | kraken | took 60523ms 19:27:59 INFO - SUITE-END | took 1170s 19:28:00 INFO - Completed test suite (00:19:31) 19:28:00 INFO - javascript benchmark 19:28:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7731.479513784229, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3424.7088997435217, 3472.8263586820653, 3492.7904325740456, 3499.685028347448, 3502.6497350264976, 5752.453516915892, 5819.738111784969, 5905.468507834299, 5932.080527518231, 5939.7921072762465, 5885.32318783339, 5904.675242861641, 5932.851678708034, 5941.613795103326, 5989.341172471025, 5306.177542480922, 5371.113766228567, 5399.757010934517, 5439.3200849893765, 5442.12925931851, 5216.765245563959, 5229.346331708536, 5445.047116754552, 5449.809256676017, 5486.890262194754, 5287.814926477574, 5304.124819404813, 5321.3348331458565, 5343.118385466393, 5387.730613469331, 5327.653702509344, 5391.218273350342, 5401.297831281908, 5412.025835349636, 5431.755570999275, 5189.870253243661, 5275.894482110375, 5321.600879934021, 5350.464953504657, 5362.195670649434, 5642.238297829782, 5698.344690360579, 5730.169125476824, 5787.797427090031, 5792.275965504312, 6307.779227727054, 6334.113224148623, 6336.524760642924, 6346.904796428011, 6350.841228969267, 6168.25980882297, 6266.310705822356, 6350.110984462179, 6403.103565500834, 6407.8398040048905, 5884.764609415618, 5928.644281343133, 5931.58478906481, 5960.314563825129, 5965.761369545213, 6464.127342808754, 6499.545031847725, 6517.608943463408, 6525.836854078686, 6548.770793022317, 6077.604955677955, 6114.905704492704, 6147.784827531015, 6269.686515674198, 6283.654399008098, 6301.432871041537, 6365.522585806083, 6367.42693157618, 6371.426571608485, 6389.2652344980925, 6310.1796766420075, 6317.0, 6318.7472501100365, 6321.589096708699, 6334.239891213084, 6153.077038444179, 6235.563510554218, 6254.499640028877, 6277.340879207709, 6314.589551679126, 4812.326274321597, 4827.08285425768, 4830.492798256203, 4834.854954351375, 4859.125357435625, 4268.359746038119, 4300.075483771005, 4304.182205380967, 4315.223259813264, 4320.1143765527995, 5800.216970708901, 5909.2908850938165, 5981.790637327673, 6000.129981152709, 6063.787767428119, 6183.783567575113, 6239.282482514569, 6284.717187726564, 6289.276733175743, 6291.465225455888, 6062.0, 6082.148499210114, 6108.1143234230785, 6119.602225855305, 6126.448619624166, 5255.553277971415, 5404.891902162013, 5423.159410291411, 5454.3454785426, 5523.6409633373705, 6587.077809106729, 6645.202575690948, 6658.667066646648, 6670.0, 6706.765263215764, 6173.938260617516, 6488.188976377953, 6514.250861150934, 6517.152770140041, 6519.641419721961, 6475.158229430144, 6557.901631475436, 6573.934260657524, 6606.174228221473, 6682.632455214815, 6318.968405157945, 6356.491480681442, 6357.046443033397, 6360.077788720702, 6371.74513019474, 6149.815505534841, 6217.253929528486, 6440.645764482999, 6457.644829534421, 6472.5145614080075, 6106.358832322542, 6185.628862268279, 6257.56197066201, 6274.152989346379, 6276.340984196594, 6188.752449902134, 6242.781502647385, 6252.374762523711, 6272.09054687077, 6279.71741271653, 5952.345242023461, 6008.579399442172, 6013.609115407485, 6197.101420293942, 6207.0, 6230.7507699693315, 6239.594426362272, 6248.0, 6266.0, 6272.40412160844, 6064.211652485149, 6089.086637004485, 6100.0849872519475, 6115.480184184395, 6121.84695382619], "value": 5836.554331783309, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.9758409663614, 625.3121566277094, 645.4803882874285, 647.5046589359141, 657.6120089147404, 45442.77278613606, 46658.06683866321, 46973.76513117438, 47027.0, 50886.74556627212, 46679.29981050279, 47189.0562188756, 47291.0, 47323.290150647765, 47413.28880066793, 9314.580843862042, 9439.103285187895, 9470.66852660157, 9480.715578532656, 9490.383125096847, 9253.167214950654, 9253.259739220879, 9255.537223138816, 9329.860052099224, 9331.393459425115, 9316.534173291342, 9346.485943273117, 9400.482973436458, 9425.104615061558, 9435.103665151799, 9235.538223088852, 9242.445453272792, 9263.305252106085, 9306.929703084164, 9400.529973501298, 9206.0, 9211.493367864765, 9221.17009469151, 9240.815183696288, 9313.580888860017, 45129.0, 45146.32280515795, 45277.54722452766, 45278.77360613209, 45284.547154528365, 3459.4983727359645, 3588.7129029677562, 3627.854885804591, 3641.3445579795625, 3658.652428019334, 34015.489767653504, 34116.0, 35046.0, 35079.29841403183, 35518.64481355179, 4717.1980763269985, 4817.494163112893, 4854.514548545152, 4891.877703057452, 4933.062718083553, 265215.0, 265402.9999999981, 266068.0, 266256.0, 267139.0, 37076.25847483035, 38077.428838567444, 38388.232235355696, 62718.0, 63532.68233658802, 38364.42453363202, 38390.0, 38531.22937541233, 38584.80707596444, 38690.80654596709, 15450.459233926758, 15588.142652154014, 15599.766003509956, 15608.14155221451, 15612.375504979673, 12560.623181304576, 12585.24488530691, 12593.496260149492, 12626.55807046749, 12628.368581570885, 9297.72106836796, 9304.767380815534, 9348.1119293667, 9368.484733339596, 9446.669366572138, 3496.3881320768764, 3515.1721105025244, 3566.233259849093, 3571.1250743567994, 3589.7128229741556, 1076.9138468922467, 1089.743910181107, 1107.3521989635992, 1172.6013155527162, 1215.6899990502366, 32625.673743262738, 33391.833040835125, 33406.164845878564, 33560.0, 33813.49279760806, 1083.6803143072812, 1118.3513562133942, 1131.179894576442, 1184.5261895241972, 1214.7084699672191, 16692.081935493665, 16721.498355049367, 16996.575085622957, 17006.489805305613, 17098.914505427394, 619020.0, 623711.0, 625201.0, 629270.0, 635023.0, 62591.374086259464, 62984.37015629877, 63119.36880631227, 63156.68421657862, 63171.36828631747, 1427.215031732543, 1433.5699290212895, 1435.9138451692932, 1455.7889106079558, 1456.8907331950147, 30756.077317680505, 30976.84511577428, 31375.686243137276, 31715.84142079275, 32238.0, 52630.73684631706, 53382.19926701025, 53569.46430535801, 53618.73190634022, 53625.0, 498670.0, 504030.0, 505647.0, 506010.0, 507423.0, 30255.0, 30700.232494187825, 30930.53604195984, 30950.0, 31095.0, 50525.74737126291, 52711.472885270654, 53220.73389633027, 56446.0, 57380.713096435924, 43747.3514176451, 44002.779986099864, 44844.55155448404, 45301.32048019217, 45488.772556138334, 42784.0, 43814.56185438105, 45010.0, 45250.0, 45899.311510326705, 38994.0, 43397.0, 43632.78183609062, 44645.55354446414, 45265.09469810651, 36065.0, 38446.2310753789, 39101.6089839098, 39757.0, 39889.601103988585, 28793.280167995967, 29031.85484072566, 30302.0, 30772.69227307788, 32243.35513289674], "value": 19845.23676936646, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [425.29401194017936, 426.3540735785286, 429.52322921557044, 431.335742955848, 442.7918878127279, 18387.264509419623, 19472.415827525198, 19720.90139549302, 21055.0, 21286.148554057858, 18002.09989500523, 18538.53653658659, 18669.813301866976, 18732.438026859218, 18816.623667526674, 5559.277293951791, 5837.299524057098, 5987.55093367997, 5988.940110598882, 5990.8801823963495, 5848.736806843681, 5885.49973252272, 5926.081457374114, 5938.346781853993, 5949.970250148744, 5675.3757086720425, 5867.8533036674, 5897.587168898179, 5905.143754155645, 5912.556558258127, 5684.658920464785, 5876.618019828718, 5885.705714714269, 5903.173555702205, 5905.881882362329, 5271.789128434858, 5291.126964050927, 5295.179247216687, 5336.0, 5336.786528538853, 17932.282708691637, 22089.0, 22204.222852200095, 23723.05107795686, 23887.402814929766, 2482.3049546127113, 2555.7572030657057, 2601.8308809927294, 2842.1757690269797, 2946.9410611787644, 14708.705825883422, 14872.851271487363, 14999.550013499613, 15038.097714137186, 15083.0, 2012.0945574491536, 2054.815066644009, 2077.2314243729766, 2136.156218293781, 2141.154244073582, 62171.37828621701, 77706.0, 79304.60347698283, 81652.0, 82761.0, 11151.107911367071, 11432.657020289405, 11588.478518466689, 11748.177627565989, 11794.351310677823, 16367.427140050278, 16462.094584797953, 16502.2573984171, 16537.255823487732, 16562.917185413997, 8226.218509241613, 8396.118407567239, 8399.580020999048, 8500.74497765068, 8602.483850968962, 8007.639656215484, 8008.439409241297, 8052.396475901756, 8157.67369305233, 8175.305099066527, 6999.510034297652, 7014.438844892396, 7047.577145371294, 7105.076340075757, 7115.644217789089, 2094.9790502094784, 2103.5161912759845, 2112.7359080114984, 2117.915283388678, 2142.6678864775986, 989.604158336671, 1033.333499892565, 1045.7385653586603, 1075.3547871277171, 1187.1927089578996, 19642.508937276398, 19973.900130499544, 20182.596348072955, 20504.0, 20659.896700516703, 1072.4798472740715, 1079.400932482464, 1109.0406798119568, 1143.1654891928938, 1171.2738102376582, 10821.569678559255, 11885.405729713653, 11893.22694024903, 11910.46402911871, 11989.400529973467, 512693.0, 514606.0, 527087.0, 528920.0, 536904.0, 76592.61703691445, 85566.57216713877, 99542.50228748955, 99801.50099249458, 101668.0, 1072.383379556758, 1091.6997825597866, 1109.0905457524752, 1117.3631030312806, 1121.243160866412, 17748.55628609295, 18153.364632237808, 18182.0, 18222.72665909986, 18362.632747345244, 43127.35308970305, 45364.54635453603, 45417.31874021958, 45663.0, 46101.07797843957, 63323.6833815828, 64141.35858641354, 64563.67718161567, 65983.34016659964, 66067.33932660612, 8613.870791938001, 8640.956795215983, 8739.868901966349, 8897.644094236159, 8979.865302020606, 11106.833782452726, 12858.164219325714, 13398.330083495592, 13649.727005460034, 13716.794248086486, 11695.0, 12050.337231452355, 12104.82113219629, 12131.575394861138, 12312.26126432417, 11142.888571114185, 11622.0, 11670.066394688574, 11689.88310116922, 11956.103292252941, 11778.234414763014, 11783.175177737476, 12049.698757531132, 12330.63008109758, 12381.876181238433, 7577.962110189414, 8633.223009929137, 8840.867386989328, 8912.86630700527, 8946.37375383717, 10176.440295783803, 11776.234544754563, 11860.169788115094, 11942.701432464259, 12133.69665758363], "value": 9761.769871828268, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1610.1949025487256, 1623.9188040597971, 1862.0, 1921.375552945293, 1953.5799803042335, 8339.416240863142, 9404.670836520723, 9592.376495527786, 10253.077223049933, 10260.435676037814, 9737.367071140388, 10077.899221007807, 10135.49322533874, 10141.0, 10156.187504999582, 2570.3445621366573, 2607.9348016299555, 2608.686957565095, 2609.4128821015215, 2611.4124322027487, 2533.8226324157226, 2604.0495219244935, 2605.8957641694406, 2607.4785042991384, 2610.8172427930053, 2577.098015694501, 2597.2467984284535, 2618.751218634227, 2632.5919482480244, 2640.0, 2452.1172377943926, 2498.675172227617, 2589.184406911826, 2590.7020692620404, 2596.1302963507246, 2480.838745481538, 2499.0503608628605, 2499.125306142854, 2520.5841036229, 2528.7850532704742, 9783.119519243302, 9978.700638980843, 10004.449755263458, 10019.799604007952, 10021.348612340247, 5726.79956201531, 5850.970745146247, 5874.148248503943, 5878.882422351572, 5882.029465138247, 3751.3247615429486, 3786.826083913968, 3903.355946268862, 3972.245273398074, 4044.4539987101953, 1271.1419791640606, 1279.993600031994, 1289.8129771183126, 1312.875276848698, 1341.0947610362966, 14501.33234678015, 14560.344784484618, 14573.70852582953, 14621.122732636077, 14628.341724622418, 5282.735863206901, 5330.413654498002, 5443.836684899459, 5454.945450545523, 5478.0, 11929.0, 12030.518779248732, 12045.217060891015, 12102.636920892388, 12111.394430278451, 5976.820695379146, 5992.0712289595185, 5997.610155339889, 6015.037593984942, 6019.578629495893, 4690.882727931761, 5323.680579165185, 5374.48942350476, 5488.259085023471, 5491.148871924858, 4571.062932098978, 4586.220342541776, 4599.931001034987, 4663.953360466419, 4810.037992401533, 1453.5130731205165, 1465.5237047959242, 1467.6697743007737, 1474.6903150338549, 1489.2107183192925, 836.824266903957, 974.2400927276735, 985.7042887133831, 991.0386924683046, 995.4823491784232, 6164.660943648142, 6319.873602528016, 6450.419462248326, 6458.0, 6490.2536208335705, 517.2164171280513, 519.5350161605342, 1062.3148069495287, 1087.0977089016098, 1093.4696672114019, 4378.014946636981, 4404.933925991113, 4418.204723149864, 4422.889427764331, 4467.7319360838455, 12545.121841471191, 12764.489420423264, 12852.293123878277, 12853.421596028014, 12962.675933101747, 12129.87870121305, 12503.937480312541, 12546.937265313614, 13015.609531714064, 13021.934890325489, 9077.228435583049, 9278.67524636648, 9307.11582399671, 9374.390664606779, 9399.90600094004, 6285.96857015712, 6502.317256687979, 6537.249376397035, 6655.567388119756, 6685.997100434974, 11509.53961841517, 11748.118891083031, 11825.467853946766, 11869.169158158846, 11934.880651193376, 11700.648980530597, 11950.641480755592, 12009.099317551394, 12071.336076515876, 12312.445939932904, 7317.26827317264, 8051.677932882619, 8284.212999765012, 8352.665893364441, 8491.405601608076, 9613.423194608346, 9620.422774633544, 9643.951780241054, 9678.95160524193, 9752.366096203725, 8308.70919517814, 8428.831423371375, 8531.061583225715, 8589.613467393858, 8599.22606965351, 8061.87907181381, 8176.591170441573, 8372.497650141011, 8439.578021099043, 8472.788180295542, 7359.411247100112, 7414.740484083031, 7512.5492470451945, 7523.88714169277, 7524.209957954336, 5322.707251101072, 5411.83764487066, 5456.699881506555, 5581.553475721851, 5598.580106492111, 5601.439856014529, 5620.297462817148, 5651.378348381757, 5757.337906140848, 5857.970710146422], "value": 5169.296098918291, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.18177283384034, 348.75238580607765, 349.08887802834596, 352.01611495869076, 353.7947990165703, 5881.294244690633, 5887.85280367991, 5892.9705351473185, 5909.468147866696, 5982.611130276529, 5765.423457654243, 5778.59549831512, 5794.188813566104, 5798.492391978084, 5821.970890145543, 4164.29207034804, 4466.8883277917985, 4508.61676757476, 4514.458265008204, 4516.728996260218, 4492.079123779634, 4518.412606361168, 4523.547645235483, 4526.79629416677, 4551.431071116111, 4503.144402563519, 4529.573184446888, 4537.863864084083, 4544.5682660147395, 4575.611073058794, 4344.131173765244, 4459.910801783946, 4496.145732310851, 4514.864554063367, 4515.480719717241, 3890.3386424307937, 3939.074317535377, 3947.388154836005, 3957.8021098945223, 3968.6626636735914, 5602.439756024406, 5620.437956204388, 5621.522170615503, 5643.435656434323, 5653.473562138241, 4994.475580064113, 5118.488151184889, 5133.409657889353, 5141.820036298749, 5176.534111929945, 5991.2325863870265, 6057.545684073712, 6090.360512146205, 6095.299040610343, 6135.570510064253, 4329.7618630975285, 4360.760158191299, 4376.190404775095, 4431.556844315575, 4432.224360736858, 6283.748650053993, 6350.587211831216, 6384.265809431929, 6387.776427825004, 6410.67946602668, 4463.152001119842, 4467.548046884775, 4468.977655111768, 4479.484859241164, 4488.102379524108, 4414.470263568328, 4475.433598240655, 4520.728756274634, 4526.117407105648, 4536.0, 5098.08234517783, 5128.717920514333, 5134.127198376285, 5142.845714628493, 5156.458571849902, 6022.5483088768515, 6096.939030609726, 6099.237595300588, 6138.1713468681155, 6147.262328520606, 1522.444307827635, 1552.2161308539116, 1572.1746083306355, 1579.518246934696, 1584.2870708181365, 1006.6828948881079, 1006.9244806639531, 1115.5537784885948, 1124.6232512108372, 1143.9771204576027, 5819.82540523785, 5913.822585322448, 5936.851578710481, 5992.820215393545, 6002.309734380602, 6087.147799308101, 6200.751969921243, 6221.906671399933, 6261.373862613702, 6280.654563999024, 5779.543693930063, 5844.707764611838, 5893.469587737039, 5933.795750294878, 5977.073553599199, 3259.5599594054975, 3335.983320083433, 3350.2964377481003, 3368.7473439491646, 3373.7807042542645, 6184.907226391608, 6377.0, 6397.424231819158, 6417.326180751047, 6441.420272175526, 6250.124982502453, 6271.498280137578, 6342.302346741854, 6378.712957916812, 6390.4248617624635, 6173.876522469525, 6418.646974416359, 6487.22153341602, 6493.188351456068, 6642.27300901769, 6325.936740632535, 6355.491560675227, 6356.0, 6379.840503987251, 6381.234251889803, 5931.288245410406, 6330.987042073246, 6337.556371053982, 6342.619442833445, 6395.5203359747275, 6490.740370385321, 6525.967370163119, 6526.641034743135, 6558.409743123142, 6597.373249541286, 4305.138972205634, 4329.783510824509, 4347.478302603708, 4352.368906508602, 4378.562143785596, 6032.4570788629235, 6313.305536391085, 6360.713767880549, 6364.554481186273, 6385.595169062799, 6146.723397447215, 6190.226221722285, 6213.2233470816145, 6216.0, 6222.62664240147, 6000.729967151401, 6138.447539721446, 6171.197744293393, 6196.876062478816, 6197.349278325892, 5928.940710593011, 6054.606450580698, 6062.818115456544, 6078.574499784972, 6099.695015249308, 6118.969405152946, 6132.172156758959, 6172.321044685171, 6185.41238582334, 6203.596766210182, 5963.880722385441, 6067.362926892612, 6086.969565152146, 6112.524427606826, 6142.938570614237], "value": 4659.5541728186045, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.3051839715474, 724.3770357492559, 859.4113032572687, 889.0842432294738, 892.317377206437, 14553.0, 15145.545633630994, 15168.848311516895, 15206.923965380158, 15209.847901520981, 14229.857701422983, 14239.216843073627, 14371.568852934402, 14394.424223031067, 14408.063475874062, 726.5640615630606, 833.7040350675513, 853.9743807685779, 854.4275335525182, 870.225499305617, 854.692310768123, 859.8237361340941, 863.4301361101643, 863.7063398444527, 864.567716141929, 903.1239697493421, 907.3013779389865, 911.1071150272737, 911.8449863523217, 913.0367462327242, 903.5437104262338, 903.8870141232346, 904.2449554621833, 904.2720609909021, 907.1654078248027, 664.4119953840885, 666.540087339734, 666.5400873397389, 667.1560475997867, 668.5554106519158, 14567.635809104751, 14639.780403293958, 14680.119192848357, 14680.412783488648, 14759.114453132739, 14202.85797142036, 15259.542213733606, 15350.155741434217, 15370.538883833391, 15509.922450387789, 12393.318367489876, 12409.937950310281, 12485.50057997679, 12703.809442858364, 12746.362681865963, 4798.640101992364, 4810.735409552473, 4824.734639594821, 4827.300041493999, 4865.099956508022, 77333.61333193355, 77611.6119419405, 79804.0, 80426.0, 80539.19460805434, 10873.456327183609, 11327.5840519935, 11388.373639449745, 11598.536058557564, 11718.94140529309, 20293.086811093537, 20349.186032558533, 20377.083031263628, 20378.388648340573, 20902.790972090388, 8765.948086229693, 8938.50838203905, 9006.63973441055, 9063.91233052038, 9081.500517471603, 4995.100881841231, 5092.796288148433, 5137.588992880561, 5144.6398752087, 5265.078611243017, 3761.153740408386, 3930.390789427643, 3933.252681990413, 3940.9605903941165, 3955.2287303976022, 634.7302396481477, 656.1044174701593, 697.5326531224092, 703.1737708192853, 703.6094967293201, 810.5784991804229, 830.8961379827522, 833.2459124492223, 851.1148405658047, 867.7657032601162, 9891.258155638212, 10439.37363758177, 10471.37171769681, 10494.475276236157, 10536.68291463567, 667.6194569095569, 709.8651256261294, 718.3606590134784, 808.4785313472895, 839.4291881520625, 4898.240772680169, 5023.572996295283, 5058.898822023539, 5134.717590532557, 5198.532132108053, 81232.59383703161, 132409.33795331154, 132487.33756331156, 134201.0, 135373.0, 66558.0, 68396.6580167096, 98751.50624246833, 114251.0, 114265.4286728561, 92651.53674231586, 93546.53226733959, 94335.056649434, 95612.52193738987, 100251.98992040382, 9955.352902061633, 9969.0, 10048.0, 10186.236032297458, 10222.795544089226, 44872.55127448814, 47119.52880471152, 52941.7352913233, 54058.45941540534, 56498.0, 51647.483525164265, 51854.74072629613, 52022.739886300325, 52070.0, 67402.32597673961, 13264.204147751167, 13492.595222142958, 13687.931560342135, 14169.0, 14173.43306267779, 15013.699726005638, 15281.770773438186, 15407.0, 15722.528324150293, 16307.918460408097, 13357.332133393485, 13653.180809151483, 13914.930425347808, 13918.791218131939, 14199.219042952736, 13821.654458638615, 13829.930850345683, 13911.234882081582, 13925.791113133513, 14175.929120354333, 11918.284902905853, 12983.935080324916, 13237.602871913858, 13349.66625834362, 13639.522616708367, 11069.889301107209, 11558.653240402802, 11633.88366116328, 11803.763924721286, 11987.34069626144, 11141.0, 12061.939690301493, 12065.0, 12198.085143614442, 12361.876381236072], "value": 7841.915505995714, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1508.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 104.0, 109.0, 109.0, 109.0, 112.0, 110.0, 107.0, 109.0, 110.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 124.0, 156.0, 181.0, 126.0, 157.0, 150.0, 128.0, 191.0, 124.0], "value": 148.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 162.0, 161.0, 164.0, 163.0, 162.0, 163.0, 162.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 77.0, 182.0, 76.0, 76.0, 74.0, 76.0, 166.0, 75.0], "value": 95.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 150.0, 85.0, 84.0, 84.0, 142.0, 85.0, 85.0, 138.0], "value": 102.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 148.0, 146.0, 147.0, 146.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 52.0, 53.0, 52.0, 53.0, 55.0, 54.0, 57.0, 53.0, 54.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 61.0, 62.0, 61.0, 61.0, 61.0, 61.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 77.0, 77.0, 78.0, 84.0, 76.0, 109.0, 78.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 116.0, 115.0, 116.0, 126.0, 114.0, 126.0, 126.0, 132.0, 121.0], "value": 122.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 148.0, 150.0, 164.0, 158.0, 151.0, 149.0, 153.0, 148.0], "value": 152.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 62.0, 65.0, 61.0, 60.0, 63.0, 61.0, 61.0, 62.0], "value": 61.8, "unit": "score"}]}]} 19:28:00 INFO - Return code: 0 19:28:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:28:00 ERROR - # TBPL SUCCESS # 19:28:00 INFO - Running post-action listener: _resource_record_post_action 19:28:00 INFO - ##### 19:28:00 INFO - ##### Finished run-tests step (success) 19:28:00 INFO - ##### 19:28:00 INFO - Running post-run listener: _resource_record_post_run 19:28:00 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 761856; Write bytes: 330432512; Read time: 256; Write time: 179660 19:28:00 INFO - TinderboxPrint: CPU usage
13.3% 19:28:00 INFO - TinderboxPrint: I/O read bytes / time
761,856 / 256 19:28:00 INFO - TinderboxPrint: I/O write bytes / time
330,432,512 / 179,660 19:28:00 INFO - TinderboxPrint: CPU idle
8,215.7 (86.7%) 19:28:00 INFO - TinderboxPrint: CPU user
1,210.2 (12.8%) 19:28:00 INFO - TinderboxPrint: Swap in / out
0 / 0 19:28:00 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 81473536; Read time: 188; Write time: 35300 19:28:00 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 757760; Write bytes: 248958976; Read time: 68; Write time: 144360 19:28:00 INFO - Running post-run listener: _upload_blobber_files 19:28:00 INFO - Blob upload gear active. 19:28:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:28:00 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 19:28:00 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'] 19:28:00 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 19:28:01 INFO - (blobuploader) - INFO - Open directory for files ... 19:28:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:28:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:28:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:28:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:28:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:28:02 INFO - (blobuploader) - INFO - Done attempting. 19:28:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:28:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:28:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:28:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:28:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:28:05 INFO - (blobuploader) - INFO - Done attempting. 19:28:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:28:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:28:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:28:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:28:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:28:06 INFO - (blobuploader) - INFO - Done attempting. 19:28:06 INFO - (blobuploader) - INFO - Iteration through files over. 19:28:06 INFO - Return code: 0 19:28:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:28:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:28:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea9e98c89255a95078199a466f9f5405136c2bdec8c08fd7acb55db918d848f30e3c6369200d81391d657390c41beb8896eb7fe318a82d53ea832a31cf48dcc9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8355263216197defe8190b014d77fe4e7a9740aa90393a7691455c809597d768b753f0b3703220c6be9ffd9c9aa49fa979775ded86862b706ca8819272320d04", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9ef2bc8c2926efe4e892b5e0d8ced7b36ba9d8b8da2f6309318dc73e2a39f1032364bdd2c9a3475f1409c3686ad50198e870902bed1f87a21a249a4d27991a7f"} 19:28:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:28:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:28:06 INFO - Contents: 19:28:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea9e98c89255a95078199a466f9f5405136c2bdec8c08fd7acb55db918d848f30e3c6369200d81391d657390c41beb8896eb7fe318a82d53ea832a31cf48dcc9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8355263216197defe8190b014d77fe4e7a9740aa90393a7691455c809597d768b753f0b3703220c6be9ffd9c9aa49fa979775ded86862b706ca8819272320d04", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9ef2bc8c2926efe4e892b5e0d8ced7b36ba9d8b8da2f6309318dc73e2a39f1032364bdd2c9a3475f1409c3686ad50198e870902bed1f87a21a249a4d27991a7f"} 19:28:06 INFO - Running post-run listener: copy_logs_to_upload_dir 19:28:06 INFO - Copying logs to upload dir... 19:28:06 INFO - mkdir: /builds/slave/test/build/upload/logs 19:28:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.079670 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-22 19:28:06.559854) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 19:28:06.564157) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1466646474.545788-1916508181 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/ea9e98c89255a95078199a466f9f5405136c2bdec8c08fd7acb55db918d848f30e3c6369200d81391d657390c41beb8896eb7fe318a82d53ea832a31cf48dcc9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8355263216197defe8190b014d77fe4e7a9740aa90393a7691455c809597d768b753f0b3703220c6be9ffd9c9aa49fa979775ded86862b706ca8819272320d04", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9ef2bc8c2926efe4e892b5e0d8ced7b36ba9d8b8da2f6309318dc73e2a39f1032364bdd2c9a3475f1409c3686ad50198e870902bed1f87a21a249a4d27991a7f"} build_url:https://queue.taskcluster.net/v1/task/fgIu4NmDTTaf5NWKDiiBXw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011201 build_url: 'https://queue.taskcluster.net/v1/task/fgIu4NmDTTaf5NWKDiiBXw/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/ea9e98c89255a95078199a466f9f5405136c2bdec8c08fd7acb55db918d848f30e3c6369200d81391d657390c41beb8896eb7fe318a82d53ea832a31cf48dcc9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8355263216197defe8190b014d77fe4e7a9740aa90393a7691455c809597d768b753f0b3703220c6be9ffd9c9aa49fa979775ded86862b706ca8819272320d04", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9ef2bc8c2926efe4e892b5e0d8ced7b36ba9d8b8da2f6309318dc73e2a39f1032364bdd2c9a3475f1409c3686ad50198e870902bed1f87a21a249a4d27991a7f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 19:28:06.590640) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 19:28:06.591024) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1466646474.545788-1916508181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004497 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 19:28:06.675482) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 19:28:06.675991) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 19:28:06.676402) ========= ========= Total master_lag: 0.20 =========