builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-060 starttime: 1467542039.42 results: success (0) buildid: 20160703004921 builduid: 2916d3fb19594bd79bc0048addbc1e97 revision: 01f2dde06c5fd93b38c0d80b6028210b48dd3f4a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-03 03:33:59.416111) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-03 03:33:59.416605) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-03 03:33:59.416894) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-03 03:33:59.455031) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 03:33:59.455354) ========= 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=337fe3f4b1febe37b85fccc40000019e-1467540769.570594-421014012 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-03 03:34: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.6M=0s 2016-07-03 03:34:01 (37.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122734 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 03:33:59.597092) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 03:33:59.597430) ========= 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=337fe3f4b1febe37b85fccc40000019e-1467540769.570594-421014012 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020430 ========= master_lag: 0.15 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 03:33:59.763472) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-03 03:33:59.763834) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 01f2dde06c5fd93b38c0d80b6028210b48dd3f4a --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 01f2dde06c5fd93b38c0d80b6028210b48dd3f4a --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=337fe3f4b1febe37b85fccc40000019e-1467540769.570594-421014012 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-03 03:34:01,394 truncating revision to first 12 chars 2016-07-03 03:34:01,394 Setting DEBUG logging. 2016-07-03 03:34:01,394 attempt 1/10 2016-07-03 03:34:01,394 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/01f2dde06c5f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-03 03:34:02,572 unpacking tar archive at: mozilla-aurora-01f2dde06c5f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.504430 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-03 03:34:01.300060) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-03 03:34:01.300396) ========= script_repo_revision: 01f2dde06c5fd93b38c0d80b6028210b48dd3f4a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-03 03:34:01.300816) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-03 03:34:01.301095) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-03 03:34:01.309533) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-07-03 03:34:01.310015) ========= /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=337fe3f4b1febe37b85fccc40000019e-1467540769.570594-421014012 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:34:03 INFO - MultiFileLogger online at 20160703 03:34:03 in /builds/slave/test 03:34:03 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 03:34:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:34:03 INFO - {'append_to_log': False, 03:34:03 INFO - 'base_work_dir': '/builds/slave/test', 03:34:03 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:34:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:34:03 INFO - 'branch': 'Mozilla-Aurora', 03:34:03 INFO - 'buildbot_json_path': 'buildprops.json', 03:34:03 INFO - 'config_files': ('talos/linux_config.py',), 03:34:03 INFO - 'default_actions': ('clobber', 03:34:03 INFO - 'read-buildbot-config', 03:34:03 INFO - 'download-and-extract', 03:34:03 INFO - 'populate-webroot', 03:34:03 INFO - 'create-virtualenv', 03:34:03 INFO - 'install', 03:34:03 INFO - 'run-tests'), 03:34:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:34:03 INFO - 'download_minidump_stackwalk': True, 03:34:03 INFO - 'download_symbols': 'ondemand', 03:34:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:34:03 INFO - 'tooltool.py': '/tools/tooltool.py', 03:34:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:34:03 INFO - '/tools/misc-python/virtualenv.py')}, 03:34:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:34:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:34:03 INFO - 'installer_path': 'installer.exe', 03:34:03 INFO - 'log_level': 'info', 03:34:03 INFO - 'log_name': 'talos', 03:34:03 INFO - 'log_to_console': True, 03:34:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:34:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:34:03 INFO - 'opt_config_files': (), 03:34:03 INFO - 'pip_index': False, 03:34:03 INFO - 'sps_profile': False, 03:34:03 INFO - 'sps_profile_interval': 0, 03:34:03 INFO - 'suite': 'dromaeojs-e10s', 03:34:03 INFO - 'system_bits': '32', 03:34:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:34:03 INFO - 'title': 'talos-linux64-ix-060', 03:34:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:34:03 INFO - 'use_talos_json': True, 03:34:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:34:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:34:03 INFO - 'work_dir': 'build'} 03:34:03 INFO - ##### 03:34:03 INFO - ##### Running clobber step. 03:34:03 INFO - ##### 03:34:03 INFO - Running pre-action listener: _resource_record_pre_action 03:34:03 INFO - Running main action method: clobber 03:34:03 INFO - rmtree: /builds/slave/test/build 03:34:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:34:03 INFO - Running post-action listener: _resource_record_post_action 03:34:03 INFO - ##### 03:34:03 INFO - ##### Finished clobber step (success) 03:34:03 INFO - ##### 03:34:03 INFO - ##### 03:34:03 INFO - ##### Running read-buildbot-config step. 03:34:03 INFO - ##### 03:34:03 INFO - Running pre-action listener: _resource_record_pre_action 03:34:03 INFO - Running main action method: read_buildbot_config 03:34:03 INFO - Using buildbot properties: 03:34:03 INFO - { 03:34:03 INFO - "project": "", 03:34:03 INFO - "product": "firefox", 03:34:03 INFO - "script_repo_revision": "production", 03:34:03 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:34:03 INFO - "repository": "", 03:34:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:34:03 INFO - "buildid": "20160703004921", 03:34:03 INFO - "pgo_build": "True", 03:34:03 INFO - "basedir": "/builds/slave/test", 03:34:03 INFO - "buildnumber": 381, 03:34:03 INFO - "slavename": "talos-linux64-ix-060", 03:34:03 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:34:03 INFO - "platform": "ubuntu64_hw", 03:34:03 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:34:03 INFO - "branch": "mozilla-aurora", 03:34:03 INFO - "repo_path": "releases/mozilla-aurora", 03:34:03 INFO - "revision": "01f2dde06c5fd93b38c0d80b6028210b48dd3f4a", 03:34:03 INFO - "stage_platform": "linux64-pgo", 03:34:03 INFO - "builduid": "2916d3fb19594bd79bc0048addbc1e97", 03:34:03 INFO - "slavebuilddir": "test" 03:34:03 INFO - } 03:34:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 03:34:03 INFO - Running post-action listener: _resource_record_post_action 03:34:03 INFO - ##### 03:34:03 INFO - ##### Finished read-buildbot-config step (success) 03:34:03 INFO - ##### 03:34:03 INFO - ##### 03:34:03 INFO - ##### Running download-and-extract step. 03:34:03 INFO - ##### 03:34:03 INFO - Running pre-action listener: _resource_record_pre_action 03:34:03 INFO - Running main action method: download_and_extract 03:34:03 INFO - mkdir: /builds/slave/test/build/tests 03:34: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')]} 03:34:03 INFO - https://queue.taskcluster.net/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:34:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:34:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:34:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:34:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:34:15 INFO - Downloaded 1361 bytes. 03:34:15 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:34:15 INFO - Using the following test package requirements: 03:34:15 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:34:15 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:15 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:34:15 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:15 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:34:15 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:15 INFO - u'jsshell-linux-x86_64.zip'], 03:34:15 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:15 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:34:15 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:34:15 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:15 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:34:15 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:15 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:34:15 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:15 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:34:15 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:15 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:34:15 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:34:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:15 INFO - https://queue.taskcluster.net/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:34:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:34:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:34:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:34:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:34:24 INFO - Downloaded 24525288 bytes. 03:34:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:34:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:34:25 INFO - Return code: 0 03:34:25 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:34:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:25 INFO - https://queue.taskcluster.net/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:34:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:34:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:34:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:34:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:34:28 INFO - Downloaded 24525288 bytes. 03:34:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:34:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:34:29 INFO - Return code: 0 03:34:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:29 INFO - https://queue.taskcluster.net/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:34:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:34:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:34:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:34:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:34:30 INFO - Downloaded 10833369 bytes. 03:34:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:34:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:34:30 INFO - Return code: 0 03:34: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')]} 03:34:30 INFO - https://queue.taskcluster.net/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:34:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:34:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:34:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:34:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:34:32 INFO - Downloaded 63629607 bytes. 03:34:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:34:32 INFO - mkdir: /builds/slave/test/properties 03:34:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:34:32 INFO - Writing to file /builds/slave/test/properties/build_url 03:34:32 INFO - Contents: 03:34:32 INFO - build_url:https://queue.taskcluster.net/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:34:32 INFO - Running post-action listener: _resource_record_post_action 03:34:32 INFO - Running post-action listener: set_extra_try_arguments 03:34:32 INFO - ##### 03:34:32 INFO - ##### Finished download-and-extract step (success) 03:34:32 INFO - ##### 03:34:32 INFO - ##### 03:34:32 INFO - ##### Running populate-webroot step. 03:34:32 INFO - ##### 03:34:32 INFO - Running pre-action listener: _resource_record_pre_action 03:34:32 INFO - Running main action method: populate_webroot 03:34:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:34:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:34:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:34:32 INFO - '--tppagecycles', 03:34:32 INFO - '7'], 03:34:32 INFO - 'tests': ['tsvgm']}}, 03:34:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:34:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:34:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:34:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:34:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:34:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:34:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:32 INFO - 'talos_options': ['--disable-e10s'], 03:34:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:34:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:34:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:32 INFO - 'talos_options': ['--disable-e10s'], 03:34:32 INFO - 'tests': ['damp', 'tps']}, 03:34:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:32 INFO - 'tests': ['damp', 'tps']}, 03:34:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:34:32 INFO - 'tests': ['dromaeo_dom']}, 03:34:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:34:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:34:32 INFO - 'tests': ['a11yr', 03:34:32 INFO - 'ts_paint', 03:34:32 INFO - 'tpaint', 03:34:32 INFO - 'sessionrestore', 03:34:32 INFO - 'sessionrestore_no_auto_restore', 03:34:32 INFO - 'tabpaint']}, 03:34:32 INFO - 'other-e10s': {'tests': ['a11yr', 03:34:32 INFO - 'ts_paint', 03:34:32 INFO - 'tpaint', 03:34:32 INFO - 'sessionrestore', 03:34:32 INFO - 'sessionrestore_no_auto_restore', 03:34:32 INFO - 'tabpaint']}, 03:34:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:34:32 INFO - 'ts_paint', 03:34:32 INFO - 'tpaint', 03:34:32 INFO - 'sessionrestore', 03:34:32 INFO - 'sessionrestore_no_auto_restore', 03:34:32 INFO - 'tabpaint']}, 03:34:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:34:32 INFO - 'ts_paint', 03:34:32 INFO - 'tpaint', 03:34:32 INFO - 'sessionrestore', 03:34:32 INFO - 'sessionrestore_no_auto_restore', 03:34:32 INFO - 'tabpaint']}, 03:34:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:34:32 INFO - 'tests': ['a11yr', 03:34:32 INFO - 'ts_paint', 03:34:32 INFO - 'tpaint', 03:34:32 INFO - 'sessionrestore', 03:34:32 INFO - 'sessionrestore_no_auto_restore', 03:34:32 INFO - 'tabpaint']}, 03:34:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:34:32 INFO - 'tests': ['a11yr', 03:34:32 INFO - 'ts_paint', 03:34:32 INFO - 'tpaint', 03:34:32 INFO - 'sessionrestore', 03:34:32 INFO - 'sessionrestore_no_auto_restore', 03:34:32 INFO - 'tabpaint']}, 03:34:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:34:32 INFO - 'tests': ['tsvgx', 03:34:32 INFO - 'tsvgr_opacity', 03:34:32 INFO - 'tart', 03:34:32 INFO - 'tscrollx', 03:34:32 INFO - 'cart']}, 03:34:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:34:32 INFO - 'tsvgr_opacity', 03:34:32 INFO - 'tart', 03:34:32 INFO - 'tscrollx', 03:34:32 INFO - 'cart']}, 03:34:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:32 INFO - 'talos_options': ['--disable-e10s'], 03:34:32 INFO - 'tests': ['tp5o']}, 03:34:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:32 INFO - 'tests': ['tp5o']}, 03:34:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:32 INFO - 'talos_options': ['--disable-e10s', 03:34:32 INFO - '--xperf_path', 03:34:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:34:32 INFO - 'tests': ['tp5n']}, 03:34:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:32 INFO - 'talos_options': ['--xperf_path', 03:34:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:34:32 INFO - 'tests': ['tp5n']}}, 03:34:32 INFO - 'talos.zip': {'path': '', 03:34:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:34:32 INFO - Running post-action listener: _resource_record_post_action 03:34:32 INFO - ##### 03:34:32 INFO - ##### Finished populate-webroot step (success) 03:34:32 INFO - ##### 03:34:32 INFO - ##### 03:34:32 INFO - ##### Running create-virtualenv step. 03:34:32 INFO - ##### 03:34:32 INFO - Running pre-action listener: _resource_record_pre_action 03:34:32 INFO - Running main action method: create_virtualenv 03:34:32 INFO - Creating virtualenv /builds/slave/test/build/venv 03:34:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:34:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:34:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:34:32 INFO - Using real prefix '/usr' 03:34:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:34:33 INFO - Installing distribute.............................................................................................................................................................................................done. 03:34:35 INFO - Installing pip.................done. 03:34:35 INFO - Return code: 0 03:34:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:34:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6338613f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248c1c0>, '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 0x248d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248d550>, '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': '337fe3f4b1febe37b85fccc40000019e-1467540769.570594-421014012', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:34:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:34:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:34:35 INFO - Using env: {'DISPLAY': ':0', 03:34:35 INFO - 'HOME': '/home/cltbld', 03:34:35 INFO - 'LANG': 'en_US.UTF-8', 03:34:35 INFO - 'LANGUAGE': 'en_US:en', 03:34:35 INFO - 'LOGNAME': 'cltbld', 03:34:35 INFO - 'MAIL': '/var/mail/cltbld', 03:34:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:35 INFO - 'MOZ_NO_REMOTE': '1', 03:34:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:35 INFO - 'NO_EM_RESTART': '1', 03:34:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:35 INFO - 'PWD': '/builds/slave/test', 03:34:35 INFO - 'SHELL': '/bin/bash', 03:34:35 INFO - 'SHLVL': '1', 03:34:35 INFO - 'TERM': 'linux', 03:34:35 INFO - 'TMOUT': '86400', 03:34:35 INFO - 'USER': 'cltbld', 03:34:35 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1467540769.570594-421014012', 03:34:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:35 INFO - '_': '/tools/buildbot/bin/python'} 03:34:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:35 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:34:35 INFO - Cleaning up... 03:34:35 INFO - Return code: 0 03:34:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:34:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6338613f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248c1c0>, '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 0x248d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248d550>, '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': '337fe3f4b1febe37b85fccc40000019e-1467540769.570594-421014012', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:34:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:34:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:34:35 INFO - Using env: {'DISPLAY': ':0', 03:34:35 INFO - 'HOME': '/home/cltbld', 03:34:35 INFO - 'LANG': 'en_US.UTF-8', 03:34:35 INFO - 'LANGUAGE': 'en_US:en', 03:34:35 INFO - 'LOGNAME': 'cltbld', 03:34:35 INFO - 'MAIL': '/var/mail/cltbld', 03:34:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:35 INFO - 'MOZ_NO_REMOTE': '1', 03:34:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:35 INFO - 'NO_EM_RESTART': '1', 03:34:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:35 INFO - 'PWD': '/builds/slave/test', 03:34:35 INFO - 'SHELL': '/bin/bash', 03:34:35 INFO - 'SHLVL': '1', 03:34:35 INFO - 'TERM': 'linux', 03:34:35 INFO - 'TMOUT': '86400', 03:34:35 INFO - 'USER': 'cltbld', 03:34:35 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1467540769.570594-421014012', 03:34:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:35 INFO - '_': '/tools/buildbot/bin/python'} 03:34:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:35 INFO - Downloading/unpacking psutil>=3.1.1 03:34: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 03:34: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 03:34: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 03:34: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 03:34: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 03:34: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 03:34:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:34:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:34:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:34:37 INFO - Installing collected packages: psutil 03:34:37 INFO - Running setup.py install for psutil 03:34:37 INFO - building 'psutil._psutil_linux' extension 03:34:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:34:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:34:38 INFO - building 'psutil._psutil_posix' extension 03:34:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:34:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:34:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:34:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:34:38 INFO - Successfully installed psutil 03:34:38 INFO - Cleaning up... 03:34:38 INFO - Return code: 0 03:34:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:34: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')]} 03:34:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34: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')]} 03:34:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6338613f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248c1c0>, '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 0x248d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248d550>, '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': '337fe3f4b1febe37b85fccc40000019e-1467540769.570594-421014012', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:34: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:34: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 mozsystemmonitor==0.3 03:34:38 INFO - Using env: {'DISPLAY': ':0', 03:34:38 INFO - 'HOME': '/home/cltbld', 03:34:38 INFO - 'LANG': 'en_US.UTF-8', 03:34:38 INFO - 'LANGUAGE': 'en_US:en', 03:34:38 INFO - 'LOGNAME': 'cltbld', 03:34:38 INFO - 'MAIL': '/var/mail/cltbld', 03:34:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:38 INFO - 'MOZ_NO_REMOTE': '1', 03:34:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:38 INFO - 'NO_EM_RESTART': '1', 03:34:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:38 INFO - 'PWD': '/builds/slave/test', 03:34:38 INFO - 'SHELL': '/bin/bash', 03:34:38 INFO - 'SHLVL': '1', 03:34:38 INFO - 'TERM': 'linux', 03:34:38 INFO - 'TMOUT': '86400', 03:34:38 INFO - 'USER': 'cltbld', 03:34:38 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1467540769.570594-421014012', 03:34:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:38 INFO - '_': '/tools/buildbot/bin/python'} 03:34:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:34: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 03:34: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 03:34: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 03:34: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 03:34: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 03:34: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 03:34:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:34:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:34:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:34:40 INFO - Installing collected packages: mozsystemmonitor 03:34:40 INFO - Running setup.py install for mozsystemmonitor 03:34:40 INFO - Successfully installed mozsystemmonitor 03:34:40 INFO - Cleaning up... 03:34:40 INFO - Return code: 0 03:34:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:34:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:40 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 0x7f6338613f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248c1c0>, '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 0x248d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248d550>, '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': '337fe3f4b1febe37b85fccc40000019e-1467540769.570594-421014012', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:34:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:34:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:34:40 INFO - Using env: {'DISPLAY': ':0', 03:34:40 INFO - 'HOME': '/home/cltbld', 03:34:40 INFO - 'LANG': 'en_US.UTF-8', 03:34:40 INFO - 'LANGUAGE': 'en_US:en', 03:34:40 INFO - 'LOGNAME': 'cltbld', 03:34:40 INFO - 'MAIL': '/var/mail/cltbld', 03:34:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:40 INFO - 'MOZ_NO_REMOTE': '1', 03:34:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:40 INFO - 'NO_EM_RESTART': '1', 03:34:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:40 INFO - 'PWD': '/builds/slave/test', 03:34:40 INFO - 'SHELL': '/bin/bash', 03:34:40 INFO - 'SHLVL': '1', 03:34:40 INFO - 'TERM': 'linux', 03:34:40 INFO - 'TMOUT': '86400', 03:34:40 INFO - 'USER': 'cltbld', 03:34:40 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1467540769.570594-421014012', 03:34:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:40 INFO - '_': '/tools/buildbot/bin/python'} 03:34:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:40 INFO - Downloading/unpacking jsonschema==2.5.1 03:34: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 03:34: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 03:34: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 03:34: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 03:34: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 03:34: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 03:34:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:34:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:34:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:43 INFO - Downloading functools32-3.2.3-2.tar.gz 03:34:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:34:43 INFO - warning: no files found matching '*.txt' 03:34:43 INFO - no previously-included directories found matching 'build' 03:34:43 INFO - no previously-included directories found matching 'dist' 03:34:43 INFO - no previously-included directories found matching '.git*' 03:34:43 INFO - Installing collected packages: jsonschema, functools32 03:34:43 INFO - Running setup.py install for functools32 03:34:43 INFO - warning: no files found matching '*.txt' 03:34:43 INFO - no previously-included directories found matching 'build' 03:34:43 INFO - no previously-included directories found matching 'dist' 03:34:43 INFO - no previously-included directories found matching '.git*' 03:34:43 INFO - Successfully installed jsonschema functools32 03:34:43 INFO - Cleaning up... 03:34:43 INFO - Return code: 0 03:34:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:34:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6338613f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248c1c0>, '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 0x248d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248d550>, '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': '337fe3f4b1febe37b85fccc40000019e-1467540769.570594-421014012', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:34:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:34:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:34:43 INFO - Using env: {'DISPLAY': ':0', 03:34:43 INFO - 'HOME': '/home/cltbld', 03:34:43 INFO - 'LANG': 'en_US.UTF-8', 03:34:43 INFO - 'LANGUAGE': 'en_US:en', 03:34:43 INFO - 'LOGNAME': 'cltbld', 03:34:43 INFO - 'MAIL': '/var/mail/cltbld', 03:34:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:43 INFO - 'MOZ_NO_REMOTE': '1', 03:34:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:43 INFO - 'NO_EM_RESTART': '1', 03:34:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:43 INFO - 'PWD': '/builds/slave/test', 03:34:43 INFO - 'SHELL': '/bin/bash', 03:34:43 INFO - 'SHLVL': '1', 03:34:43 INFO - 'TERM': 'linux', 03:34:43 INFO - 'TMOUT': '86400', 03:34:43 INFO - 'USER': 'cltbld', 03:34:43 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1467540769.570594-421014012', 03:34:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:43 INFO - '_': '/tools/buildbot/bin/python'} 03:34:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:43 INFO - Downloading/unpacking blobuploader==1.2.4 03:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:45 INFO - Downloading blobuploader-1.2.4.tar.gz 03:34:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:34:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:34:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:46 INFO - Downloading docopt-0.6.1.tar.gz 03:34:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:34:46 INFO - Installing collected packages: blobuploader, requests, docopt 03:34:46 INFO - Running setup.py install for blobuploader 03:34:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:34:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:34:46 INFO - Running setup.py install for requests 03:34:46 INFO - Running setup.py install for docopt 03:34:46 INFO - Successfully installed blobuploader requests docopt 03:34:46 INFO - Cleaning up... 03:34:46 INFO - Return code: 0 03:34:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:34:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:46 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 0x7f6338613f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248c1c0>, '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 0x248d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248d550>, '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': '337fe3f4b1febe37b85fccc40000019e-1467540769.570594-421014012', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:34:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:34:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:34:46 INFO - Using env: {'DISPLAY': ':0', 03:34:46 INFO - 'HOME': '/home/cltbld', 03:34:46 INFO - 'LANG': 'en_US.UTF-8', 03:34:46 INFO - 'LANGUAGE': 'en_US:en', 03:34:46 INFO - 'LOGNAME': 'cltbld', 03:34:46 INFO - 'MAIL': '/var/mail/cltbld', 03:34:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:46 INFO - 'MOZ_NO_REMOTE': '1', 03:34:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:46 INFO - 'NO_EM_RESTART': '1', 03:34:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:46 INFO - 'PWD': '/builds/slave/test', 03:34:46 INFO - 'SHELL': '/bin/bash', 03:34:46 INFO - 'SHLVL': '1', 03:34:46 INFO - 'TERM': 'linux', 03:34:46 INFO - 'TMOUT': '86400', 03:34:46 INFO - 'USER': 'cltbld', 03:34:46 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1467540769.570594-421014012', 03:34:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:46 INFO - '_': '/tools/buildbot/bin/python'} 03:34:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:34:47 INFO - Running setup.py (path:/tmp/pip-WgVESx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:34:47 INFO - Running setup.py (path:/tmp/pip-6eYcGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:34:47 INFO - Running setup.py (path:/tmp/pip-5eMhO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:34:47 INFO - Running setup.py (path:/tmp/pip-KwTXfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:34:47 INFO - Running setup.py (path:/tmp/pip-GoDTrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:34:47 INFO - Running setup.py (path:/tmp/pip-aKzzIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:34:47 INFO - Running setup.py (path:/tmp/pip-9VCvll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:34:47 INFO - Running setup.py (path:/tmp/pip-QM6m6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:34:47 INFO - Running setup.py (path:/tmp/pip-XAGBpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:34:47 INFO - Running setup.py (path:/tmp/pip-HpC_mv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:34:47 INFO - Running setup.py (path:/tmp/pip-hsC02h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:34:47 INFO - Running setup.py (path:/tmp/pip-8oVmp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:34:47 INFO - Running setup.py (path:/tmp/pip-gqqbWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:34:47 INFO - Running setup.py (path:/tmp/pip-NPyWou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:48 INFO - Running setup.py (path:/tmp/pip-PIXOsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:34:48 INFO - Running setup.py (path:/tmp/pip-yfomdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:34:48 INFO - Running setup.py (path:/tmp/pip-2QamMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:34:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:34:48 INFO - Running setup.py install for manifestparser 03:34:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:34:48 INFO - Running setup.py install for mozcrash 03:34:48 INFO - Running setup.py install for mozdebug 03:34:48 INFO - Running setup.py install for mozdevice 03:34:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:34:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:34:48 INFO - Running setup.py install for mozfile 03:34:48 INFO - Running setup.py install for mozhttpd 03:34:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:34:48 INFO - Running setup.py install for mozinfo 03:34:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:34:48 INFO - Running setup.py install for mozInstall 03:34:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:34:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:34:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:34:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:34:49 INFO - Running setup.py install for mozleak 03:34:49 INFO - Running setup.py install for mozlog 03:34:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:34:49 INFO - Running setup.py install for moznetwork 03:34:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:34:49 INFO - Running setup.py install for mozprocess 03:34:49 INFO - Running setup.py install for mozprofile 03:34:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:34:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:34:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:34:49 INFO - Running setup.py install for mozrunner 03:34:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:34:49 INFO - Running setup.py install for mozscreenshot 03:34:49 INFO - Running setup.py install for moztest 03:34:49 INFO - Running setup.py install for mozversion 03:34:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:34:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:34:50 INFO - Cleaning up... 03:34:50 INFO - Return code: 0 03:34:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:34:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:50 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 0x7f6338613f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248c1c0>, '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 0x248d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248d550>, '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': '337fe3f4b1febe37b85fccc40000019e-1467540769.570594-421014012', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:34:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:34:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:34:50 INFO - Using env: {'DISPLAY': ':0', 03:34:50 INFO - 'HOME': '/home/cltbld', 03:34:50 INFO - 'LANG': 'en_US.UTF-8', 03:34:50 INFO - 'LANGUAGE': 'en_US:en', 03:34:50 INFO - 'LOGNAME': 'cltbld', 03:34:50 INFO - 'MAIL': '/var/mail/cltbld', 03:34:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:50 INFO - 'MOZ_NO_REMOTE': '1', 03:34:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:50 INFO - 'NO_EM_RESTART': '1', 03:34:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:50 INFO - 'PWD': '/builds/slave/test', 03:34:50 INFO - 'SHELL': '/bin/bash', 03:34:50 INFO - 'SHLVL': '1', 03:34:50 INFO - 'TERM': 'linux', 03:34:50 INFO - 'TMOUT': '86400', 03:34:50 INFO - 'USER': 'cltbld', 03:34:50 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1467540769.570594-421014012', 03:34:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:50 INFO - '_': '/tools/buildbot/bin/python'} 03:34:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:34:50 INFO - Running setup.py (path:/tmp/pip-dkjD97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:34:50 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:34:50 INFO - Running setup.py (path:/tmp/pip-w37ygv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:34:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:34:50 INFO - Running setup.py (path:/tmp/pip-5z_8f6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:34:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:34:50 INFO - Running setup.py (path:/tmp/pip-DsSoI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:34:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:34:50 INFO - Running setup.py (path:/tmp/pip-ZT9ffx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:34:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:34:50 INFO - Running setup.py (path:/tmp/pip-sEHXq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:34:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:34:50 INFO - Running setup.py (path:/tmp/pip-komUpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:34:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:34:50 INFO - Running setup.py (path:/tmp/pip-xo6DAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:34:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:34:50 INFO - Running setup.py (path:/tmp/pip-rlzc_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:34:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:34:50 INFO - Running setup.py (path:/tmp/pip-vNhSIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:34:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:34:50 INFO - Running setup.py (path:/tmp/pip-8SR8kj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:34:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:34:51 INFO - Running setup.py (path:/tmp/pip-y1CZ8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:34:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:34:51 INFO - Running setup.py (path:/tmp/pip-0V1JxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:34:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:34:51 INFO - Running setup.py (path:/tmp/pip-CYiA0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:34:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:51 INFO - Running setup.py (path:/tmp/pip-y6ONnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:34:51 INFO - Running setup.py (path:/tmp/pip-9AdzBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:34:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:34:51 INFO - Running setup.py (path:/tmp/pip-JYa_LV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:34:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:34:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:34:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:34:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:34:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:34:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:34:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:53 INFO - Downloading blessings-1.6.tar.gz 03:34:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:34:53 INFO - Installing collected packages: blessings 03:34:53 INFO - Running setup.py install for blessings 03:34:53 INFO - Successfully installed blessings 03:34:53 INFO - Cleaning up... 03:34:53 INFO - Return code: 0 03:34:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:34:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:34:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:34:53 INFO - Reading from file tmpfile_stdout 03:34:53 INFO - Current package versions: 03:34:53 INFO - argparse == 1.2.1 03:34:53 INFO - blessings == 1.6 03:34:53 INFO - blobuploader == 1.2.4 03:34:53 INFO - docopt == 0.6.1 03:34:53 INFO - functools32 == 3.2.3-2 03:34:53 INFO - jsonschema == 2.5.1 03:34:53 INFO - manifestparser == 1.1 03:34:53 INFO - mozInstall == 1.12 03:34:53 INFO - mozcrash == 0.17 03:34:53 INFO - mozdebug == 0.1 03:34:53 INFO - mozdevice == 0.48 03:34:53 INFO - mozfile == 1.2 03:34:53 INFO - mozhttpd == 0.7 03:34:53 INFO - mozinfo == 0.9 03:34:53 INFO - mozleak == 0.1 03:34:53 INFO - mozlog == 3.2 03:34:53 INFO - moznetwork == 0.27 03:34:53 INFO - mozprocess == 0.22 03:34:53 INFO - mozprofile == 0.28 03:34:53 INFO - mozrunner == 6.11 03:34:53 INFO - mozscreenshot == 0.1 03:34:53 INFO - mozsystemmonitor == 0.3 03:34:53 INFO - moztest == 0.7 03:34:53 INFO - mozversion == 1.4 03:34:53 INFO - psutil == 3.1.1 03:34:53 INFO - requests == 1.2.3 03:34:53 INFO - wsgiref == 0.1.2 03:34:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:34:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:53 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 0x7f6338613f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248c1c0>, '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 0x248d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248d550>, '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': '337fe3f4b1febe37b85fccc40000019e-1467540769.570594-421014012', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:34:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:34:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:34:53 INFO - Using env: {'DISPLAY': ':0', 03:34:53 INFO - 'HOME': '/home/cltbld', 03:34:53 INFO - 'LANG': 'en_US.UTF-8', 03:34:53 INFO - 'LANGUAGE': 'en_US:en', 03:34:53 INFO - 'LOGNAME': 'cltbld', 03:34:53 INFO - 'MAIL': '/var/mail/cltbld', 03:34:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:53 INFO - 'MOZ_NO_REMOTE': '1', 03:34:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:53 INFO - 'NO_EM_RESTART': '1', 03:34:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:53 INFO - 'PWD': '/builds/slave/test', 03:34:53 INFO - 'SHELL': '/bin/bash', 03:34:53 INFO - 'SHLVL': '1', 03:34:53 INFO - 'TERM': 'linux', 03:34:53 INFO - 'TMOUT': '86400', 03:34:53 INFO - 'USER': 'cltbld', 03:34:53 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1467540769.570594-421014012', 03:34:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:53 INFO - '_': '/tools/buildbot/bin/python'} 03:34:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:34:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:34:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:34:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:34:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:34:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:34:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:34:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:34:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:34:54 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:34:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:34:54 INFO - Cleaning up... 03:34:54 INFO - Return code: 0 03:34:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:34:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6338613f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248c1c0>, '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 0x248d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248d550>, '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': '337fe3f4b1febe37b85fccc40000019e-1467540769.570594-421014012', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:34:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:34:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:34:54 INFO - Using env: {'DISPLAY': ':0', 03:34:54 INFO - 'HOME': '/home/cltbld', 03:34:54 INFO - 'LANG': 'en_US.UTF-8', 03:34:54 INFO - 'LANGUAGE': 'en_US:en', 03:34:54 INFO - 'LOGNAME': 'cltbld', 03:34:54 INFO - 'MAIL': '/var/mail/cltbld', 03:34:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:54 INFO - 'MOZ_NO_REMOTE': '1', 03:34:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:54 INFO - 'NO_EM_RESTART': '1', 03:34:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:54 INFO - 'PWD': '/builds/slave/test', 03:34:54 INFO - 'SHELL': '/bin/bash', 03:34:54 INFO - 'SHLVL': '1', 03:34:54 INFO - 'TERM': 'linux', 03:34:54 INFO - 'TMOUT': '86400', 03:34:54 INFO - 'USER': 'cltbld', 03:34:54 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1467540769.570594-421014012', 03:34:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:54 INFO - '_': '/tools/buildbot/bin/python'} 03:34:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:34:54 INFO - Cleaning up... 03:34:54 INFO - Return code: 0 03:34:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:34:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6338613f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248c1c0>, '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 0x248d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248d550>, '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': '337fe3f4b1febe37b85fccc40000019e-1467540769.570594-421014012', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:34:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:34:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:34:54 INFO - Using env: {'DISPLAY': ':0', 03:34:54 INFO - 'HOME': '/home/cltbld', 03:34:54 INFO - 'LANG': 'en_US.UTF-8', 03:34:54 INFO - 'LANGUAGE': 'en_US:en', 03:34:54 INFO - 'LOGNAME': 'cltbld', 03:34:54 INFO - 'MAIL': '/var/mail/cltbld', 03:34:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:54 INFO - 'MOZ_NO_REMOTE': '1', 03:34:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:54 INFO - 'NO_EM_RESTART': '1', 03:34:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:54 INFO - 'PWD': '/builds/slave/test', 03:34:54 INFO - 'SHELL': '/bin/bash', 03:34:54 INFO - 'SHLVL': '1', 03:34:54 INFO - 'TERM': 'linux', 03:34:54 INFO - 'TMOUT': '86400', 03:34:54 INFO - 'USER': 'cltbld', 03:34:54 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1467540769.570594-421014012', 03:34:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:54 INFO - '_': '/tools/buildbot/bin/python'} 03:34:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:54 INFO - Downloading/unpacking flake8 03:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:34:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:34:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:34:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:34:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:34:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:34:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:34:57 INFO - no previously-included directories found matching 'docs/_build' 03:34:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:34:57 INFO - Running setup.py install for pep8 03:34:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:34:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:34:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:34:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:34:57 INFO - no previously-included directories found matching 'docs/_build' 03:34:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:34:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:34:57 INFO - Cleaning up... 03:34:57 INFO - Return code: 0 03:34:57 INFO - Running post-action listener: _resource_record_post_action 03:34:57 INFO - Running post-action listener: _start_resource_monitoring 03:34:57 INFO - Starting resource monitoring. 03:34:57 INFO - ##### 03:34:57 INFO - ##### Finished create-virtualenv step (success) 03:34:57 INFO - ##### 03:34:57 INFO - ##### 03:34:57 INFO - ##### Running install step. 03:34:57 INFO - ##### 03:34:57 INFO - Running pre-action listener: _resource_record_pre_action 03:34:57 INFO - Running main action method: install 03:34:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:34:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:34:57 INFO - Reading from file tmpfile_stdout 03:34:57 INFO - Detecting whether we're running mozinstall >=1.0... 03:34:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:34:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:34:57 INFO - Reading from file tmpfile_stdout 03:34:57 INFO - Output received: 03:34:57 INFO - Usage: mozinstall [options] installer 03:34:57 INFO - Options: 03:34:57 INFO - -h, --help show this help message and exit 03:34:57 INFO - -d DEST, --destination=DEST 03:34:57 INFO - Directory to install application into. [default: 03:34:57 INFO - "/builds/slave/test"] 03:34:57 INFO - --app=APP Application being installed. [default: firefox] 03:34:57 INFO - mkdir: /builds/slave/test/build/application 03:34:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:34:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:35:13 INFO - Reading from file tmpfile_stdout 03:35:13 INFO - Output received: 03:35:13 INFO - /builds/slave/test/build/application/firefox/firefox 03:35:13 INFO - Running post-action listener: _resource_record_post_action 03:35:13 INFO - ##### 03:35:13 INFO - ##### Finished install step (success) 03:35:13 INFO - ##### 03:35:13 INFO - ##### 03:35:13 INFO - ##### Running run-tests step. 03:35:13 INFO - ##### 03:35:13 INFO - Running pre-action listener: _resource_record_pre_action 03:35:13 INFO - Running main action method: run_tests 03:35:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:35:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:35:13 INFO - Python 2.7.3 03:35:13 INFO - Return code: 0 03:35:13 INFO - grabbing minidump binary from tooltool 03:35: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')]} 03:35:13 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 0x248c1c0>, '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 0x248d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248d550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:35:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:35:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:35:13 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:35:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:35:13 INFO - Return code: 0 03:35:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:35:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:35:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:35:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:35:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:35:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:35:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:35:14 INFO - Return code: 0 03:35:14 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/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 03:35:14 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/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 03:35:14 INFO - Using env: {'DISPLAY': ':0', 03:35:14 INFO - 'HOME': '/home/cltbld', 03:35:14 INFO - 'LANG': 'en_US.UTF-8', 03:35:14 INFO - 'LANGUAGE': 'en_US:en', 03:35:14 INFO - 'LOGNAME': 'cltbld', 03:35:14 INFO - 'MAIL': '/var/mail/cltbld', 03:35:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:35:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:35:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:14 INFO - 'MOZ_NO_REMOTE': '1', 03:35:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:35:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:14 INFO - 'NO_EM_RESTART': '1', 03:35:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:14 INFO - 'PWD': '/builds/slave/test', 03:35:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:35:14 INFO - 'SHELL': '/bin/bash', 03:35:14 INFO - 'SHLVL': '1', 03:35:14 INFO - 'TERM': 'linux', 03:35:14 INFO - 'TMOUT': '86400', 03:35:14 INFO - 'USER': 'cltbld', 03:35:14 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1467540769.570594-421014012', 03:35:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:14 INFO - '_': '/tools/buildbot/bin/python'} 03:35:14 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/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 03:35:14 INFO - mozversion application_buildid: 20160703004921 03:35:14 INFO - mozversion application_changeset: 01f2dde06c5fd93b38c0d80b6028210b48dd3f4a 03:35:14 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:35:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:35:14 INFO - mozversion application_name: Firefox 03:35:14 INFO - mozversion application_remotingname: firefox-dev 03:35:14 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:35:14 INFO - mozversion application_vendor: Mozilla 03:35:14 INFO - mozversion application_version: 49.0a2 03:35:14 INFO - mozversion platform_buildid: 20160703004921 03:35:14 INFO - mozversion platform_changeset: 01f2dde06c5fd93b38c0d80b6028210b48dd3f4a 03:35:14 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:35:14 INFO - mozversion platform_version: 49.0a2 03:35:14 INFO - using testdate: 1467542114 03:35:14 INFO - actual date: 1467542114 03:35:14 INFO - starting webserver on 'localhost:43496' 03:35:14 INFO - SUITE-START | Running 2 tests 03:35:14 INFO - TEST-START | dromaeo_css 03:35:14 INFO - operating with platform_type : linux_ 03:35:14 INFO - Initialising browser for dromaeo_css test... 03:35:14 INFO - TEST-INFO | started process 8105 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy32lop/profile http://localhost:43496/getInfo.html) 03:35:19 INFO - PROCESS | 8105 | __metrics Screen width/height:1600/1200 03:35:19 INFO - PROCESS | 8105 | colorDepth:24 03:35:19 INFO - PROCESS | 8105 | Browser inner width/height: 1024/697 03:35:19 INFO - PROCESS | 8105 | __metrics 03:35:20 ERROR - PROCESS | 8105 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 03:35:21 INFO - TEST-INFO | 8105: exit 0 03:35:21 INFO - Browser initialized. 03:35:21 INFO - Running cycle 1/1 for dromaeo_css test... 03:35:21 INFO - TEST-INFO | started process 8233 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy32lop/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:35:32 INFO - PROCESS | 8233 | RSS: Main: 156225536 03:35:32 INFO - PROCESS | 8233 | 03:36:22 INFO - PROCESS | 8233 | 1467542182518 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:38:30 INFO - PROCESS | 8233 | Cycle 1(1): loaded http://localhost:43496/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43496/tests/dromaeo/cssquery-ext.html) 03:38:31 INFO - PROCESS | 8233 | RSS: Main: 159875072 03:38:31 INFO - PROCESS | 8233 | 03:41:33 INFO - PROCESS | 8233 | Cycle 1(1): loaded http://localhost:43496/tests/dromaeo/cssquery-ext.html (next: http://localhost:43496/tests/dromaeo/cssquery-jquery.html) 03:41:34 INFO - PROCESS | 8233 | RSS: Main: 157753344 03:41:34 INFO - PROCESS | 8233 | 03:44:36 INFO - PROCESS | 8233 | Cycle 1(1): loaded http://localhost:43496/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43496/tests/dromaeo/cssquery-mootools.html) 03:44:36 INFO - PROCESS | 8233 | RSS: Main: 157294592 03:44:36 INFO - PROCESS | 8233 | 03:47:38 INFO - PROCESS | 8233 | Cycle 1(1): loaded http://localhost:43496/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43496/tests/dromaeo/cssquery-prototype.html) 03:47:39 INFO - PROCESS | 8233 | RSS: Main: 156868608 03:47:39 INFO - PROCESS | 8233 | 03:50:41 INFO - PROCESS | 8233 | Cycle 1(1): loaded http://localhost:43496/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43496/tests/dromaeo/cssquery-yui.html) 03:50:42 INFO - PROCESS | 8233 | RSS: Main: 159158272 03:50:42 INFO - PROCESS | 8233 | 03:53:44 INFO - PROCESS | 8233 | Cycle 1(1): loaded http://localhost:43496/tests/dromaeo/cssquery-yui.html (next: http://localhost:43496/tests/dromaeo/cssquery-dojo.html) 03:53:44 INFO - PROCESS | 8233 | RSS: Main: 159145984 03:53:44 INFO - PROCESS | 8233 | 03:53:44 INFO - PROCESS | 8233 | __start_tp_report 03:53:44 INFO - PROCESS | 8233 | _x_x_mozilla_page_load 03:53:44 INFO - PROCESS | 8233 | _x_x_mozilla_page_load_details 03:53:44 INFO - PROCESS | 8233 | |i|pagename|runs| 03:53:44 INFO - PROCESS | 8233 | |0;dojo.html;3426.023583278766;3441.948370774439;3455.1707590178357;3460.2560449503335;3495.4931534927446;5755.453231942964;5805.535557155428;5871.44221298977;5894.145348924403;5918.260217472816;5866.149408335788;5883.764649414029;5913.674747888876;5915.556333275;5916.852078698024;5233.058049551079;5295.099833028395;5304.443033481487;5304.946950530503;5348.197770334462;5195.376554813428;5241.790328386879;5298.258243845846;5359.38367087786;5385.272988146608;5274.92087618686;5297.390800057985;5329.413764485904;5333.493318134771;5342.465753424665;5387.1111266640955;5387.542058924976;5390.029794636964;5392.245085688007;5411;5033.672811267256;5198.558122559587;5205.29728486657;5314.601404894648;5317.441668624816;5690.630109042899;5709.115087161496;5742.08126699726;5758.193852860602;5773.480386765212;6294.087357333161;6326.557141000132;6330.335314791927;6337.746490140389;6346.555741098125;6146.7541298348015;6156.199694039791;6216.595921265103;6261.46777523911;6382.297947225801;5859.501942334907;5875.118732190205;5879.265091863517;5882.352941176425;5918.526517878559;6381.904271435932;6401.679916004181;6403.583767055126;6413.903791443132;6416.294207637156;5981.910271345933;5983.311919129356;6075.605085669417;6111.96944015277;6128.356522565066;6182.562259819388;6197.318294987548;6228.56400051992;6230.127782110508;6234.314225435199;6067.362926892701;6121.846953826101;6186.628802271878;6205.069239614094;6227.626342419469;6179.227596550431;6199.938000619936;6252.968735156386;6324;6371.203599550056;4777.163996300703;4797;4797.832075877397;4816.253480710496;4830.058138662997;4131.772752498641;4231.978840105779;4274.978625106854;4279.358096285519;4280.101178752497;5922.733476993546;6048.274207095177;6071.119687645267;6117.174181485531;6128.442013630915;6326.4622507087415;6424.068510066108;6429.099926010363;6429.260635027032;6441.227052753699;5876.001079816441;5892.263467066617;5904.76380944766;6167.321594624587;6169.753209871645;5312.628116031918;5339.86650333737;5351.678899266057;5352.4915133062295;5370.3287089113865;6444.226692796894;6456.3543645636;6457.61254324742;6461.224653041665;6463.903041454382;6101.664408457577;6237.875242495215;6240.875182496416;6250.1874756281395;6266.592671476339;6402.35976402356;6476.384743449365;6491.350864913471;6525.2169739631545;6530.8040758777315;6181.227346581677;6182.1345011699295;6229.4393504584805;6245.18812554365;6246.937530624818;6001.129836173817;6189.226346706661;6191.907121393093;6255.624662520263;6352.110704501466;6125.969370153299;6156.907646385218;6183.5671502994355;6186.381361863778;6192.195014648067;6030.48740857032;6157.138000679998;6168.691565421621;6176.382361763787;6187.504999600112;6081.118237855398;6105.823680184464;6109.969450152721;6124.717717613011;6128.242096493223;6221.502279817694;6238.438540531374;6240.625562466266;6278.6546739929745;6279.30927597973;5875.353711091862;6034.939650603438;6092.543059270483;6099.878002440015;6136.018237082046 03:53:44 INFO - PROCESS | 8233 | |1;ext.html;590.533478551944;642.9967850160748;643.5270076493777;669.7823207457576;675.3010633993812;42568;47038.29442558364;47191;47266.52733472664;47310.52689473104;47280;47659;47757.761211193894;47906.281405778944;47921.52078479214;8942.955285223565;9065.682701105463;9077.727668169966;9082.228010619105;9083.863742043875;8832.690855820048;8876.289896808239;8911.509866957314;8956.149165829236;8966.820663586725;8961.59672814725;8978.640854365818;9001.729948101567;9012.459252444874;9019.368644194908;8930.419522731001;8937.910620893805;9001.23489503393;9012.414193077462;9029.729108126701;8793;8850.336224783103;8861.202491775772;8906.421082629608;8942.552872356357;43414.56585434137;43731.78134109341;43893.78053109714;43992.56007439917;44079.33880991788;3708.2027364116843;3819.9809000955097;3862.517185351831;4048.332025215836;4620.953790462119;34582.308353832785;35039.824800876086;35176;35495.64504354949;36221;4518.593326600621;4550.5735556463615;4637.142128706167;4641;4704.082703872747;382290;384480;385164.9999999972;385955;385995;65174.67412662906;65534;65748.67125664341;65838;65842;42469.57530424718;42951;43127.784361078;43394.34908476375;43430.131397372505;18980.715289270673;18989.050547472572;19133.425997220107;19152.425427237205;19163.904180479007;14998.47505337308;15055.54833355001;15069.698606027818;15091.698166036618;15093.094414335175;21421.464463388227;21522.677159842617;21570.892145539172;21607.89196054041;21620.35138945834;7471.738489152962;7716.5370077795515;7890.831505363995;7958.602069896482;7974.043114826258;1031.3811712972306;1113.4989254835357;1153.423288355822;1198.6643739752708;1215.9513619455122;33259.667403326144;33268.66731332656;33404.164895877315;34063.65936340605;34169.31661366808;1170.2744298534963;1170.2861254634665;1193.0813273779142;1216.087934049463;1286.0933042205222;17781.555461113316;17831.375901843374;17881;17893.19480623349;18005.819941800677;686073;692939;696154;696367;697173;66650;66660.33339666638;66802;67497.66251168713;67555;1476.3577843638052;1514.6137734877536;1519.9392024319125;1525.6497999270948;1530.112534729854;34329.828350858086;34378;34422.48366274558;34468.31063378769;34479.82760086284;57899.4210057894;58007.709961449924;58010.70994645;58396.416035839095;58499;594243;603687;604097;604799;606196;31612.209694757814;32051.198720032186;32143.839280803448;32542.674573253964;32568.674313256564;53819.73090134524;53823.461765383414;53852;54974.17538736842;55155.17267240914;44801.327980080976;45272;45716.77141614271;46138;46748.29877551908;43526.34710479282;44228.557714422444;44921.32618010667;45681;46153.538464614925;44565.55434445614;44992.55007449884;45142.32286515771;45909.540904590525;46089;38464.6153538461;38554.80722596481;38698.61301387063;39041.609583903795;40111.59888401195;30008.84995575008;30046.69953300439;30422.695773041985;31026;31045.223869403446 03:53:44 INFO - PROCESS | 8233 | |2;jquery.html;429.38032386977784;430.84058898207667;431.6891837876728;434.8391095294741;442.98671039868805;18920.810791892076;19961.401157965283;20594.794052059493;21224.89387553064;21268.893655531738;18125.274989000456;18931;19113;19122.235110595593;19790.604187916233;5390.8921821563545;5535.391106978229;5587.776488940438;5598.776048958057;5618.15727640853;5372.54333381663;5409.43200963899;5418.91871621926;5467.617266791326;5987.850303742398;5936.703164841762;5963.075723262879;5968.910466343008;5971.402859714016;5992.221011268529;5507.531859791942;5518.530924871391;5525.640833345819;5950.077737950624;5978.8206353809455;5346.91979620306;5359.81240656579;5361.115415956362;5362.597805164628;5370.060239458079;14433.566992990227;16207.675846483004;21146.89426552873;22468.325950221355;22612.09551617933;2362.6337917622623;2410.373302941248;2461.5815311397105;2479.838810477313;2667.199840047978;10691.411972341519;10793.67618971432;10887.945560272148;11000.119990400828;13509.256990865499;2052.6202652509182;2061.1240222905353;2126.5959467701086;2137.657974724052;2163.123934806406;81038.59480702618;81083.5945820273;81756.59121704413;82588.58705706493;82638.17361826365;11676.416179191176;12110.212836165621;12356.443960021641;12546.996240300754;12682.80975785364;17109.401170958958;17151.313947442213;17173.227204775565;17189.914050429667;17198.31206751716;8917.509536975529;8935.419197752126;9103.954480227556;9199.586018629177;9339.066093390607;8856.778580535538;8908.910910890809;8913.866292005625;9027.864582031143;9087.318451116193;5109.642325037212;5126.769295381717;5145.819896303611;5156.716380599103;5203.864532105609;2119.8340912498065;2127.627665158591;2142.0896119149297;2198.6701994700925;2215.3021798133536;970.5632465390603;1048.8898665640152;1060.4591658254192;1079.5681727309138;1088.6996364360807;17498.387556435464;19115.235390584498;19475.41573752761;20032.298869539496;20124;1062.442217835627;1063.2929102146986;1081.2863510083307;1081.6106201767357;1091.9026378489725;10771.730706732395;11314.377709226072;11320.943395283135;11355.432228388547;11381.829272560919;506055;517406;522957;536752;547263;81717;94233;94978.52510737402;95080;96045.51977240069;1085.6742977106837;1085.9837102443469;1099.4667586220676;1105.1987309200765;1108.6175269531998;16842.494725158263;17682.5579360517;17787.55531111681;17927.73108403349;18110.456686299432;28846.855765721037;41331.7933410343;42653.36019959641;42857.35713964231;44372.77813610911;57151;58776.41223587709;58982.41017589941;59204.70397647984;59587.40412595992;8937.195652391316;9021.594028268612;9103.408278461879;9118.498482583522;9137.269018478639;12890.935545322214;12915;13209.603711888658;13403.597892063253;13705.862941370458;11623.1282653803;11805.527778889093;11914.16600837933;11919.165658404176;11982.580609678967;11525.711857203301;11541.36522491271;11721.88278117242;11932.522699091938;11965.581204657796;11330.320180789178;11855.34795586251;12049.33728644933;12069;12468.750624987631;9048.592813323285;9065.18413342776;9127.817443651222;9129.904411470667;9305.11601397866;9130.634774608941;11985.460654270753;12097.81853272184;12178.57374991871;12189.817152742538 03:53:44 INFO - PROCESS | 8233 | |3;mootools.html;1611.3796188467436;1624.0986252629793;1865.4310435317232;1906.1041310584021;1959.6080783843227;9412.905870941297;9652.083052110056;10000.599976000969;10078.798424031524;10093.54579043943;9886.20910327174;9958.800823983516;10027.749306267347;10083.092521673048;10106.747331316721;2486.8632225227607;2523.079076137206;2523.1673547729206;2532.240327901631;2532.8602129041915;2474.5545801755675;2523.40699935515;2553.502067096917;2556.079811267942;2564.8204625676212;2498.1756020513276;2501.4371766352515;2535.7464253574585;2541.390066384073;2546;2393.4136136646457;2422.4307287787356;2437.597796363589;2460.5447992121335;2466.9753302466925;2446.449548851512;2462.0398044762555;2472.1841792208706;2490.5392502386935;2493.1772515070165;9773;9810.411375317504;9811.803763924681;9876.209903207726;9885.25860560461;5765.942340576583;5875.324337701177;5876.265466816648;5917.822465326004;5920.881582368372;3479.2693534357813;3608.386574282378;3632.8365223565;3637.5816781069984;3678.3011227866887;1088.6026600290836;1103.6302838549095;1109.2734259060328;1127.5320741892106;1155.8901904319075;13785.931070344684;13792.172469651752;13895.374708138159;13941.790873136912;13966.162030278114;4924.679895806761;4959.504049595083;5079.009593129378;5087.058894104603;5088.592912566985;10779.245452818384;10790.136789056856;10833.620823271147;10873.782524349468;10875.293105948089;5620;5625.353084395265;5687.829365119053;5700.173474846124;5703.914441283384;4830.66185367028;5185.455527169668;5303.893922121536;5326.653767505178;5332.093544097513;4241.130568233505;4272.6795490338345;4330.826766929351;4338.978305108454;4341.782910854445;1274.5220542296638;1334.8798608125314;1336.9264690441923;1337.725766217923;1351.8977989226846;956.6077908057663;970.5195928015536;1045.8274384726587;1052.21609900623;1094.141099237111;6529.673516324165;6670.264112480097;6689.598624082473;6745.156855393076;6747.932520674829;469.99295010574866;478.9784459699322;483.48508838087326;486.7006790823618;494.2832892306171;4456.732596044248;4462.352958820953;4479.484859241164;4481.865544033684;4514.616257618073;12088.939555302168;12426.689332766753;12460.314682692358;12463.688407789878;12466.501339946482;11502.88497115018;12137.393130343624;12160.148789584644;12499.187552809039;12574.874251257554;8837.867431988525;9055.954720226357;9072.90927090734;9094.454332740057;9110.088991100969;6568.310327415744;6679.532432729857;6703.597784132968;6825.010373495915;6878.140232470942;11186.489823873673;11438.714032149262;11471.254368466023;11480.540778368771;11562.248453850472;11341.149413794163;11549.307041577533;11626.476808543805;11788.528458861549;11847.289162650268;8336.124706905688;8625.439346442461;8641.351898607503;8679.826403471769;8860.867086993829;9352.766180845261;9449.669261576088;9449.905500944902;9477.147056764925;9511.952440238032;8438.113998030118;8690;8702.738917832476;8759.868601971102;8805;8174.83650327002;8249.257566819015;8333.374996875138;8368.581570921551;8425.705100321704;7329.9267007329245;7382.224866389167;7421.740239091821;7427.145878224073;7440.888386674313;5575;5705.7147142643535;5790.565707572033;5824.446677565625;5859.296884373903;5651.463111004448;5659.688717120598;5724.055530837365;5734.311882574118;5844.970775146097 03:53:44 INFO - PROCESS | 8233 | |4;prototype.html;346.67585807270206;347.610676042832;349.08365540456305;350.369335196646;357.4031367616081;5773.5092517136045;5846.853828654281;5854.243726881939;5857.502112320452;5877.177195192666;5696.237324897422;5792.391798861122;5812.0119579671455;5821.118546319567;5858.824235272938;4516.954830451703;4527.343535187412;4532.481618657737;4537.251353526664;4565.1098035883015;4510.188166130095;4526.660500462462;4548.840790572331;4549.681522293441;4575.428071491064;4529.207388706979;4531.6601254905845;4536.5236650151755;4545.727196385017;4549.181147393468;4340.262155433568;4454.910901781978;4464.241079016559;4481.955180448186;4483.6324920899115;3955.991222238311;3975.403689446577;3986.222686576119;3988.6210809973004;3991.5231364395067;5596.720163991825;5611.270534830487;5618.943810561883;5634.464725851038;5676.687782171979;5026.89946201074;5110.897782044338;5126.2054381570915;5154.664946778485;5158.484151584849;5990.580659353847;6130.509559235251;6158.753649854;6173.32093469718;6188.84527886802;4284.400183974246;4368.563143685637;4373.671974601918;4386.188555117282;4391.165678521071;6123.6938153092615;6308.653024083674;6342.778002769927;6352.904706429407;6378.712957916905;4413.404190434315;4417.558244175621;4424.73451592899;4434.135343607965;4442.888927776831;4458.487273963471;4458.5318541553315;4458.9331160032625;4474.485434175046;4479.843205487792;4805.903881922342;5029.622778291643;5067.189249720027;5087.771050302671;5116.513931176532;6074.088886666947;6086.239220097488;6089.878202436015;6098.69506524672;6112.707734599525;1502.5191938579549;1527.5111964171358;1530.915799631031;1531.4486784757478;1539.3996341426853;921.235374639048;974.0697633759743;975.9072888075622;978.6966040527459;986.1666891476691;5184.326037615086;5236.895262094737;5255.684658920477;5304.681719096867;5328.200769884471;5512.779488820483;5526.530244929146;5562.610617256753;5566.332040155207;5570.888582228333;4963.528464795839;5272.446393128666;5278.9382158348835;5294.391145018295;5324;2988.2230620038945;2997.1267957526547;3005.1518316235356;3031.590735250757;3034.8179109253515;5685.839381035263;5753.986104863348;5798.768049277982;5806.854828629318;5840.766369345263;5884.558658100659;6412.67936603168;6426.518011149183;6453.774117905851;6470.741170353227;6599.70301336441;6620.60967196894;6621.9006714899315;6640.402363787186;6663.700133494004;6215.751369945152;6320.29352074928;6358.904616430665;6397.936020639734;6438.29178790342;6102.511799056154;6240.563160578898;6284.465820405317;6305.905411418924;6329.778457753957;6426.068220107964;6435.452986496013;6441.871162576816;6454.096041667625;6454.128692626436;4410.720890941591;4429.09203613265;4438.467383913951;4463.575960283768;4465.6427485800405;6198.845028874134;6306.84232894163;6382.936170638234;6383.9361606383345;6390.392912673288;6117.042546385114;6148;6157.9384206157365;6168.784092556739;6176.6911654418;5905.202797622438;6068.423499767515;6117.418845209698;6140.3245642978345;6168.414000669929;6029.7337559113075;6058.333583305921;6061.1514387984835;6070.392960704071;6089.208402907594;6185.567010309415;6191.9690401547705;6218.689065546795;6224.439800417984;6227.688615569113;5815.709214539341;6047.848803779941;6048.243969503812;6050.45545900871;6100.847478813065 03:53:44 INFO - PROCESS | 8233 | |5;yui.html;776.8601651702692;799.848028874514;811.2374368093991;811.4765975945512;930.7998780262244;14396.784048239284;15423;15472.303746331414;15517.844821551767;15539;12977.416016279267;15330.846691533081;15497.767533486978;15523.611909702264;15525.301361438735;829.3075282139421;873.1748497669705;873.2402809555696;873.2620935309653;873.9431936924111;842.8482873082843;853.5134973065356;857.3012994409536;857.3569822633025;859.7119964811795;914.8993610702818;916.408916249019;916.9083091690811;917.4953775423523;918.6279556779515;904.3624244907357;906.6192199276287;907.0521305236044;911.2937473458123;912.4616476278961;667.5360624366067;667.9131712877295;672.092674888901;672.2907332763932;674.2583158525582;14249.358778854976;14251.85748142526;14323.78514322286;14335.354909029014;14340;14761.409543618242;15207.163606001666;16284.095730079085;16365.83634163655;16632.33470661172;12421.813672794826;12772.16980896248;12988.28564428956;13329.266890321029;13355.465781368734;4037;4078.3270760324513;4084.9387259191135;4128.566500517462;4265.338872474771;76494.61752691257;77003.61498192474;79568.20431795665;80495.19504804935;80746.59626701829;12684.619461416172;12694.238345699288;12769.170003949714;12772.744545109046;12873.678158046123;23236;23359;23401.882990584938;23500.647490287316;24267.63598546023;9229.723108306627;9241.58412871409;9344.392614480037;9395.20140788027;9513.524323783784;5359.705216213146;5401.864953376197;5429.918551221735;5442.319710036246;5596;3801.125741079567;3900.90247743803;3935.9212815743526;3965.1673148638533;3967.2544080604443;650.6649075726004;657.8552718401944;659.2023651381786;665.3712241931329;676.7665155521337;675.5440077947464;765.2806362019684;766.6396793507042;780.6526095887389;835.995820020896;10448.373097614167;11181.83227251592;11183.32900026001;11276.379799111128;11303.420719616615;767.1752865669428;778.9961050194713;829.672279449614;860.4622111180512;863.9179277968583;4865.708057516489;4999.125153098194;5041.621878359138;5195.428502864682;5231.581473482112;113721;115485;115774.42112789382;117017;118214;65739;94588;96642;102371.48814255881;103352;56199.15701264484;92002.53998729963;92053.53973230091;92932.53533732424;93375.53312233396;9937.082441460621;9978.501074946078;10195;10268.332558383681;10292.485375731334;38309.23381532409;45884.77057614824;52803;54483.455165447835;54937.725311373186;65942.34057659362;66602;73424;75157.24842751502;79031.20968790239;13652.65868353299;13744.862551374757;13840.653983650087;13876.514321999086;14286.499972500913;13323.13399629021;13529.255890926093;14098.154110753389;14219.289035548389;14496.85503144955;13683.315834208448;13768.449262029808;13841.238731869844;14120.293985300488;14211.715765684836;12372.13395062373;12544.310062946626;12615.621531354074;12666.873331266937;13231.867681323063;13255.204687718768;13517.86482135166;13597.184168949894;13689.589312320646;13915.304234788018;10696.251262411557;10816.242862999829;11207.551697931991;11414.771704566028;11605.984691705162;11189.216754827085;11198.49572445482;11352.54589816398;11381.601643942422;11447 03:53:44 INFO - PROCESS | 8233 | __end_tp_report 03:53:44 INFO - PROCESS | 8233 | __start_cc_report 03:53:44 INFO - PROCESS | 8233 | _x_x_mozilla_cycle_collect,329 03:53:44 INFO - PROCESS | 8233 | __end_cc_report 03:53:44 INFO - PROCESS | 8233 | __startTimestamp1467543224733__endTimestamp 03:53:44 INFO - PROCESS | 8233 | 03:53:44 INFO - PROCESS | 8233 | ------- Summary: start ------- 03:53:44 INFO - PROCESS | 8233 | Number of tests: 6 03:53:44 INFO - PROCESS | 8233 | 03:53:44 INFO - PROCESS | 8233 | [#0] dojo.html Cycles:165 Average:5822.91 Median:6101.66 stddev:662.85 (10.9%) stddev-sans-first:637.66 03:53:44 INFO - PROCESS | 8233 | Values: 3426.0 3441.9 3455.2 3460.3 3495.5 5755.5 5805.5 5871.4 5894.1 5918.3 5866.1 5883.8 5913.7 5915.6 5916.9 5233.1 5295.1 5304.4 5304.9 5348.2 5195.4 5241.8 5298.3 5359.4 5385.3 5274.9 5297.4 5329.4 5333.5 5342.5 5387.1 5387.5 5390.0 5392.2 5411.0 5033.7 5198.6 5205.3 5314.6 5317.4 5690.6 5709.1 5742.1 5758.2 5773.5 6294.1 6326.6 6330.3 6337.7 6346.6 6146.8 6156.2 6216.6 6261.5 6382.3 5859.5 5875.1 5879.3 5882.4 5918.5 6381.9 6401.7 6403.6 6413.9 6416.3 5981.9 5983.3 6075.6 6112.0 6128.4 6182.6 6197.3 6228.6 6230.1 6234.3 6067.4 6121.8 6186.6 6205.1 6227.6 6179.2 6199.9 6253.0 6324.0 6371.2 4777.2 4797.0 4797.8 4816.3 4830.1 4131.8 4232.0 4275.0 4279.4 4280.1 5922.7 6048.3 6071.1 6117.2 6128.4 6326.5 6424.1 6429.1 6429.3 6441.2 5876.0 5892.3 5904.8 6167.3 6169.8 5312.6 5339.9 5351.7 5352.5 5370.3 6444.2 6456.4 6457.6 6461.2 6463.9 6101.7 6237.9 6240.9 6250.2 6266.6 6402.4 6476.4 6491.4 6525.2 6530.8 6181.2 6182.1 6229.4 6245.2 6246.9 6001.1 6189.2 6191.9 6255.6 6352.1 6126.0 6156.9 6183.6 6186.4 6192.2 6030.5 6157.1 6168.7 6176.4 6187.5 6081.1 6105.8 6110.0 6124.7 6128.2 6221.5 6238.4 6240.6 6278.7 6279.3 5875.4 6034.9 6092.5 6099.9 6136.0 03:53:44 INFO - PROCESS | 8233 | 03:53:44 INFO - PROCESS | 8233 | [#1] ext.html Cycles:180 Average:71873.78 Median:45067.44 stddev:153629.74 (340.9%) stddev-sans-first:153967.49 03:53:44 INFO - PROCESS | 8233 | Values: 590.5 643.0 643.5 669.8 675.3 42568.0 47038.3 47191.0 47266.5 47310.5 47280.0 47659.0 47757.8 47906.3 47921.5 8943.0 9065.7 9077.7 9082.2 9083.9 8832.7 8876.3 8911.5 8956.1 8966.8 8961.6 8978.6 9001.7 9012.5 9019.4 8930.4 8937.9 9001.2 9012.4 9029.7 8793.0 8850.3 8861.2 8906.4 8942.6 43414.6 43731.8 43893.8 43992.6 44079.3 3708.2 3820.0 3862.5 4048.3 4621.0 34582.3 35039.8 35176.0 35495.6 36221.0 4518.6 4550.6 4637.1 4641.0 4704.1 382290.0 384480.0 385165.0 385955.0 385995.0 65174.7 65534.0 65748.7 65838.0 65842.0 42469.6 42951.0 43127.8 43394.3 43430.1 18980.7 18989.1 19133.4 19152.4 19163.9 14998.5 15055.5 15069.7 15091.7 15093.1 21421.5 21522.7 21570.9 21607.9 21620.4 7471.7 7716.5 7890.8 7958.6 7974.0 1031.4 1113.5 1153.4 1198.7 1216.0 33259.7 33268.7 33404.2 34063.7 34169.3 1170.3 1170.3 1193.1 1216.1 1286.1 17781.6 17831.4 17881.0 17893.2 18005.8 686073.0 692939.0 696154.0 696367.0 697173.0 66650.0 66660.3 66802.0 67497.7 67555.0 1476.4 1514.6 1519.9 1525.6 1530.1 34329.8 34378.0 34422.5 34468.3 34479.8 57899.4 58007.7 58010.7 58396.4 58499.0 594243.0 603687.0 604097.0 604799.0 606196.0 31612.2 32051.2 32143.8 32542.7 32568.7 53819.7 53823.5 53852.0 54974.2 55155.2 44801.3 45272.0 45716.8 46138.0 46748.3 43526.3 44228.6 44921.3 45681.0 46153.5 44565.6 44992.6 45142.3 45909.5 46089.0 38464.6 38554.8 38698.6 39041.6 40111.6 30008.8 30046.7 30422.7 31026.0 31045.2 03:53:44 INFO - PROCESS | 8233 | 03:53:44 INFO - PROCESS | 8233 | [#2] jquery.html Cycles:180 Average:30194.70 Median:12341.81 stddev:86573.04 (701.5%) stddev-sans-first:86787.05 03:53:44 INFO - PROCESS | 8233 | Values: 429.4 430.8 431.7 434.8 443.0 18920.8 19961.4 20594.8 21224.9 21268.9 18125.3 18931.0 19113.0 19122.2 19790.6 5390.9 5535.4 5587.8 5598.8 5618.2 5372.5 5409.4 5418.9 5467.6 5987.9 5936.7 5963.1 5968.9 5971.4 5992.2 5507.5 5518.5 5525.6 5950.1 5978.8 5346.9 5359.8 5361.1 5362.6 5370.1 14433.6 16207.7 21146.9 22468.3 22612.1 2362.6 2410.4 2461.6 2479.8 2667.2 10691.4 10793.7 10887.9 11000.1 13509.3 2052.6 2061.1 2126.6 2137.7 2163.1 81038.6 81083.6 81756.6 82588.6 82638.2 11676.4 12110.2 12356.4 12547.0 12682.8 17109.4 17151.3 17173.2 17189.9 17198.3 8917.5 8935.4 9104.0 9199.6 9339.1 8856.8 8908.9 8913.9 9027.9 9087.3 5109.6 5126.8 5145.8 5156.7 5203.9 2119.8 2127.6 2142.1 2198.7 2215.3 970.6 1048.9 1060.5 1079.6 1088.7 17498.4 19115.2 19475.4 20032.3 20124.0 1062.4 1063.3 1081.3 1081.6 1091.9 10771.7 11314.4 11320.9 11355.4 11381.8 506055.0 517406.0 522957.0 536752.0 547263.0 81717.0 94233.0 94978.5 95080.0 96045.5 1085.7 1086.0 1099.5 1105.2 1108.6 16842.5 17682.6 17787.6 17927.7 18110.5 28846.9 41331.8 42653.4 42857.4 44372.8 57151.0 58776.4 58982.4 59204.7 59587.4 8937.2 9021.6 9103.4 9118.5 9137.3 12890.9 12915.0 13209.6 13403.6 13705.9 11623.1 11805.5 11914.2 11919.2 11982.6 11525.7 11541.4 11721.9 11932.5 11965.6 11330.3 11855.3 12049.3 12069.0 12468.8 9048.6 9065.2 9127.8 9129.9 9305.1 9130.6 11985.5 12097.8 12178.6 12189.8 03:53:44 INFO - PROCESS | 8233 | 03:53:44 INFO - PROCESS | 8233 | [#3] mootools.html Cycles:180 Average:6410.57 Median:4470.92 stddev:3742.95 (83.7%) stddev-sans-first:3736.08 03:53:44 INFO - PROCESS | 8233 | Values: 1611.4 1624.1 1865.4 1906.1 1959.6 9412.9 9652.1 10000.6 10078.8 10093.5 9886.2 9958.8 10027.7 10083.1 10106.7 2486.9 2523.1 2523.2 2532.2 2532.9 2474.6 2523.4 2553.5 2556.1 2564.8 2498.2 2501.4 2535.7 2541.4 2546.0 2393.4 2422.4 2437.6 2460.5 2467.0 2446.4 2462.0 2472.2 2490.5 2493.2 9773.0 9810.4 9811.8 9876.2 9885.3 5765.9 5875.3 5876.3 5917.8 5920.9 3479.3 3608.4 3632.8 3637.6 3678.3 1088.6 1103.6 1109.3 1127.5 1155.9 13785.9 13792.2 13895.4 13941.8 13966.2 4924.7 4959.5 5079.0 5087.1 5088.6 10779.2 10790.1 10833.6 10873.8 10875.3 5620.0 5625.4 5687.8 5700.2 5703.9 4830.7 5185.5 5303.9 5326.7 5332.1 4241.1 4272.7 4330.8 4339.0 4341.8 1274.5 1334.9 1336.9 1337.7 1351.9 956.6 970.5 1045.8 1052.2 1094.1 6529.7 6670.3 6689.6 6745.2 6747.9 470.0 479.0 483.5 486.7 494.3 4456.7 4462.4 4479.5 4481.9 4514.6 12088.9 12426.7 12460.3 12463.7 12466.5 11502.9 12137.4 12160.1 12499.2 12574.9 8837.9 9056.0 9072.9 9094.5 9110.1 6568.3 6679.5 6703.6 6825.0 6878.1 11186.5 11438.7 11471.3 11480.5 11562.2 11341.1 11549.3 11626.5 11788.5 11847.3 8336.1 8625.4 8641.4 8679.8 8860.9 9352.8 9449.7 9449.9 9477.1 9512.0 8438.1 8690.0 8702.7 8759.9 8805.0 8174.8 8249.3 8333.4 8368.6 8425.7 7329.9 7382.2 7421.7 7427.1 7440.9 5575.0 5705.7 5790.6 5824.4 5859.3 5651.5 5659.7 5724.1 5734.3 5845.0 03:53:44 INFO - PROCESS | 8233 | 03:53:44 INFO - PROCESS | 8233 | [#4] prototype.html Cycles:180 Average:5060.55 Median:5691.04 stddev:1513.02 (26.6%) stddev-sans-first:1475.32 03:53:44 INFO - PROCESS | 8233 | Values: 346.7 347.6 349.1 350.4 357.4 5773.5 5846.9 5854.2 5857.5 5877.2 5696.2 5792.4 5812.0 5821.1 5858.8 4517.0 4527.3 4532.5 4537.3 4565.1 4510.2 4526.7 4548.8 4549.7 4575.4 4529.2 4531.7 4536.5 4545.7 4549.2 4340.3 4454.9 4464.2 4482.0 4483.6 3956.0 3975.4 3986.2 3988.6 3991.5 5596.7 5611.3 5618.9 5634.5 5676.7 5026.9 5110.9 5126.2 5154.7 5158.5 5990.6 6130.5 6158.8 6173.3 6188.8 4284.4 4368.6 4373.7 4386.2 4391.2 6123.7 6308.7 6342.8 6352.9 6378.7 4413.4 4417.6 4424.7 4434.1 4442.9 4458.5 4458.5 4458.9 4474.5 4479.8 4805.9 5029.6 5067.2 5087.8 5116.5 6074.1 6086.2 6089.9 6098.7 6112.7 1502.5 1527.5 1530.9 1531.4 1539.4 921.2 974.1 975.9 978.7 986.2 5184.3 5236.9 5255.7 5304.7 5328.2 5512.8 5526.5 5562.6 5566.3 5570.9 4963.5 5272.4 5278.9 5294.4 5324.0 2988.2 2997.1 3005.2 3031.6 3034.8 5685.8 5754.0 5798.8 5806.9 5840.8 5884.6 6412.7 6426.5 6453.8 6470.7 6599.7 6620.6 6621.9 6640.4 6663.7 6215.8 6320.3 6358.9 6397.9 6438.3 6102.5 6240.6 6284.5 6305.9 6329.8 6426.1 6435.5 6441.9 6454.1 6454.1 4410.7 4429.1 4438.5 4463.6 4465.6 6198.8 6306.8 6382.9 6383.9 6390.4 6117.0 6148.0 6157.9 6168.8 6176.7 5905.2 6068.4 6117.4 6140.3 6168.4 6029.7 6058.3 6061.2 6070.4 6089.2 6185.6 6192.0 6218.7 6224.4 6227.7 5815.7 6047.8 6048.2 6050.5 6100.8 03:53:44 INFO - PROCESS | 8233 | 03:53:44 INFO - PROCESS | 8233 | [#5] yui.html Cycles:180 Average:20850.53 Median:4002.13 stddev:29594.17 (739.5%) stddev-sans-first:29638.80 03:53:44 INFO - PROCESS | 8233 | Values: 776.9 799.8 811.2 811.5 930.8 14396.8 15423.0 15472.3 15517.8 15539.0 12977.4 15330.8 15497.8 15523.6 15525.3 829.3 873.2 873.2 873.3 873.9 842.8 853.5 857.3 857.4 859.7 914.9 916.4 916.9 917.5 918.6 904.4 906.6 907.1 911.3 912.5 667.5 667.9 672.1 672.3 674.3 14249.4 14251.9 14323.8 14335.4 14340.0 14761.4 15207.2 16284.1 16365.8 16632.3 12421.8 12772.2 12988.3 13329.3 13355.5 4037.0 4078.3 4084.9 4128.6 4265.3 76494.6 77003.6 79568.2 80495.2 80746.6 12684.6 12694.2 12769.2 12772.7 12873.7 23236.0 23359.0 23401.9 23500.6 24267.6 9229.7 9241.6 9344.4 9395.2 9513.5 5359.7 5401.9 5429.9 5442.3 5596.0 3801.1 3900.9 3935.9 3965.2 3967.3 650.7 657.9 659.2 665.4 676.8 675.5 765.3 766.6 780.7 836.0 10448.4 11181.8 11183.3 11276.4 11303.4 767.2 779.0 829.7 860.5 863.9 4865.7 4999.1 5041.6 5195.4 5231.6 113721.0 115485.0 115774.4 117017.0 118214.0 65739.0 94588.0 96642.0 102371.5 103352.0 56199.2 92002.5 92053.5 92932.5 93375.5 9937.1 9978.5 10195.0 10268.3 10292.5 38309.2 45884.8 52803.0 54483.5 54937.7 65942.3 66602.0 73424.0 75157.2 79031.2 13652.7 13744.9 13840.7 13876.5 14286.5 13323.1 13529.3 14098.2 14219.3 14496.9 13683.3 13768.4 13841.2 14120.3 14211.7 12372.1 12544.3 12615.6 12666.9 13231.9 13255.2 13517.9 13597.2 13689.6 13915.3 10696.3 10816.2 11207.6 11414.8 11606.0 11189.2 11198.5 11352.5 11381.6 11447.0 03:53:44 INFO - PROCESS | 8233 | -------- Summary: end -------- 03:53:44 INFO - PROCESS | 8233 | 03:53:45 INFO - TEST-INFO | 8233: exit 0 03:53:45 INFO - TEST-OK | dromaeo_css | took 1110584ms 03:53:45 INFO - TEST-START | kraken 03:53:45 INFO - operating with platform_type : linux_ 03:53:45 INFO - Initialising browser for kraken test... 03:53:45 INFO - TEST-INFO | started process 8473 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdox_yz/profile http://localhost:43496/getInfo.html) 03:53:49 INFO - PROCESS | 8473 | __metrics Screen width/height:1600/1200 03:53:49 INFO - PROCESS | 8473 | colorDepth:24 03:53:49 INFO - PROCESS | 8473 | Browser inner width/height: 1024/697 03:53:49 INFO - PROCESS | 8473 | __metrics 03:53:50 ERROR - PROCESS | 8473 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 03:53:51 INFO - TEST-INFO | 8473: exit 0 03:53:51 INFO - Browser initialized. 03:53:51 INFO - Running cycle 1/1 for kraken test... 03:53:51 INFO - TEST-INFO | started process 8605 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdox_yz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:54:03 INFO - PROCESS | 8605 | RSS: Main: 156438528 03:54:03 INFO - PROCESS | 8605 | 03:54:05 INFO - PROCESS | 8605 | Cycle 1(1): loaded http://localhost:43496/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43496/tests/kraken/driver.html?testName=audio-beat-detection) 03:54:06 INFO - PROCESS | 8605 | RSS: Main: 161394688 03:54:06 INFO - PROCESS | 8605 | 03:54:09 INFO - PROCESS | 8605 | Cycle 1(1): loaded http://localhost:43496/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43496/tests/kraken/driver.html?testName=audio-dft) 03:54:09 INFO - PROCESS | 8605 | RSS: Main: 160727040 03:54:09 INFO - PROCESS | 8605 | 03:54:12 INFO - PROCESS | 8605 | Cycle 1(1): loaded http://localhost:43496/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43496/tests/kraken/driver.html?testName=audio-fft) 03:54:13 INFO - PROCESS | 8605 | RSS: Main: 161599488 03:54:13 INFO - PROCESS | 8605 | 03:54:15 INFO - PROCESS | 8605 | Cycle 1(1): loaded http://localhost:43496/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43496/tests/kraken/driver.html?testName=audio-oscillator) 03:54:16 INFO - PROCESS | 8605 | RSS: Main: 161083392 03:54:16 INFO - PROCESS | 8605 | 03:54:18 INFO - PROCESS | 8605 | Cycle 1(1): loaded http://localhost:43496/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43496/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:54:18 INFO - PROCESS | 8605 | RSS: Main: 160878592 03:54:18 INFO - PROCESS | 8605 | 03:54:22 INFO - PROCESS | 8605 | Cycle 1(1): loaded http://localhost:43496/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43496/tests/kraken/driver.html?testName=imaging-darkroom) 03:54:22 INFO - PROCESS | 8605 | RSS: Main: 160686080 03:54:22 INFO - PROCESS | 8605 | 03:54:26 INFO - PROCESS | 8605 | Cycle 1(1): loaded http://localhost:43496/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43496/tests/kraken/driver.html?testName=imaging-desaturate) 03:54:26 INFO - PROCESS | 8605 | RSS: Main: 161329152 03:54:26 INFO - PROCESS | 8605 | 03:54:29 INFO - PROCESS | 8605 | Cycle 1(1): loaded http://localhost:43496/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43496/tests/kraken/driver.html?testName=json-parse-financial) 03:54:30 INFO - PROCESS | 8605 | RSS: Main: 161492992 03:54:30 INFO - PROCESS | 8605 | 03:54:31 INFO - PROCESS | 8605 | Cycle 1(1): loaded http://localhost:43496/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43496/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:54:32 INFO - PROCESS | 8605 | RSS: Main: 161411072 03:54:32 INFO - PROCESS | 8605 | 03:54:34 INFO - PROCESS | 8605 | Cycle 1(1): loaded http://localhost:43496/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43496/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:54:34 INFO - PROCESS | 8605 | RSS: Main: 161009664 03:54:34 INFO - PROCESS | 8605 | 03:54:36 INFO - PROCESS | 8605 | Cycle 1(1): loaded http://localhost:43496/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43496/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:54:37 INFO - PROCESS | 8605 | RSS: Main: 161693696 03:54:37 INFO - PROCESS | 8605 | 03:54:39 INFO - PROCESS | 8605 | Cycle 1(1): loaded http://localhost:43496/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43496/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:54:40 INFO - PROCESS | 8605 | RSS: Main: 161951744 03:54:40 INFO - PROCESS | 8605 | 03:54:43 INFO - PROCESS | 8605 | Cycle 1(1): loaded http://localhost:43496/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43496/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:54:43 INFO - PROCESS | 8605 | RSS: Main: 161943552 03:54:43 INFO - PROCESS | 8605 | 03:54:45 INFO - PROCESS | 8605 | Cycle 1(1): loaded http://localhost:43496/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43496/tests/kraken/driver.html?testName=ai-astar) 03:54:45 INFO - PROCESS | 8605 | RSS: Main: 163041280 03:54:45 INFO - PROCESS | 8605 | 03:54:45 INFO - PROCESS | 8605 | __start_tp_report 03:54:45 INFO - PROCESS | 8605 | _x_x_mozilla_page_load 03:54:45 INFO - PROCESS | 8605 | _x_x_mozilla_page_load_details 03:54:45 INFO - PROCESS | 8605 | |i|pagename|runs| 03:54:45 INFO - PROCESS | 8605 | |0;ai-astar;113;105;111;111;110;111;109;108;110;111 03:54:45 INFO - PROCESS | 8605 | |1;audio-beat-detection;152;123;152;177;130;160;152;125;199;128 03:54:45 INFO - PROCESS | 8605 | |2;audio-dft;162;163;162;162;162;163;163;163;162;163 03:54:45 INFO - PROCESS | 8605 | |3;audio-fft;76;75;77;178;78;75;75;78;160;77 03:54:45 INFO - PROCESS | 8605 | |4;audio-oscillator;85;85;139;84;84;85;141;85;84;153 03:54:45 INFO - PROCESS | 8605 | |5;imaging-gaussian-blur;117;117;117;117;118;118;117;117;117;117 03:54:45 INFO - PROCESS | 8605 | |6;imaging-darkroom;147;147;147;147;147;147;146;147;147;147 03:54:45 INFO - PROCESS | 8605 | |7;imaging-desaturate;96;96;95;96;96;95;95;97;96;96 03:54:45 INFO - PROCESS | 8605 | |8;json-parse-financial;55;55;54;55;56;55;54;57;54;56 03:54:45 INFO - PROCESS | 8605 | |9;json-stringify-tinderbox;59;61;60;60;60;60;60;60;60;61 03:54:45 INFO - PROCESS | 8605 | |10;stanford-crypto-aes;81;75;77;76;83;78;77;79;101;76 03:54:45 INFO - PROCESS | 8605 | |11;stanford-crypto-ccm;127;119;121;131;121;123;125;124;139;124 03:54:45 INFO - PROCESS | 8605 | |12;stanford-crypto-pbkdf2;160;154;161;155;153;156;152;157;154;156 03:54:45 INFO - PROCESS | 8605 | |13;stanford-crypto-sha256-iterative;62;63;62;64;63;64;71;62;66;61 03:54:45 INFO - PROCESS | 8605 | __end_tp_report 03:54:45 INFO - PROCESS | 8605 | __start_cc_report 03:54:45 INFO - PROCESS | 8605 | _x_x_mozilla_cycle_collect,892 03:54:45 INFO - PROCESS | 8605 | __end_cc_report 03:54:45 INFO - PROCESS | 8605 | __startTimestamp1467543285757__endTimestamp 03:54:45 INFO - PROCESS | 8605 | 03:54:45 INFO - PROCESS | 8605 | ------- Summary: start ------- 03:54:45 INFO - PROCESS | 8605 | Number of tests: 14 03:54:45 INFO - PROCESS | 8605 | 03:54:45 INFO - PROCESS | 8605 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:2.18 (2.0%) stddev-sans-first:2.01 03:54:45 INFO - PROCESS | 8605 | Values: 113.0 105.0 111.0 111.0 110.0 111.0 109.0 108.0 110.0 111.0 03:54:45 INFO - PROCESS | 8605 | 03:54:45 INFO - PROCESS | 8605 | [#1] audio-beat-detection Cycles:10 Average:149.80 Median:152.00 stddev:24.67 (16.2%) stddev-sans-first:26.16 03:54:45 INFO - PROCESS | 8605 | Values: 152.0 123.0 152.0 177.0 130.0 160.0 152.0 125.0 199.0 128.0 03:54:45 INFO - PROCESS | 8605 | 03:54:45 INFO - PROCESS | 8605 | [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:0.53 (0.3%) stddev-sans-first:0.53 03:54:45 INFO - PROCESS | 8605 | Values: 162.0 163.0 162.0 162.0 162.0 163.0 163.0 163.0 162.0 163.0 03:54:45 INFO - PROCESS | 8605 | 03:54:45 INFO - PROCESS | 8605 | [#3] audio-fft Cycles:10 Average:94.90 Median:76.50 stddev:39.30 (51.4%) stddev-sans-first:41.09 03:54:45 INFO - PROCESS | 8605 | Values: 76.0 75.0 77.0 178.0 78.0 75.0 75.0 78.0 160.0 77.0 03:54:45 INFO - PROCESS | 8605 | 03:54:45 INFO - PROCESS | 8605 | [#4] audio-oscillator Cycles:10 Average:102.50 Median:84.50 stddev:29.09 (34.4%) stddev-sans-first:30.16 03:54:45 INFO - PROCESS | 8605 | Values: 85.0 85.0 139.0 84.0 84.0 85.0 141.0 85.0 84.0 153.0 03:54:45 INFO - PROCESS | 8605 | 03:54:45 INFO - PROCESS | 8605 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:54:45 INFO - PROCESS | 8605 | Values: 117.0 117.0 117.0 117.0 118.0 118.0 117.0 117.0 117.0 117.0 03:54:45 INFO - PROCESS | 8605 | 03:54:45 INFO - PROCESS | 8605 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 03:54:45 INFO - PROCESS | 8605 | Values: 147.0 147.0 147.0 147.0 147.0 147.0 146.0 147.0 147.0 147.0 03:54:45 INFO - PROCESS | 8605 | 03:54:45 INFO - PROCESS | 8605 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 03:54:45 INFO - PROCESS | 8605 | Values: 96.0 96.0 95.0 96.0 96.0 95.0 95.0 97.0 96.0 96.0 03:54:45 INFO - PROCESS | 8605 | 03:54:45 INFO - PROCESS | 8605 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.00 stddev:0.99 (1.8%) stddev-sans-first:1.05 03:54:45 INFO - PROCESS | 8605 | Values: 55.0 55.0 54.0 55.0 56.0 55.0 54.0 57.0 54.0 56.0 03:54:45 INFO - PROCESS | 8605 | 03:54:45 INFO - PROCESS | 8605 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:60.00 stddev:0.57 (0.9%) stddev-sans-first:0.44 03:54:45 INFO - PROCESS | 8605 | Values: 59.0 61.0 60.0 60.0 60.0 60.0 60.0 60.0 60.0 61.0 03:54:45 INFO - PROCESS | 8605 | 03:54:45 INFO - PROCESS | 8605 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:77.50 stddev:7.67 (9.9%) stddev-sans-first:8.14 03:54:45 INFO - PROCESS | 8605 | Values: 81.0 75.0 77.0 76.0 83.0 78.0 77.0 79.0 101.0 76.0 03:54:45 INFO - PROCESS | 8605 | 03:54:45 INFO - PROCESS | 8605 | [#11] stanford-crypto-ccm Cycles:10 Average:125.40 Median:124.50 stddev:5.85 (4.7%) stddev-sans-first:6.18 03:54:45 INFO - PROCESS | 8605 | Values: 127.0 119.0 121.0 131.0 121.0 123.0 125.0 124.0 139.0 124.0 03:54:45 INFO - PROCESS | 8605 | 03:54:45 INFO - PROCESS | 8605 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.80 Median:156.00 stddev:2.90 (1.9%) stddev-sans-first:2.65 03:54:45 INFO - PROCESS | 8605 | Values: 160.0 154.0 161.0 155.0 153.0 156.0 152.0 157.0 154.0 156.0 03:54:45 INFO - PROCESS | 8605 | 03:54:45 INFO - PROCESS | 8605 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:63.50 stddev:2.90 (4.6%) stddev-sans-first:3.00 03:54:45 INFO - PROCESS | 8605 | Values: 62.0 63.0 62.0 64.0 63.0 64.0 71.0 62.0 66.0 61.0 03:54:45 INFO - PROCESS | 8605 | -------- Summary: end -------- 03:54:45 INFO - PROCESS | 8605 | 03:54:46 INFO - TEST-INFO | 8605: exit 0 03:54:46 INFO - TEST-OK | kraken | took 61326ms 03:54:46 INFO - SUITE-END | took 1171s 03:54:46 INFO - Completed test suite (00:19:32) 03:54:46 INFO - javascript benchmark 03:54:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7753.075560607889, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3426.023583278766, 3441.948370774439, 3455.1707590178357, 3460.2560449503335, 3495.4931534927446, 5755.453231942964, 5805.535557155428, 5871.44221298977, 5894.145348924403, 5918.260217472816, 5866.149408335788, 5883.764649414029, 5913.674747888876, 5915.556333275, 5916.852078698024, 5233.058049551079, 5295.099833028395, 5304.443033481487, 5304.946950530503, 5348.197770334462, 5195.376554813428, 5241.790328386879, 5298.258243845846, 5359.38367087786, 5385.272988146608, 5274.92087618686, 5297.390800057985, 5329.413764485904, 5333.493318134771, 5342.465753424665, 5387.1111266640955, 5387.542058924976, 5390.029794636964, 5392.245085688007, 5411.0, 5033.672811267256, 5198.558122559587, 5205.29728486657, 5314.601404894648, 5317.441668624816, 5690.630109042899, 5709.115087161496, 5742.08126699726, 5758.193852860602, 5773.480386765212, 6294.087357333161, 6326.557141000132, 6330.335314791927, 6337.746490140389, 6346.555741098125, 6146.7541298348015, 6156.199694039791, 6216.595921265103, 6261.46777523911, 6382.297947225801, 5859.501942334907, 5875.118732190205, 5879.265091863517, 5882.352941176425, 5918.526517878559, 6381.904271435932, 6401.679916004181, 6403.583767055126, 6413.903791443132, 6416.294207637156, 5981.910271345933, 5983.311919129356, 6075.605085669417, 6111.96944015277, 6128.356522565066, 6182.562259819388, 6197.318294987548, 6228.56400051992, 6230.127782110508, 6234.314225435199, 6067.362926892701, 6121.846953826101, 6186.628802271878, 6205.069239614094, 6227.626342419469, 6179.227596550431, 6199.938000619936, 6252.968735156386, 6324.0, 6371.203599550056, 4777.163996300703, 4797.0, 4797.832075877397, 4816.253480710496, 4830.058138662997, 4131.772752498641, 4231.978840105779, 4274.978625106854, 4279.358096285519, 4280.101178752497, 5922.733476993546, 6048.274207095177, 6071.119687645267, 6117.174181485531, 6128.442013630915, 6326.4622507087415, 6424.068510066108, 6429.099926010363, 6429.260635027032, 6441.227052753699, 5876.001079816441, 5892.263467066617, 5904.76380944766, 6167.321594624587, 6169.753209871645, 5312.628116031918, 5339.86650333737, 5351.678899266057, 5352.4915133062295, 5370.3287089113865, 6444.226692796894, 6456.3543645636, 6457.61254324742, 6461.224653041665, 6463.903041454382, 6101.664408457577, 6237.875242495215, 6240.875182496416, 6250.1874756281395, 6266.592671476339, 6402.35976402356, 6476.384743449365, 6491.350864913471, 6525.2169739631545, 6530.8040758777315, 6181.227346581677, 6182.1345011699295, 6229.4393504584805, 6245.18812554365, 6246.937530624818, 6001.129836173817, 6189.226346706661, 6191.907121393093, 6255.624662520263, 6352.110704501466, 6125.969370153299, 6156.907646385218, 6183.5671502994355, 6186.381361863778, 6192.195014648067, 6030.48740857032, 6157.138000679998, 6168.691565421621, 6176.382361763787, 6187.504999600112, 6081.118237855398, 6105.823680184464, 6109.969450152721, 6124.717717613011, 6128.242096493223, 6221.502279817694, 6238.438540531374, 6240.625562466266, 6278.6546739929745, 6279.30927597973, 5875.353711091862, 6034.939650603438, 6092.543059270483, 6099.878002440015, 6136.018237082046], "value": 5778.475788884559, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.533478551944, 642.9967850160748, 643.5270076493777, 669.7823207457576, 675.3010633993812, 42568.0, 47038.29442558364, 47191.0, 47266.52733472664, 47310.52689473104, 47280.0, 47659.0, 47757.761211193894, 47906.281405778944, 47921.52078479214, 8942.955285223565, 9065.682701105463, 9077.727668169966, 9082.228010619105, 9083.863742043875, 8832.690855820048, 8876.289896808239, 8911.509866957314, 8956.149165829236, 8966.820663586725, 8961.59672814725, 8978.640854365818, 9001.729948101567, 9012.459252444874, 9019.368644194908, 8930.419522731001, 8937.910620893805, 9001.23489503393, 9012.414193077462, 9029.729108126701, 8793.0, 8850.336224783103, 8861.202491775772, 8906.421082629608, 8942.552872356357, 43414.56585434137, 43731.78134109341, 43893.78053109714, 43992.56007439917, 44079.33880991788, 3708.2027364116843, 3819.9809000955097, 3862.517185351831, 4048.332025215836, 4620.953790462119, 34582.308353832785, 35039.824800876086, 35176.0, 35495.64504354949, 36221.0, 4518.593326600621, 4550.5735556463615, 4637.142128706167, 4641.0, 4704.082703872747, 382290.0, 384480.0, 385164.9999999972, 385955.0, 385995.0, 65174.67412662906, 65534.0, 65748.67125664341, 65838.0, 65842.0, 42469.57530424718, 42951.0, 43127.784361078, 43394.34908476375, 43430.131397372505, 18980.715289270673, 18989.050547472572, 19133.425997220107, 19152.425427237205, 19163.904180479007, 14998.47505337308, 15055.54833355001, 15069.698606027818, 15091.698166036618, 15093.094414335175, 21421.464463388227, 21522.677159842617, 21570.892145539172, 21607.89196054041, 21620.35138945834, 7471.738489152962, 7716.5370077795515, 7890.831505363995, 7958.602069896482, 7974.043114826258, 1031.3811712972306, 1113.4989254835357, 1153.423288355822, 1198.6643739752708, 1215.9513619455122, 33259.667403326144, 33268.66731332656, 33404.164895877315, 34063.65936340605, 34169.31661366808, 1170.2744298534963, 1170.2861254634665, 1193.0813273779142, 1216.087934049463, 1286.0933042205222, 17781.555461113316, 17831.375901843374, 17881.0, 17893.19480623349, 18005.819941800677, 686073.0, 692939.0, 696154.0, 696367.0, 697173.0, 66650.0, 66660.33339666638, 66802.0, 67497.66251168713, 67555.0, 1476.3577843638052, 1514.6137734877536, 1519.9392024319125, 1525.6497999270948, 1530.112534729854, 34329.828350858086, 34378.0, 34422.48366274558, 34468.31063378769, 34479.82760086284, 57899.4210057894, 58007.709961449924, 58010.70994645, 58396.416035839095, 58499.0, 594243.0, 603687.0, 604097.0, 604799.0, 606196.0, 31612.209694757814, 32051.198720032186, 32143.839280803448, 32542.674573253964, 32568.674313256564, 53819.73090134524, 53823.461765383414, 53852.0, 54974.17538736842, 55155.17267240914, 44801.327980080976, 45272.0, 45716.77141614271, 46138.0, 46748.29877551908, 43526.34710479282, 44228.557714422444, 44921.32618010667, 45681.0, 46153.538464614925, 44565.55434445614, 44992.55007449884, 45142.32286515771, 45909.540904590525, 46089.0, 38464.6153538461, 38554.80722596481, 38698.61301387063, 39041.609583903795, 40111.59888401195, 30008.84995575008, 30046.69953300439, 30422.695773041985, 31026.0, 31045.223869403446], "value": 21861.41863013162, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.38032386977784, 430.84058898207667, 431.6891837876728, 434.8391095294741, 442.98671039868805, 18920.810791892076, 19961.401157965283, 20594.794052059493, 21224.89387553064, 21268.893655531738, 18125.274989000456, 18931.0, 19113.0, 19122.235110595593, 19790.604187916233, 5390.8921821563545, 5535.391106978229, 5587.776488940438, 5598.776048958057, 5618.15727640853, 5372.54333381663, 5409.43200963899, 5418.91871621926, 5467.617266791326, 5987.850303742398, 5936.703164841762, 5963.075723262879, 5968.910466343008, 5971.402859714016, 5992.221011268529, 5507.531859791942, 5518.530924871391, 5525.640833345819, 5950.077737950624, 5978.8206353809455, 5346.91979620306, 5359.81240656579, 5361.115415956362, 5362.597805164628, 5370.060239458079, 14433.566992990227, 16207.675846483004, 21146.89426552873, 22468.325950221355, 22612.09551617933, 2362.6337917622623, 2410.373302941248, 2461.5815311397105, 2479.838810477313, 2667.199840047978, 10691.411972341519, 10793.67618971432, 10887.945560272148, 11000.119990400828, 13509.256990865499, 2052.6202652509182, 2061.1240222905353, 2126.5959467701086, 2137.657974724052, 2163.123934806406, 81038.59480702618, 81083.5945820273, 81756.59121704413, 82588.58705706493, 82638.17361826365, 11676.416179191176, 12110.212836165621, 12356.443960021641, 12546.996240300754, 12682.80975785364, 17109.401170958958, 17151.313947442213, 17173.227204775565, 17189.914050429667, 17198.31206751716, 8917.509536975529, 8935.419197752126, 9103.954480227556, 9199.586018629177, 9339.066093390607, 8856.778580535538, 8908.910910890809, 8913.866292005625, 9027.864582031143, 9087.318451116193, 5109.642325037212, 5126.769295381717, 5145.819896303611, 5156.716380599103, 5203.864532105609, 2119.8340912498065, 2127.627665158591, 2142.0896119149297, 2198.6701994700925, 2215.3021798133536, 970.5632465390603, 1048.8898665640152, 1060.4591658254192, 1079.5681727309138, 1088.6996364360807, 17498.387556435464, 19115.235390584498, 19475.41573752761, 20032.298869539496, 20124.0, 1062.442217835627, 1063.2929102146986, 1081.2863510083307, 1081.6106201767357, 1091.9026378489725, 10771.730706732395, 11314.377709226072, 11320.943395283135, 11355.432228388547, 11381.829272560919, 506055.0, 517406.0, 522957.0, 536752.0, 547263.0, 81717.0, 94233.0, 94978.52510737402, 95080.0, 96045.51977240069, 1085.6742977106837, 1085.9837102443469, 1099.4667586220676, 1105.1987309200765, 1108.6175269531998, 16842.494725158263, 17682.5579360517, 17787.55531111681, 17927.73108403349, 18110.456686299432, 28846.855765721037, 41331.7933410343, 42653.36019959641, 42857.35713964231, 44372.77813610911, 57151.0, 58776.41223587709, 58982.41017589941, 59204.70397647984, 59587.40412595992, 8937.195652391316, 9021.594028268612, 9103.408278461879, 9118.498482583522, 9137.269018478639, 12890.935545322214, 12915.0, 13209.603711888658, 13403.597892063253, 13705.862941370458, 11623.1282653803, 11805.527778889093, 11914.16600837933, 11919.165658404176, 11982.580609678967, 11525.711857203301, 11541.36522491271, 11721.88278117242, 11932.522699091938, 11965.581204657796, 11330.320180789178, 11855.34795586251, 12049.33728644933, 12069.0, 12468.750624987631, 9048.592813323285, 9065.18413342776, 9127.817443651222, 9129.904411470667, 9305.11601397866, 9130.634774608941, 11985.460654270753, 12097.81853272184, 12178.57374991871, 12189.817152742538], "value": 9553.06820287464, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1611.3796188467436, 1624.0986252629793, 1865.4310435317232, 1906.1041310584021, 1959.6080783843227, 9412.905870941297, 9652.083052110056, 10000.599976000969, 10078.798424031524, 10093.54579043943, 9886.20910327174, 9958.800823983516, 10027.749306267347, 10083.092521673048, 10106.747331316721, 2486.8632225227607, 2523.079076137206, 2523.1673547729206, 2532.240327901631, 2532.8602129041915, 2474.5545801755675, 2523.40699935515, 2553.502067096917, 2556.079811267942, 2564.8204625676212, 2498.1756020513276, 2501.4371766352515, 2535.7464253574585, 2541.390066384073, 2546.0, 2393.4136136646457, 2422.4307287787356, 2437.597796363589, 2460.5447992121335, 2466.9753302466925, 2446.449548851512, 2462.0398044762555, 2472.1841792208706, 2490.5392502386935, 2493.1772515070165, 9773.0, 9810.411375317504, 9811.803763924681, 9876.209903207726, 9885.25860560461, 5765.942340576583, 5875.324337701177, 5876.265466816648, 5917.822465326004, 5920.881582368372, 3479.2693534357813, 3608.386574282378, 3632.8365223565, 3637.5816781069984, 3678.3011227866887, 1088.6026600290836, 1103.6302838549095, 1109.2734259060328, 1127.5320741892106, 1155.8901904319075, 13785.931070344684, 13792.172469651752, 13895.374708138159, 13941.790873136912, 13966.162030278114, 4924.679895806761, 4959.504049595083, 5079.009593129378, 5087.058894104603, 5088.592912566985, 10779.245452818384, 10790.136789056856, 10833.620823271147, 10873.782524349468, 10875.293105948089, 5620.0, 5625.353084395265, 5687.829365119053, 5700.173474846124, 5703.914441283384, 4830.66185367028, 5185.455527169668, 5303.893922121536, 5326.653767505178, 5332.093544097513, 4241.130568233505, 4272.6795490338345, 4330.826766929351, 4338.978305108454, 4341.782910854445, 1274.5220542296638, 1334.8798608125314, 1336.9264690441923, 1337.725766217923, 1351.8977989226846, 956.6077908057663, 970.5195928015536, 1045.8274384726587, 1052.21609900623, 1094.141099237111, 6529.673516324165, 6670.264112480097, 6689.598624082473, 6745.156855393076, 6747.932520674829, 469.99295010574866, 478.9784459699322, 483.48508838087326, 486.7006790823618, 494.2832892306171, 4456.732596044248, 4462.352958820953, 4479.484859241164, 4481.865544033684, 4514.616257618073, 12088.939555302168, 12426.689332766753, 12460.314682692358, 12463.688407789878, 12466.501339946482, 11502.88497115018, 12137.393130343624, 12160.148789584644, 12499.187552809039, 12574.874251257554, 8837.867431988525, 9055.954720226357, 9072.90927090734, 9094.454332740057, 9110.088991100969, 6568.310327415744, 6679.532432729857, 6703.597784132968, 6825.010373495915, 6878.140232470942, 11186.489823873673, 11438.714032149262, 11471.254368466023, 11480.540778368771, 11562.248453850472, 11341.149413794163, 11549.307041577533, 11626.476808543805, 11788.528458861549, 11847.289162650268, 8336.124706905688, 8625.439346442461, 8641.351898607503, 8679.826403471769, 8860.867086993829, 9352.766180845261, 9449.669261576088, 9449.905500944902, 9477.147056764925, 9511.952440238032, 8438.113998030118, 8690.0, 8702.738917832476, 8759.868601971102, 8805.0, 8174.83650327002, 8249.257566819015, 8333.374996875138, 8368.581570921551, 8425.705100321704, 7329.9267007329245, 7382.224866389167, 7421.740239091821, 7427.145878224073, 7440.888386674313, 5575.0, 5705.7147142643535, 5790.565707572033, 5824.446677565625, 5859.296884373903, 5651.463111004448, 5659.688717120598, 5724.055530837365, 5734.311882574118, 5844.970775146097], "value": 4985.868957613707, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.67585807270206, 347.610676042832, 349.08365540456305, 350.369335196646, 357.4031367616081, 5773.5092517136045, 5846.853828654281, 5854.243726881939, 5857.502112320452, 5877.177195192666, 5696.237324897422, 5792.391798861122, 5812.0119579671455, 5821.118546319567, 5858.824235272938, 4516.954830451703, 4527.343535187412, 4532.481618657737, 4537.251353526664, 4565.1098035883015, 4510.188166130095, 4526.660500462462, 4548.840790572331, 4549.681522293441, 4575.428071491064, 4529.207388706979, 4531.6601254905845, 4536.5236650151755, 4545.727196385017, 4549.181147393468, 4340.262155433568, 4454.910901781978, 4464.241079016559, 4481.955180448186, 4483.6324920899115, 3955.991222238311, 3975.403689446577, 3986.222686576119, 3988.6210809973004, 3991.5231364395067, 5596.720163991825, 5611.270534830487, 5618.943810561883, 5634.464725851038, 5676.687782171979, 5026.89946201074, 5110.897782044338, 5126.2054381570915, 5154.664946778485, 5158.484151584849, 5990.580659353847, 6130.509559235251, 6158.753649854, 6173.32093469718, 6188.84527886802, 4284.400183974246, 4368.563143685637, 4373.671974601918, 4386.188555117282, 4391.165678521071, 6123.6938153092615, 6308.653024083674, 6342.778002769927, 6352.904706429407, 6378.712957916905, 4413.404190434315, 4417.558244175621, 4424.73451592899, 4434.135343607965, 4442.888927776831, 4458.487273963471, 4458.5318541553315, 4458.9331160032625, 4474.485434175046, 4479.843205487792, 4805.903881922342, 5029.622778291643, 5067.189249720027, 5087.771050302671, 5116.513931176532, 6074.088886666947, 6086.239220097488, 6089.878202436015, 6098.69506524672, 6112.707734599525, 1502.5191938579549, 1527.5111964171358, 1530.915799631031, 1531.4486784757478, 1539.3996341426853, 921.235374639048, 974.0697633759743, 975.9072888075622, 978.6966040527459, 986.1666891476691, 5184.326037615086, 5236.895262094737, 5255.684658920477, 5304.681719096867, 5328.200769884471, 5512.779488820483, 5526.530244929146, 5562.610617256753, 5566.332040155207, 5570.888582228333, 4963.528464795839, 5272.446393128666, 5278.9382158348835, 5294.391145018295, 5324.0, 2988.2230620038945, 2997.1267957526547, 3005.1518316235356, 3031.590735250757, 3034.8179109253515, 5685.839381035263, 5753.986104863348, 5798.768049277982, 5806.854828629318, 5840.766369345263, 5884.558658100659, 6412.67936603168, 6426.518011149183, 6453.774117905851, 6470.741170353227, 6599.70301336441, 6620.60967196894, 6621.9006714899315, 6640.402363787186, 6663.700133494004, 6215.751369945152, 6320.29352074928, 6358.904616430665, 6397.936020639734, 6438.29178790342, 6102.511799056154, 6240.563160578898, 6284.465820405317, 6305.905411418924, 6329.778457753957, 6426.068220107964, 6435.452986496013, 6441.871162576816, 6454.096041667625, 6454.128692626436, 4410.720890941591, 4429.09203613265, 4438.467383913951, 4463.575960283768, 4465.6427485800405, 6198.845028874134, 6306.84232894163, 6382.936170638234, 6383.9361606383345, 6390.392912673288, 6117.042546385114, 6148.0, 6157.9384206157365, 6168.784092556739, 6176.6911654418, 5905.202797622438, 6068.423499767515, 6117.418845209698, 6140.3245642978345, 6168.414000669929, 6029.7337559113075, 6058.333583305921, 6061.1514387984835, 6070.392960704071, 6089.208402907594, 6185.567010309415, 6191.9690401547705, 6218.689065546795, 6224.439800417984, 6227.688615569113, 5815.709214539341, 6047.848803779941, 6048.243969503812, 6050.45545900871, 6100.847478813065], "value": 4571.321806011316, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [776.8601651702692, 799.848028874514, 811.2374368093991, 811.4765975945512, 930.7998780262244, 14396.784048239284, 15423.0, 15472.303746331414, 15517.844821551767, 15539.0, 12977.416016279267, 15330.846691533081, 15497.767533486978, 15523.611909702264, 15525.301361438735, 829.3075282139421, 873.1748497669705, 873.2402809555696, 873.2620935309653, 873.9431936924111, 842.8482873082843, 853.5134973065356, 857.3012994409536, 857.3569822633025, 859.7119964811795, 914.8993610702818, 916.408916249019, 916.9083091690811, 917.4953775423523, 918.6279556779515, 904.3624244907357, 906.6192199276287, 907.0521305236044, 911.2937473458123, 912.4616476278961, 667.5360624366067, 667.9131712877295, 672.092674888901, 672.2907332763932, 674.2583158525582, 14249.358778854976, 14251.85748142526, 14323.78514322286, 14335.354909029014, 14340.0, 14761.409543618242, 15207.163606001666, 16284.095730079085, 16365.83634163655, 16632.33470661172, 12421.813672794826, 12772.16980896248, 12988.28564428956, 13329.266890321029, 13355.465781368734, 4037.0, 4078.3270760324513, 4084.9387259191135, 4128.566500517462, 4265.338872474771, 76494.61752691257, 77003.61498192474, 79568.20431795665, 80495.19504804935, 80746.59626701829, 12684.619461416172, 12694.238345699288, 12769.170003949714, 12772.744545109046, 12873.678158046123, 23236.0, 23359.0, 23401.882990584938, 23500.647490287316, 24267.63598546023, 9229.723108306627, 9241.58412871409, 9344.392614480037, 9395.20140788027, 9513.524323783784, 5359.705216213146, 5401.864953376197, 5429.918551221735, 5442.319710036246, 5596.0, 3801.125741079567, 3900.90247743803, 3935.9212815743526, 3965.1673148638533, 3967.2544080604443, 650.6649075726004, 657.8552718401944, 659.2023651381786, 665.3712241931329, 676.7665155521337, 675.5440077947464, 765.2806362019684, 766.6396793507042, 780.6526095887389, 835.995820020896, 10448.373097614167, 11181.83227251592, 11183.32900026001, 11276.379799111128, 11303.420719616615, 767.1752865669428, 778.9961050194713, 829.672279449614, 860.4622111180512, 863.9179277968583, 4865.708057516489, 4999.125153098194, 5041.621878359138, 5195.428502864682, 5231.581473482112, 113721.0, 115485.0, 115774.42112789382, 117017.0, 118214.0, 65739.0, 94588.0, 96642.0, 102371.48814255881, 103352.0, 56199.15701264484, 92002.53998729963, 92053.53973230091, 92932.53533732424, 93375.53312233396, 9937.082441460621, 9978.501074946078, 10195.0, 10268.332558383681, 10292.485375731334, 38309.23381532409, 45884.77057614824, 52803.0, 54483.455165447835, 54937.725311373186, 65942.34057659362, 66602.0, 73424.0, 75157.24842751502, 79031.20968790239, 13652.65868353299, 13744.862551374757, 13840.653983650087, 13876.514321999086, 14286.499972500913, 13323.13399629021, 13529.255890926093, 14098.154110753389, 14219.289035548389, 14496.85503144955, 13683.315834208448, 13768.449262029808, 13841.238731869844, 14120.293985300488, 14211.715765684836, 12372.13395062373, 12544.310062946626, 12615.621531354074, 12666.873331266937, 13231.867681323063, 13255.204687718768, 13517.86482135166, 13597.184168949894, 13689.589312320646, 13915.304234788018, 10696.251262411557, 10816.242862999829, 11207.551697931991, 11414.771704566028, 11605.984691705162, 11189.216754827085, 11198.49572445482, 11352.54589816398, 11381.601643942422, 11447.0], "value": 7895.605374967476, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1519.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 105.0, 111.0, 111.0, 110.0, 111.0, 109.0, 108.0, 110.0, 111.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 123.0, 152.0, 177.0, 130.0, 160.0, 152.0, 125.0, 199.0, 128.0], "value": 149.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 162.0, 162.0, 163.0, 163.0, 163.0, 162.0, 163.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 178.0, 78.0, 75.0, 75.0, 78.0, 160.0, 77.0], "value": 94.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 139.0, 84.0, 84.0, 85.0, 141.0, 85.0, 84.0, 153.0], "value": 102.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 97.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 55.0, 56.0, 55.0, 54.0, 57.0, 54.0, 56.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 61.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 75.0, 77.0, 76.0, 83.0, 78.0, 77.0, 79.0, 101.0, 76.0], "value": 80.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 119.0, 121.0, 131.0, 121.0, 123.0, 125.0, 124.0, 139.0, 124.0], "value": 125.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 154.0, 161.0, 155.0, 153.0, 156.0, 152.0, 157.0, 154.0, 156.0], "value": 155.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 64.0, 63.0, 64.0, 71.0, 62.0, 66.0, 61.0], "value": 63.8, "unit": "score"}]}]} 03:54:47 INFO - Return code: 0 03:54:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:54:47 ERROR - # TBPL SUCCESS # 03:54:47 INFO - Running post-action listener: _resource_record_post_action 03:54:47 INFO - ##### 03:54:47 INFO - ##### Finished run-tests step (success) 03:54:47 INFO - ##### 03:54:47 INFO - Running post-run listener: _resource_record_post_run 03:54:47 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 505057280; Read time: 12; Write time: 464708 03:54:47 INFO - TinderboxPrint: CPU usage
13.4% 03:54:47 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 03:54:47 INFO - TinderboxPrint: I/O write bytes / time
505,057,280 / 464,708 03:54:47 INFO - TinderboxPrint: CPU idle
8,213.9 (86.6%) 03:54:47 INFO - TinderboxPrint: CPU user
1,214.6 (12.8%) 03:54:47 INFO - TinderboxPrint: Swap in / out
0 / 0 03:54:47 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 252776448; Read time: 0; Write time: 316996 03:54:47 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 252280832; Read time: 12; Write time: 147712 03:54:47 INFO - Running post-run listener: _upload_blobber_files 03:54:47 INFO - Blob upload gear active. 03:54:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:54:47 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:54:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:54:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:54:48 INFO - (blobuploader) - INFO - Open directory for files ... 03:54:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:54:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:54:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:54:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:54:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:54:48 INFO - (blobuploader) - INFO - Done attempting. 03:54:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:54:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:54:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:54:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:54:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:54:52 INFO - (blobuploader) - INFO - Done attempting. 03:54:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:54:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:54:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:54:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:54:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:54:53 INFO - (blobuploader) - INFO - Done attempting. 03:54:53 INFO - (blobuploader) - INFO - Iteration through files over. 03:54:53 INFO - Return code: 0 03:54:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:54:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:54:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/42bd8acdb04980a5b07d6d9b99960149cedd9a47c64554599cb781f76d153252e401e27695cd487affaf54568103e72dcc94d13a1108ef571206d57e36b9f856", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f499e1c4126abbd4d473068161535acc4b2e91658da04713c858da507f0371eaaf95bbcf3e842382603f8d9750b086e07e32719f94234a694183959a59bd7bb7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/098bf0c0157a2c81ba5d6136482ca3226307b4a8f30deab662078f79ce3003b2b58a6ac7dd0ee819b5ba5b7ba9436cc6fc0fa3cec7d8da0491db3f3d2963d5b8"} 03:54:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:54:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:54:53 INFO - Contents: 03:54:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/42bd8acdb04980a5b07d6d9b99960149cedd9a47c64554599cb781f76d153252e401e27695cd487affaf54568103e72dcc94d13a1108ef571206d57e36b9f856", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f499e1c4126abbd4d473068161535acc4b2e91658da04713c858da507f0371eaaf95bbcf3e842382603f8d9750b086e07e32719f94234a694183959a59bd7bb7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/098bf0c0157a2c81ba5d6136482ca3226307b4a8f30deab662078f79ce3003b2b58a6ac7dd0ee819b5ba5b7ba9436cc6fc0fa3cec7d8da0491db3f3d2963d5b8"} 03:54:53 INFO - Running post-run listener: copy_logs_to_upload_dir 03:54:53 INFO - Copying logs to upload dir... 03:54:53 INFO - mkdir: /builds/slave/test/build/upload/logs 03:54:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.267278 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-07-03 03:54:51.601634) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-03 03:54:51.608710) ========= 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=337fe3f4b1febe37b85fccc40000019e-1467540769.570594-421014012 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/42bd8acdb04980a5b07d6d9b99960149cedd9a47c64554599cb781f76d153252e401e27695cd487affaf54568103e72dcc94d13a1108ef571206d57e36b9f856", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f499e1c4126abbd4d473068161535acc4b2e91658da04713c858da507f0371eaaf95bbcf3e842382603f8d9750b086e07e32719f94234a694183959a59bd7bb7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/098bf0c0157a2c81ba5d6136482ca3226307b4a8f30deab662078f79ce3003b2b58a6ac7dd0ee819b5ba5b7ba9436cc6fc0fa3cec7d8da0491db3f3d2963d5b8"} build_url:https://queue.taskcluster.net/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011364 build_url: 'https://queue.taskcluster.net/v1/task/HntX6dLQRiihjeyH7uG-uw/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/42bd8acdb04980a5b07d6d9b99960149cedd9a47c64554599cb781f76d153252e401e27695cd487affaf54568103e72dcc94d13a1108ef571206d57e36b9f856", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f499e1c4126abbd4d473068161535acc4b2e91658da04713c858da507f0371eaaf95bbcf3e842382603f8d9750b086e07e32719f94234a694183959a59bd7bb7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/098bf0c0157a2c81ba5d6136482ca3226307b4a8f30deab662078f79ce3003b2b58a6ac7dd0ee819b5ba5b7ba9436cc6fc0fa3cec7d8da0491db3f3d2963d5b8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-03 03:54:51.634376) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 03:54:51.634703) ========= 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=337fe3f4b1febe37b85fccc40000019e-1467540769.570594-421014012 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004451 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 03:54:51.718436) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-03 03:54:51.718764) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-03 03:54:51.719051) ========= ========= Total master_lag: 0.31 =========