builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-019 starttime: 1467544020.58 results: success (0) buildid: 20160703011021 builduid: a7e0a85ce501428586fbf3e562c1bece revision: b9faa10c9918a271440acd6233028ba10c0ae1ac ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-03 04:07:00.581741) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-03 04:07:00.582150) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-03 04:07:00.582419) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-03 04:07:00.610098) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 04:07:00.610347) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1467543624.376589-2033187659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-03 04:07:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.1M=0s 2016-07-03 04:07:01 (47.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114850 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 04:07:00.741633) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 04:07:00.742010) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1467543624.376589-2033187659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017900 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 04:07:00.790919) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 04:07:00.791251) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b9faa10c9918a271440acd6233028ba10c0ae1ac --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 b9faa10c9918a271440acd6233028ba10c0ae1ac --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=78329bfc0fd5309db0a6e0ac000001b4-1467543624.376589-2033187659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-03 04:07:01,241 truncating revision to first 12 chars 2016-07-03 04:07:01,241 Setting DEBUG logging. 2016-07-03 04:07:01,241 attempt 1/10 2016-07-03 04:07:01,242 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b9faa10c9918?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-03 04:07:01,864 unpacking tar archive at: mozilla-aurora-b9faa10c9918/testing/mozharness/ program finished with exit code 0 elapsedTime=0.952496 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 04:07:01.757854) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-03 04:07:01.758146) ========= script_repo_revision: b9faa10c9918a271440acd6233028ba10c0ae1ac ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-03 04:07:01.758540) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-03 04:07:01.758809) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-03 04:07:01.767866) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-07-03 04:07:01.768137) ========= /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=78329bfc0fd5309db0a6e0ac000001b4-1467543624.376589-2033187659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:07:02 INFO - MultiFileLogger online at 20160703 04:07:02 in /builds/slave/test 04:07:02 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 04:07:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:07:02 INFO - {'append_to_log': False, 04:07:02 INFO - 'base_work_dir': '/builds/slave/test', 04:07:02 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:07:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:07:02 INFO - 'branch': 'Mozilla-Aurora', 04:07:02 INFO - 'buildbot_json_path': 'buildprops.json', 04:07:02 INFO - 'config_files': ('talos/linux_config.py',), 04:07:02 INFO - 'default_actions': ('clobber', 04:07:02 INFO - 'read-buildbot-config', 04:07:02 INFO - 'download-and-extract', 04:07:02 INFO - 'populate-webroot', 04:07:02 INFO - 'create-virtualenv', 04:07:02 INFO - 'install', 04:07:02 INFO - 'run-tests'), 04:07:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:07:02 INFO - 'download_minidump_stackwalk': True, 04:07:02 INFO - 'download_symbols': 'ondemand', 04:07:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:07:02 INFO - 'tooltool.py': '/tools/tooltool.py', 04:07:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:07:02 INFO - '/tools/misc-python/virtualenv.py')}, 04:07:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:07:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:07:02 INFO - 'installer_path': 'installer.exe', 04:07:02 INFO - 'log_level': 'info', 04:07:02 INFO - 'log_name': 'talos', 04:07:02 INFO - 'log_to_console': True, 04:07:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:07:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:07:02 INFO - 'opt_config_files': (), 04:07:02 INFO - 'pip_index': False, 04:07:02 INFO - 'sps_profile': False, 04:07:02 INFO - 'sps_profile_interval': 0, 04:07:02 INFO - 'suite': 'dromaeojs-e10s', 04:07:02 INFO - 'system_bits': '32', 04:07:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:07:02 INFO - 'title': 'talos-linux64-ix-019', 04:07:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:07:02 INFO - 'use_talos_json': True, 04:07:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:07:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:07:02 INFO - 'work_dir': 'build'} 04:07:02 INFO - ##### 04:07:02 INFO - ##### Running clobber step. 04:07:02 INFO - ##### 04:07:02 INFO - Running pre-action listener: _resource_record_pre_action 04:07:02 INFO - Running main action method: clobber 04:07:02 INFO - rmtree: /builds/slave/test/build 04:07:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:07:03 INFO - Running post-action listener: _resource_record_post_action 04:07:03 INFO - ##### 04:07:03 INFO - ##### Finished clobber step (success) 04:07:03 INFO - ##### 04:07:03 INFO - ##### 04:07:03 INFO - ##### Running read-buildbot-config step. 04:07:03 INFO - ##### 04:07:03 INFO - Running pre-action listener: _resource_record_pre_action 04:07:03 INFO - Running main action method: read_buildbot_config 04:07:03 INFO - Using buildbot properties: 04:07:03 INFO - { 04:07:03 INFO - "project": "", 04:07:03 INFO - "product": "firefox", 04:07:03 INFO - "script_repo_revision": "production", 04:07:03 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 04:07:03 INFO - "repository": "", 04:07:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 04:07:03 INFO - "buildid": "20160703011021", 04:07:03 INFO - "pgo_build": "True", 04:07:03 INFO - "basedir": "/builds/slave/test", 04:07:03 INFO - "buildnumber": 394, 04:07:03 INFO - "slavename": "talos-linux64-ix-019", 04:07:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:07:03 INFO - "platform": "ubuntu64_hw", 04:07:03 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:07:03 INFO - "branch": "mozilla-aurora", 04:07:03 INFO - "repo_path": "releases/mozilla-aurora", 04:07:03 INFO - "revision": "b9faa10c9918a271440acd6233028ba10c0ae1ac", 04:07:03 INFO - "stage_platform": "linux64-pgo", 04:07:03 INFO - "builduid": "a7e0a85ce501428586fbf3e562c1bece", 04:07:03 INFO - "slavebuilddir": "test" 04:07:03 INFO - } 04:07:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/FUEeBfmtQXeihgHe0tvNCQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 04:07:03 INFO - Running post-action listener: _resource_record_post_action 04:07:03 INFO - ##### 04:07:03 INFO - ##### Finished read-buildbot-config step (success) 04:07:03 INFO - ##### 04:07:03 INFO - ##### 04:07:03 INFO - ##### Running download-and-extract step. 04:07:03 INFO - ##### 04:07:03 INFO - Running pre-action listener: _resource_record_pre_action 04:07:03 INFO - Running main action method: download_and_extract 04:07:03 INFO - mkdir: /builds/slave/test/build/tests 04:07:03 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')]} 04:07:03 INFO - https://queue.taskcluster.net/v1/task/FUEeBfmtQXeihgHe0tvNCQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:07:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FUEeBfmtQXeihgHe0tvNCQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 04:07:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FUEeBfmtQXeihgHe0tvNCQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 04:07:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FUEeBfmtQXeihgHe0tvNCQ/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 04:07:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FUEeBfmtQXeihgHe0tvNCQ/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 04:07:05 INFO - Downloaded 1361 bytes. 04:07:05 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 04:07:05 INFO - Using the following test package requirements: 04:07:05 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 04:07:05 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:07:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:07:05 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:07:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:07:05 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:07:05 INFO - u'jsshell-linux-x86_64.zip'], 04:07:05 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:07:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:07:05 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 04:07:05 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:07:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:07:05 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:07:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:07:05 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:07:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:07:05 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:07:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:07:05 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:07:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:05 INFO - https://queue.taskcluster.net/v1/task/FUEeBfmtQXeihgHe0tvNCQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:07:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FUEeBfmtQXeihgHe0tvNCQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:07:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FUEeBfmtQXeihgHe0tvNCQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:07:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FUEeBfmtQXeihgHe0tvNCQ/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 04:07:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FUEeBfmtQXeihgHe0tvNCQ/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 04:07:07 INFO - Downloaded 24525015 bytes. 04:07:07 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'] 04:07:07 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 04:07:08 INFO - Return code: 0 04:07:08 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 04:07: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')]} 04:07:08 INFO - https://queue.taskcluster.net/v1/task/FUEeBfmtQXeihgHe0tvNCQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:07:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FUEeBfmtQXeihgHe0tvNCQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:07:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FUEeBfmtQXeihgHe0tvNCQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:07:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FUEeBfmtQXeihgHe0tvNCQ/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 04:07:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FUEeBfmtQXeihgHe0tvNCQ/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 04:07:11 INFO - Downloaded 24525015 bytes. 04:07:11 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'] 04:07:11 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 04:07:13 INFO - Return code: 0 04:07:13 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')]} 04:07:13 INFO - https://queue.taskcluster.net/v1/task/FUEeBfmtQXeihgHe0tvNCQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:07:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FUEeBfmtQXeihgHe0tvNCQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 04:07:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FUEeBfmtQXeihgHe0tvNCQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 04:07:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FUEeBfmtQXeihgHe0tvNCQ/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 04:07:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FUEeBfmtQXeihgHe0tvNCQ/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 04:07:14 INFO - Downloaded 10833369 bytes. 04:07:14 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'] 04:07:14 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 04:07:14 INFO - Return code: 0 04:07:14 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')]} 04:07:14 INFO - https://queue.taskcluster.net/v1/task/FUEeBfmtQXeihgHe0tvNCQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:07:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FUEeBfmtQXeihgHe0tvNCQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:07:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FUEeBfmtQXeihgHe0tvNCQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:07:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FUEeBfmtQXeihgHe0tvNCQ/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 04:07:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FUEeBfmtQXeihgHe0tvNCQ/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 04:07:16 INFO - Downloaded 63635245 bytes. 04:07:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FUEeBfmtQXeihgHe0tvNCQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:07:16 INFO - mkdir: /builds/slave/test/properties 04:07:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:07:16 INFO - Writing to file /builds/slave/test/properties/build_url 04:07:16 INFO - Contents: 04:07:16 INFO - build_url:https://queue.taskcluster.net/v1/task/FUEeBfmtQXeihgHe0tvNCQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:07:16 INFO - Running post-action listener: _resource_record_post_action 04:07:16 INFO - Running post-action listener: set_extra_try_arguments 04:07:16 INFO - ##### 04:07:16 INFO - ##### Finished download-and-extract step (success) 04:07:16 INFO - ##### 04:07:16 INFO - ##### 04:07:16 INFO - ##### Running populate-webroot step. 04:07:16 INFO - ##### 04:07:16 INFO - Running pre-action listener: _resource_record_pre_action 04:07:16 INFO - Running main action method: populate_webroot 04:07:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:07:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:07:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:07:16 INFO - '--tppagecycles', 04:07:16 INFO - '7'], 04:07:16 INFO - 'tests': ['tsvgm']}}, 04:07:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:07:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:07:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:07:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:07:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:07:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:07:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:16 INFO - 'talos_options': ['--disable-e10s'], 04:07:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:07:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:07:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:16 INFO - 'talos_options': ['--disable-e10s'], 04:07:16 INFO - 'tests': ['damp', 'tps']}, 04:07:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:16 INFO - 'tests': ['damp', 'tps']}, 04:07:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:07:16 INFO - 'tests': ['dromaeo_dom']}, 04:07:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:07:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:07:16 INFO - 'tests': ['a11yr', 04:07:16 INFO - 'ts_paint', 04:07:16 INFO - 'tpaint', 04:07:16 INFO - 'sessionrestore', 04:07:16 INFO - 'sessionrestore_no_auto_restore', 04:07:16 INFO - 'tabpaint']}, 04:07:16 INFO - 'other-e10s': {'tests': ['a11yr', 04:07:16 INFO - 'ts_paint', 04:07:16 INFO - 'tpaint', 04:07:16 INFO - 'sessionrestore', 04:07:16 INFO - 'sessionrestore_no_auto_restore', 04:07:16 INFO - 'tabpaint']}, 04:07:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:07:16 INFO - 'ts_paint', 04:07:16 INFO - 'tpaint', 04:07:16 INFO - 'sessionrestore', 04:07:16 INFO - 'sessionrestore_no_auto_restore', 04:07:16 INFO - 'tabpaint']}, 04:07:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:07:16 INFO - 'ts_paint', 04:07:16 INFO - 'tpaint', 04:07:16 INFO - 'sessionrestore', 04:07:16 INFO - 'sessionrestore_no_auto_restore', 04:07:16 INFO - 'tabpaint']}, 04:07:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:07:16 INFO - 'tests': ['a11yr', 04:07:16 INFO - 'ts_paint', 04:07:16 INFO - 'tpaint', 04:07:16 INFO - 'sessionrestore', 04:07:16 INFO - 'sessionrestore_no_auto_restore', 04:07:16 INFO - 'tabpaint']}, 04:07:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:07:16 INFO - 'tests': ['a11yr', 04:07:16 INFO - 'ts_paint', 04:07:16 INFO - 'tpaint', 04:07:16 INFO - 'sessionrestore', 04:07:16 INFO - 'sessionrestore_no_auto_restore', 04:07:16 INFO - 'tabpaint']}, 04:07:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:07:16 INFO - 'tests': ['tsvgx', 04:07:16 INFO - 'tsvgr_opacity', 04:07:16 INFO - 'tart', 04:07:16 INFO - 'tscrollx', 04:07:16 INFO - 'cart']}, 04:07:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:07:16 INFO - 'tsvgr_opacity', 04:07:16 INFO - 'tart', 04:07:16 INFO - 'tscrollx', 04:07:16 INFO - 'cart']}, 04:07:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:16 INFO - 'talos_options': ['--disable-e10s'], 04:07:16 INFO - 'tests': ['tp5o']}, 04:07:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:16 INFO - 'tests': ['tp5o']}, 04:07:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:16 INFO - 'talos_options': ['--disable-e10s', 04:07:16 INFO - '--xperf_path', 04:07:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:07:16 INFO - 'tests': ['tp5n']}, 04:07:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:16 INFO - 'talos_options': ['--xperf_path', 04:07:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:07:16 INFO - 'tests': ['tp5n']}}, 04:07:16 INFO - 'talos.zip': {'path': '', 04:07:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:07:16 INFO - Running post-action listener: _resource_record_post_action 04:07:16 INFO - ##### 04:07:16 INFO - ##### Finished populate-webroot step (success) 04:07:16 INFO - ##### 04:07:16 INFO - ##### 04:07:16 INFO - ##### Running create-virtualenv step. 04:07:16 INFO - ##### 04:07:16 INFO - Running pre-action listener: _resource_record_pre_action 04:07:16 INFO - Running main action method: create_virtualenv 04:07:16 INFO - Creating virtualenv /builds/slave/test/build/venv 04:07:16 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 04:07:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:07:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:07:16 INFO - Using real prefix '/usr' 04:07:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:07:17 INFO - Installing distribute.............................................................................................................................................................................................done. 04:07:19 INFO - Installing pip.................done. 04:07:19 INFO - Return code: 0 04:07:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:07:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:19 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 0x7f7e14c13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1764350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f31c0>, '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 0x17f40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f4550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467543624.376589-2033187659', '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 04:07:19 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 04:07:19 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 04:07:19 INFO - Using env: {'DISPLAY': ':0', 04:07:19 INFO - 'HOME': '/home/cltbld', 04:07:19 INFO - 'LANG': 'en_US.UTF-8', 04:07:19 INFO - 'LANGUAGE': 'en_US:en', 04:07:19 INFO - 'LOGNAME': 'cltbld', 04:07:19 INFO - 'MAIL': '/var/mail/cltbld', 04:07:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:19 INFO - 'MOZ_NO_REMOTE': '1', 04:07:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:19 INFO - 'NO_EM_RESTART': '1', 04:07:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:19 INFO - 'PWD': '/builds/slave/test', 04:07:19 INFO - 'SHELL': '/bin/bash', 04:07:19 INFO - 'SHLVL': '1', 04:07:19 INFO - 'TERM': 'linux', 04:07:19 INFO - 'TMOUT': '86400', 04:07:19 INFO - 'USER': 'cltbld', 04:07:19 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467543624.376589-2033187659', 04:07:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:19 INFO - '_': '/tools/buildbot/bin/python'} 04:07:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:19 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 04:07:19 INFO - Cleaning up... 04:07:19 INFO - Return code: 0 04:07:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:07:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:19 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 0x7f7e14c13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1764350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f31c0>, '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 0x17f40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f4550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467543624.376589-2033187659', '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 04:07:19 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 04:07:19 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 04:07:19 INFO - Using env: {'DISPLAY': ':0', 04:07:19 INFO - 'HOME': '/home/cltbld', 04:07:19 INFO - 'LANG': 'en_US.UTF-8', 04:07:19 INFO - 'LANGUAGE': 'en_US:en', 04:07:19 INFO - 'LOGNAME': 'cltbld', 04:07:19 INFO - 'MAIL': '/var/mail/cltbld', 04:07:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:19 INFO - 'MOZ_NO_REMOTE': '1', 04:07:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:19 INFO - 'NO_EM_RESTART': '1', 04:07:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:19 INFO - 'PWD': '/builds/slave/test', 04:07:19 INFO - 'SHELL': '/bin/bash', 04:07:19 INFO - 'SHLVL': '1', 04:07:19 INFO - 'TERM': 'linux', 04:07:19 INFO - 'TMOUT': '86400', 04:07:19 INFO - 'USER': 'cltbld', 04:07:19 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467543624.376589-2033187659', 04:07:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:19 INFO - '_': '/tools/buildbot/bin/python'} 04:07:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:19 INFO - Downloading/unpacking psutil>=3.1.1 04:07:19 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 04:07:19 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 04:07:19 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 04:07:19 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 04:07:19 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 04:07:19 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 04:07:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:07:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:07:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:07:21 INFO - Installing collected packages: psutil 04:07:21 INFO - Running setup.py install for psutil 04:07:21 INFO - building 'psutil._psutil_linux' extension 04:07:21 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 04:07:22 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 04:07:22 INFO - building 'psutil._psutil_posix' extension 04:07:22 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 04:07:22 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 04:07:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:07:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:07:22 INFO - Successfully installed psutil 04:07:22 INFO - Cleaning up... 04:07:22 INFO - Return code: 0 04:07:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:07:22 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')]} 04:07:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:22 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')]} 04:07:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:22 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 0x7f7e14c13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1764350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f31c0>, '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 0x17f40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f4550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467543624.376589-2033187659', '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 04:07:22 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 04:07:22 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 04:07:22 INFO - Using env: {'DISPLAY': ':0', 04:07:22 INFO - 'HOME': '/home/cltbld', 04:07:22 INFO - 'LANG': 'en_US.UTF-8', 04:07:22 INFO - 'LANGUAGE': 'en_US:en', 04:07:22 INFO - 'LOGNAME': 'cltbld', 04:07:22 INFO - 'MAIL': '/var/mail/cltbld', 04:07:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:22 INFO - 'MOZ_NO_REMOTE': '1', 04:07:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:22 INFO - 'NO_EM_RESTART': '1', 04:07:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:22 INFO - 'PWD': '/builds/slave/test', 04:07:22 INFO - 'SHELL': '/bin/bash', 04:07:22 INFO - 'SHLVL': '1', 04:07:22 INFO - 'TERM': 'linux', 04:07:22 INFO - 'TMOUT': '86400', 04:07:22 INFO - 'USER': 'cltbld', 04:07:22 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467543624.376589-2033187659', 04:07:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:22 INFO - '_': '/tools/buildbot/bin/python'} 04:07:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:07:22 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 04:07:22 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 04:07:22 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 04:07:22 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 04:07:22 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 04:07:22 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 04:07:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:07:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:07:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:07:24 INFO - Installing collected packages: mozsystemmonitor 04:07:24 INFO - Running setup.py install for mozsystemmonitor 04:07:24 INFO - Successfully installed mozsystemmonitor 04:07:24 INFO - Cleaning up... 04:07:24 INFO - Return code: 0 04:07:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:07:24 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')]} 04:07:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:24 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')]} 04:07:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:24 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 0x7f7e14c13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1764350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f31c0>, '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 0x17f40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f4550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467543624.376589-2033187659', '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 04:07:24 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 04:07:24 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 04:07:24 INFO - Using env: {'DISPLAY': ':0', 04:07:24 INFO - 'HOME': '/home/cltbld', 04:07:24 INFO - 'LANG': 'en_US.UTF-8', 04:07:24 INFO - 'LANGUAGE': 'en_US:en', 04:07:24 INFO - 'LOGNAME': 'cltbld', 04:07:24 INFO - 'MAIL': '/var/mail/cltbld', 04:07:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:24 INFO - 'MOZ_NO_REMOTE': '1', 04:07:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:24 INFO - 'NO_EM_RESTART': '1', 04:07:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:24 INFO - 'PWD': '/builds/slave/test', 04:07:24 INFO - 'SHELL': '/bin/bash', 04:07:24 INFO - 'SHLVL': '1', 04:07:24 INFO - 'TERM': 'linux', 04:07:24 INFO - 'TMOUT': '86400', 04:07:24 INFO - 'USER': 'cltbld', 04:07:24 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467543624.376589-2033187659', 04:07:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:24 INFO - '_': '/tools/buildbot/bin/python'} 04:07:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:24 INFO - Downloading/unpacking jsonschema==2.5.1 04:07:24 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 04:07:24 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 04:07:24 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 04:07:24 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 04:07:24 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 04:07:24 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 04:07:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:07:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:07:26 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 04:07:26 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 04:07:26 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 04:07:26 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 04:07:26 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 04:07:26 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 04:07:26 INFO - Downloading functools32-3.2.3-2.tar.gz 04:07:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:07:27 INFO - warning: no files found matching '*.txt' 04:07:27 INFO - no previously-included directories found matching 'build' 04:07:27 INFO - no previously-included directories found matching 'dist' 04:07:27 INFO - no previously-included directories found matching '.git*' 04:07:27 INFO - Installing collected packages: jsonschema, functools32 04:07:27 INFO - Running setup.py install for functools32 04:07:27 INFO - warning: no files found matching '*.txt' 04:07:27 INFO - no previously-included directories found matching 'build' 04:07:27 INFO - no previously-included directories found matching 'dist' 04:07:27 INFO - no previously-included directories found matching '.git*' 04:07:27 INFO - Successfully installed jsonschema functools32 04:07:27 INFO - Cleaning up... 04:07:27 INFO - Return code: 0 04:07:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04: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')]} 04:07:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04: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')]} 04:07:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7e14c13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1764350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f31c0>, '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 0x17f40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f4550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467543624.376589-2033187659', '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 04:07:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:07:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:07:27 INFO - Using env: {'DISPLAY': ':0', 04:07:27 INFO - 'HOME': '/home/cltbld', 04:07:27 INFO - 'LANG': 'en_US.UTF-8', 04:07:27 INFO - 'LANGUAGE': 'en_US:en', 04:07:27 INFO - 'LOGNAME': 'cltbld', 04:07:27 INFO - 'MAIL': '/var/mail/cltbld', 04:07:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:27 INFO - 'MOZ_NO_REMOTE': '1', 04:07:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:27 INFO - 'NO_EM_RESTART': '1', 04:07:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:27 INFO - 'PWD': '/builds/slave/test', 04:07:27 INFO - 'SHELL': '/bin/bash', 04:07:27 INFO - 'SHLVL': '1', 04:07:27 INFO - 'TERM': 'linux', 04:07:27 INFO - 'TMOUT': '86400', 04:07:27 INFO - 'USER': 'cltbld', 04:07:27 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467543624.376589-2033187659', 04:07:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:27 INFO - '_': '/tools/buildbot/bin/python'} 04:07:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:27 INFO - Downloading/unpacking blobuploader==1.2.4 04:07:27 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 04:07:27 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 04:07:27 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 04:07:27 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 04:07:27 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 04:07:27 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 04:07:29 INFO - Downloading blobuploader-1.2.4.tar.gz 04:07:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:07:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:07:29 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 04:07:29 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 04:07:29 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 04:07:29 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 04:07:29 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 04:07:29 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 04:07:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:07:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:07:29 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 04:07:29 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 04:07:29 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 04:07:29 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 04:07:29 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 04:07:29 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 04:07:30 INFO - Downloading docopt-0.6.1.tar.gz 04:07:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:07:30 INFO - Installing collected packages: blobuploader, requests, docopt 04:07:30 INFO - Running setup.py install for blobuploader 04:07:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:07:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:07:30 INFO - Running setup.py install for requests 04:07:30 INFO - Running setup.py install for docopt 04:07:30 INFO - Successfully installed blobuploader requests docopt 04:07:30 INFO - Cleaning up... 04:07:30 INFO - Return code: 0 04:07:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:07:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:30 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 0x7f7e14c13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1764350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f31c0>, '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 0x17f40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f4550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467543624.376589-2033187659', '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 04:07:30 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 04:07:30 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 04:07:30 INFO - Using env: {'DISPLAY': ':0', 04:07:30 INFO - 'HOME': '/home/cltbld', 04:07:30 INFO - 'LANG': 'en_US.UTF-8', 04:07:30 INFO - 'LANGUAGE': 'en_US:en', 04:07:30 INFO - 'LOGNAME': 'cltbld', 04:07:30 INFO - 'MAIL': '/var/mail/cltbld', 04:07:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:30 INFO - 'MOZ_NO_REMOTE': '1', 04:07:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:30 INFO - 'NO_EM_RESTART': '1', 04:07:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:30 INFO - 'PWD': '/builds/slave/test', 04:07:30 INFO - 'SHELL': '/bin/bash', 04:07:30 INFO - 'SHLVL': '1', 04:07:30 INFO - 'TERM': 'linux', 04:07:30 INFO - 'TMOUT': '86400', 04:07:30 INFO - 'USER': 'cltbld', 04:07:30 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467543624.376589-2033187659', 04:07:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:30 INFO - '_': '/tools/buildbot/bin/python'} 04:07:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:07:30 INFO - Running setup.py (path:/tmp/pip-wz5JcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:07:30 INFO - Running setup.py (path:/tmp/pip-nok0XT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:07:31 INFO - Running setup.py (path:/tmp/pip-PWV9bU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:07:31 INFO - Running setup.py (path:/tmp/pip-fpdbHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:07:31 INFO - Running setup.py (path:/tmp/pip-M37eSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:07:31 INFO - Running setup.py (path:/tmp/pip-H99GZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:07:31 INFO - Running setup.py (path:/tmp/pip-eMXpzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:07:31 INFO - Running setup.py (path:/tmp/pip-syTAPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:07:31 INFO - Running setup.py (path:/tmp/pip-Y1Bt80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:07:31 INFO - Running setup.py (path:/tmp/pip-Jk2j35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:07:31 INFO - Running setup.py (path:/tmp/pip-KxiOg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:07:31 INFO - Running setup.py (path:/tmp/pip-Iy0lX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:07:31 INFO - Running setup.py (path:/tmp/pip-w40EG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:07:31 INFO - Running setup.py (path:/tmp/pip-05GnVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:07:31 INFO - Running setup.py (path:/tmp/pip-VwT0aR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:07:31 INFO - Running setup.py (path:/tmp/pip-Ao1NHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:07:32 INFO - Running setup.py (path:/tmp/pip-_0BZQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:07:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:07:32 INFO - Running setup.py install for manifestparser 04:07:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:07:32 INFO - Running setup.py install for mozcrash 04:07:32 INFO - Running setup.py install for mozdebug 04:07:32 INFO - Running setup.py install for mozdevice 04:07:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:07:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:07:32 INFO - Running setup.py install for mozfile 04:07:32 INFO - Running setup.py install for mozhttpd 04:07:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:07:32 INFO - Running setup.py install for mozinfo 04:07:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:07:32 INFO - Running setup.py install for mozInstall 04:07:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:07:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:07:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:07:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:07:32 INFO - Running setup.py install for mozleak 04:07:33 INFO - Running setup.py install for mozlog 04:07:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:07:33 INFO - Running setup.py install for moznetwork 04:07:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:07:33 INFO - Running setup.py install for mozprocess 04:07:33 INFO - Running setup.py install for mozprofile 04:07:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:07:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:07:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:07:33 INFO - Running setup.py install for mozrunner 04:07:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:07:33 INFO - Running setup.py install for mozscreenshot 04:07:33 INFO - Running setup.py install for moztest 04:07:33 INFO - Running setup.py install for mozversion 04:07:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:07:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:07:33 INFO - Cleaning up... 04:07:33 INFO - Return code: 0 04:07:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:07:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:33 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 0x7f7e14c13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1764350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f31c0>, '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 0x17f40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f4550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467543624.376589-2033187659', '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 04:07:33 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 04:07:33 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 04:07:33 INFO - Using env: {'DISPLAY': ':0', 04:07:33 INFO - 'HOME': '/home/cltbld', 04:07:33 INFO - 'LANG': 'en_US.UTF-8', 04:07:33 INFO - 'LANGUAGE': 'en_US:en', 04:07:33 INFO - 'LOGNAME': 'cltbld', 04:07:33 INFO - 'MAIL': '/var/mail/cltbld', 04:07:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:33 INFO - 'MOZ_NO_REMOTE': '1', 04:07:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:33 INFO - 'NO_EM_RESTART': '1', 04:07:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:33 INFO - 'PWD': '/builds/slave/test', 04:07:33 INFO - 'SHELL': '/bin/bash', 04:07:33 INFO - 'SHLVL': '1', 04:07:33 INFO - 'TERM': 'linux', 04:07:33 INFO - 'TMOUT': '86400', 04:07:33 INFO - 'USER': 'cltbld', 04:07:33 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467543624.376589-2033187659', 04:07:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:33 INFO - '_': '/tools/buildbot/bin/python'} 04:07:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:07:34 INFO - Running setup.py (path:/tmp/pip-HncyPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:07:34 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)) 04:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:07:34 INFO - Running setup.py (path:/tmp/pip-o2YIks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:07:34 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)) 04:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:07:34 INFO - Running setup.py (path:/tmp/pip-zdD9yV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:07:34 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)) 04:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:07:34 INFO - Running setup.py (path:/tmp/pip-bzVGuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:07:34 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)) 04:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:07:34 INFO - Running setup.py (path:/tmp/pip-UwkTFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:07:34 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)) 04:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:07:34 INFO - Running setup.py (path:/tmp/pip-eQ0fve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:07:34 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)) 04:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:07:34 INFO - Running setup.py (path:/tmp/pip-KqZE7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:07:34 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)) 04:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:07:34 INFO - Running setup.py (path:/tmp/pip-gRPIz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:07:34 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)) 04:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:07:34 INFO - Running setup.py (path:/tmp/pip-NQmV5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:07:34 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)) 04:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:07:34 INFO - Running setup.py (path:/tmp/pip-co2PKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:07:34 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)) 04:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:07:34 INFO - Running setup.py (path:/tmp/pip-1h6m2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:07:34 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)) 04:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:07:34 INFO - Running setup.py (path:/tmp/pip-xckb9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:07:35 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)) 04:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:07:35 INFO - Running setup.py (path:/tmp/pip-KW3xTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:07:35 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)) 04:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:07:35 INFO - Running setup.py (path:/tmp/pip-9haFk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:07:35 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)) 04:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:07:35 INFO - Running setup.py (path:/tmp/pip-H4J471-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:07:35 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)) 04:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:07:35 INFO - Running setup.py (path:/tmp/pip-7LaCv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:07:35 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)) 04:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:07:35 INFO - Running setup.py (path:/tmp/pip-ccN9Wu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:07:35 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)) 04:07:35 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)) 04:07:35 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)) 04:07:35 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)) 04:07:35 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)) 04:07:35 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)) 04:07:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:07:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:37 INFO - Downloading blessings-1.6.tar.gz 04:07:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:07:37 INFO - Installing collected packages: blessings 04:07:37 INFO - Running setup.py install for blessings 04:07:37 INFO - Successfully installed blessings 04:07:37 INFO - Cleaning up... 04:07:37 INFO - Return code: 0 04:07:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:07:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:07:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:07:37 INFO - Reading from file tmpfile_stdout 04:07:37 INFO - Current package versions: 04:07:37 INFO - argparse == 1.2.1 04:07:37 INFO - blessings == 1.6 04:07:37 INFO - blobuploader == 1.2.4 04:07:37 INFO - docopt == 0.6.1 04:07:37 INFO - functools32 == 3.2.3-2 04:07:37 INFO - jsonschema == 2.5.1 04:07:37 INFO - manifestparser == 1.1 04:07:37 INFO - mozInstall == 1.12 04:07:37 INFO - mozcrash == 0.17 04:07:37 INFO - mozdebug == 0.1 04:07:37 INFO - mozdevice == 0.48 04:07:37 INFO - mozfile == 1.2 04:07:37 INFO - mozhttpd == 0.7 04:07:37 INFO - mozinfo == 0.9 04:07:37 INFO - mozleak == 0.1 04:07:37 INFO - mozlog == 3.2 04:07:37 INFO - moznetwork == 0.27 04:07:37 INFO - mozprocess == 0.22 04:07:37 INFO - mozprofile == 0.28 04:07:37 INFO - mozrunner == 6.11 04:07:37 INFO - mozscreenshot == 0.1 04:07:37 INFO - mozsystemmonitor == 0.3 04:07:37 INFO - moztest == 0.7 04:07:37 INFO - mozversion == 1.4 04:07:37 INFO - psutil == 3.1.1 04:07:37 INFO - requests == 1.2.3 04:07:37 INFO - wsgiref == 0.1.2 04:07:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:07:37 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')]} 04:07:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:37 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')]} 04:07:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:37 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 0x7f7e14c13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1764350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f31c0>, '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 0x17f40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f4550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467543624.376589-2033187659', '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 04:07:37 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 04:07:37 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 04:07:37 INFO - Using env: {'DISPLAY': ':0', 04:07:37 INFO - 'HOME': '/home/cltbld', 04:07:37 INFO - 'LANG': 'en_US.UTF-8', 04:07:37 INFO - 'LANGUAGE': 'en_US:en', 04:07:37 INFO - 'LOGNAME': 'cltbld', 04:07:37 INFO - 'MAIL': '/var/mail/cltbld', 04:07:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:37 INFO - 'MOZ_NO_REMOTE': '1', 04:07:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:37 INFO - 'NO_EM_RESTART': '1', 04:07:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:37 INFO - 'PWD': '/builds/slave/test', 04:07:37 INFO - 'SHELL': '/bin/bash', 04:07:37 INFO - 'SHLVL': '1', 04:07:37 INFO - 'TERM': 'linux', 04:07:37 INFO - 'TMOUT': '86400', 04:07:37 INFO - 'USER': 'cltbld', 04:07:37 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467543624.376589-2033187659', 04:07:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:37 INFO - '_': '/tools/buildbot/bin/python'} 04:07:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:37 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)) 04:07:37 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)) 04:07:37 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)) 04:07:37 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)) 04:07:37 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)) 04:07:37 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)) 04:07:37 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)) 04:07:37 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)) 04:07:37 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)) 04:07:37 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)) 04:07:37 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)) 04:07:37 INFO - Cleaning up... 04:07:37 INFO - Return code: 0 04:07:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:07:37 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')]} 04:07:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:37 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')]} 04:07:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:37 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 0x7f7e14c13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1764350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f31c0>, '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 0x17f40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f4550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467543624.376589-2033187659', '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 04:07:37 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 04:07:37 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 04:07:37 INFO - Using env: {'DISPLAY': ':0', 04:07:37 INFO - 'HOME': '/home/cltbld', 04:07:37 INFO - 'LANG': 'en_US.UTF-8', 04:07:37 INFO - 'LANGUAGE': 'en_US:en', 04:07:37 INFO - 'LOGNAME': 'cltbld', 04:07:37 INFO - 'MAIL': '/var/mail/cltbld', 04:07:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:37 INFO - 'MOZ_NO_REMOTE': '1', 04:07:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:37 INFO - 'NO_EM_RESTART': '1', 04:07:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:37 INFO - 'PWD': '/builds/slave/test', 04:07:37 INFO - 'SHELL': '/bin/bash', 04:07:37 INFO - 'SHLVL': '1', 04:07:37 INFO - 'TERM': 'linux', 04:07:37 INFO - 'TMOUT': '86400', 04:07:37 INFO - 'USER': 'cltbld', 04:07:37 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467543624.376589-2033187659', 04:07:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:37 INFO - '_': '/tools/buildbot/bin/python'} 04:07:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:07:38 INFO - Cleaning up... 04:07:38 INFO - Return code: 0 04:07:38 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:07:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:38 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 0x7f7e14c13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1764350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f31c0>, '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 0x17f40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f4550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467543624.376589-2033187659', '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 04:07:38 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 04:07:38 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 04:07:38 INFO - Using env: {'DISPLAY': ':0', 04:07:38 INFO - 'HOME': '/home/cltbld', 04:07:38 INFO - 'LANG': 'en_US.UTF-8', 04:07:38 INFO - 'LANGUAGE': 'en_US:en', 04:07:38 INFO - 'LOGNAME': 'cltbld', 04:07:38 INFO - 'MAIL': '/var/mail/cltbld', 04:07:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:38 INFO - 'MOZ_NO_REMOTE': '1', 04:07:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:38 INFO - 'NO_EM_RESTART': '1', 04:07:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:38 INFO - 'PWD': '/builds/slave/test', 04:07:38 INFO - 'SHELL': '/bin/bash', 04:07:38 INFO - 'SHLVL': '1', 04:07:38 INFO - 'TERM': 'linux', 04:07:38 INFO - 'TMOUT': '86400', 04:07:38 INFO - 'USER': 'cltbld', 04:07:38 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467543624.376589-2033187659', 04:07:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:38 INFO - '_': '/tools/buildbot/bin/python'} 04:07:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:38 INFO - Downloading/unpacking flake8 04:07:38 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 04:07:38 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 04:07:38 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 04:07:38 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 04:07:38 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 04:07:38 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 04:07:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:07:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:07:40 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 04:07:40 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 04:07:40 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 04:07:40 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 04:07:40 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 04:07:40 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 04:07:40 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:07:40 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:07:40 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 04:07:40 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 04:07:40 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 04:07:40 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 04:07:40 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 04:07:40 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 04:07:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:07:40 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 04:07:40 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 04:07:40 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 04:07:40 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 04:07:40 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 04:07:40 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 04:07:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:07:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:07:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:07:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:07:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:07:41 INFO - no previously-included directories found matching 'docs/_build' 04:07:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:07:41 INFO - Running setup.py install for pep8 04:07:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:07:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:07:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:07:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:07:41 INFO - no previously-included directories found matching 'docs/_build' 04:07:41 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:07:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:07:41 INFO - Cleaning up... 04:07:41 INFO - Return code: 0 04:07:41 INFO - Running post-action listener: _resource_record_post_action 04:07:41 INFO - Running post-action listener: _start_resource_monitoring 04:07:41 INFO - Starting resource monitoring. 04:07:41 INFO - ##### 04:07:41 INFO - ##### Finished create-virtualenv step (success) 04:07:41 INFO - ##### 04:07:41 INFO - ##### 04:07:41 INFO - ##### Running install step. 04:07:41 INFO - ##### 04:07:41 INFO - Running pre-action listener: _resource_record_pre_action 04:07:41 INFO - Running main action method: install 04:07:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:07:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:07:41 INFO - Reading from file tmpfile_stdout 04:07:41 INFO - Detecting whether we're running mozinstall >=1.0... 04:07:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:07:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:07:41 INFO - Reading from file tmpfile_stdout 04:07:41 INFO - Output received: 04:07:41 INFO - Usage: mozinstall [options] installer 04:07:41 INFO - Options: 04:07:41 INFO - -h, --help show this help message and exit 04:07:41 INFO - -d DEST, --destination=DEST 04:07:41 INFO - Directory to install application into. [default: 04:07:41 INFO - "/builds/slave/test"] 04:07:41 INFO - --app=APP Application being installed. [default: firefox] 04:07:41 INFO - mkdir: /builds/slave/test/build/application 04:07:41 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'] 04:07:41 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 04:07:57 INFO - Reading from file tmpfile_stdout 04:07:57 INFO - Output received: 04:07:57 INFO - /builds/slave/test/build/application/firefox/firefox 04:07:57 INFO - Running post-action listener: _resource_record_post_action 04:07:57 INFO - ##### 04:07:57 INFO - ##### Finished install step (success) 04:07:57 INFO - ##### 04:07:57 INFO - ##### 04:07:57 INFO - ##### Running run-tests step. 04:07:57 INFO - ##### 04:07:57 INFO - Running pre-action listener: _resource_record_pre_action 04:07:57 INFO - Running main action method: run_tests 04:07:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:07:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:07:57 INFO - Python 2.7.3 04:07:57 INFO - Return code: 0 04:07:57 INFO - grabbing minidump binary from tooltool 04: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')]} 04:07:57 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 0x17f31c0>, '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 0x17f40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f4550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:07:57 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 04:07:57 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 04:07:57 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 04:07:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:07:57 INFO - Return code: 0 04:07:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:07:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:07:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:07:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:07:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:07:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:07:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:07:58 INFO - Return code: 0 04:07:58 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/FUEeBfmtQXeihgHe0tvNCQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 04:07:58 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/FUEeBfmtQXeihgHe0tvNCQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --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 04:07:58 INFO - Using env: {'DISPLAY': ':0', 04:07:58 INFO - 'HOME': '/home/cltbld', 04:07:58 INFO - 'LANG': 'en_US.UTF-8', 04:07:58 INFO - 'LANGUAGE': 'en_US:en', 04:07:58 INFO - 'LOGNAME': 'cltbld', 04:07:58 INFO - 'MAIL': '/var/mail/cltbld', 04:07:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:07:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:07:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:58 INFO - 'MOZ_NO_REMOTE': '1', 04:07:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:07:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:58 INFO - 'NO_EM_RESTART': '1', 04:07:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:58 INFO - 'PWD': '/builds/slave/test', 04:07:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:07:58 INFO - 'SHELL': '/bin/bash', 04:07:58 INFO - 'SHLVL': '1', 04:07:58 INFO - 'TERM': 'linux', 04:07:58 INFO - 'TMOUT': '86400', 04:07:58 INFO - 'USER': 'cltbld', 04:07:58 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467543624.376589-2033187659', 04:07:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:58 INFO - '_': '/tools/buildbot/bin/python'} 04:07:58 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/FUEeBfmtQXeihgHe0tvNCQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 04:07:58 INFO - mozversion application_buildid: 20160703011021 04:07:58 INFO - mozversion application_changeset: b9faa10c9918a271440acd6233028ba10c0ae1ac 04:07:58 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:07:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:07:58 INFO - mozversion application_name: Firefox 04:07:58 INFO - mozversion application_remotingname: firefox-dev 04:07:58 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:07:58 INFO - mozversion application_vendor: Mozilla 04:07:58 INFO - mozversion application_version: 49.0a2 04:07:58 INFO - mozversion platform_buildid: 20160703011021 04:07:58 INFO - mozversion platform_changeset: b9faa10c9918a271440acd6233028ba10c0ae1ac 04:07:58 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:07:58 INFO - mozversion platform_version: 49.0a2 04:07:58 INFO - using testdate: 1467544078 04:07:58 INFO - actual date: 1467544078 04:07:58 INFO - starting webserver on 'localhost:39065' 04:07:58 INFO - SUITE-START | Running 2 tests 04:07:58 INFO - TEST-START | dromaeo_css 04:07:58 INFO - operating with platform_type : linux_ 04:07:58 INFO - Initialising browser for dromaeo_css test... 04:07:58 INFO - TEST-INFO | started process 20163 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHmAvJN/profile http://localhost:39065/getInfo.html) 04:08:03 INFO - PROCESS | 20163 | __metrics Screen width/height:1600/1200 04:08:03 INFO - PROCESS | 20163 | colorDepth:24 04:08:03 INFO - PROCESS | 20163 | Browser inner width/height: 1024/697 04:08:03 INFO - PROCESS | 20163 | __metrics 04:08:04 ERROR - PROCESS | 20163 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 04:08:05 INFO - TEST-INFO | 20163: exit 0 04:08:05 INFO - Browser initialized. 04:08:05 INFO - Running cycle 1/1 for dromaeo_css test... 04:08:05 INFO - TEST-INFO | started process 20293 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHmAvJN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:08:17 INFO - PROCESS | 20293 | RSS: Main: 156422144 04:08:17 INFO - PROCESS | 20293 | 04:09:06 INFO - PROCESS | 20293 | 1467544146667 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] 04:11:15 INFO - PROCESS | 20293 | Cycle 1(1): loaded http://localhost:39065/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39065/tests/dromaeo/cssquery-ext.html) 04:11:16 INFO - PROCESS | 20293 | RSS: Main: 159219712 04:11:16 INFO - PROCESS | 20293 | 04:14:18 INFO - PROCESS | 20293 | Cycle 1(1): loaded http://localhost:39065/tests/dromaeo/cssquery-ext.html (next: http://localhost:39065/tests/dromaeo/cssquery-jquery.html) 04:14:19 INFO - PROCESS | 20293 | RSS: Main: 157302784 04:14:19 INFO - PROCESS | 20293 | 04:17:20 INFO - PROCESS | 20293 | Cycle 1(1): loaded http://localhost:39065/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39065/tests/dromaeo/cssquery-mootools.html) 04:17:21 INFO - PROCESS | 20293 | RSS: Main: 157310976 04:17:21 INFO - PROCESS | 20293 | 04:20:23 INFO - PROCESS | 20293 | Cycle 1(1): loaded http://localhost:39065/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39065/tests/dromaeo/cssquery-prototype.html) 04:20:23 INFO - PROCESS | 20293 | RSS: Main: 156999680 04:20:23 INFO - PROCESS | 20293 | 04:23:26 INFO - PROCESS | 20293 | Cycle 1(1): loaded http://localhost:39065/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39065/tests/dromaeo/cssquery-yui.html) 04:23:27 INFO - PROCESS | 20293 | RSS: Main: 159178752 04:23:27 INFO - PROCESS | 20293 | 04:26:29 INFO - PROCESS | 20293 | Cycle 1(1): loaded http://localhost:39065/tests/dromaeo/cssquery-yui.html (next: http://localhost:39065/tests/dromaeo/cssquery-dojo.html) 04:26:29 INFO - PROCESS | 20293 | RSS: Main: 159326208 04:26:29 INFO - PROCESS | 20293 | 04:26:29 INFO - PROCESS | 20293 | __start_tp_report 04:26:29 INFO - PROCESS | 20293 | _x_x_mozilla_page_load 04:26:29 INFO - PROCESS | 20293 | _x_x_mozilla_page_load_details 04:26:29 INFO - PROCESS | 20293 | |i|pagename|runs| 04:26:29 INFO - PROCESS | 20293 | |0;dojo.html;3391.5421418108554;3438.707709844663;3439.4324936385497;3444.466107753299;3455.118944669109;5724.914126288104;5726.083826587742;5726.828195154147;5778.884422311551;5810.738516766745;5763;5783.392743761897;5812.244408226935;5829.125631155329;5853.853653658661;5276.261323414725;5292.92060619091;5338.332708411449;5351.518363347298;5396.676199428027;5171.793128274864;5212.739363031852;5219.060569097561;5381.946180538203;5386.515213630772;5231.058409486291;5267.604929630274;5306.602004849632;5315.229291752694;5352.143657014878;5380.488853558905;5381.0583147948955;5390.4879036491475;5408.567314614821;5412.972935135299;5020.573251273646;5172.431032586413;5221.086309895753;5289.656172348785;5308.601854860901;5584.804531841407;5703.258576385043;5720.828375148711;5770.567207459415;5785.508231800302;6272.717727702265;6282.340354262828;6314.652694101823;6324.3043265240785;6341.619502829799;6059.939400605982;6130.031268545464;6163.322034576193;6349.174607301067;6363.522735794834;5783.768649254067;5832.533397328246;5850.912236316459;5854.619449735754;5868.97065514674;6393.808185754435;6439.8068057958335;6476.773312934025;6479.935200647933;6480.319566445455;6082.665453400017;6138.324784273726;6150.292716337678;6210;6215.533834962305;6284.24589049317;6308.653024083719;6313.3686631336495;6317.936820631827;6333.778317758856;5967.910481342783;6199.876002480015;6254.312025677172;6259.405356491217;6264.436200741955;6145.770845830852;6182.165407669997;6219.689015549295;6286.277078136073;6297.338779428185;4696.459907110726;4702.952970470252;4704.600108990706;4729.668923175344;4734.360861283752;4160.8335666573;4175.123224122907;4253.21315556623;4254.510731265882;4280;5788.797392091256;5906.645601263938;5934.1692163097205;5983.581149319506;6063.636181829104;6226.097215903668;6312.400321969406;6342.5560210785725;6349.746010159634;6360.1731774869895;5797.536197104221;5851.1223316502865;6021.157038014681;6028.2766068072115;6046.09308603713;5308.071087559739;5312.415634280226;5324.866878328073;5368.946310536923;5377.354717433933;6431.228252609717;6464.935350646433;6474.12599299098;6486.383793539606;6487.351264873475;5935.198748168942;6121.270068921507;6185.505159587312;6196.287426945779;6209.813705588839;6402.103705481143;6518.413342799171;6579.539432239889;6585.308542603149;6590.209174899042;6230.190075290183;6235.625862448268;6238.625682459067;6238.968805155945;6246.406591373812;6058.363871793398;6139.093519790236;6180.598261113013;6350.809475715736;6367.681615919093;6106.207495297345;6133.212252453684;6137.979623346715;6151.415615516519;6159.322474527708;6102.572819902564;6103.511719062553;6105.908411373922;6110.114033465212;6115.301188036123;5806.216160818404;5852.005159123045;5926.051831706906;5945.19739835134;6018.127371531016;6116.235470566179;6139.386061394003;6141.539384546088;6147.538934580014;6159.353267906805;6008.639481630941;6015.849603759941;6016.09758536223;6019.638821670714;6027.065804800263 04:26:29 INFO - PROCESS | 20293 | |1;ext.html;585.6573904266004;634.3941535833279;639.6545865232774;658.2035736758522;672.6569449580712;42000.15999680008;47178.764106179464;47185;47216;47317.29024064642;47812;48223.27665085027;48460.75769621147;48468;48563.51436485634;8958.372913896046;9053.50205738684;9062.818743625123;9082.818343633124;9087;8740.956295218546;8809.075047120055;8854.822903541924;8859.911400886005;8865.202131808135;8853.601587928526;8881.822363552725;8904.198622124008;8921.286297096249;8955.731328060136;8807.911920880806;8830.823383532326;8867.068957759408;8870.778230544223;8873.51195684237;8865.113488651083;8940.46357218569;8942.239909607626;8960.103989601053;8964.103589640983;43513;43632.3455148173;43750.343744843856;43836.780816095714;43858;3765.7928813915496;4000.5199376074765;4001.899952501182;4295.162443323553;4482.798274077674;33503.497447538306;34254;34845;35026.29947401063;35378.82310588431;4647.95352046482;4734.857954261378;4747.810087596492;4793.32893394925;4828.61371090312;373338;373817;373995;374950;375434;62594.37405625977;62775;62948.37051629425;63151;63200.36799632037;40311.79844100761;40583.18833623311;41231.38152927708;42630.147397051885;67921.3207867925;17520.21159047846;17682.381116661112;17688.734668979974;17692;17746.733798993024;12795.552155674506;12798.104132710621;12822.615321540368;12851.228926264454;12879.806802897963;21220.25729099474;21553.78446215549;21597.67603485949;21598.35204943854;21671.24150654751;7478.177400485943;7807.180246074194;7908.960455197802;7910.683572657144;7935.246151615587;1025.8050970315617;1107.1917500224881;1140.4639819284923;1173.8708742038368;1204.3556697166973;32930.67069329276;33124;33187.83406083003;33649.49525757116;34047.14882127967;1178.5698220149584;1203.3562044306254;1219.451246938881;1243.7325974915436;1275.9298238596966;17717.911410442866;17736.55658608545;17744.29022839098;17789.7331540027;17804.46586602404;602242;602759;605549;607412;610956;63771;64258;64584;64659.353406465336;64838.35161648323;1475.3950880139091;1480.1563109027966;1505.32260482781;1511.093343993595;1528.296983387654;32812.1796955078;32831.50752738663;33133;33184.33631327312;33762.83118584391;55544;55770.16344754913;55983;55983.16025259706;56040;467608;468178;469183;470402;472237;30676.233094172825;31044.84477577688;31855.522167167048;31902.36195276128;31966;52352.73823630858;52737.47262527326;52782.472175277755;53853.19220211778;53872;44009.44550115557;44955.32567011432;45317.09365812731;46221.07557848891;46372.7681361591;44796;45395.319070213314;45751.77124114358;45791.54208457873;46095.76952115218;44075.11849762923;45756;46104.308435372826;46341.304880427495;48052.75973620109;39035.21929561449;39366.606333936295;39429;40279.79860100798;40461.39307910325;29692;29797.957071502395;30113;30551.2362190947;30567 04:26:29 INFO - PROCESS | 20293 | |2;jquery.html;435.93896854440374;436.58306317466804;439.28615999001624;443.815816436179;453.6707447179762;19663.606727865434;19685.606287874252;20512.589748205028;20696.48258793531;20706.89646551769;18783.812161878377;19767.5058123547;20213.494662633442;20327.085281162344;20372.388828335173;5632;5786.9710651446685;5822.388649191837;5826.854328641797;5836.649801011931;5509.889802203954;5823;5847.181394604759;5927.318358388776;5983;5695.914561281584;5851.327097383792;5882.5588080893895;5924.674142922137;5954.553408494358;5731.140328950649;5866.823995280149;5909;5934.169216309699;5947.970260148693;5875.265591801025;5875.471207591295;5912.674802885839;5918.3785702501045;5946.643201407929;12820.35898205086;13146.934265328708;13248.271345076017;14459.843212542972;14717.337719802528;2381.8094552435764;2389.940251493709;2470.258922323296;2498.1256560203965;2768.1280396674983;10870;10896.346219226873;10975.890241097566;11239.044681202107;11763.58827441044;2028.8275496582808;2091.1530830013867;2093.3615247349553;2164.3398763377163;2201.4496375906024;60110.69944650293;71074;82029.9999999994;83221.58389208015;83573.16426835775;11554.248973816675;11740.647780566596;11892.216167574932;11918.344491053076;11950.223235489839;16625.833741662427;16848;16946.830531694526;16979.83020169807;16991;8373.665053397917;8392.328613710888;8420.915790842013;8427.789305267417;8611.526366049802;8038.356931445471;8061.395395345373;8106.067802202704;8144.063432705197;8183.79540511492;4633.258678611406;4856.106118613743;4943.134951383494;5103.540681338697;5203.479652034766;2031.6850888112367;2084.9061792219386;2103.2323202031453;2116.6190085784706;2125.851190416687;992.1368409483796;1012.9797404051877;1036.5698235232444;1037.911777498921;1137.3460260350332;19970.800291997184;20221.191152354037;20561.588768224552;20567.8971605141;20591.588168236853;1023.3092662452815;1027.4913917610832;1039.750459889621;1055.466989170464;1058.2010582010532;11180.944095279634;11623.709407264885;11692.181547291608;11710.88289117115;11713.121515886343;489441;499307;517683;518555;524186;81633;99801.50099249458;101235.49382253189;101999.49000254952;103300;1037.3464717228098;1081.832315991007;1093.6336327330275;1100.785346857355;1105.2152971390242;18402.171902264698;18472.630547388708;18516.231826329204;18529;18829.529261768566;39673.40489892712;41415.58584414118;42357.36463952981;42677.14645707131;44105;53276.2008569864;64366;65553.67223163854;65674;66163;7507.66215520292;7795.103563090317;7884.448088633741;7979.640916158671;8749;9532.809343812945;12844.422001010164;12892.613221603367;13092.083554151119;13117.540886068942;11431.771364572829;11452.14108941816;11483.655490335303;11692.649220523397;11869.52521899149;11492.48283827213;11553.364564949008;11679.941600291944;11717.765644686888;11924.70188245266;11651.359175245443;11679.591214307458;11779.764404712028;12026.639200823989;12073.939630301793;7355.374793142642;7764.301212890867;7893.289603935444;8003.11965683786;8256.711015114442;10581.947090264808;10846.078083362687;11196.496157673088;11323.943380283046;11394.25937314072 04:26:29 INFO - PROCESS | 20293 | |3;mootools.html;1591.9124448155353;1605.6788642271545;1843.1429385335816;1895.3745264062861;1914.4161030885582;8881.777955551115;9333.486658233795;9385.859212111824;10124.797504049915;10129.290949633529;9518.524073796318;9811.65659201928;9890.406575605452;9904.158146557551;9925.702228933125;2553.6807899012624;2596.532624127656;2597.6103584462294;2599.5970624553224;2604.348912771807;2499.2252401755513;2573.4981678572685;2577.935551611206;2578.845269283849;2582.3931376126593;2565.602331638599;2575.33041409234;2589.145581957949;2593.0276146445085;2598.272483704556;2503.987480062606;2516.3457501049675;2538.0989748639154;2538.5557527432716;2552.961705574418;2506.7618576235227;2515.1071369663873;2517.3958250020046;2528.254165021323;2557.309526427854;9751.561179746928;9864.95067524665;9913.90086099137;9916.603335866557;9917.801643967152;5909.113632955048;6001.639901605918;6047.939520604782;6072.45347918685;6087.3303936566945;3699.4265888787013;3751.118487155516;3806.200697853454;3829.3681542545446;3849.40334248192;1206.9094817888692;1237.7029512916924;1250.7060840702427;1257.3398965543163;1268.8477382714134;14185.929070354685;14209.934254930922;14353.856461435356;14354.85645143556;14379.928100359431;5220.425753167148;5270.077736396115;5290.047791397508;5312.601554883399;5364.7317634118135;11782.705432364259;11915.52337906474;11930.105242106876;11940.522379104912;11995.400229988465;5995.850103747442;6012.428819262163;6026.126211699279;6046.848828779228;6047.0627052806885;4838.129136755418;5182.611304152204;5385.542228910586;5390.460953904578;5500.119980803052;4470.709403888737;4503;4551.226291530448;4558.247889098328;4582.656300777388;1404.592668126232;1437.2669938331526;1460.4304321314696;1464.406915199346;1468.0604413175577;948.7770373962113;1045.257866914484;1049.7847941172042;1057.5452555401098;1067.2102644043352;6334.334894836068;6460.224773027267;6512.944177611298;6515.511336649675;6531.216254049545;484.7430861643335;493.4769144706622;498.82042464712674;506.70611045593466;519.4286285086375;4221.2190744712325;4284.978575107167;4291.3777502262;4332.220200363965;4340.782960851945;12322.199057061262;12392.690182745324;12547.811782823264;12694.555690550971;12707.174033687965;12377.133600648049;12513.186642868184;12586.937065314614;12598.81101783474;12623.873761262454;8961.462312261285;9095.954520227357;9143.085691430804;9169.633214671338;9174.036726143791;5936.554758393051;6131.325554189125;6163;6269.592476489013;6317.526185536011;10972;11390.145739069769;11460.770784584429;11480;11489.425528723697;11738.530458781554;11742.00192983606;11758.647240582795;11769.529218831492;11878.109141814572;8100.351971842357;8626.266767324847;8903.955480222558;8991.100889910957;9117.133872282122;9764.951175244363;9786.31495795316;9833.655822046194;9880.802383952425;9888.110070093438;8570.228679418882;8645.438046526955;8666.176713212235;8697.391182617155;8890.110988901059;8494.957525212581;8610.569471526524;8730.738077857675;8810.251128654136;8917.73246802597;7336.96331518339;7389.704411823467;7456.850862982818;7487.47587668858;7512.13610434807;5403.13549832025;5611.57913156523;5619.80330688424;5635.0702134147405;5738.856528586819;5491.588130890119;5564.666120032811;5668.631538949955;5810.796622118206;5866.413358664099 04:26:29 INFO - PROCESS | 20293 | |4;prototype.html;364.0788804325057;364.2187507795778;371.8215256676795;373.91773809761844;375.7876799608221;5687.317521897367;5706.429357064291;5752.165935939286;5855.151003104547;5858.85352866178;5703.144528320754;5714.228579141814;5745.2818397700285;5748.5401167906575;5784.161296611988;4441.955580444194;4467.151241264166;4501.70738901972;4505.211587972108;4514.074614703978;4429.8228070877285;4469.463664360265;4496.9775151124195;4505.797239124247;4535.344599221277;4470.955290447103;4471.1728330259;4485;4499.932501012488;4524.11779702958;4359.215341238576;4498.212812757754;4499.842505512308;4516.345129956138;4549.727016378994;3925.9411108833106;3938.8818335449982;3951.68386529077;3963.7225394222414;3975.3440682287387;5625.774969001235;5634.04221282383;5644.802431914904;5646.915296270559;5664.235328230678;5127.794888204505;5205.583553315726;5228.67324040802;5229.633925625208;5242.580593552545;6013.849653758647;6063.333033366326;6077.270727512682;6085.6348619082555;6114.174586430864;4381.255186618282;4384.473863136444;4390.012247244376;4411.536788637179;4413.337999300099;6160.7535698572;6266.686665666698;6381.404648837791;6409.8397540061405;6417.871642567169;4462.9776851116185;4476.37330773692;4490.416245888014;4513;4526.207913615104;4568.33759104928;4573.679842410999;4591.724496530219;4618.099470603267;4638.373819534387;5020.623453241022;5147.871303217449;5149.9742501288;5166.363045215587;5269.235960785742;5919.763209471573;6042.818715438544;6062.787802426894;6106.503906542836;6119.694015299217;1537.2237020304674;1542.2520077762276;1551.5655616427418;1552.7360348740742;1553.5261745167832;984.1683777208248;1004.8442491413842;1008.6368907193405;1018.1600179851652;1021.4228960637216;5261.789528418821;5267.894642107136;5295.735213239323;5315.335583052119;5374.731263436813;5548.389677135512;5567.721613919369;5579.191017302468;5588.497035266845;5603.299587551556;5286.286351342596;5307.575393968474;5535.778568857281;5982.670953097534;5994.9700251499335;3361.7310615150727;3391.4065038618637;3399.1502124468884;3408.6932176103774;3410.60778010527;6318.873622527615;6648.301928297556;6658.4673226141795;6672.366125218096;6685.732570697215;6442.549021568539;6453.322401147906;6540.855350313676;6541.47668186544;6545.541812073109;6300.21247344082;6623.138991931018;6637.601743895381;6648.734050638017;6710.530262881552;6346.3019067903415;6376.756532476123;6397.776077837253;6414.679266036586;6438.742450301936;6322.49420046386;6333.6516491591565;6364.96817515928;6374.872502550016;6398.328175541501;6451.870962580816;6624.238212605612;6626.072349870926;6669.599824010575;6679.365460281266;4398.450193725785;4439.4228750262255;4441;4451.710638808467;4470.597646211857;6106.755729770759;6229.877416570465;6234.563580549318;6375.426211640789;6425.742970281136;6144.815655530341;6160.168377269011;6169.444749972524;6175.69121543912;6258.561900666909;6019.428154325332;6207.6585787782105;6207.937920620736;6221.129041934042;6246.219222597176;5987.2815262168815;6032.90950635732;6068.666223357758;6072.119542666377;6079.696015199134;6179.443850053517;6186.288576813724;6202.72087756043;6229.906551401642;6269.780557680459;5893.263342082239;6028.698565071817;6043.881881851871;6045.063015232646;6045.758169673164 04:26:29 INFO - PROCESS | 20293 | |5;yui.html;835.8955130608674;856.9228769410752;895.2256298301969;917.339515548805;926.9165775080241;15908.52274431766;16521.008739475626;16543.09013004286;17108.144592770343;17175.484735457925;14851.331690073946;15473.613159671015;15617.21913904303;15624.2969066392;15628.609284767857;871.9520426376547;872.2150064941571;878.9208971192592;882.0606054551914;882.0782282514756;850.4472093139478;876.8640860666607;879.6745204274428;882.483747008001;893.7318804358699;922.8523436250201;922.9861552076724;923.7413524213231;925.1488630459993;927.1562877781221;912.7216199059284;914.7210100919217;917.8118485710413;923.0262073512441;923.7967647117623;670.4636290967255;673.3468535520537;674.27852198148;674.9696263668146;675.5608854244731;14830.258487075604;14831.48089816862;14882.479113230986;14898.553043408716;14919.254037298091;14656.560303190921;15471.226438678133;15579.298931548108;15722;15793.447229347033;12988.610341689764;13015.674608134777;13066.869331306756;13166.86833131666;13441.596752097452;4100.753954762724;4111.116110036327;4137.420761093449;4180.456540649727;4246.681498887596;81926;83469.16530834735;83881.58059209665;84111;84309.57845210796;11670.591529296435;11811.586594469325;12231.143819932697;12285.447154878051;12396.31820249895;22369.328920132422;22541.211057612905;22746.09015639389;22776.772232277795;22802.885985569967;8981.775455613531;9001.36990410665;9009;9041.864372034424;9314.48770317639;4919.1391506486225;5006;5012.298278241049;5068.189089745697;5080.491950804964;3967.761934283952;4049.635532802062;4061.1674606705556;4080.9183816323507;4090.550039495653;696.1506961506954;698.9475789315821;701.1516065560627;701.435344547644;708.8475977664724;690.0781324012601;785.2763184809289;814.7311387242196;842.7008412013647;856.5075081827974;9343.2525397968;9935.503224838729;9962.850557241647;10116.241281903887;10257.58969641206;726.8364617961022;738.9556626602314;746.0823187479323;754.1779460388203;757.1028331427276;4531.501534831166;4647.674662773574;4654.138984287918;4663.160631086369;4719.079779442975;118335.40832295784;119492;124682;126707.36646316893;127440;65757;71262;104758;105635;107617;58524;92374.53812730893;92381;93687;93704;9193.816123677623;9315.487648179414;9394.859077113711;9435.198008169382;9499.38254013487;54717;55023.72488137534;55725.44274557203;55726.44273557375;56332;79499;81735.59132204301;81960.18039819764;82095.589522052;82338.58830705807;11744.060475161796;11963.222390544586;12438.19151755133;13145.737085258432;13431.05982581249;12791.616251512469;13589.79615305791;13852.86147138556;13994.230317332644;14502.492412765503;13305.866941330463;13501.392437340146;13626.863731362559;13880.652983675489;13883.236421996888;13307.800382994457;13311.800322995357;13428.261445620194;13995.930020349833;14144.717105658036;12471.688207794516;12564.560240391542;12740;13725.382357793724;14721.631959201106;11546.14522356458;11736.295822250693;12599.685007874876;12725.61823145307;12790.61628151157;11600.825987610024;12109.576164834189;12903.483860645845;12915.547955821501;13248.271345076113 04:26:29 INFO - PROCESS | 20293 | __end_tp_report 04:26:29 INFO - PROCESS | 20293 | __start_cc_report 04:26:29 INFO - PROCESS | 20293 | _x_x_mozilla_cycle_collect,342 04:26:29 INFO - PROCESS | 20293 | __end_cc_report 04:26:29 INFO - PROCESS | 20293 | __startTimestamp1467545189646__endTimestamp 04:26:29 INFO - PROCESS | 20293 | 04:26:29 INFO - PROCESS | 20293 | ------- Summary: start ------- 04:26:29 INFO - PROCESS | 20293 | Number of tests: 6 04:26:29 INFO - PROCESS | 20293 | 04:26:29 INFO - PROCESS | 20293 | [#0] dojo.html Cycles:165 Average:5796.60 Median:6021.16 stddev:667.68 (11.1%) stddev-sans-first:642.52 04:26:29 INFO - PROCESS | 20293 | Values: 3391.5 3438.7 3439.4 3444.5 3455.1 5724.9 5726.1 5726.8 5778.9 5810.7 5763.0 5783.4 5812.2 5829.1 5853.9 5276.3 5292.9 5338.3 5351.5 5396.7 5171.8 5212.7 5219.1 5381.9 5386.5 5231.1 5267.6 5306.6 5315.2 5352.1 5380.5 5381.1 5390.5 5408.6 5413.0 5020.6 5172.4 5221.1 5289.7 5308.6 5584.8 5703.3 5720.8 5770.6 5785.5 6272.7 6282.3 6314.7 6324.3 6341.6 6059.9 6130.0 6163.3 6349.2 6363.5 5783.8 5832.5 5850.9 5854.6 5869.0 6393.8 6439.8 6476.8 6479.9 6480.3 6082.7 6138.3 6150.3 6210.0 6215.5 6284.2 6308.7 6313.4 6317.9 6333.8 5967.9 6199.9 6254.3 6259.4 6264.4 6145.8 6182.2 6219.7 6286.3 6297.3 4696.5 4703.0 4704.6 4729.7 4734.4 4160.8 4175.1 4253.2 4254.5 4280.0 5788.8 5906.6 5934.2 5983.6 6063.6 6226.1 6312.4 6342.6 6349.7 6360.2 5797.5 5851.1 6021.2 6028.3 6046.1 5308.1 5312.4 5324.9 5368.9 5377.4 6431.2 6464.9 6474.1 6486.4 6487.4 5935.2 6121.3 6185.5 6196.3 6209.8 6402.1 6518.4 6579.5 6585.3 6590.2 6230.2 6235.6 6238.6 6239.0 6246.4 6058.4 6139.1 6180.6 6350.8 6367.7 6106.2 6133.2 6138.0 6151.4 6159.3 6102.6 6103.5 6105.9 6110.1 6115.3 5806.2 5852.0 5926.1 5945.2 6018.1 6116.2 6139.4 6141.5 6147.5 6159.4 6008.6 6015.8 6016.1 6019.6 6027.1 04:26:29 INFO - PROCESS | 20293 | 04:26:29 INFO - PROCESS | 20293 | [#1] ext.html Cycles:180 Average:65157.91 Median:45573.55 stddev:130782.75 (287.0%) stddev-sans-first:131059.77 04:26:29 INFO - PROCESS | 20293 | Values: 585.7 634.4 639.7 658.2 672.7 42000.2 47178.8 47185.0 47216.0 47317.3 47812.0 48223.3 48460.8 48468.0 48563.5 8958.4 9053.5 9062.8 9082.8 9087.0 8741.0 8809.1 8854.8 8859.9 8865.2 8853.6 8881.8 8904.2 8921.3 8955.7 8807.9 8830.8 8867.1 8870.8 8873.5 8865.1 8940.5 8942.2 8960.1 8964.1 43513.0 43632.3 43750.3 43836.8 43858.0 3765.8 4000.5 4001.9 4295.2 4482.8 33503.5 34254.0 34845.0 35026.3 35378.8 4648.0 4734.9 4747.8 4793.3 4828.6 373338.0 373817.0 373995.0 374950.0 375434.0 62594.4 62775.0 62948.4 63151.0 63200.4 40311.8 40583.2 41231.4 42630.1 67921.3 17520.2 17682.4 17688.7 17692.0 17746.7 12795.6 12798.1 12822.6 12851.2 12879.8 21220.3 21553.8 21597.7 21598.4 21671.2 7478.2 7807.2 7909.0 7910.7 7935.2 1025.8 1107.2 1140.5 1173.9 1204.4 32930.7 33124.0 33187.8 33649.5 34047.1 1178.6 1203.4 1219.5 1243.7 1275.9 17717.9 17736.6 17744.3 17789.7 17804.5 602242.0 602759.0 605549.0 607412.0 610956.0 63771.0 64258.0 64584.0 64659.4 64838.4 1475.4 1480.2 1505.3 1511.1 1528.3 32812.2 32831.5 33133.0 33184.3 33762.8 55544.0 55770.2 55983.0 55983.2 56040.0 467608.0 468178.0 469183.0 470402.0 472237.0 30676.2 31044.8 31855.5 31902.4 31966.0 52352.7 52737.5 52782.5 53853.2 53872.0 44009.4 44955.3 45317.1 46221.1 46372.8 44796.0 45395.3 45751.8 45791.5 46095.8 44075.1 45756.0 46104.3 46341.3 48052.8 39035.2 39366.6 39429.0 40279.8 40461.4 29692.0 29798.0 30113.0 30551.2 30567.0 04:26:29 INFO - PROCESS | 20293 | 04:26:29 INFO - PROCESS | 20293 | [#2] jquery.html Cycles:180 Average:29667.50 Median:2098.30 stddev:84104.56 (4008.2%) stddev-sans-first:84311.85 04:26:29 INFO - PROCESS | 20293 | Values: 435.9 436.6 439.3 443.8 453.7 19663.6 19685.6 20512.6 20696.5 20706.9 18783.8 19767.5 20213.5 20327.1 20372.4 5632.0 5787.0 5822.4 5826.9 5836.6 5509.9 5823.0 5847.2 5927.3 5983.0 5695.9 5851.3 5882.6 5924.7 5954.6 5731.1 5866.8 5909.0 5934.2 5948.0 5875.3 5875.5 5912.7 5918.4 5946.6 12820.4 13146.9 13248.3 14459.8 14717.3 2381.8 2389.9 2470.3 2498.1 2768.1 10870.0 10896.3 10975.9 11239.0 11763.6 2028.8 2091.2 2093.4 2164.3 2201.4 60110.7 71074.0 82030.0 83221.6 83573.2 11554.2 11740.6 11892.2 11918.3 11950.2 16625.8 16848.0 16946.8 16979.8 16991.0 8373.7 8392.3 8420.9 8427.8 8611.5 8038.4 8061.4 8106.1 8144.1 8183.8 4633.3 4856.1 4943.1 5103.5 5203.5 2031.7 2084.9 2103.2 2116.6 2125.9 992.1 1013.0 1036.6 1037.9 1137.3 19970.8 20221.2 20561.6 20567.9 20591.6 1023.3 1027.5 1039.8 1055.5 1058.2 11180.9 11623.7 11692.2 11710.9 11713.1 489441.0 499307.0 517683.0 518555.0 524186.0 81633.0 99801.5 101235.5 101999.5 103300.0 1037.3 1081.8 1093.6 1100.8 1105.2 18402.2 18472.6 18516.2 18529.0 18829.5 39673.4 41415.6 42357.4 42677.1 44105.0 53276.2 64366.0 65553.7 65674.0 66163.0 7507.7 7795.1 7884.4 7979.6 8749.0 9532.8 12844.4 12892.6 13092.1 13117.5 11431.8 11452.1 11483.7 11692.6 11869.5 11492.5 11553.4 11679.9 11717.8 11924.7 11651.4 11679.6 11779.8 12026.6 12073.9 7355.4 7764.3 7893.3 8003.1 8256.7 10581.9 10846.1 11196.5 11323.9 11394.3 04:26:29 INFO - PROCESS | 20293 | 04:26:29 INFO - PROCESS | 20293 | [#3] mootools.html Cycles:180 Average:6503.39 Median:4710.39 stddev:3813.47 (81.0%) stddev-sans-first:3806.31 04:26:29 INFO - PROCESS | 20293 | Values: 1591.9 1605.7 1843.1 1895.4 1914.4 8881.8 9333.5 9385.9 10124.8 10129.3 9518.5 9811.7 9890.4 9904.2 9925.7 2553.7 2596.5 2597.6 2599.6 2604.3 2499.2 2573.5 2577.9 2578.8 2582.4 2565.6 2575.3 2589.1 2593.0 2598.3 2504.0 2516.3 2538.1 2538.6 2553.0 2506.8 2515.1 2517.4 2528.3 2557.3 9751.6 9865.0 9913.9 9916.6 9917.8 5909.1 6001.6 6047.9 6072.5 6087.3 3699.4 3751.1 3806.2 3829.4 3849.4 1206.9 1237.7 1250.7 1257.3 1268.8 14185.9 14209.9 14353.9 14354.9 14379.9 5220.4 5270.1 5290.0 5312.6 5364.7 11782.7 11915.5 11930.1 11940.5 11995.4 5995.9 6012.4 6026.1 6046.8 6047.1 4838.1 5182.6 5385.5 5390.5 5500.1 4470.7 4503.0 4551.2 4558.2 4582.7 1404.6 1437.3 1460.4 1464.4 1468.1 948.8 1045.3 1049.8 1057.5 1067.2 6334.3 6460.2 6512.9 6515.5 6531.2 484.7 493.5 498.8 506.7 519.4 4221.2 4285.0 4291.4 4332.2 4340.8 12322.2 12392.7 12547.8 12694.6 12707.2 12377.1 12513.2 12586.9 12598.8 12623.9 8961.5 9096.0 9143.1 9169.6 9174.0 5936.6 6131.3 6163.0 6269.6 6317.5 10972.0 11390.1 11460.8 11480.0 11489.4 11738.5 11742.0 11758.6 11769.5 11878.1 8100.4 8626.3 8904.0 8991.1 9117.1 9765.0 9786.3 9833.7 9880.8 9888.1 8570.2 8645.4 8666.2 8697.4 8890.1 8495.0 8610.6 8730.7 8810.3 8917.7 7337.0 7389.7 7456.9 7487.5 7512.1 5403.1 5611.6 5619.8 5635.1 5738.9 5491.6 5564.7 5668.6 5810.8 5866.4 04:26:29 INFO - PROCESS | 20293 | 04:26:29 INFO - PROCESS | 20293 | [#4] prototype.html Cycles:180 Average:5126.90 Median:5655.58 stddev:1521.94 (26.9%) stddev-sans-first:1483.63 04:26:29 INFO - PROCESS | 20293 | Values: 364.1 364.2 371.8 373.9 375.8 5687.3 5706.4 5752.2 5855.2 5858.9 5703.1 5714.2 5745.3 5748.5 5784.2 4442.0 4467.2 4501.7 4505.2 4514.1 4429.8 4469.5 4497.0 4505.8 4535.3 4471.0 4471.2 4485.0 4499.9 4524.1 4359.2 4498.2 4499.8 4516.3 4549.7 3925.9 3938.9 3951.7 3963.7 3975.3 5625.8 5634.0 5644.8 5646.9 5664.2 5127.8 5205.6 5228.7 5229.6 5242.6 6013.8 6063.3 6077.3 6085.6 6114.2 4381.3 4384.5 4390.0 4411.5 4413.3 6160.8 6266.7 6381.4 6409.8 6417.9 4463.0 4476.4 4490.4 4513.0 4526.2 4568.3 4573.7 4591.7 4618.1 4638.4 5020.6 5147.9 5150.0 5166.4 5269.2 5919.8 6042.8 6062.8 6106.5 6119.7 1537.2 1542.3 1551.6 1552.7 1553.5 984.2 1004.8 1008.6 1018.2 1021.4 5261.8 5267.9 5295.7 5315.3 5374.7 5548.4 5567.7 5579.2 5588.5 5603.3 5286.3 5307.6 5535.8 5982.7 5995.0 3361.7 3391.4 3399.2 3408.7 3410.6 6318.9 6648.3 6658.5 6672.4 6685.7 6442.5 6453.3 6540.9 6541.5 6545.5 6300.2 6623.1 6637.6 6648.7 6710.5 6346.3 6376.8 6397.8 6414.7 6438.7 6322.5 6333.7 6365.0 6374.9 6398.3 6451.9 6624.2 6626.1 6669.6 6679.4 4398.5 4439.4 4441.0 4451.7 4470.6 6106.8 6229.9 6234.6 6375.4 6425.7 6144.8 6160.2 6169.4 6175.7 6258.6 6019.4 6207.7 6207.9 6221.1 6246.2 5987.3 6032.9 6068.7 6072.1 6079.7 6179.4 6186.3 6202.7 6229.9 6269.8 5893.3 6028.7 6043.9 6045.1 6045.8 04:26:29 INFO - PROCESS | 20293 | 04:26:29 INFO - PROCESS | 20293 | [#5] yui.html Cycles:180 Average:21571.82 Median:4589.59 stddev:31169.38 (679.1%) stddev-sans-first:31217.93 04:26:29 INFO - PROCESS | 20293 | Values: 835.9 856.9 895.2 917.3 926.9 15908.5 16521.0 16543.1 17108.1 17175.5 14851.3 15473.6 15617.2 15624.3 15628.6 872.0 872.2 878.9 882.1 882.1 850.4 876.9 879.7 882.5 893.7 922.9 923.0 923.7 925.1 927.2 912.7 914.7 917.8 923.0 923.8 670.5 673.3 674.3 675.0 675.6 14830.3 14831.5 14882.5 14898.6 14919.3 14656.6 15471.2 15579.3 15722.0 15793.4 12988.6 13015.7 13066.9 13166.9 13441.6 4100.8 4111.1 4137.4 4180.5 4246.7 81926.0 83469.2 83881.6 84111.0 84309.6 11670.6 11811.6 12231.1 12285.4 12396.3 22369.3 22541.2 22746.1 22776.8 22802.9 8981.8 9001.4 9009.0 9041.9 9314.5 4919.1 5006.0 5012.3 5068.2 5080.5 3967.8 4049.6 4061.2 4080.9 4090.6 696.2 698.9 701.2 701.4 708.8 690.1 785.3 814.7 842.7 856.5 9343.3 9935.5 9962.9 10116.2 10257.6 726.8 739.0 746.1 754.2 757.1 4531.5 4647.7 4654.1 4663.2 4719.1 118335.4 119492.0 124682.0 126707.4 127440.0 65757.0 71262.0 104758.0 105635.0 107617.0 58524.0 92374.5 92381.0 93687.0 93704.0 9193.8 9315.5 9394.9 9435.2 9499.4 54717.0 55023.7 55725.4 55726.4 56332.0 79499.0 81735.6 81960.2 82095.6 82338.6 11744.1 11963.2 12438.2 13145.7 13431.1 12791.6 13589.8 13852.9 13994.2 14502.5 13305.9 13501.4 13626.9 13880.7 13883.2 13307.8 13311.8 13428.3 13995.9 14144.7 12471.7 12564.6 12740.0 13725.4 14721.6 11546.1 11736.3 12599.7 12725.6 12790.6 11600.8 12109.6 12903.5 12915.5 13248.3 04:26:29 INFO - PROCESS | 20293 | -------- Summary: end -------- 04:26:29 INFO - PROCESS | 20293 | 04:26:30 INFO - TEST-INFO | 20293: exit 0 04:26:30 INFO - TEST-OK | dromaeo_css | took 1111643ms 04:26:30 INFO - TEST-START | kraken 04:26:30 INFO - operating with platform_type : linux_ 04:26:30 INFO - Initialising browser for kraken test... 04:26:30 INFO - TEST-INFO | started process 20540 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIgmT9k/profile http://localhost:39065/getInfo.html) 04:26:35 INFO - PROCESS | 20540 | __metrics Screen width/height:1600/1200 04:26:35 INFO - PROCESS | 20540 | colorDepth:24 04:26:35 INFO - PROCESS | 20540 | Browser inner width/height: 1024/697 04:26:35 INFO - PROCESS | 20540 | __metrics 04:26:36 ERROR - PROCESS | 20540 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 04:26:36 INFO - TEST-INFO | 20540: exit 0 04:26:36 INFO - Browser initialized. 04:26:36 INFO - Running cycle 1/1 for kraken test... 04:26:36 INFO - TEST-INFO | started process 20666 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIgmT9k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:26:48 INFO - PROCESS | 20666 | RSS: Main: 155906048 04:26:48 INFO - PROCESS | 20666 | 04:26:51 INFO - PROCESS | 20666 | Cycle 1(1): loaded http://localhost:39065/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39065/tests/kraken/driver.html?testName=audio-beat-detection) 04:26:51 INFO - PROCESS | 20666 | RSS: Main: 161304576 04:26:51 INFO - PROCESS | 20666 | 04:26:54 INFO - PROCESS | 20666 | Cycle 1(1): loaded http://localhost:39065/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39065/tests/kraken/driver.html?testName=audio-dft) 04:26:55 INFO - PROCESS | 20666 | RSS: Main: 160845824 04:26:55 INFO - PROCESS | 20666 | 04:26:58 INFO - PROCESS | 20666 | Cycle 1(1): loaded http://localhost:39065/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39065/tests/kraken/driver.html?testName=audio-fft) 04:26:58 INFO - PROCESS | 20666 | RSS: Main: 161542144 04:26:58 INFO - PROCESS | 20666 | 04:27:00 INFO - PROCESS | 20666 | Cycle 1(1): loaded http://localhost:39065/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39065/tests/kraken/driver.html?testName=audio-oscillator) 04:27:01 INFO - PROCESS | 20666 | RSS: Main: 161402880 04:27:01 INFO - PROCESS | 20666 | 04:27:03 INFO - PROCESS | 20666 | Cycle 1(1): loaded http://localhost:39065/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39065/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:27:04 INFO - PROCESS | 20666 | RSS: Main: 161464320 04:27:04 INFO - PROCESS | 20666 | 04:27:07 INFO - PROCESS | 20666 | Cycle 1(1): loaded http://localhost:39065/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39065/tests/kraken/driver.html?testName=imaging-darkroom) 04:27:07 INFO - PROCESS | 20666 | RSS: Main: 160817152 04:27:07 INFO - PROCESS | 20666 | 04:27:11 INFO - PROCESS | 20666 | Cycle 1(1): loaded http://localhost:39065/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39065/tests/kraken/driver.html?testName=imaging-desaturate) 04:27:11 INFO - PROCESS | 20666 | RSS: Main: 161447936 04:27:11 INFO - PROCESS | 20666 | 04:27:14 INFO - PROCESS | 20666 | Cycle 1(1): loaded http://localhost:39065/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39065/tests/kraken/driver.html?testName=json-parse-financial) 04:27:15 INFO - PROCESS | 20666 | RSS: Main: 161374208 04:27:15 INFO - PROCESS | 20666 | 04:27:16 INFO - PROCESS | 20666 | Cycle 1(1): loaded http://localhost:39065/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39065/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:27:17 INFO - PROCESS | 20666 | RSS: Main: 161185792 04:27:17 INFO - PROCESS | 20666 | 04:27:19 INFO - PROCESS | 20666 | Cycle 1(1): loaded http://localhost:39065/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39065/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:27:19 INFO - PROCESS | 20666 | RSS: Main: 161325056 04:27:19 INFO - PROCESS | 20666 | 04:27:21 INFO - PROCESS | 20666 | Cycle 1(1): loaded http://localhost:39065/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39065/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:27:22 INFO - PROCESS | 20666 | RSS: Main: 161574912 04:27:22 INFO - PROCESS | 20666 | 04:27:25 INFO - PROCESS | 20666 | Cycle 1(1): loaded http://localhost:39065/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39065/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:27:25 INFO - PROCESS | 20666 | RSS: Main: 161665024 04:27:25 INFO - PROCESS | 20666 | 04:27:28 INFO - PROCESS | 20666 | Cycle 1(1): loaded http://localhost:39065/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39065/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:27:29 INFO - PROCESS | 20666 | RSS: Main: 161644544 04:27:29 INFO - PROCESS | 20666 | 04:27:30 INFO - PROCESS | 20666 | Cycle 1(1): loaded http://localhost:39065/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39065/tests/kraken/driver.html?testName=ai-astar) 04:27:30 INFO - PROCESS | 20666 | RSS: Main: 162287616 04:27:30 INFO - PROCESS | 20666 | 04:27:30 INFO - PROCESS | 20666 | __start_tp_report 04:27:30 INFO - PROCESS | 20666 | _x_x_mozilla_page_load 04:27:30 INFO - PROCESS | 20666 | _x_x_mozilla_page_load_details 04:27:30 INFO - PROCESS | 20666 | |i|pagename|runs| 04:27:30 INFO - PROCESS | 20666 | |0;ai-astar;110;104;112;109;109;111;111;109;110;111 04:27:30 INFO - PROCESS | 20666 | |1;audio-beat-detection;155;125;150;170;126;154;151;126;188;124 04:27:30 INFO - PROCESS | 20666 | |2;audio-dft;162;162;164;161;161;163;162;162;162;162 04:27:30 INFO - PROCESS | 20666 | |3;audio-fft;74;74;76;172;76;77;78;77;177;75 04:27:30 INFO - PROCESS | 20666 | |4;audio-oscillator;86;83;140;85;84;84;139;85;84;153 04:27:30 INFO - PROCESS | 20666 | |5;imaging-gaussian-blur;118;117;117;118;117;118;117;117;117;117 04:27:30 INFO - PROCESS | 20666 | |6;imaging-darkroom;148;149;146;146;147;147;147;147;148;147 04:27:30 INFO - PROCESS | 20666 | |7;imaging-desaturate;95;95;97;95;95;95;95;95;95;95 04:27:30 INFO - PROCESS | 20666 | |8;json-parse-financial;50;50;54;52;56;53;52;52;51;52 04:27:30 INFO - PROCESS | 20666 | |9;json-stringify-tinderbox;60;61;60;60;61;63;60;61;67;60 04:27:30 INFO - PROCESS | 20666 | |10;stanford-crypto-aes;76;76;82;80;79;77;77;79;108;78 04:27:30 INFO - PROCESS | 20666 | |11;stanford-crypto-ccm;120;121;136;126;139;123;131;120;122;129 04:27:30 INFO - PROCESS | 20666 | |12;stanford-crypto-pbkdf2;159;151;162;160;158;151;151;159;153;153 04:27:30 INFO - PROCESS | 20666 | |13;stanford-crypto-sha256-iterative;65;62;60;62;71;60;61;63;61;60 04:27:30 INFO - PROCESS | 20666 | __end_tp_report 04:27:30 INFO - PROCESS | 20666 | __start_cc_report 04:27:30 INFO - PROCESS | 20666 | _x_x_mozilla_cycle_collect,885 04:27:30 INFO - PROCESS | 20666 | __end_cc_report 04:27:30 INFO - PROCESS | 20666 | __startTimestamp1467545250929__endTimestamp 04:27:30 INFO - PROCESS | 20666 | 04:27:30 INFO - PROCESS | 20666 | ------- Summary: start ------- 04:27:30 INFO - PROCESS | 20666 | Number of tests: 14 04:27:30 INFO - PROCESS | 20666 | 04:27:30 INFO - PROCESS | 20666 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.50 stddev:2.22 (2.0%) stddev-sans-first:2.35 04:27:30 INFO - PROCESS | 20666 | Values: 110.0 104.0 112.0 109.0 109.0 111.0 111.0 109.0 110.0 111.0 04:27:30 INFO - PROCESS | 20666 | 04:27:30 INFO - PROCESS | 20666 | [#1] audio-beat-detection Cycles:10 Average:146.90 Median:152.50 stddev:21.71 (14.2%) stddev-sans-first:22.83 04:27:30 INFO - PROCESS | 20666 | Values: 155.0 125.0 150.0 170.0 126.0 154.0 151.0 126.0 188.0 124.0 04:27:30 INFO - PROCESS | 20666 | 04:27:30 INFO - PROCESS | 20666 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 04:27:30 INFO - PROCESS | 20666 | Values: 162.0 162.0 164.0 161.0 161.0 163.0 162.0 162.0 162.0 162.0 04:27:30 INFO - PROCESS | 20666 | 04:27:30 INFO - PROCESS | 20666 | [#3] audio-fft Cycles:10 Average:95.60 Median:76.00 stddev:41.62 (54.8%) stddev-sans-first:43.41 04:27:30 INFO - PROCESS | 20666 | Values: 74.0 74.0 76.0 172.0 76.0 77.0 78.0 77.0 177.0 75.0 04:27:30 INFO - PROCESS | 20666 | 04:27:30 INFO - PROCESS | 20666 | [#4] audio-oscillator Cycles:10 Average:102.30 Median:84.00 stddev:29.02 (34.5%) stddev-sans-first:30.18 04:27:30 INFO - PROCESS | 20666 | Values: 86.0 83.0 140.0 85.0 84.0 84.0 139.0 85.0 84.0 153.0 04:27:30 INFO - PROCESS | 20666 | 04:27:30 INFO - PROCESS | 20666 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 04:27:30 INFO - PROCESS | 20666 | Values: 118.0 117.0 117.0 118.0 117.0 118.0 117.0 117.0 117.0 117.0 04:27:30 INFO - PROCESS | 20666 | 04:27:30 INFO - PROCESS | 20666 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 04:27:30 INFO - PROCESS | 20666 | Values: 148.0 149.0 146.0 146.0 147.0 147.0 147.0 147.0 148.0 147.0 04:27:30 INFO - PROCESS | 20666 | 04:27:30 INFO - PROCESS | 20666 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 04:27:30 INFO - PROCESS | 20666 | Values: 95.0 95.0 97.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 04:27:30 INFO - PROCESS | 20666 | 04:27:30 INFO - PROCESS | 20666 | [#8] json-parse-financial Cycles:10 Average:52.20 Median:52.00 stddev:1.81 (3.5%) stddev-sans-first:1.74 04:27:30 INFO - PROCESS | 20666 | Values: 50.0 50.0 54.0 52.0 56.0 53.0 52.0 52.0 51.0 52.0 04:27:30 INFO - PROCESS | 20666 | 04:27:30 INFO - PROCESS | 20666 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.00 stddev:2.21 (3.6%) stddev-sans-first:2.30 04:27:30 INFO - PROCESS | 20666 | Values: 60.0 61.0 60.0 60.0 61.0 63.0 60.0 61.0 67.0 60.0 04:27:30 INFO - PROCESS | 20666 | 04:27:30 INFO - PROCESS | 20666 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:78.50 stddev:9.60 (12.2%) stddev-sans-first:10.00 04:27:30 INFO - PROCESS | 20666 | Values: 76.0 76.0 82.0 80.0 79.0 77.0 77.0 79.0 108.0 78.0 04:27:30 INFO - PROCESS | 20666 | 04:27:30 INFO - PROCESS | 20666 | [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:127.50 stddev:6.83 (5.4%) stddev-sans-first:6.80 04:27:30 INFO - PROCESS | 20666 | Values: 120.0 121.0 136.0 126.0 139.0 123.0 131.0 120.0 122.0 129.0 04:27:30 INFO - PROCESS | 20666 | 04:27:30 INFO - PROCESS | 20666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.70 Median:158.50 stddev:4.30 (2.7%) stddev-sans-first:4.39 04:27:30 INFO - PROCESS | 20666 | Values: 159.0 151.0 162.0 160.0 158.0 151.0 151.0 159.0 153.0 153.0 04:27:30 INFO - PROCESS | 20666 | 04:27:30 INFO - PROCESS | 20666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.50 Median:62.00 stddev:3.37 (5.4%) stddev-sans-first:3.46 04:27:30 INFO - PROCESS | 20666 | Values: 65.0 62.0 60.0 62.0 71.0 60.0 61.0 63.0 61.0 60.0 04:27:30 INFO - PROCESS | 20666 | -------- Summary: end -------- 04:27:30 INFO - PROCESS | 20666 | 04:27:31 INFO - TEST-INFO | 20666: exit 0 04:27:31 INFO - TEST-OK | kraken | took 61536ms 04:27:31 INFO - SUITE-END | took 1173s 04:27:32 INFO - Completed test suite (00:19:33) 04:27:32 INFO - javascript benchmark 04:27:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7749.959642062323, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3391.5421418108554, 3438.707709844663, 3439.4324936385497, 3444.466107753299, 3455.118944669109, 5724.914126288104, 5726.083826587742, 5726.828195154147, 5778.884422311551, 5810.738516766745, 5763.0, 5783.392743761897, 5812.244408226935, 5829.125631155329, 5853.853653658661, 5276.261323414725, 5292.92060619091, 5338.332708411449, 5351.518363347298, 5396.676199428027, 5171.793128274864, 5212.739363031852, 5219.060569097561, 5381.946180538203, 5386.515213630772, 5231.058409486291, 5267.604929630274, 5306.602004849632, 5315.229291752694, 5352.143657014878, 5380.488853558905, 5381.0583147948955, 5390.4879036491475, 5408.567314614821, 5412.972935135299, 5020.573251273646, 5172.431032586413, 5221.086309895753, 5289.656172348785, 5308.601854860901, 5584.804531841407, 5703.258576385043, 5720.828375148711, 5770.567207459415, 5785.508231800302, 6272.717727702265, 6282.340354262828, 6314.652694101823, 6324.3043265240785, 6341.619502829799, 6059.939400605982, 6130.031268545464, 6163.322034576193, 6349.174607301067, 6363.522735794834, 5783.768649254067, 5832.533397328246, 5850.912236316459, 5854.619449735754, 5868.97065514674, 6393.808185754435, 6439.8068057958335, 6476.773312934025, 6479.935200647933, 6480.319566445455, 6082.665453400017, 6138.324784273726, 6150.292716337678, 6210.0, 6215.533834962305, 6284.24589049317, 6308.653024083719, 6313.3686631336495, 6317.936820631827, 6333.778317758856, 5967.910481342783, 6199.876002480015, 6254.312025677172, 6259.405356491217, 6264.436200741955, 6145.770845830852, 6182.165407669997, 6219.689015549295, 6286.277078136073, 6297.338779428185, 4696.459907110726, 4702.952970470252, 4704.600108990706, 4729.668923175344, 4734.360861283752, 4160.8335666573, 4175.123224122907, 4253.21315556623, 4254.510731265882, 4280.0, 5788.797392091256, 5906.645601263938, 5934.1692163097205, 5983.581149319506, 6063.636181829104, 6226.097215903668, 6312.400321969406, 6342.5560210785725, 6349.746010159634, 6360.1731774869895, 5797.536197104221, 5851.1223316502865, 6021.157038014681, 6028.2766068072115, 6046.09308603713, 5308.071087559739, 5312.415634280226, 5324.866878328073, 5368.946310536923, 5377.354717433933, 6431.228252609717, 6464.935350646433, 6474.12599299098, 6486.383793539606, 6487.351264873475, 5935.198748168942, 6121.270068921507, 6185.505159587312, 6196.287426945779, 6209.813705588839, 6402.103705481143, 6518.413342799171, 6579.539432239889, 6585.308542603149, 6590.209174899042, 6230.190075290183, 6235.625862448268, 6238.625682459067, 6238.968805155945, 6246.406591373812, 6058.363871793398, 6139.093519790236, 6180.598261113013, 6350.809475715736, 6367.681615919093, 6106.207495297345, 6133.212252453684, 6137.979623346715, 6151.415615516519, 6159.322474527708, 6102.572819902564, 6103.511719062553, 6105.908411373922, 6110.114033465212, 6115.301188036123, 5806.216160818404, 5852.005159123045, 5926.051831706906, 5945.19739835134, 6018.127371531016, 6116.235470566179, 6139.386061394003, 6141.539384546088, 6147.538934580014, 6159.353267906805, 6008.639481630941, 6015.849603759941, 6016.09758536223, 6019.638821670714, 6027.065804800263], "value": 5751.519926129786, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.6573904266004, 634.3941535833279, 639.6545865232774, 658.2035736758522, 672.6569449580712, 42000.15999680008, 47178.764106179464, 47185.0, 47216.0, 47317.29024064642, 47812.0, 48223.27665085027, 48460.75769621147, 48468.0, 48563.51436485634, 8958.372913896046, 9053.50205738684, 9062.818743625123, 9082.818343633124, 9087.0, 8740.956295218546, 8809.075047120055, 8854.822903541924, 8859.911400886005, 8865.202131808135, 8853.601587928526, 8881.822363552725, 8904.198622124008, 8921.286297096249, 8955.731328060136, 8807.911920880806, 8830.823383532326, 8867.068957759408, 8870.778230544223, 8873.51195684237, 8865.113488651083, 8940.46357218569, 8942.239909607626, 8960.103989601053, 8964.103589640983, 43513.0, 43632.3455148173, 43750.343744843856, 43836.780816095714, 43858.0, 3765.7928813915496, 4000.5199376074765, 4001.899952501182, 4295.162443323553, 4482.798274077674, 33503.497447538306, 34254.0, 34845.0, 35026.29947401063, 35378.82310588431, 4647.95352046482, 4734.857954261378, 4747.810087596492, 4793.32893394925, 4828.61371090312, 373338.0, 373817.0, 373995.0, 374950.0, 375434.0, 62594.37405625977, 62775.0, 62948.37051629425, 63151.0, 63200.36799632037, 40311.79844100761, 40583.18833623311, 41231.38152927708, 42630.147397051885, 67921.3207867925, 17520.21159047846, 17682.381116661112, 17688.734668979974, 17692.0, 17746.733798993024, 12795.552155674506, 12798.104132710621, 12822.615321540368, 12851.228926264454, 12879.806802897963, 21220.25729099474, 21553.78446215549, 21597.67603485949, 21598.35204943854, 21671.24150654751, 7478.177400485943, 7807.180246074194, 7908.960455197802, 7910.683572657144, 7935.246151615587, 1025.8050970315617, 1107.1917500224881, 1140.4639819284923, 1173.8708742038368, 1204.3556697166973, 32930.67069329276, 33124.0, 33187.83406083003, 33649.49525757116, 34047.14882127967, 1178.5698220149584, 1203.3562044306254, 1219.451246938881, 1243.7325974915436, 1275.9298238596966, 17717.911410442866, 17736.55658608545, 17744.29022839098, 17789.7331540027, 17804.46586602404, 602242.0, 602759.0, 605549.0, 607412.0, 610956.0, 63771.0, 64258.0, 64584.0, 64659.353406465336, 64838.35161648323, 1475.3950880139091, 1480.1563109027966, 1505.32260482781, 1511.093343993595, 1528.296983387654, 32812.1796955078, 32831.50752738663, 33133.0, 33184.33631327312, 33762.83118584391, 55544.0, 55770.16344754913, 55983.0, 55983.16025259706, 56040.0, 467608.0, 468178.0, 469183.0, 470402.0, 472237.0, 30676.233094172825, 31044.84477577688, 31855.522167167048, 31902.36195276128, 31966.0, 52352.73823630858, 52737.47262527326, 52782.472175277755, 53853.19220211778, 53872.0, 44009.44550115557, 44955.32567011432, 45317.09365812731, 46221.07557848891, 46372.7681361591, 44796.0, 45395.319070213314, 45751.77124114358, 45791.54208457873, 46095.76952115218, 44075.11849762923, 45756.0, 46104.308435372826, 46341.304880427495, 48052.75973620109, 39035.21929561449, 39366.606333936295, 39429.0, 40279.79860100798, 40461.39307910325, 29692.0, 29797.957071502395, 30113.0, 30551.2362190947, 30567.0], "value": 21403.15255683108, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [435.93896854440374, 436.58306317466804, 439.28615999001624, 443.815816436179, 453.6707447179762, 19663.606727865434, 19685.606287874252, 20512.589748205028, 20696.48258793531, 20706.89646551769, 18783.812161878377, 19767.5058123547, 20213.494662633442, 20327.085281162344, 20372.388828335173, 5632.0, 5786.9710651446685, 5822.388649191837, 5826.854328641797, 5836.649801011931, 5509.889802203954, 5823.0, 5847.181394604759, 5927.318358388776, 5983.0, 5695.914561281584, 5851.327097383792, 5882.5588080893895, 5924.674142922137, 5954.553408494358, 5731.140328950649, 5866.823995280149, 5909.0, 5934.169216309699, 5947.970260148693, 5875.265591801025, 5875.471207591295, 5912.674802885839, 5918.3785702501045, 5946.643201407929, 12820.35898205086, 13146.934265328708, 13248.271345076017, 14459.843212542972, 14717.337719802528, 2381.8094552435764, 2389.940251493709, 2470.258922323296, 2498.1256560203965, 2768.1280396674983, 10870.0, 10896.346219226873, 10975.890241097566, 11239.044681202107, 11763.58827441044, 2028.8275496582808, 2091.1530830013867, 2093.3615247349553, 2164.3398763377163, 2201.4496375906024, 60110.69944650293, 71074.0, 82029.9999999994, 83221.58389208015, 83573.16426835775, 11554.248973816675, 11740.647780566596, 11892.216167574932, 11918.344491053076, 11950.223235489839, 16625.833741662427, 16848.0, 16946.830531694526, 16979.83020169807, 16991.0, 8373.665053397917, 8392.328613710888, 8420.915790842013, 8427.789305267417, 8611.526366049802, 8038.356931445471, 8061.395395345373, 8106.067802202704, 8144.063432705197, 8183.79540511492, 4633.258678611406, 4856.106118613743, 4943.134951383494, 5103.540681338697, 5203.479652034766, 2031.6850888112367, 2084.9061792219386, 2103.2323202031453, 2116.6190085784706, 2125.851190416687, 992.1368409483796, 1012.9797404051877, 1036.5698235232444, 1037.911777498921, 1137.3460260350332, 19970.800291997184, 20221.191152354037, 20561.588768224552, 20567.8971605141, 20591.588168236853, 1023.3092662452815, 1027.4913917610832, 1039.750459889621, 1055.466989170464, 1058.2010582010532, 11180.944095279634, 11623.709407264885, 11692.181547291608, 11710.88289117115, 11713.121515886343, 489441.0, 499307.0, 517683.0, 518555.0, 524186.0, 81633.0, 99801.50099249458, 101235.49382253189, 101999.49000254952, 103300.0, 1037.3464717228098, 1081.832315991007, 1093.6336327330275, 1100.785346857355, 1105.2152971390242, 18402.171902264698, 18472.630547388708, 18516.231826329204, 18529.0, 18829.529261768566, 39673.40489892712, 41415.58584414118, 42357.36463952981, 42677.14645707131, 44105.0, 53276.2008569864, 64366.0, 65553.67223163854, 65674.0, 66163.0, 7507.66215520292, 7795.103563090317, 7884.448088633741, 7979.640916158671, 8749.0, 9532.809343812945, 12844.422001010164, 12892.613221603367, 13092.083554151119, 13117.540886068942, 11431.771364572829, 11452.14108941816, 11483.655490335303, 11692.649220523397, 11869.52521899149, 11492.48283827213, 11553.364564949008, 11679.941600291944, 11717.765644686888, 11924.70188245266, 11651.359175245443, 11679.591214307458, 11779.764404712028, 12026.639200823989, 12073.939630301793, 7355.374793142642, 7764.301212890867, 7893.289603935444, 8003.11965683786, 8256.711015114442, 10581.947090264808, 10846.078083362687, 11196.496157673088, 11323.943380283046, 11394.25937314072], "value": 9376.775166277452, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1591.9124448155353, 1605.6788642271545, 1843.1429385335816, 1895.3745264062861, 1914.4161030885582, 8881.777955551115, 9333.486658233795, 9385.859212111824, 10124.797504049915, 10129.290949633529, 9518.524073796318, 9811.65659201928, 9890.406575605452, 9904.158146557551, 9925.702228933125, 2553.6807899012624, 2596.532624127656, 2597.6103584462294, 2599.5970624553224, 2604.348912771807, 2499.2252401755513, 2573.4981678572685, 2577.935551611206, 2578.845269283849, 2582.3931376126593, 2565.602331638599, 2575.33041409234, 2589.145581957949, 2593.0276146445085, 2598.272483704556, 2503.987480062606, 2516.3457501049675, 2538.0989748639154, 2538.5557527432716, 2552.961705574418, 2506.7618576235227, 2515.1071369663873, 2517.3958250020046, 2528.254165021323, 2557.309526427854, 9751.561179746928, 9864.95067524665, 9913.90086099137, 9916.603335866557, 9917.801643967152, 5909.113632955048, 6001.639901605918, 6047.939520604782, 6072.45347918685, 6087.3303936566945, 3699.4265888787013, 3751.118487155516, 3806.200697853454, 3829.3681542545446, 3849.40334248192, 1206.9094817888692, 1237.7029512916924, 1250.7060840702427, 1257.3398965543163, 1268.8477382714134, 14185.929070354685, 14209.934254930922, 14353.856461435356, 14354.85645143556, 14379.928100359431, 5220.425753167148, 5270.077736396115, 5290.047791397508, 5312.601554883399, 5364.7317634118135, 11782.705432364259, 11915.52337906474, 11930.105242106876, 11940.522379104912, 11995.400229988465, 5995.850103747442, 6012.428819262163, 6026.126211699279, 6046.848828779228, 6047.0627052806885, 4838.129136755418, 5182.611304152204, 5385.542228910586, 5390.460953904578, 5500.119980803052, 4470.709403888737, 4503.0, 4551.226291530448, 4558.247889098328, 4582.656300777388, 1404.592668126232, 1437.2669938331526, 1460.4304321314696, 1464.406915199346, 1468.0604413175577, 948.7770373962113, 1045.257866914484, 1049.7847941172042, 1057.5452555401098, 1067.2102644043352, 6334.334894836068, 6460.224773027267, 6512.944177611298, 6515.511336649675, 6531.216254049545, 484.7430861643335, 493.4769144706622, 498.82042464712674, 506.70611045593466, 519.4286285086375, 4221.2190744712325, 4284.978575107167, 4291.3777502262, 4332.220200363965, 4340.782960851945, 12322.199057061262, 12392.690182745324, 12547.811782823264, 12694.555690550971, 12707.174033687965, 12377.133600648049, 12513.186642868184, 12586.937065314614, 12598.81101783474, 12623.873761262454, 8961.462312261285, 9095.954520227357, 9143.085691430804, 9169.633214671338, 9174.036726143791, 5936.554758393051, 6131.325554189125, 6163.0, 6269.592476489013, 6317.526185536011, 10972.0, 11390.145739069769, 11460.770784584429, 11480.0, 11489.425528723697, 11738.530458781554, 11742.00192983606, 11758.647240582795, 11769.529218831492, 11878.109141814572, 8100.351971842357, 8626.266767324847, 8903.955480222558, 8991.100889910957, 9117.133872282122, 9764.951175244363, 9786.31495795316, 9833.655822046194, 9880.802383952425, 9888.110070093438, 8570.228679418882, 8645.438046526955, 8666.176713212235, 8697.391182617155, 8890.110988901059, 8494.957525212581, 8610.569471526524, 8730.738077857675, 8810.251128654136, 8917.73246802597, 7336.96331518339, 7389.704411823467, 7456.850862982818, 7487.47587668858, 7512.13610434807, 5403.13549832025, 5611.57913156523, 5619.80330688424, 5635.0702134147405, 5738.856528586819, 5491.588130890119, 5564.666120032811, 5668.631538949955, 5810.796622118206, 5866.413358664099], "value": 5076.311329174166, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.0788804325057, 364.2187507795778, 371.8215256676795, 373.91773809761844, 375.7876799608221, 5687.317521897367, 5706.429357064291, 5752.165935939286, 5855.151003104547, 5858.85352866178, 5703.144528320754, 5714.228579141814, 5745.2818397700285, 5748.5401167906575, 5784.161296611988, 4441.955580444194, 4467.151241264166, 4501.70738901972, 4505.211587972108, 4514.074614703978, 4429.8228070877285, 4469.463664360265, 4496.9775151124195, 4505.797239124247, 4535.344599221277, 4470.955290447103, 4471.1728330259, 4485.0, 4499.932501012488, 4524.11779702958, 4359.215341238576, 4498.212812757754, 4499.842505512308, 4516.345129956138, 4549.727016378994, 3925.9411108833106, 3938.8818335449982, 3951.68386529077, 3963.7225394222414, 3975.3440682287387, 5625.774969001235, 5634.04221282383, 5644.802431914904, 5646.915296270559, 5664.235328230678, 5127.794888204505, 5205.583553315726, 5228.67324040802, 5229.633925625208, 5242.580593552545, 6013.849653758647, 6063.333033366326, 6077.270727512682, 6085.6348619082555, 6114.174586430864, 4381.255186618282, 4384.473863136444, 4390.012247244376, 4411.536788637179, 4413.337999300099, 6160.7535698572, 6266.686665666698, 6381.404648837791, 6409.8397540061405, 6417.871642567169, 4462.9776851116185, 4476.37330773692, 4490.416245888014, 4513.0, 4526.207913615104, 4568.33759104928, 4573.679842410999, 4591.724496530219, 4618.099470603267, 4638.373819534387, 5020.623453241022, 5147.871303217449, 5149.9742501288, 5166.363045215587, 5269.235960785742, 5919.763209471573, 6042.818715438544, 6062.787802426894, 6106.503906542836, 6119.694015299217, 1537.2237020304674, 1542.2520077762276, 1551.5655616427418, 1552.7360348740742, 1553.5261745167832, 984.1683777208248, 1004.8442491413842, 1008.6368907193405, 1018.1600179851652, 1021.4228960637216, 5261.789528418821, 5267.894642107136, 5295.735213239323, 5315.335583052119, 5374.731263436813, 5548.389677135512, 5567.721613919369, 5579.191017302468, 5588.497035266845, 5603.299587551556, 5286.286351342596, 5307.575393968474, 5535.778568857281, 5982.670953097534, 5994.9700251499335, 3361.7310615150727, 3391.4065038618637, 3399.1502124468884, 3408.6932176103774, 3410.60778010527, 6318.873622527615, 6648.301928297556, 6658.4673226141795, 6672.366125218096, 6685.732570697215, 6442.549021568539, 6453.322401147906, 6540.855350313676, 6541.47668186544, 6545.541812073109, 6300.21247344082, 6623.138991931018, 6637.601743895381, 6648.734050638017, 6710.530262881552, 6346.3019067903415, 6376.756532476123, 6397.776077837253, 6414.679266036586, 6438.742450301936, 6322.49420046386, 6333.6516491591565, 6364.96817515928, 6374.872502550016, 6398.328175541501, 6451.870962580816, 6624.238212605612, 6626.072349870926, 6669.599824010575, 6679.365460281266, 4398.450193725785, 4439.4228750262255, 4441.0, 4451.710638808467, 4470.597646211857, 6106.755729770759, 6229.877416570465, 6234.563580549318, 6375.426211640789, 6425.742970281136, 6144.815655530341, 6160.168377269011, 6169.444749972524, 6175.69121543912, 6258.561900666909, 6019.428154325332, 6207.6585787782105, 6207.937920620736, 6221.129041934042, 6246.219222597176, 5987.2815262168815, 6032.90950635732, 6068.666223357758, 6072.119542666377, 6079.696015199134, 6179.443850053517, 6186.288576813724, 6202.72087756043, 6229.906551401642, 6269.780557680459, 5893.263342082239, 6028.698565071817, 6043.881881851871, 6045.063015232646, 6045.758169673164], "value": 4642.931716842278, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [835.8955130608674, 856.9228769410752, 895.2256298301969, 917.339515548805, 926.9165775080241, 15908.52274431766, 16521.008739475626, 16543.09013004286, 17108.144592770343, 17175.484735457925, 14851.331690073946, 15473.613159671015, 15617.21913904303, 15624.2969066392, 15628.609284767857, 871.9520426376547, 872.2150064941571, 878.9208971192592, 882.0606054551914, 882.0782282514756, 850.4472093139478, 876.8640860666607, 879.6745204274428, 882.483747008001, 893.7318804358699, 922.8523436250201, 922.9861552076724, 923.7413524213231, 925.1488630459993, 927.1562877781221, 912.7216199059284, 914.7210100919217, 917.8118485710413, 923.0262073512441, 923.7967647117623, 670.4636290967255, 673.3468535520537, 674.27852198148, 674.9696263668146, 675.5608854244731, 14830.258487075604, 14831.48089816862, 14882.479113230986, 14898.553043408716, 14919.254037298091, 14656.560303190921, 15471.226438678133, 15579.298931548108, 15722.0, 15793.447229347033, 12988.610341689764, 13015.674608134777, 13066.869331306756, 13166.86833131666, 13441.596752097452, 4100.753954762724, 4111.116110036327, 4137.420761093449, 4180.456540649727, 4246.681498887596, 81926.0, 83469.16530834735, 83881.58059209665, 84111.0, 84309.57845210796, 11670.591529296435, 11811.586594469325, 12231.143819932697, 12285.447154878051, 12396.31820249895, 22369.328920132422, 22541.211057612905, 22746.09015639389, 22776.772232277795, 22802.885985569967, 8981.775455613531, 9001.36990410665, 9009.0, 9041.864372034424, 9314.48770317639, 4919.1391506486225, 5006.0, 5012.298278241049, 5068.189089745697, 5080.491950804964, 3967.761934283952, 4049.635532802062, 4061.1674606705556, 4080.9183816323507, 4090.550039495653, 696.1506961506954, 698.9475789315821, 701.1516065560627, 701.435344547644, 708.8475977664724, 690.0781324012601, 785.2763184809289, 814.7311387242196, 842.7008412013647, 856.5075081827974, 9343.2525397968, 9935.503224838729, 9962.850557241647, 10116.241281903887, 10257.58969641206, 726.8364617961022, 738.9556626602314, 746.0823187479323, 754.1779460388203, 757.1028331427276, 4531.501534831166, 4647.674662773574, 4654.138984287918, 4663.160631086369, 4719.079779442975, 118335.40832295784, 119492.0, 124682.0, 126707.36646316893, 127440.0, 65757.0, 71262.0, 104758.0, 105635.0, 107617.0, 58524.0, 92374.53812730893, 92381.0, 93687.0, 93704.0, 9193.816123677623, 9315.487648179414, 9394.859077113711, 9435.198008169382, 9499.38254013487, 54717.0, 55023.72488137534, 55725.44274557203, 55726.44273557375, 56332.0, 79499.0, 81735.59132204301, 81960.18039819764, 82095.589522052, 82338.58830705807, 11744.060475161796, 11963.222390544586, 12438.19151755133, 13145.737085258432, 13431.05982581249, 12791.616251512469, 13589.79615305791, 13852.86147138556, 13994.230317332644, 14502.492412765503, 13305.866941330463, 13501.392437340146, 13626.863731362559, 13880.652983675489, 13883.236421996888, 13307.800382994457, 13311.800322995357, 13428.261445620194, 13995.930020349833, 14144.717105658036, 12471.688207794516, 12564.560240391542, 12740.0, 13725.382357793724, 14721.631959201106, 11546.14522356458, 11736.295822250693, 12599.685007874876, 12725.61823145307, 12790.61628151157, 11600.825987610024, 12109.576164834189, 12903.483860645845, 12915.547955821501, 13248.271345076113], "value": 7963.4767423515505, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1515.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 104.0, 112.0, 109.0, 109.0, 111.0, 111.0, 109.0, 110.0, 111.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 125.0, 150.0, 170.0, 126.0, 154.0, 151.0, 126.0, 188.0, 124.0], "value": 146.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 164.0, 161.0, 161.0, 163.0, 162.0, 162.0, 162.0, 162.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 172.0, 76.0, 77.0, 78.0, 77.0, 177.0, 75.0], "value": 95.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 140.0, 85.0, 84.0, 84.0, 139.0, 85.0, 84.0, 153.0], "value": 102.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 148.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 54.0, 52.0, 56.0, 53.0, 52.0, 52.0, 51.0, 52.0], "value": 52.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 60.0, 61.0, 63.0, 60.0, 61.0, 67.0, 60.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 82.0, 80.0, 79.0, 77.0, 77.0, 79.0, 108.0, 78.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 121.0, 136.0, 126.0, 139.0, 123.0, 131.0, 120.0, 122.0, 129.0], "value": 126.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 151.0, 162.0, 160.0, 158.0, 151.0, 151.0, 159.0, 153.0, 153.0], "value": 155.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 60.0, 62.0, 71.0, 60.0, 61.0, 63.0, 61.0, 60.0], "value": 62.5, "unit": "score"}]}]} 04:27:32 INFO - Return code: 0 04:27:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:27:32 ERROR - # TBPL SUCCESS # 04:27:32 INFO - Running post-action listener: _resource_record_post_action 04:27:32 INFO - ##### 04:27:32 INFO - ##### Finished run-tests step (success) 04:27:32 INFO - ##### 04:27:32 INFO - Running post-run listener: _resource_record_post_run 04:27:32 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 502853632; Read time: 12; Write time: 352128 04:27:32 INFO - TinderboxPrint: CPU usage
13.4% 04:27:32 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 04:27:32 INFO - TinderboxPrint: I/O write bytes / time
502,853,632 / 352,128 04:27:32 INFO - TinderboxPrint: CPU idle
8,223.7 (86.6%) 04:27:32 INFO - TinderboxPrint: CPU user
1,214.1 (12.8%) 04:27:32 INFO - TinderboxPrint: Swap in / out
0 / 0 04:27:32 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252698624; Read time: 0; Write time: 225784 04:27:32 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 249569280; Read time: 12; Write time: 126328 04:27:32 INFO - Running post-run listener: _upload_blobber_files 04:27:32 INFO - Blob upload gear active. 04:27:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:27:32 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 04:27:32 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'] 04:27:32 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 04:27:33 INFO - (blobuploader) - INFO - Open directory for files ... 04:27:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:27:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:27:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:27:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:27:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:27:33 INFO - (blobuploader) - INFO - Done attempting. 04:27:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:27:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:27:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:27:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:27:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:27:34 INFO - (blobuploader) - INFO - Done attempting. 04:27:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:27:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:27:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:27:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:27:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:27:38 INFO - (blobuploader) - INFO - Done attempting. 04:27:38 INFO - (blobuploader) - INFO - Iteration through files over. 04:27:38 INFO - Return code: 0 04:27:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:27:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:27:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e15b9de18b00e4de0549a660f0fca5770ba7df27baa864a66fa393b659e5f8e67991bc2374a195fb650f4fd5bb3933c660ed84e2cda7916a70c64831eaad5bb4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/59a7e045ab29f5967521c5d6b74b66b249ba0e281a68178c0802bbbce6ce3a5bd3b34607cd544ae253b32c956ec9c617dc402d1c8cac91937501f22b545431ff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b407ac82f06b76a2aac068efa56a02813ade86db17f5ade2ee19392017b0db5affed4f268714f2d73214c19f077ace3aeee3abc368e2df832b6e197a9815e84b"} 04:27:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:27:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:27:38 INFO - Contents: 04:27:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e15b9de18b00e4de0549a660f0fca5770ba7df27baa864a66fa393b659e5f8e67991bc2374a195fb650f4fd5bb3933c660ed84e2cda7916a70c64831eaad5bb4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/59a7e045ab29f5967521c5d6b74b66b249ba0e281a68178c0802bbbce6ce3a5bd3b34607cd544ae253b32c956ec9c617dc402d1c8cac91937501f22b545431ff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b407ac82f06b76a2aac068efa56a02813ade86db17f5ade2ee19392017b0db5affed4f268714f2d73214c19f077ace3aeee3abc368e2df832b6e197a9815e84b"} 04:27:38 INFO - Running post-run listener: copy_logs_to_upload_dir 04:27:38 INFO - Copying logs to upload dir... 04:27:38 INFO - mkdir: /builds/slave/test/build/upload/logs 04:27:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.154168 ========= master_lag: 1.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-07-03 04:27:38.936226) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-03 04:27:38.940968) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1467543624.376589-2033187659 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/e15b9de18b00e4de0549a660f0fca5770ba7df27baa864a66fa393b659e5f8e67991bc2374a195fb650f4fd5bb3933c660ed84e2cda7916a70c64831eaad5bb4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/59a7e045ab29f5967521c5d6b74b66b249ba0e281a68178c0802bbbce6ce3a5bd3b34607cd544ae253b32c956ec9c617dc402d1c8cac91937501f22b545431ff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b407ac82f06b76a2aac068efa56a02813ade86db17f5ade2ee19392017b0db5affed4f268714f2d73214c19f077ace3aeee3abc368e2df832b6e197a9815e84b"} build_url:https://queue.taskcluster.net/v1/task/FUEeBfmtQXeihgHe0tvNCQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011217 build_url: 'https://queue.taskcluster.net/v1/task/FUEeBfmtQXeihgHe0tvNCQ/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/e15b9de18b00e4de0549a660f0fca5770ba7df27baa864a66fa393b659e5f8e67991bc2374a195fb650f4fd5bb3933c660ed84e2cda7916a70c64831eaad5bb4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/59a7e045ab29f5967521c5d6b74b66b249ba0e281a68178c0802bbbce6ce3a5bd3b34607cd544ae253b32c956ec9c617dc402d1c8cac91937501f22b545431ff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b407ac82f06b76a2aac068efa56a02813ade86db17f5ade2ee19392017b0db5affed4f268714f2d73214c19f077ace3aeee3abc368e2df832b6e197a9815e84b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-03 04:27:38.969588) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 04:27:38.969955) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1467543624.376589-2033187659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004518 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 04:27:39.019630) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-03 04:27:39.019948) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-03 04:27:39.020283) ========= ========= Total master_lag: 1.14 =========