builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-017 starttime: 1466687659.32 results: success (0) buildid: 20160623050224 builduid: e46f9388705842b694bd090c71d6e926 revision: 437fc937572dd344f58226d40ba9eccb4ffcaedb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 06:14:19.322115) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 06:14:19.322880) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 06:14:19.323223) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 06:14:19.367098) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 06:14:19.367424) ========= 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=0333a256a5e4f052382dd180000001b1-1466686808.693297-400966052 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-23 06:14:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 214M=0s 2016-06-23 06:14:19 (214 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117072 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 06:14:19.500558) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 06:14:19.500908) ========= 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=0333a256a5e4f052382dd180000001b1-1466686808.693297-400966052 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019631 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 06:14:19.551738) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 06:14:19.552155) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 437fc937572dd344f58226d40ba9eccb4ffcaedb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 437fc937572dd344f58226d40ba9eccb4ffcaedb --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=0333a256a5e4f052382dd180000001b1-1466686808.693297-400966052 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-23 06:14:19,656 truncating revision to first 12 chars 2016-06-23 06:14:19,656 Setting DEBUG logging. 2016-06-23 06:14:19,656 attempt 1/10 2016-06-23 06:14:19,656 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/437fc937572d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-23 06:14:19,971 unpacking tar archive at: mozilla-central-437fc937572d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.661640 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 06:14:20.228204) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 06:14:20.228698) ========= script_repo_revision: 437fc937572dd344f58226d40ba9eccb4ffcaedb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 06:14:20.229195) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 06:14:20.229547) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 06:14:20.241726) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-06-23 06:14:20.242045) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=0333a256a5e4f052382dd180000001b1-1466686808.693297-400966052 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:14:20 INFO - MultiFileLogger online at 20160623 06:14:20 in /builds/slave/test 06:14:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 06:14:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:14:20 INFO - {'append_to_log': False, 06:14:20 INFO - 'base_work_dir': '/builds/slave/test', 06:14:20 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 06:14:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:14:20 INFO - 'branch': 'Firefox-Non-PGO', 06:14:20 INFO - 'buildbot_json_path': 'buildprops.json', 06:14:20 INFO - 'config_files': ('talos/linux_config.py',), 06:14:20 INFO - 'default_actions': ('clobber', 06:14:20 INFO - 'read-buildbot-config', 06:14:20 INFO - 'download-and-extract', 06:14:20 INFO - 'populate-webroot', 06:14:20 INFO - 'create-virtualenv', 06:14:20 INFO - 'install', 06:14:20 INFO - 'run-tests'), 06:14:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:14:20 INFO - 'download_minidump_stackwalk': True, 06:14:20 INFO - 'download_symbols': 'ondemand', 06:14:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:14:20 INFO - 'tooltool.py': '/tools/tooltool.py', 06:14:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:14:20 INFO - '/tools/misc-python/virtualenv.py')}, 06:14:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:14:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:14:20 INFO - 'installer_path': 'installer.exe', 06:14:20 INFO - 'log_level': 'info', 06:14:20 INFO - 'log_name': 'talos', 06:14:20 INFO - 'log_to_console': True, 06:14:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:14:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:14:20 INFO - 'opt_config_files': (), 06:14:20 INFO - 'pip_index': False, 06:14:20 INFO - 'sps_profile': False, 06:14:20 INFO - 'sps_profile_interval': 0, 06:14:20 INFO - 'suite': 'dromaeojs-e10s', 06:14:20 INFO - 'system_bits': '32', 06:14:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:14:20 INFO - 'title': 'talos-linux64-ix-017', 06:14:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:14:20 INFO - 'use_talos_json': True, 06:14:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:14:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:14:20 INFO - 'work_dir': 'build'} 06:14:20 INFO - ##### 06:14:20 INFO - ##### Running clobber step. 06:14:20 INFO - ##### 06:14:20 INFO - Running pre-action listener: _resource_record_pre_action 06:14:20 INFO - Running main action method: clobber 06:14:20 INFO - rmtree: /builds/slave/test/build 06:14:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:14:20 INFO - Running post-action listener: _resource_record_post_action 06:14:20 INFO - ##### 06:14:20 INFO - ##### Finished clobber step (success) 06:14:20 INFO - ##### 06:14:20 INFO - ##### 06:14:20 INFO - ##### Running read-buildbot-config step. 06:14:20 INFO - ##### 06:14:20 INFO - Running pre-action listener: _resource_record_pre_action 06:14:20 INFO - Running main action method: read_buildbot_config 06:14:20 INFO - Using buildbot properties: 06:14:20 INFO - { 06:14:20 INFO - "project": "", 06:14:20 INFO - "product": "firefox", 06:14:20 INFO - "script_repo_revision": "production", 06:14:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 06:14:20 INFO - "repository": "", 06:14:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 06:14:20 INFO - "buildid": "20160623050224", 06:14:20 INFO - "pgo_build": "False", 06:14:20 INFO - "basedir": "/builds/slave/test", 06:14:20 INFO - "buildnumber": 358, 06:14:20 INFO - "slavename": "talos-linux64-ix-017", 06:14:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:14:20 INFO - "platform": "ubuntu64_hw", 06:14:20 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 06:14:20 INFO - "branch": "mozilla-central", 06:14:20 INFO - "repo_path": "mozilla-central", 06:14:20 INFO - "revision": "437fc937572dd344f58226d40ba9eccb4ffcaedb", 06:14:20 INFO - "stage_platform": "linux64", 06:14:20 INFO - "builduid": "e46f9388705842b694bd090c71d6e926", 06:14:20 INFO - "slavebuilddir": "test" 06:14:20 INFO - } 06:14:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/JZV7md5PQJaYsyxnXpF99A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 06:14:20 INFO - Running post-action listener: _resource_record_post_action 06:14:20 INFO - ##### 06:14:20 INFO - ##### Finished read-buildbot-config step (success) 06:14:20 INFO - ##### 06:14:20 INFO - ##### 06:14:20 INFO - ##### Running download-and-extract step. 06:14:20 INFO - ##### 06:14:20 INFO - Running pre-action listener: _resource_record_pre_action 06:14:20 INFO - Running main action method: download_and_extract 06:14:20 INFO - mkdir: /builds/slave/test/build/tests 06:14:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:20 INFO - https://queue.taskcluster.net/v1/task/JZV7md5PQJaYsyxnXpF99A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:14:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JZV7md5PQJaYsyxnXpF99A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:14:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JZV7md5PQJaYsyxnXpF99A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:14:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JZV7md5PQJaYsyxnXpF99A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:14:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JZV7md5PQJaYsyxnXpF99A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:14:24 INFO - Downloaded 1361 bytes. 06:14:24 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:14:24 INFO - Using the following test package requirements: 06:14:24 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:14:24 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:14:24 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:14:24 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:24 INFO - u'jsshell-linux-x86_64.zip'], 06:14:24 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:14:24 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:14:24 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:14:24 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:14:24 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:14:24 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:14:24 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:14:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:24 INFO - https://queue.taskcluster.net/v1/task/JZV7md5PQJaYsyxnXpF99A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:14:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JZV7md5PQJaYsyxnXpF99A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:14:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JZV7md5PQJaYsyxnXpF99A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:14:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JZV7md5PQJaYsyxnXpF99A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:14:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JZV7md5PQJaYsyxnXpF99A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:14:25 INFO - Downloaded 22703215 bytes. 06:14:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:14:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:14:26 INFO - Return code: 0 06:14:26 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:14:26 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')]} 06:14:26 INFO - https://queue.taskcluster.net/v1/task/JZV7md5PQJaYsyxnXpF99A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:14:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JZV7md5PQJaYsyxnXpF99A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:14:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JZV7md5PQJaYsyxnXpF99A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:14:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JZV7md5PQJaYsyxnXpF99A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:14:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JZV7md5PQJaYsyxnXpF99A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:14:37 INFO - Downloaded 22703215 bytes. 06:14:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:14:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:14:39 INFO - Return code: 0 06:14:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:39 INFO - https://queue.taskcluster.net/v1/task/JZV7md5PQJaYsyxnXpF99A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:14:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JZV7md5PQJaYsyxnXpF99A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:14:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JZV7md5PQJaYsyxnXpF99A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:14:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JZV7md5PQJaYsyxnXpF99A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:14:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JZV7md5PQJaYsyxnXpF99A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:14:40 INFO - Downloaded 14405384 bytes. 06:14:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:14:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:14:41 INFO - Return code: 0 06:14:41 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')]} 06:14:41 INFO - https://queue.taskcluster.net/v1/task/JZV7md5PQJaYsyxnXpF99A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:14:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JZV7md5PQJaYsyxnXpF99A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:14:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JZV7md5PQJaYsyxnXpF99A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:14:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JZV7md5PQJaYsyxnXpF99A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:14:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JZV7md5PQJaYsyxnXpF99A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:14:42 INFO - Downloaded 56269149 bytes. 06:14:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JZV7md5PQJaYsyxnXpF99A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:14:42 INFO - mkdir: /builds/slave/test/properties 06:14:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:14:42 INFO - Writing to file /builds/slave/test/properties/build_url 06:14:42 INFO - Contents: 06:14:42 INFO - build_url:https://queue.taskcluster.net/v1/task/JZV7md5PQJaYsyxnXpF99A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:14:43 INFO - Running post-action listener: _resource_record_post_action 06:14:43 INFO - Running post-action listener: set_extra_try_arguments 06:14:43 INFO - ##### 06:14:43 INFO - ##### Finished download-and-extract step (success) 06:14:43 INFO - ##### 06:14:43 INFO - ##### 06:14:43 INFO - ##### Running populate-webroot step. 06:14:43 INFO - ##### 06:14:43 INFO - Running pre-action listener: _resource_record_pre_action 06:14:43 INFO - Running main action method: populate_webroot 06:14:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:14:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:14:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:14:43 INFO - '--tppagecycles', 06:14:43 INFO - '7'], 06:14:43 INFO - 'tests': ['tsvgm']}}, 06:14:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:14:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:14:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:14:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:14:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:14:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:14:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:43 INFO - 'talos_options': ['--disable-e10s'], 06:14:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:14:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:14:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:43 INFO - 'talos_options': ['--disable-e10s'], 06:14:43 INFO - 'tests': ['damp', 'tps']}, 06:14:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:43 INFO - 'tests': ['damp', 'tps']}, 06:14:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:14:43 INFO - 'tests': ['dromaeo_dom']}, 06:14:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:14:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:14:43 INFO - 'tests': ['basic_compositor_video']}, 06:14:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:14:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:14:43 INFO - 'tests': ['a11yr', 06:14:43 INFO - 'ts_paint', 06:14:43 INFO - 'tpaint', 06:14:43 INFO - 'sessionrestore', 06:14:43 INFO - 'sessionrestore_no_auto_restore', 06:14:43 INFO - 'tabpaint']}, 06:14:43 INFO - 'other-e10s': {'tests': ['a11yr', 06:14:43 INFO - 'ts_paint', 06:14:43 INFO - 'tpaint', 06:14:43 INFO - 'sessionrestore', 06:14:43 INFO - 'sessionrestore_no_auto_restore', 06:14:43 INFO - 'tabpaint']}, 06:14:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:14:43 INFO - 'ts_paint', 06:14:43 INFO - 'tpaint', 06:14:43 INFO - 'sessionrestore', 06:14:43 INFO - 'sessionrestore_no_auto_restore', 06:14:43 INFO - 'tabpaint']}, 06:14:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:14:43 INFO - 'ts_paint', 06:14:43 INFO - 'tpaint', 06:14:43 INFO - 'sessionrestore', 06:14:43 INFO - 'sessionrestore_no_auto_restore', 06:14:43 INFO - 'tabpaint']}, 06:14:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:14:43 INFO - 'tests': ['a11yr', 06:14:43 INFO - 'ts_paint', 06:14:43 INFO - 'tpaint', 06:14:43 INFO - 'sessionrestore', 06:14:43 INFO - 'sessionrestore_no_auto_restore', 06:14:43 INFO - 'tabpaint']}, 06:14:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:14:43 INFO - 'tests': ['a11yr', 06:14:43 INFO - 'ts_paint', 06:14:43 INFO - 'tpaint', 06:14:43 INFO - 'sessionrestore', 06:14:43 INFO - 'sessionrestore_no_auto_restore', 06:14:43 INFO - 'tabpaint']}, 06:14:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:14:43 INFO - 'tests': ['tsvgx', 06:14:43 INFO - 'tsvgr_opacity', 06:14:43 INFO - 'tart', 06:14:43 INFO - 'tscrollx', 06:14:43 INFO - 'cart']}, 06:14:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:14:43 INFO - 'tsvgr_opacity', 06:14:43 INFO - 'tart', 06:14:43 INFO - 'tscrollx', 06:14:43 INFO - 'cart']}, 06:14:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:43 INFO - 'talos_options': ['--disable-e10s'], 06:14:43 INFO - 'tests': ['tp5o']}, 06:14:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:43 INFO - 'tests': ['tp5o']}, 06:14:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:43 INFO - 'talos_options': ['--disable-e10s', 06:14:43 INFO - '--xperf_path', 06:14:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:14:43 INFO - 'tests': ['tp5n']}, 06:14:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:43 INFO - 'talos_options': ['--xperf_path', 06:14:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:14:43 INFO - 'tests': ['tp5n']}}, 06:14:43 INFO - 'talos.zip': {'path': '', 06:14:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:14:43 INFO - Running post-action listener: _resource_record_post_action 06:14:43 INFO - ##### 06:14:43 INFO - ##### Finished populate-webroot step (success) 06:14:43 INFO - ##### 06:14:43 INFO - ##### 06:14:43 INFO - ##### Running create-virtualenv step. 06:14:43 INFO - ##### 06:14:43 INFO - Running pre-action listener: _resource_record_pre_action 06:14:43 INFO - Running main action method: create_virtualenv 06:14:43 INFO - Creating virtualenv /builds/slave/test/build/venv 06:14:43 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 06:14:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:14:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:14:43 INFO - Using real prefix '/usr' 06:14:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:14:43 INFO - Installing distribute.............................................................................................................................................................................................done. 06:14:45 INFO - Installing pip.................done. 06:14:45 INFO - Return code: 0 06:14:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:14:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:45 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 0x7f72f82dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25421c0>, '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 0x25430c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2543550>, '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': '0333a256a5e4f052382dd180000001b1-1466686808.693297-400966052', '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 06:14:45 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 06:14:45 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 06:14:45 INFO - Using env: {'DISPLAY': ':0', 06:14:45 INFO - 'HOME': '/home/cltbld', 06:14:45 INFO - 'LANG': 'en_US.UTF-8', 06:14:45 INFO - 'LANGUAGE': 'en_US:en', 06:14:45 INFO - 'LOGNAME': 'cltbld', 06:14:45 INFO - 'MAIL': '/var/mail/cltbld', 06:14:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:45 INFO - 'MOZ_NO_REMOTE': '1', 06:14:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:14:45 INFO - 'NO_EM_RESTART': '1', 06:14:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:14:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:45 INFO - 'PWD': '/builds/slave/test', 06:14:45 INFO - 'SHELL': '/bin/bash', 06:14:45 INFO - 'SHLVL': '1', 06:14:45 INFO - 'TERM': 'linux', 06:14:45 INFO - 'TMOUT': '86400', 06:14:45 INFO - 'USER': 'cltbld', 06:14:45 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466686808.693297-400966052', 06:14:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:45 INFO - '_': '/tools/buildbot/bin/python'} 06:14:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:46 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 06:14:46 INFO - Cleaning up... 06:14:46 INFO - Return code: 0 06:14:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:14: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')]} 06:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14: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')]} 06:14:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f72f82dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25421c0>, '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 0x25430c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2543550>, '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': '0333a256a5e4f052382dd180000001b1-1466686808.693297-400966052', '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 06:14:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:14:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:14:46 INFO - Using env: {'DISPLAY': ':0', 06:14:46 INFO - 'HOME': '/home/cltbld', 06:14:46 INFO - 'LANG': 'en_US.UTF-8', 06:14:46 INFO - 'LANGUAGE': 'en_US:en', 06:14:46 INFO - 'LOGNAME': 'cltbld', 06:14:46 INFO - 'MAIL': '/var/mail/cltbld', 06:14:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:46 INFO - 'MOZ_NO_REMOTE': '1', 06:14:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:14:46 INFO - 'NO_EM_RESTART': '1', 06:14:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:14:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:46 INFO - 'PWD': '/builds/slave/test', 06:14:46 INFO - 'SHELL': '/bin/bash', 06:14:46 INFO - 'SHLVL': '1', 06:14:46 INFO - 'TERM': 'linux', 06:14:46 INFO - 'TMOUT': '86400', 06:14:46 INFO - 'USER': 'cltbld', 06:14:46 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466686808.693297-400966052', 06:14:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:46 INFO - '_': '/tools/buildbot/bin/python'} 06:14:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:46 INFO - Downloading/unpacking psutil>=3.1.1 06:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:14:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:14:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:14:48 INFO - Installing collected packages: psutil 06:14:48 INFO - Running setup.py install for psutil 06:14:48 INFO - building 'psutil._psutil_linux' extension 06:14:48 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 06:14:48 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 06:14:48 INFO - building 'psutil._psutil_posix' extension 06:14:48 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 06:14:48 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 06:14:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:14:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:14:48 INFO - Successfully installed psutil 06:14:48 INFO - Cleaning up... 06:14:48 INFO - Return code: 0 06:14:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f72f82dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25421c0>, '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 0x25430c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2543550>, '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': '0333a256a5e4f052382dd180000001b1-1466686808.693297-400966052', '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 06:14:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:14:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:14:48 INFO - Using env: {'DISPLAY': ':0', 06:14:48 INFO - 'HOME': '/home/cltbld', 06:14:48 INFO - 'LANG': 'en_US.UTF-8', 06:14:48 INFO - 'LANGUAGE': 'en_US:en', 06:14:48 INFO - 'LOGNAME': 'cltbld', 06:14:48 INFO - 'MAIL': '/var/mail/cltbld', 06:14:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:48 INFO - 'MOZ_NO_REMOTE': '1', 06:14:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:14:48 INFO - 'NO_EM_RESTART': '1', 06:14:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:14:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:48 INFO - 'PWD': '/builds/slave/test', 06:14:48 INFO - 'SHELL': '/bin/bash', 06:14:48 INFO - 'SHLVL': '1', 06:14:48 INFO - 'TERM': 'linux', 06:14:48 INFO - 'TMOUT': '86400', 06:14:48 INFO - 'USER': 'cltbld', 06:14:48 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466686808.693297-400966052', 06:14:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:48 INFO - '_': '/tools/buildbot/bin/python'} 06:14:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:14:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:14:50 INFO - Installing collected packages: mozsystemmonitor 06:14:50 INFO - Running setup.py install for mozsystemmonitor 06:14:51 INFO - Successfully installed mozsystemmonitor 06:14:51 INFO - Cleaning up... 06:14:51 INFO - Return code: 0 06:14:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:14:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f72f82dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25421c0>, '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 0x25430c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2543550>, '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': '0333a256a5e4f052382dd180000001b1-1466686808.693297-400966052', '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 06:14:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:14:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:14:51 INFO - Using env: {'DISPLAY': ':0', 06:14:51 INFO - 'HOME': '/home/cltbld', 06:14:51 INFO - 'LANG': 'en_US.UTF-8', 06:14:51 INFO - 'LANGUAGE': 'en_US:en', 06:14:51 INFO - 'LOGNAME': 'cltbld', 06:14:51 INFO - 'MAIL': '/var/mail/cltbld', 06:14:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:51 INFO - 'MOZ_NO_REMOTE': '1', 06:14:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:14:51 INFO - 'NO_EM_RESTART': '1', 06:14:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:14:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:51 INFO - 'PWD': '/builds/slave/test', 06:14:51 INFO - 'SHELL': '/bin/bash', 06:14:51 INFO - 'SHLVL': '1', 06:14:51 INFO - 'TERM': 'linux', 06:14:51 INFO - 'TMOUT': '86400', 06:14:51 INFO - 'USER': 'cltbld', 06:14:51 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466686808.693297-400966052', 06:14:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:51 INFO - '_': '/tools/buildbot/bin/python'} 06:14:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:51 INFO - Downloading/unpacking jsonschema==2.5.1 06:14: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 06:14: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 06:14: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 06:14: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 06:14: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 06:14: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 06:14:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:14:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:53 INFO - Downloading functools32-3.2.3-2.tar.gz 06:14:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:14:53 INFO - warning: no files found matching '*.txt' 06:14:53 INFO - no previously-included directories found matching 'build' 06:14:53 INFO - no previously-included directories found matching 'dist' 06:14:53 INFO - no previously-included directories found matching '.git*' 06:14:53 INFO - Installing collected packages: jsonschema, functools32 06:14:53 INFO - Running setup.py install for functools32 06:14:53 INFO - warning: no files found matching '*.txt' 06:14:53 INFO - no previously-included directories found matching 'build' 06:14:53 INFO - no previously-included directories found matching 'dist' 06:14:53 INFO - no previously-included directories found matching '.git*' 06:14:53 INFO - Successfully installed jsonschema functools32 06:14:53 INFO - Cleaning up... 06:14:53 INFO - Return code: 0 06:14:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:14: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')]} 06:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14: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')]} 06:14:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:53 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 0x7f72f82dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25421c0>, '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 0x25430c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2543550>, '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': '0333a256a5e4f052382dd180000001b1-1466686808.693297-400966052', '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 06:14:53 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 06:14:53 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 06:14:53 INFO - Using env: {'DISPLAY': ':0', 06:14:53 INFO - 'HOME': '/home/cltbld', 06:14:53 INFO - 'LANG': 'en_US.UTF-8', 06:14:53 INFO - 'LANGUAGE': 'en_US:en', 06:14:53 INFO - 'LOGNAME': 'cltbld', 06:14:53 INFO - 'MAIL': '/var/mail/cltbld', 06:14:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:53 INFO - 'MOZ_NO_REMOTE': '1', 06:14:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:14:53 INFO - 'NO_EM_RESTART': '1', 06:14:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:14:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:53 INFO - 'PWD': '/builds/slave/test', 06:14:53 INFO - 'SHELL': '/bin/bash', 06:14:53 INFO - 'SHLVL': '1', 06:14:53 INFO - 'TERM': 'linux', 06:14:53 INFO - 'TMOUT': '86400', 06:14:53 INFO - 'USER': 'cltbld', 06:14:53 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466686808.693297-400966052', 06:14:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:53 INFO - '_': '/tools/buildbot/bin/python'} 06:14:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:53 INFO - Downloading/unpacking blobuploader==1.2.4 06:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:55 INFO - Downloading blobuploader-1.2.4.tar.gz 06:14:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:14:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:14:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:14: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 06:14: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 06:14: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 06:14: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 06:14: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 06:14: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 06:14:56 INFO - Downloading docopt-0.6.1.tar.gz 06:14:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:14:56 INFO - Installing collected packages: blobuploader, requests, docopt 06:14:56 INFO - Running setup.py install for blobuploader 06:14:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:14:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:14:56 INFO - Running setup.py install for requests 06:14:57 INFO - Running setup.py install for docopt 06:14:57 INFO - Successfully installed blobuploader requests docopt 06:14:57 INFO - Cleaning up... 06:14:57 INFO - Return code: 0 06:14:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:14:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:57 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 0x7f72f82dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25421c0>, '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 0x25430c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2543550>, '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': '0333a256a5e4f052382dd180000001b1-1466686808.693297-400966052', '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 06:14:57 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 06:14:57 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 06:14:57 INFO - Using env: {'DISPLAY': ':0', 06:14:57 INFO - 'HOME': '/home/cltbld', 06:14:57 INFO - 'LANG': 'en_US.UTF-8', 06:14:57 INFO - 'LANGUAGE': 'en_US:en', 06:14:57 INFO - 'LOGNAME': 'cltbld', 06:14:57 INFO - 'MAIL': '/var/mail/cltbld', 06:14:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:57 INFO - 'MOZ_NO_REMOTE': '1', 06:14:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:14:57 INFO - 'NO_EM_RESTART': '1', 06:14:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:14:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:57 INFO - 'PWD': '/builds/slave/test', 06:14:57 INFO - 'SHELL': '/bin/bash', 06:14:57 INFO - 'SHLVL': '1', 06:14:57 INFO - 'TERM': 'linux', 06:14:57 INFO - 'TMOUT': '86400', 06:14:57 INFO - 'USER': 'cltbld', 06:14:57 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466686808.693297-400966052', 06:14:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:57 INFO - '_': '/tools/buildbot/bin/python'} 06:14:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:14:57 INFO - Running setup.py (path:/tmp/pip-7eF_Aq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:14:57 INFO - Running setup.py (path:/tmp/pip-eEwpZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:14:57 INFO - Running setup.py (path:/tmp/pip-dqKiC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:14:57 INFO - Running setup.py (path:/tmp/pip-1eyjlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:14:57 INFO - Running setup.py (path:/tmp/pip-rwKchf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:14:57 INFO - Running setup.py (path:/tmp/pip-d0h6FJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:14:57 INFO - Running setup.py (path:/tmp/pip-71CSmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:14:58 INFO - Running setup.py (path:/tmp/pip-gVmXjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:14:58 INFO - Running setup.py (path:/tmp/pip-twzrOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:14:58 INFO - Running setup.py (path:/tmp/pip-CaIE53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:14:58 INFO - Running setup.py (path:/tmp/pip-cOjk44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:14:58 INFO - Running setup.py (path:/tmp/pip-BPZXeV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:14:58 INFO - Running setup.py (path:/tmp/pip-3iKyDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:14:58 INFO - Running setup.py (path:/tmp/pip-xHxHGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:14:58 INFO - Running setup.py (path:/tmp/pip-fBL8fd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:14:58 INFO - Running setup.py (path:/tmp/pip-Ks2Zux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:14:58 INFO - Running setup.py (path:/tmp/pip-HkVvFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:14:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:14:58 INFO - Running setup.py install for manifestparser 06:14:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:14:58 INFO - Running setup.py install for mozcrash 06:14:58 INFO - Running setup.py install for mozdebug 06:14:59 INFO - Running setup.py install for mozdevice 06:14:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:14:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:14:59 INFO - Running setup.py install for mozfile 06:14:59 INFO - Running setup.py install for mozhttpd 06:14:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:14:59 INFO - Running setup.py install for mozinfo 06:14:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:14:59 INFO - Running setup.py install for mozInstall 06:14:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:14:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:14:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:14:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:14:59 INFO - Running setup.py install for mozleak 06:14:59 INFO - Running setup.py install for mozlog 06:14:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:14:59 INFO - Running setup.py install for moznetwork 06:14:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:14:59 INFO - Running setup.py install for mozprocess 06:14:59 INFO - Running setup.py install for mozprofile 06:15:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:15:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:15:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:15:00 INFO - Running setup.py install for mozrunner 06:15:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:15:00 INFO - Running setup.py install for mozscreenshot 06:15:00 INFO - Running setup.py install for moztest 06:15:00 INFO - Running setup.py install for mozversion 06:15:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:15:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:15:00 INFO - Cleaning up... 06:15:00 INFO - Return code: 0 06:15:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:15:00 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')]} 06:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:00 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')]} 06:15:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:00 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 0x7f72f82dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25421c0>, '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 0x25430c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2543550>, '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': '0333a256a5e4f052382dd180000001b1-1466686808.693297-400966052', '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 06:15:00 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 06:15:00 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 06:15:00 INFO - Using env: {'DISPLAY': ':0', 06:15:00 INFO - 'HOME': '/home/cltbld', 06:15:00 INFO - 'LANG': 'en_US.UTF-8', 06:15:00 INFO - 'LANGUAGE': 'en_US:en', 06:15:00 INFO - 'LOGNAME': 'cltbld', 06:15:00 INFO - 'MAIL': '/var/mail/cltbld', 06:15:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:00 INFO - 'MOZ_NO_REMOTE': '1', 06:15:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:00 INFO - 'NO_EM_RESTART': '1', 06:15:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:00 INFO - 'PWD': '/builds/slave/test', 06:15:00 INFO - 'SHELL': '/bin/bash', 06:15:00 INFO - 'SHLVL': '1', 06:15:00 INFO - 'TERM': 'linux', 06:15:00 INFO - 'TMOUT': '86400', 06:15:00 INFO - 'USER': 'cltbld', 06:15:00 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466686808.693297-400966052', 06:15:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:00 INFO - '_': '/tools/buildbot/bin/python'} 06:15:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:15:00 INFO - Running setup.py (path:/tmp/pip-EjWRG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:15:00 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)) 06:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:15:00 INFO - Running setup.py (path:/tmp/pip-ksGFqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:15:00 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)) 06:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:15:00 INFO - Running setup.py (path:/tmp/pip-uVr2hj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:15:00 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)) 06:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:15:01 INFO - Running setup.py (path:/tmp/pip-HpgsOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:15:01 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)) 06:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:15:01 INFO - Running setup.py (path:/tmp/pip-VWkdgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:15:01 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)) 06:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:15:01 INFO - Running setup.py (path:/tmp/pip-Bapx0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:15:01 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)) 06:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:15:01 INFO - Running setup.py (path:/tmp/pip-BqZriW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:15:01 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)) 06:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:15:01 INFO - Running setup.py (path:/tmp/pip-ukzl6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:15:01 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)) 06:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:15:01 INFO - Running setup.py (path:/tmp/pip-_Rtrmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:15:01 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)) 06:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:15:01 INFO - Running setup.py (path:/tmp/pip-JJW9f_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:15:01 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)) 06:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:15:01 INFO - Running setup.py (path:/tmp/pip-bi9unB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:15:01 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)) 06:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:15:01 INFO - Running setup.py (path:/tmp/pip-LW0kul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:15:01 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)) 06:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:15:01 INFO - Running setup.py (path:/tmp/pip-dIILsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:15:01 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)) 06:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:15:01 INFO - Running setup.py (path:/tmp/pip-P__xEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:15:01 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)) 06:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:15:01 INFO - Running setup.py (path:/tmp/pip-psv_Rp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:15:01 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)) 06:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:15:01 INFO - Running setup.py (path:/tmp/pip-Oexbl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:15:01 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)) 06:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:15:01 INFO - Running setup.py (path:/tmp/pip-JnokvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:15:02 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)) 06:15:02 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)) 06:15:02 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)) 06:15:02 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)) 06:15:02 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)) 06:15:02 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)) 06:15:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:03 INFO - Downloading blessings-1.6.tar.gz 06:15:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:15:04 INFO - Installing collected packages: blessings 06:15:04 INFO - Running setup.py install for blessings 06:15:04 INFO - Successfully installed blessings 06:15:04 INFO - Cleaning up... 06:15:04 INFO - Return code: 0 06:15:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:15:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:15:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:15:04 INFO - Reading from file tmpfile_stdout 06:15:04 INFO - Current package versions: 06:15:04 INFO - argparse == 1.2.1 06:15:04 INFO - blessings == 1.6 06:15:04 INFO - blobuploader == 1.2.4 06:15:04 INFO - docopt == 0.6.1 06:15:04 INFO - functools32 == 3.2.3-2 06:15:04 INFO - jsonschema == 2.5.1 06:15:04 INFO - manifestparser == 1.1 06:15:04 INFO - mozInstall == 1.12 06:15:04 INFO - mozcrash == 0.17 06:15:04 INFO - mozdebug == 0.1 06:15:04 INFO - mozdevice == 0.48 06:15:04 INFO - mozfile == 1.2 06:15:04 INFO - mozhttpd == 0.7 06:15:04 INFO - mozinfo == 0.9 06:15:04 INFO - mozleak == 0.1 06:15:04 INFO - mozlog == 3.2 06:15:04 INFO - moznetwork == 0.27 06:15:04 INFO - mozprocess == 0.22 06:15:04 INFO - mozprofile == 0.28 06:15:04 INFO - mozrunner == 6.11 06:15:04 INFO - mozscreenshot == 0.1 06:15:04 INFO - mozsystemmonitor == 0.3 06:15:04 INFO - moztest == 0.7 06:15:04 INFO - mozversion == 1.4 06:15:04 INFO - psutil == 3.1.1 06:15:04 INFO - requests == 1.2.3 06:15:04 INFO - wsgiref == 0.1.2 06:15:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:15:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:04 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 0x7f72f82dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25421c0>, '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 0x25430c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2543550>, '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': '0333a256a5e4f052382dd180000001b1-1466686808.693297-400966052', '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 06:15:04 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 06:15:04 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 06:15:04 INFO - Using env: {'DISPLAY': ':0', 06:15:04 INFO - 'HOME': '/home/cltbld', 06:15:04 INFO - 'LANG': 'en_US.UTF-8', 06:15:04 INFO - 'LANGUAGE': 'en_US:en', 06:15:04 INFO - 'LOGNAME': 'cltbld', 06:15:04 INFO - 'MAIL': '/var/mail/cltbld', 06:15:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:04 INFO - 'MOZ_NO_REMOTE': '1', 06:15:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:04 INFO - 'NO_EM_RESTART': '1', 06:15:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:04 INFO - 'PWD': '/builds/slave/test', 06:15:04 INFO - 'SHELL': '/bin/bash', 06:15:04 INFO - 'SHLVL': '1', 06:15:04 INFO - 'TERM': 'linux', 06:15:04 INFO - 'TMOUT': '86400', 06:15:04 INFO - 'USER': 'cltbld', 06:15:04 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466686808.693297-400966052', 06:15:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:04 INFO - '_': '/tools/buildbot/bin/python'} 06:15:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:04 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)) 06:15:04 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)) 06:15:04 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)) 06:15:04 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)) 06:15:04 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)) 06:15:04 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)) 06:15:04 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)) 06:15:04 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)) 06:15:04 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)) 06:15:04 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)) 06:15:04 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)) 06:15:04 INFO - Cleaning up... 06:15:04 INFO - Return code: 0 06:15:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:15:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:04 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 0x7f72f82dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25421c0>, '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 0x25430c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2543550>, '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': '0333a256a5e4f052382dd180000001b1-1466686808.693297-400966052', '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 06:15:04 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 06:15:04 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 06:15:04 INFO - Using env: {'DISPLAY': ':0', 06:15:04 INFO - 'HOME': '/home/cltbld', 06:15:04 INFO - 'LANG': 'en_US.UTF-8', 06:15:04 INFO - 'LANGUAGE': 'en_US:en', 06:15:04 INFO - 'LOGNAME': 'cltbld', 06:15:04 INFO - 'MAIL': '/var/mail/cltbld', 06:15:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:04 INFO - 'MOZ_NO_REMOTE': '1', 06:15:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:04 INFO - 'NO_EM_RESTART': '1', 06:15:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:04 INFO - 'PWD': '/builds/slave/test', 06:15:04 INFO - 'SHELL': '/bin/bash', 06:15:04 INFO - 'SHLVL': '1', 06:15:04 INFO - 'TERM': 'linux', 06:15:04 INFO - 'TMOUT': '86400', 06:15:04 INFO - 'USER': 'cltbld', 06:15:04 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466686808.693297-400966052', 06:15:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:04 INFO - '_': '/tools/buildbot/bin/python'} 06:15:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:15:04 INFO - Cleaning up... 06:15:04 INFO - Return code: 0 06:15:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:15:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:04 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 0x7f72f82dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25421c0>, '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 0x25430c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2543550>, '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': '0333a256a5e4f052382dd180000001b1-1466686808.693297-400966052', '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 06:15:04 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 06:15:04 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 06:15:04 INFO - Using env: {'DISPLAY': ':0', 06:15:04 INFO - 'HOME': '/home/cltbld', 06:15:04 INFO - 'LANG': 'en_US.UTF-8', 06:15:04 INFO - 'LANGUAGE': 'en_US:en', 06:15:04 INFO - 'LOGNAME': 'cltbld', 06:15:04 INFO - 'MAIL': '/var/mail/cltbld', 06:15:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:04 INFO - 'MOZ_NO_REMOTE': '1', 06:15:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:04 INFO - 'NO_EM_RESTART': '1', 06:15:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:04 INFO - 'PWD': '/builds/slave/test', 06:15:04 INFO - 'SHELL': '/bin/bash', 06:15:04 INFO - 'SHLVL': '1', 06:15:04 INFO - 'TERM': 'linux', 06:15:04 INFO - 'TMOUT': '86400', 06:15:04 INFO - 'USER': 'cltbld', 06:15:04 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466686808.693297-400966052', 06:15:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:04 INFO - '_': '/tools/buildbot/bin/python'} 06:15:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:05 INFO - Downloading/unpacking flake8 06:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:15:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:15:06 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 06:15:06 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 06:15:06 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 06:15:06 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 06:15:06 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 06:15:06 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 06:15:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:15:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:15:07 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 06:15:07 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 06:15:07 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 06:15:07 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 06:15:07 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 06:15:07 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 06:15:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:15:07 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 06:15:07 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 06:15:07 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 06:15:07 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 06:15:07 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 06:15:07 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 06:15:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:15:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:15:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:15:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:15:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:15:07 INFO - no previously-included directories found matching 'docs/_build' 06:15:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:15:07 INFO - Running setup.py install for pep8 06:15:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:15:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:15:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:15:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:15:07 INFO - no previously-included directories found matching 'docs/_build' 06:15:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:15:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:15:07 INFO - Cleaning up... 06:15:07 INFO - Return code: 0 06:15:07 INFO - Running post-action listener: _resource_record_post_action 06:15:07 INFO - Running post-action listener: _start_resource_monitoring 06:15:07 INFO - Starting resource monitoring. 06:15:07 INFO - ##### 06:15:07 INFO - ##### Finished create-virtualenv step (success) 06:15:07 INFO - ##### 06:15:07 INFO - ##### 06:15:07 INFO - ##### Running install step. 06:15:07 INFO - ##### 06:15:07 INFO - Running pre-action listener: _resource_record_pre_action 06:15:07 INFO - Running main action method: install 06:15:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:15:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:15:08 INFO - Reading from file tmpfile_stdout 06:15:08 INFO - Detecting whether we're running mozinstall >=1.0... 06:15:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:15:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:15:08 INFO - Reading from file tmpfile_stdout 06:15:08 INFO - Output received: 06:15:08 INFO - Usage: mozinstall [options] installer 06:15:08 INFO - Options: 06:15:08 INFO - -h, --help show this help message and exit 06:15:08 INFO - -d DEST, --destination=DEST 06:15:08 INFO - Directory to install application into. [default: 06:15:08 INFO - "/builds/slave/test"] 06:15:08 INFO - --app=APP Application being installed. [default: firefox] 06:15:08 INFO - mkdir: /builds/slave/test/build/application 06:15:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:15:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:15:24 INFO - Reading from file tmpfile_stdout 06:15:24 INFO - Output received: 06:15:24 INFO - /builds/slave/test/build/application/firefox/firefox 06:15:24 INFO - Running post-action listener: _resource_record_post_action 06:15:24 INFO - ##### 06:15:24 INFO - ##### Finished install step (success) 06:15:24 INFO - ##### 06:15:24 INFO - ##### 06:15:24 INFO - ##### Running run-tests step. 06:15:24 INFO - ##### 06:15:24 INFO - Running pre-action listener: _resource_record_pre_action 06:15:24 INFO - Running main action method: run_tests 06:15:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:15:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:15:24 INFO - Python 2.7.3 06:15:24 INFO - Return code: 0 06:15:24 INFO - grabbing minidump binary from tooltool 06:15:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:15:24 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 0x25421c0>, '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 0x25430c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2543550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:15:24 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 06:15:24 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 06:15:24 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 06:15:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:15:24 INFO - Return code: 0 06:15:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:15:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:15:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:15:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:15:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:15:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:15:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:15:25 INFO - Return code: 0 06:15:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JZV7md5PQJaYsyxnXpF99A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 06:15:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JZV7md5PQJaYsyxnXpF99A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 06:15:25 INFO - Using env: {'DISPLAY': ':0', 06:15:25 INFO - 'HOME': '/home/cltbld', 06:15:25 INFO - 'LANG': 'en_US.UTF-8', 06:15:25 INFO - 'LANGUAGE': 'en_US:en', 06:15:25 INFO - 'LOGNAME': 'cltbld', 06:15:25 INFO - 'MAIL': '/var/mail/cltbld', 06:15:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:15:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:15:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:25 INFO - 'MOZ_NO_REMOTE': '1', 06:15:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:15:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:25 INFO - 'NO_EM_RESTART': '1', 06:15:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:25 INFO - 'PWD': '/builds/slave/test', 06:15:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:15:25 INFO - 'SHELL': '/bin/bash', 06:15:25 INFO - 'SHLVL': '1', 06:15:25 INFO - 'TERM': 'linux', 06:15:25 INFO - 'TMOUT': '86400', 06:15:25 INFO - 'USER': 'cltbld', 06:15:25 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466686808.693297-400966052', 06:15:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:25 INFO - '_': '/tools/buildbot/bin/python'} 06:15:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JZV7md5PQJaYsyxnXpF99A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 06:15:25 INFO - mozversion application_buildid: 20160623050224 06:15:25 INFO - mozversion application_changeset: 437fc937572dd344f58226d40ba9eccb4ffcaedb 06:15:25 INFO - mozversion application_display_name: Nightly 06:15:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:15:25 INFO - mozversion application_name: Firefox 06:15:25 INFO - mozversion application_remotingname: firefox 06:15:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:15:25 INFO - mozversion application_vendor: Mozilla 06:15:25 INFO - mozversion application_version: 50.0a1 06:15:25 INFO - mozversion platform_buildid: 20160623050224 06:15:25 INFO - mozversion platform_changeset: 437fc937572dd344f58226d40ba9eccb4ffcaedb 06:15:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:15:25 INFO - mozversion platform_version: 50.0a1 06:15:25 INFO - using testdate: 1466687725 06:15:25 INFO - actual date: 1466687725 06:15:25 INFO - starting webserver on 'localhost:43012' 06:15:25 INFO - SUITE-START | Running 2 tests 06:15:25 INFO - TEST-START | dromaeo_css 06:15:25 INFO - operating with platform_type : linux_ 06:15:25 INFO - Initialising browser for dromaeo_css test... 06:15:25 INFO - TEST-INFO | started process 12238 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB2JTDJ/profile http://localhost:43012/getInfo.html) 06:15:30 INFO - PROCESS | 12238 | __metrics Screen width/height:1600/1200 06:15:30 INFO - PROCESS | 12238 | colorDepth:24 06:15:30 INFO - PROCESS | 12238 | Browser inner width/height: 1024/697 06:15:30 INFO - PROCESS | 12238 | __metrics 06:15:30 ERROR - PROCESS | 12238 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 06:15:31 INFO - TEST-INFO | 12238: exit 0 06:15:31 INFO - Browser initialized. 06:15:31 INFO - Running cycle 1/1 for dromaeo_css test... 06:15:31 INFO - TEST-INFO | started process 12360 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB2JTDJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:15:44 INFO - PROCESS | 12360 | RSS: Main: 185995264 06:15:44 INFO - PROCESS | 12360 | 06:16:33 INFO - PROCESS | 12360 | 1466687793607 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] 06:18:45 INFO - PROCESS | 12360 | Cycle 1(1): loaded http://localhost:43012/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43012/tests/dromaeo/cssquery-ext.html) 06:18:47 INFO - PROCESS | 12360 | RSS: Main: 189181952 06:18:47 INFO - PROCESS | 12360 | 06:21:49 INFO - PROCESS | 12360 | Cycle 1(1): loaded http://localhost:43012/tests/dromaeo/cssquery-ext.html (next: http://localhost:43012/tests/dromaeo/cssquery-jquery.html) 06:21:50 INFO - PROCESS | 12360 | RSS: Main: 187551744 06:21:50 INFO - PROCESS | 12360 | 06:24:52 INFO - PROCESS | 12360 | Cycle 1(1): loaded http://localhost:43012/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43012/tests/dromaeo/cssquery-mootools.html) 06:24:52 INFO - PROCESS | 12360 | RSS: Main: 189673472 06:24:52 INFO - PROCESS | 12360 | 06:27:54 INFO - PROCESS | 12360 | Cycle 1(1): loaded http://localhost:43012/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43012/tests/dromaeo/cssquery-prototype.html) 06:27:55 INFO - PROCESS | 12360 | RSS: Main: 186802176 06:27:55 INFO - PROCESS | 12360 | 06:30:57 INFO - PROCESS | 12360 | Cycle 1(1): loaded http://localhost:43012/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43012/tests/dromaeo/cssquery-yui.html) 06:30:58 INFO - PROCESS | 12360 | RSS: Main: 188600320 06:30:58 INFO - PROCESS | 12360 | 06:34:00 INFO - PROCESS | 12360 | Cycle 1(1): loaded http://localhost:43012/tests/dromaeo/cssquery-yui.html (next: http://localhost:43012/tests/dromaeo/cssquery-dojo.html) 06:34:01 INFO - PROCESS | 12360 | RSS: Main: 189620224 06:34:01 INFO - PROCESS | 12360 | 06:34:01 INFO - PROCESS | 12360 | __start_tp_report 06:34:01 INFO - PROCESS | 12360 | _x_x_mozilla_page_load 06:34:01 INFO - PROCESS | 12360 | _x_x_mozilla_page_load_details 06:34:01 INFO - PROCESS | 12360 | |i|pagename|runs| 06:34:01 INFO - PROCESS | 12360 | |0;dojo.html;2646.5500864852975;2687.6909155447124;2704.1211606227967;2707.553253713136;2711.6881558620767;4682.063587282544;4729.408823897013;4758.6906851054655;4929.112759703252;4954.653174277802;4834.564889159975;4910.2143657014885;4919.089968355847;4922.532359425858;5035.521625445586;4440.333949907507;4481.596656300932;4491.438570178736;4594.58648721615;4670.1126785910565;4368.912621747563;4507.774611269439;4526.841560545382;4567.287267274772;4590.42619672541;4469.396631454777;4568.817247310104;4600.401947746805;4628.352030715702;4645.210314246586;4429.7785110744335;4480.19356515827;4481.2381895077915;4488.685791994561;4499.842505512324;4477.977610111961;4518.344839998214;4532.365468834366;4536.251518499444;4563.904662880885;4844.66087373884;4897.069556784199;4922.507749225085;4939.382577177853;4979.427365852937;5361.839144825662;5363.597730170253;5364.7317634118135;5370.812021579265;5398.514133727944;5387;5396.298481197458;5400.919816036809;5408.648437851527;5435.701036442994;4868.561829435333;4916.778744956486;4943.826966056171;4973.2540118981715;5002.7498625068965;5469.535089517356;5493.972530137324;5494.2857428534035;5498.505134537911;5509.972450137804;5196.558292545101;5206.323177986837;5209.244659524424;5214.374275087014;5279.208118782213;5286.629935904527;5300.655457395257;5321.441248668834;5355.598330125256;5386.407495175527;5183.585313174937;5192.402873669501;5212.869678257998;5252;5267.868303292448;5263.973680131651;5272.578193744491;5275.258906892606;5276.788928442819;5283.260343551906;4365.9126817463475;4382.649388048949;4407.2507673695545;4416.403785488982;4501.279795232747;3845.5000849889334;3847.6537111660086;3849.4995650565247;3887.6695480883877;3894.162755007687;4509.210888094636;4514.164879497303;4518.118966801442;4539.114872599877;4605.032943081923;5196.038732834438;5291.99452104099;5325.707086110301;5347.0909945309395;5374.677519348774;4557.430321209848;4576.839810606612;4580.702254353457;4600.171969045604;4605.102005108972;4668.85993420198;4778.900852803805;4786.7845946932475;4798.064377446434;4830.589399900978;4892.608591312686;4982.52665996737;4997.150484417731;5026.698398096126;5038.773255203451;5398.2442458056685;5404.081306178038;5421.83734487966;5424.3761967372675;5430.51125398716;4869.537393947569;5020.146575082172;5032.3961124665275;5041.621878359065;5073.974630126826;5236.659617124875;5288.3918349390315;5306;5317.096093664164;5349.063913814989;5355;5361.812336568201;5372.086745253395;5372.946270537401;5437.510624043855;5000.874978125576;5073.467285934924;5203.453637368173;5227.137522308776;5263.157894736823;5120.18077107661;5158.329417175743;5171.224316352577;5183.5593974512585;5235.476452354734;5050.065737838511;5093.7707803148205;5117.692938423706;5136.178211486144;5141.28022076902;5093.541581257705;5194.298769666047;5210.27056212123;5216.843494695166;5229.849433124707;5066.797328106834;5098.107831129611;5108.795648174031;5121.180611102355;5132.204508301219 06:34:01 INFO - PROCESS | 12360 | |1;ext.html;514.2293277493898;584.4593750780527;591;602.6805792929749;604.474107526452;34324.313513729714;37496.437553436655;37540.81229593855;38067;38280.61719382809;37869.62130378695;38302.04244893879;38543.42184867229;38646.80676596613;38762.61237387632;7785.922140778576;7960.840783184332;7962.601869906482;7965;7970.163132871052;7741.496802707834;7830.882536761953;7838.255365740246;7871.448998570102;7887.684492620288;7882.172371900954;7891.526508409485;7894.526328420285;7945.72189973351;7978.281954624083;7827.960860195691;7840.568768717718;7890.605469726519;7895.210478952116;7940.880886786645;7762.573058481781;7904.920950790476;7906.565138917357;7930.841383172305;7946.125926148119;36756.632433675586;36880.631193688256;36921.44617830735;37053.81473092617;37311.06722331936;3295.2915123248376;3345.381104495652;3658.963410365889;3719.479272901796;3776.169242766587;28640;28719.425611487863;28877.711222887712;29195.41609167826;29236.41527169466;3500.7549471537004;3519.278547897675;3588.3361578107874;3673.834677439522;3685.7788532688123;257512;257980;258254;258607;259072.7046364775;31672.524912126337;32381.19047023796;32416.351672966408;34441.483377749355;50047.49952500501;33150.83424582861;33166;33392.49911251333;33413.16467088342;33539.32921341559;13684.110532815335;13722.794158087636;13723;13728.244946528037;13781.379837907318;11433.428328583537;11465.369404682822;11468.4839182237;11494.13793965456;11603;7790.922090779133;7805.609719514002;7820.335271501986;7886.3296619786815;7919.2872641462545;3089.382123575249;3133.9529907051415;3152.1961899715425;3158.0999415167025;3161.2729072313496;882.9911700883038;883.4213590098367;890.7817584691662;934.7562068210385;1003.0339293605838;27801.304967375574;27993.44013119726;28198.85900570484;28333.858330708626;28853;949.9002604726543;985.4186030242048;998.5157198758596;999;1006.9446180460145;14831.319222065194;15039.624009399853;15220.315085821165;15287.847121528865;15335.30991105403;390177;394782;399397;399451;399705;48825.267620985716;49776.75111624419;49905.75047124741;49997.50012499433;50155.74922125439;1188.1267268557604;1205.5539450403232;1210.1891732539043;1220.127608759741;1220.780259553289;26840.32899177536;27659.170224893285;27809.185161509613;28089;28197.71802281951;41948;42220.36669449899;42306.15387692167;42365;42475.15049699051;333700;338840;340171;340606;340928;24522.632160517962;24982.875085624455;25070.874645626656;25076.498470030863;25086.121985730413;41330.586694133875;41857.581424185366;41922.58077419187;42162.156756865304;42762;36534.45198321974;36579.085522861074;36825.63174368329;36882.8155859219;37704.245915080995;35639.64360356467;36956.7825930445;37096.44355334618;37169;37367.439488408236;33857.83071084629;35518.46722299219;35519.11202219965;36570.8171459141;39344;31213.375732485678;32259.35481290314;32444.35111297808;32459;32722;24814.25557233286;25021.249362519153;25169.49661006733;25462.68985031934;25671.87164064168 06:34:01 INFO - PROCESS | 12360 | |2;jquery.html;373.132467014192;373.78133791731835;375.36188479584706;386.8897364251189;388.9630485103916;15675.686486270268;15948.920255398722;17031.233594488247;17050.317987280527;17080.487585372444;15509.146996915166;15749.763753543706;16503.669926601462;16586.004839709596;16660.333586656518;5013.122703526896;5216.921746173792;5218.086834803913;5228.633995620308;5228.92156617651;5051.646384753069;5130.38435387754;5172.844814655547;5183.041137389576;5204.9479505204845;5416.404195538487;5457.699826509541;5463;5490;5491.588130890199;5459.153831156157;5466.234727138204;5496.258005169291;5552.444755524456;5617.4944255016835;5408.702521361323;5433.673979561239;5441.972790136064;5455.890882182373;5457;12447.066470014784;15337.923310383489;19660;19972.901490418022;20215;1762.4536393717988;1980.5147738803942;1998.6802111662064;2053.7022131790955;2288.4050146961745;8946.821063578756;9080.909190908073;9215.400998935114;9304.8604270936;9491.050894910522;1601.5675767542698;1624.0336999485287;1665.2173478465102;1669.3739847557167;1696.6295477307187;62854.371456285306;64262;64860;66667.66666166687;69178;9686.515674216262;9912.405255684682;10072.294939354322;10145.746356341151;10414.21893357986;13518.121322114031;13778.65553361174;13823.654408639663;13838.169709817443;13908.235047072509;7112.25321341262;7368.447366447538;7463.290987356192;7549.131849837339;7582.848343033108;6989.860202795916;7064.43484521237;7086.574805511686;7145.92854071463;7204.207537170907;4284.785760711952;4344.3049112142535;4362.258416069276;4401.757903315284;4513.119941611354;1677.6309211973346;1737.800152982398;1753.6755700195504;1778.5642517583276;1781.0827423876715;845.7293666026935;872.6247713483136;873.9344549158711;874.5933141089297;946.9526523673926;16137.193140342935;16821.32714691423;16835.63014169045;16859.325626974784;16960.915195423942;842.9873551896726;849.7833052571679;868.769776009358;880.5465185429509;921.1663444582664;9166.22087122602;9499.810003799885;9547.856782148274;9589.90410095904;9610.423374597547;368348;400221;402965;406176;406452;52212.47787522152;78626;78759;80213.59893200497;81461.59269203617;879.3009557401881;884.5090974509209;893.5085702863399;910.2990697163148;921.2998121427763;14550.511116981566;14811.703765924405;14911.62720931942;14913.04025135458;15174.924125379302;27000.054998074975;30012.549811753277;34247.48628770521;34633.65366346304;37216.813915930245;45531.77234113941;47215.29177062278;50821.49178508168;51340;52101.21848172356;7257.52826066304;7616.885746713914;7628.313451789366;7674.270944260286;7703.653335599799;9659;11125.44372781374;11425.085993120696;11434;11451.942740286246;9813.165880900204;9895.109440150422;10049.849252261076;10051.346662466916;10197.13324367437;10088.192944564564;10188.847167292348;10223.7444063899;10327.173826093744;10363.896361036293;9500.90499095028;9659.32384733062;9948.303618746619;9951.353162044445;10181.74545636365;7501.437392195498;7675;7686.461947663834;7713.7685869424;7754.069511658637;7562.848743025219;8804.515751633722;9762.658306959222;9832.213422926292;9943.254255930979 06:34:01 INFO - PROCESS | 12360 | |3;mootools.html;1399.3772771116853;1425.9643508912277;1528.388644542183;1678.33705686254;1705.9488215353529;7014.96492517538;7508.436867234966;7606.201348858373;8098.757037288883;8107.148749381318;7601.049868766404;7849.9402580651595;7873.842523149534;7885.369170466363;7901.288884000439;2203.2068455356057;2233.55328934213;2235.7987781099696;2239.473723674935;2249.2914731859496;2166.3500949715103;2185.4208634711813;2219.1678120704737;2220.733511978565;2229;2194.7585765565773;2199.098369668436;2199.83501237407;2210.812080973119;2211.3034394165866;2180.4221881201493;2184.8201970935675;2196.428928478591;2198.9010494527706;2199.3951663292723;1883.4820424383267;1884.1427150646423;1886.8773080017368;1891.6311319292743;1897.2411035585737;7871.448998570102;7890.289873911375;7955.045394552633;7973.162817904153;7982.521048737094;4662.277347011219;4808.2547205183255;4815.036992601494;4821.807127714887;4833.685810422311;3010.9247268818453;3075.200447883544;3096.9535456968165;3102.867453379523;3128.0772172209254;934.2525979216599;980.7401038724744;1000.2847963705913;1000.6597756762662;1000.8648832407605;11054.170937179744;11060.944695276552;11064;11077.889221107765;11131.387773672444;4262.6376757975295;4380.496242932039;4456.9108617828115;4467.977660111744;4471.977640111779;9340.065993400742;9403.623855045722;9421.858672119924;9450.102240287162;9462.52687365629;4798.2802579613335;4808.975955120272;4831.106245344622;4835.226363781778;4851.054044461296;3755.3615885299564;4274.722143060691;4359.476862776487;4396.120775844844;4426.955730442654;3692.446133080006;3698.1679122197293;3759.436084587334;3774.9811250944117;3813.161104556993;1218.141210446633;1233.8704436034266;1235.116891422637;1238.2879844089684;1238.7150955280335;678.4165617568887;760.1790066727921;790.4585359029084;808.4664121679781;832.6211573733937;5165.450364890593;5198.2722418861385;5329.54698850602;5336.306280183551;5387.488188622075;816.4285000499674;841.5665932045001;844.5312851367427;859.6475445067617;889.857622780365;3525.9823700881843;3656.287024030342;3677.154254521475;3713.8514459421863;3742.7941463219786;9773.46245956465;9987.750306242402;10061.34601250931;10096.949515252376;10156.593736250616;10056.34633748804;10098.293119481712;10103.646372376932;10114.949425252827;10132.797344053226;7293.197748247689;7672.42456815741;7687.154413014564;7709.190534993857;7719.305262526287;4975.677553856759;5112.437631860566;5145.614078944169;5258;5294.947050529599;9326.906730932875;9332.860007099764;9414.2468602513;9438.197753191056;9462.858057129286;9090.954545227232;9472.905270947478;9577;9585.520723963913;9607.807843842944;6490.286068532363;6593.80218593443;6689.899651505134;6716.597004179765;6753.763618273337;7363.153237377556;7379.704811807467;7381.557106573623;7387.704491820482;7420.851582968203;6799.388055075067;6811.829704257433;6926.411255043176;7073.469489788184;7107.395871350786;6905.1713794342995;6925.515213934977;6964.965175174092;7060.188078371053;7081.82295442618;5940.8811823764145;6000.579959402975;6005.6396616203165;6009.489193418608;6011.158437818796;4332.848350307724;4345.608895199447;4352.194843953878;4370.453693288339;4401.009772801094;4365.716228445141;4484.596386325246;4486.102779444059;4536.4102666653125;4550.158220729176 06:34:01 INFO - PROCESS | 12360 | |4;prototype.html;303.7008546581618;308.48791006928496;313.08266778339464;314.52506714860556;317.35893495139817;4919.680220785646;5023.182381390143;5029.371328583922;5189.169732842751;5191.480851914811;4990.950090499103;5044.82343117991;5048.444671086178;5061.974690126544;5075.593952483801;3929.5088113985753;3932.5280966284085;3989.8204580793936;3992.600739925999;3998.2403343364667;3868.207017561393;3963.7819919904396;3975.5428125765475;4000.7599544027307;4003.219372222418;3912.376363809016;3926.5877082906313;3927.4894263745814;3931.4495970564144;3931.8034098295116;3865.8260378283044;3903.5901230370687;3905.863294784669;3921.901952451183;3922.37242041272;3439.9312013759836;3440.2603440260464;3446.8621255149765;3459.9827000865084;3464.6535346465403;4883.1698611235815;4892.5077851255355;4988.950110498921;5000.2499625056535;5036.992601479682;4497.617702495292;4529.320601909707;4529.660275479319;4541.954580454186;4545.477270113946;5373.3014708088085;5379.919301210485;5383.353997520284;5384.246205531229;5387.4073851876265;3643.1784107946028;3706.054955986206;3757.4176002719623;3782.8108594570162;3827.8660246891227;5590.161475778625;5614.7647517546075;5632.436756324376;5639.887202255973;5681.630694004918;3850.614938506127;3868.458415821787;3870.6129387061633;3874.3219936511;3883.572806991229;3638.599754027055;3871.109644781716;3905.941410878839;3922.666573341241;3934.3311637021775;4430;4438.844640437634;4475.172093162775;4498.932516012263;4499.212637788374;5327.227552004938;5352.277442545284;5416.864578385572;5422.511973922287;5449.427810079964;1292.6962163891478;1374.299107455205;1378.676011137382;1385.4804448331874;1390.5480718766441;887.600579739107;898.7956138774074;910.7814124610178;910.8815853938945;914.7987442762582;4155.397467367215;4163.791810409528;4204.474440694913;4223.936640950326;4250.766207858597;4843.975780121077;4850.733209673502;4863.708177509361;4882.048000639841;4926.78294767349;4166.354290055411;4255.191513612465;4255.510616279167;4265.829366825292;4269.188854117708;2556.961645575318;2618.7037416478965;2623.973760262411;2646.5765477523887;2652.8938842446087;4533.274676051816;4554.453465584151;4574.977125114353;4611.631069514431;4620.607248383925;4940.654154209171;4963.255511673278;4981.576565991932;4991.128326877421;5022.698638081727;4256.489221293403;4471.977640111779;4526.660500462479;4554.385158003627;4598.977005115087;4835.516448355136;4882.951170488392;4884.7069175849565;4889.486603906681;4943.281195342475;4790.185668436305;4794.448638406628;4795.160846851857;4822.8794280143275;4840.8789780254365;4399;4533.455985281787;4561.950751327147;4563.908721825478;4599.517050709761;3617.837197326074;3625.9093522662142;3633.7638053526434;3646.4684832371;3653.178034942223;4851.51484851512;4875.488073752347;4881.267809828554;4898.902021959612;5296.073187192303;5200.791968321376;5378.7579558920725;5382.246485491956;5385.299911011543;5390.51485366319;5343.572514198777;5352.652077614943;5356.526955087226;5371.254342338678;5397.946020539902;5122.974385128051;5269.57843372537;5279.498447647621;5282.366116066097;5290.629655924048;5364.919526207188;5374.785008599612;5398.757055932414;5415.48552887475;5426.891462170655;5251.553617942518;5268.341457317835;5306.575473961997;5316.388615309289;5321.228421878884 06:34:01 INFO - PROCESS | 12360 | |5;yui.html;666.8066260784376;710.6837457331486;735.5108852613013;742.6138408027825;768.0783060327605;12576.811347829778;13320.666983325422;13685.178889266626;13712.177269363832;13729.450821967135;12637.241765494076;12782.10525263232;12783.233006019645;12787.04097192712;12813.679658008554;619.5415392609459;764.6979443119965;772.8763397856344;789.8578255913933;790.324272746799;778.7040924448702;779.4855395439012;785.4148659248867;788.4796034617153;793.3970182661191;820.2084987986592;820.335528222139;823.0247157118804;824.5547404401616;826.5164878546058;812.3907069697726;816.9550674712889;823.0411570520337;823.555280148719;823.9711610093677;598.255172310472;598.7006496751624;599.0744300056423;600.2406955201674;601.629997551507;13594.660133496742;13809.654758631013;13822.723545529134;13878.444862205499;13880.93059534706;12872.22766634005;13408.128471649312;13728.931355343258;13886.93056534721;13920.860791392159;10925.142725736643;11050.502727377287;11054.170937179662;11141.220114591983;11161.49773260197;3456.412409890325;3470.7917524948584;3476.704480119193;3523.3834079036064;3582.337267605475;64143.358566414674;64293.35706642967;65545.3445465544;66167.33832661709;66407;10477.47612619366;10700.571977120828;10707.250492465608;10751.193660475496;10824.296420732628;20493.590128197353;20551.075201615964;20660.276890308767;20747.481312966996;21317.29461643065;6584.533794151393;7428.591427471541;7429.07136607924;7447.515911465737;7509.211532789088;3756.981215093907;3759.830807613664;3839.6736277416176;3873.748206366577;3882.6716692694013;2740.8629568521496;2867.5125228711167;2876.1515352970505;2880.8559572021313;2883.3656595548946;504.080053901631;507.0518131094876;510.6706174517415;511.7850502788763;515.7885267040496;425.7083897530202;548.56937304216;552.1524459953952;572.4904834697123;588.805694120939;7859.764207073797;7872.685092596346;8011.559364235023;8137.160162982231;8205.753827385188;541.7453796715538;553.7591147850698;554.689373950589;556.7605929450375;578.1530058464369;3774.9056273592832;3804.3722785740597;3805.657490825839;3928;3964.0684439156776;82338.58830705807;92824;94377;95641.52179239059;95855;76307.61846190845;78773;79724.60137699274;79910.20089799144;80345.59827200827;72260.63869680723;74179;74664;74692.62653686697;74743.25256747472;7229.277072292939;7376.114866216089;7522.398208143226;7686.500377475446;7743.186965368555;42982;43587.82075794918;44412.77793611011;44910.55089449064;45127.7743611293;56583.71708141433;59757.701211493666;61016;64011;65362;11546.59586914454;11570.363630000094;11574.305541667527;11613.535458581562;11744.58893938708;13017.934910325766;13354.283576505799;13445.731085378433;13469.730605387642;13546.417060003581;12002.526847757576;12241.938790305992;12304.938475307925;12656.240625562496;12685.302308372758;11573.18987670855;11777.705557361134;11945.880541194825;12482.126251162696;12493.125481216228;12062.215955962834;12154.817677735018;12311.261324320569;12332.753344933231;13103.410346534238;10219.94890025575;10350.482475876326;10448.947755261175;10952.507137179005;11196.04833589154;9617;9877.604895804086;10004.349717268355;10023.599056037678;10037.598496060076 06:34:01 INFO - PROCESS | 12360 | __end_tp_report 06:34:01 INFO - PROCESS | 12360 | __start_cc_report 06:34:01 INFO - PROCESS | 12360 | _x_x_mozilla_cycle_collect,397 06:34:01 INFO - PROCESS | 12360 | __end_cc_report 06:34:01 INFO - PROCESS | 12360 | __startTimestamp1466688841224__endTimestamp 06:34:01 INFO - PROCESS | 12360 | 06:34:01 INFO - PROCESS | 12360 | ------- Summary: start ------- 06:34:01 INFO - PROCESS | 12360 | Number of tests: 6 06:34:01 INFO - PROCESS | 12360 | 06:34:01 INFO - PROCESS | 12360 | [#0] dojo.html Cycles:165 Average:4895.00 Median:5035.52 stddev:544.84 (10.8%) stddev-sans-first:517.17 06:34:01 INFO - PROCESS | 12360 | Values: 2646.6 2687.7 2704.1 2707.6 2711.7 4682.1 4729.4 4758.7 4929.1 4954.7 4834.6 4910.2 4919.1 4922.5 5035.5 4440.3 4481.6 4491.4 4594.6 4670.1 4368.9 4507.8 4526.8 4567.3 4590.4 4469.4 4568.8 4600.4 4628.4 4645.2 4429.8 4480.2 4481.2 4488.7 4499.8 4478.0 4518.3 4532.4 4536.3 4563.9 4844.7 4897.1 4922.5 4939.4 4979.4 5361.8 5363.6 5364.7 5370.8 5398.5 5387.0 5396.3 5400.9 5408.6 5435.7 4868.6 4916.8 4943.8 4973.3 5002.7 5469.5 5494.0 5494.3 5498.5 5510.0 5196.6 5206.3 5209.2 5214.4 5279.2 5286.6 5300.7 5321.4 5355.6 5386.4 5183.6 5192.4 5212.9 5252.0 5267.9 5264.0 5272.6 5275.3 5276.8 5283.3 4365.9 4382.6 4407.3 4416.4 4501.3 3845.5 3847.7 3849.5 3887.7 3894.2 4509.2 4514.2 4518.1 4539.1 4605.0 5196.0 5292.0 5325.7 5347.1 5374.7 4557.4 4576.8 4580.7 4600.2 4605.1 4668.9 4778.9 4786.8 4798.1 4830.6 4892.6 4982.5 4997.2 5026.7 5038.8 5398.2 5404.1 5421.8 5424.4 5430.5 4869.5 5020.1 5032.4 5041.6 5074.0 5236.7 5288.4 5306.0 5317.1 5349.1 5355.0 5361.8 5372.1 5372.9 5437.5 5000.9 5073.5 5203.5 5227.1 5263.2 5120.2 5158.3 5171.2 5183.6 5235.5 5050.1 5093.8 5117.7 5136.2 5141.3 5093.5 5194.3 5210.3 5216.8 5229.8 5066.8 5098.1 5108.8 5121.2 5132.2 06:34:01 INFO - PROCESS | 12360 | 06:34:01 INFO - PROCESS | 12360 | [#1] ext.html Cycles:180 Average:46909.93 Median:20215.23 stddev:88771.64 (439.1%) stddev-sans-first:88952.32 06:34:01 INFO - PROCESS | 12360 | Values: 514.2 584.5 591.0 602.7 604.5 34324.3 37496.4 37540.8 38067.0 38280.6 37869.6 38302.0 38543.4 38646.8 38762.6 7785.9 7960.8 7962.6 7965.0 7970.2 7741.5 7830.9 7838.3 7871.4 7887.7 7882.2 7891.5 7894.5 7945.7 7978.3 7828.0 7840.6 7890.6 7895.2 7940.9 7762.6 7904.9 7906.6 7930.8 7946.1 36756.6 36880.6 36921.4 37053.8 37311.1 3295.3 3345.4 3659.0 3719.5 3776.2 28640.0 28719.4 28877.7 29195.4 29236.4 3500.8 3519.3 3588.3 3673.8 3685.8 257512.0 257980.0 258254.0 258607.0 259072.7 31672.5 32381.2 32416.4 34441.5 50047.5 33150.8 33166.0 33392.5 33413.2 33539.3 13684.1 13722.8 13723.0 13728.2 13781.4 11433.4 11465.4 11468.5 11494.1 11603.0 7790.9 7805.6 7820.3 7886.3 7919.3 3089.4 3134.0 3152.2 3158.1 3161.3 883.0 883.4 890.8 934.8 1003.0 27801.3 27993.4 28198.9 28333.9 28853.0 949.9 985.4 998.5 999.0 1006.9 14831.3 15039.6 15220.3 15287.8 15335.3 390177.0 394782.0 399397.0 399451.0 399705.0 48825.3 49776.8 49905.8 49997.5 50155.7 1188.1 1205.6 1210.2 1220.1 1220.8 26840.3 27659.2 27809.2 28089.0 28197.7 41948.0 42220.4 42306.2 42365.0 42475.2 333700.0 338840.0 340171.0 340606.0 340928.0 24522.6 24982.9 25070.9 25076.5 25086.1 41330.6 41857.6 41922.6 42162.2 42762.0 36534.5 36579.1 36825.6 36882.8 37704.2 35639.6 36956.8 37096.4 37169.0 37367.4 33857.8 35518.5 35519.1 36570.8 39344.0 31213.4 32259.4 32444.4 32459.0 32722.0 24814.3 25021.2 25169.5 25462.7 25671.9 06:34:01 INFO - PROCESS | 12360 | 06:34:01 INFO - PROCESS | 12360 | [#2] jquery.html Cycles:180 Average:23963.60 Median:28653.08 stddev:65416.81 (228.3%) stddev-sans-first:65576.34 06:34:01 INFO - PROCESS | 12360 | Values: 373.1 373.8 375.4 386.9 389.0 15675.7 15948.9 17031.2 17050.3 17080.5 15509.1 15749.8 16503.7 16586.0 16660.3 5013.1 5216.9 5218.1 5228.6 5228.9 5051.6 5130.4 5172.8 5183.0 5204.9 5416.4 5457.7 5463.0 5490.0 5491.6 5459.2 5466.2 5496.3 5552.4 5617.5 5408.7 5433.7 5442.0 5455.9 5457.0 12447.1 15337.9 19660.0 19972.9 20215.0 1762.5 1980.5 1998.7 2053.7 2288.4 8946.8 9080.9 9215.4 9304.9 9491.1 1601.6 1624.0 1665.2 1669.4 1696.6 62854.4 64262.0 64860.0 66667.7 69178.0 9686.5 9912.4 10072.3 10145.7 10414.2 13518.1 13778.7 13823.7 13838.2 13908.2 7112.3 7368.4 7463.3 7549.1 7582.8 6989.9 7064.4 7086.6 7145.9 7204.2 4284.8 4344.3 4362.3 4401.8 4513.1 1677.6 1737.8 1753.7 1778.6 1781.1 845.7 872.6 873.9 874.6 947.0 16137.2 16821.3 16835.6 16859.3 16960.9 843.0 849.8 868.8 880.5 921.2 9166.2 9499.8 9547.9 9589.9 9610.4 368348.0 400221.0 402965.0 406176.0 406452.0 52212.5 78626.0 78759.0 80213.6 81461.6 879.3 884.5 893.5 910.3 921.3 14550.5 14811.7 14911.6 14913.0 15174.9 27000.1 30012.5 34247.5 34633.7 37216.8 45531.8 47215.3 50821.5 51340.0 52101.2 7257.5 7616.9 7628.3 7674.3 7703.7 9659.0 11125.4 11425.1 11434.0 11451.9 9813.2 9895.1 10049.8 10051.3 10197.1 10088.2 10188.8 10223.7 10327.2 10363.9 9500.9 9659.3 9948.3 9951.4 10181.7 7501.4 7675.0 7686.5 7713.8 7754.1 7562.8 8804.5 9762.7 9832.2 9943.3 06:34:01 INFO - PROCESS | 12360 | 06:34:01 INFO - PROCESS | 12360 | [#3] mootools.html Cycles:180 Average:5239.54 Median:4818.42 stddev:2989.30 (62.0%) stddev-sans-first:2983.75 06:34:01 INFO - PROCESS | 12360 | Values: 1399.4 1426.0 1528.4 1678.3 1705.9 7015.0 7508.4 7606.2 8098.8 8107.1 7601.0 7849.9 7873.8 7885.4 7901.3 2203.2 2233.6 2235.8 2239.5 2249.3 2166.4 2185.4 2219.2 2220.7 2229.0 2194.8 2199.1 2199.8 2210.8 2211.3 2180.4 2184.8 2196.4 2198.9 2199.4 1883.5 1884.1 1886.9 1891.6 1897.2 7871.4 7890.3 7955.0 7973.2 7982.5 4662.3 4808.3 4815.0 4821.8 4833.7 3010.9 3075.2 3097.0 3102.9 3128.1 934.3 980.7 1000.3 1000.7 1000.9 11054.2 11060.9 11064.0 11077.9 11131.4 4262.6 4380.5 4456.9 4468.0 4472.0 9340.1 9403.6 9421.9 9450.1 9462.5 4798.3 4809.0 4831.1 4835.2 4851.1 3755.4 4274.7 4359.5 4396.1 4427.0 3692.4 3698.2 3759.4 3775.0 3813.2 1218.1 1233.9 1235.1 1238.3 1238.7 678.4 760.2 790.5 808.5 832.6 5165.5 5198.3 5329.5 5336.3 5387.5 816.4 841.6 844.5 859.6 889.9 3526.0 3656.3 3677.2 3713.9 3742.8 9773.5 9987.8 10061.3 10096.9 10156.6 10056.3 10098.3 10103.6 10114.9 10132.8 7293.2 7672.4 7687.2 7709.2 7719.3 4975.7 5112.4 5145.6 5258.0 5294.9 9326.9 9332.9 9414.2 9438.2 9462.9 9091.0 9472.9 9577.0 9585.5 9607.8 6490.3 6593.8 6689.9 6716.6 6753.8 7363.2 7379.7 7381.6 7387.7 7420.9 6799.4 6811.8 6926.4 7073.5 7107.4 6905.2 6925.5 6965.0 7060.2 7081.8 5940.9 6000.6 6005.6 6009.5 6011.2 4332.8 4345.6 4352.2 4370.5 4401.0 4365.7 4484.6 4486.1 4536.4 4550.2 06:34:01 INFO - PROCESS | 12360 | 06:34:01 INFO - PROCESS | 12360 | [#4] prototype.html Cycles:180 Average:4255.22 Median:4586.98 stddev:1232.98 (26.9%) stddev-sans-first:1200.23 06:34:01 INFO - PROCESS | 12360 | Values: 303.7 308.5 313.1 314.5 317.4 4919.7 5023.2 5029.4 5189.2 5191.5 4991.0 5044.8 5048.4 5062.0 5075.6 3929.5 3932.5 3989.8 3992.6 3998.2 3868.2 3963.8 3975.5 4000.8 4003.2 3912.4 3926.6 3927.5 3931.4 3931.8 3865.8 3903.6 3905.9 3921.9 3922.4 3439.9 3440.3 3446.9 3460.0 3464.7 4883.2 4892.5 4989.0 5000.2 5037.0 4497.6 4529.3 4529.7 4542.0 4545.5 5373.3 5379.9 5383.4 5384.2 5387.4 3643.2 3706.1 3757.4 3782.8 3827.9 5590.2 5614.8 5632.4 5639.9 5681.6 3850.6 3868.5 3870.6 3874.3 3883.6 3638.6 3871.1 3905.9 3922.7 3934.3 4430.0 4438.8 4475.2 4498.9 4499.2 5327.2 5352.3 5416.9 5422.5 5449.4 1292.7 1374.3 1378.7 1385.5 1390.5 887.6 898.8 910.8 910.9 914.8 4155.4 4163.8 4204.5 4223.9 4250.8 4844.0 4850.7 4863.7 4882.0 4926.8 4166.4 4255.2 4255.5 4265.8 4269.2 2557.0 2618.7 2624.0 2646.6 2652.9 4533.3 4554.5 4575.0 4611.6 4620.6 4940.7 4963.3 4981.6 4991.1 5022.7 4256.5 4472.0 4526.7 4554.4 4599.0 4835.5 4883.0 4884.7 4889.5 4943.3 4790.2 4794.4 4795.2 4822.9 4840.9 4399.0 4533.5 4562.0 4563.9 4599.5 3617.8 3625.9 3633.8 3646.5 3653.2 4851.5 4875.5 4881.3 4898.9 5296.1 5200.8 5378.8 5382.2 5385.3 5390.5 5343.6 5352.7 5356.5 5371.3 5397.9 5123.0 5269.6 5279.5 5282.4 5290.6 5364.9 5374.8 5398.8 5415.5 5426.9 5251.6 5268.3 5306.6 5316.4 5321.2 06:34:01 INFO - PROCESS | 12360 | 06:34:01 INFO - PROCESS | 12360 | [#5] yui.html Cycles:180 Average:17708.83 Median:44000.30 stddev:24540.67 (55.8%) stddev-sans-first:24576.15 06:34:01 INFO - PROCESS | 12360 | Values: 666.8 710.7 735.5 742.6 768.1 12576.8 13320.7 13685.2 13712.2 13729.5 12637.2 12782.1 12783.2 12787.0 12813.7 619.5 764.7 772.9 789.9 790.3 778.7 779.5 785.4 788.5 793.4 820.2 820.3 823.0 824.6 826.5 812.4 817.0 823.0 823.6 824.0 598.3 598.7 599.1 600.2 601.6 13594.7 13809.7 13822.7 13878.4 13880.9 12872.2 13408.1 13728.9 13886.9 13920.9 10925.1 11050.5 11054.2 11141.2 11161.5 3456.4 3470.8 3476.7 3523.4 3582.3 64143.4 64293.4 65545.3 66167.3 66407.0 10477.5 10700.6 10707.3 10751.2 10824.3 20493.6 20551.1 20660.3 20747.5 21317.3 6584.5 7428.6 7429.1 7447.5 7509.2 3757.0 3759.8 3839.7 3873.7 3882.7 2740.9 2867.5 2876.2 2880.9 2883.4 504.1 507.1 510.7 511.8 515.8 425.7 548.6 552.2 572.5 588.8 7859.8 7872.7 8011.6 8137.2 8205.8 541.7 553.8 554.7 556.8 578.2 3774.9 3804.4 3805.7 3928.0 3964.1 82338.6 92824.0 94377.0 95641.5 95855.0 76307.6 78773.0 79724.6 79910.2 80345.6 72260.6 74179.0 74664.0 74692.6 74743.3 7229.3 7376.1 7522.4 7686.5 7743.2 42982.0 43587.8 44412.8 44910.6 45127.8 56583.7 59757.7 61016.0 64011.0 65362.0 11546.6 11570.4 11574.3 11613.5 11744.6 13017.9 13354.3 13445.7 13469.7 13546.4 12002.5 12241.9 12304.9 12656.2 12685.3 11573.2 11777.7 11945.9 12482.1 12493.1 12062.2 12154.8 12311.3 12332.8 13103.4 10219.9 10350.5 10448.9 10952.5 11196.0 9617.0 9877.6 10004.3 10023.6 10037.6 06:34:01 INFO - PROCESS | 12360 | -------- Summary: end -------- 06:34:01 INFO - PROCESS | 12360 | 06:34:02 INFO - TEST-INFO | 12360: exit 0 06:34:02 INFO - TEST-OK | dromaeo_css | took 1116461ms 06:34:02 INFO - TEST-START | kraken 06:34:02 INFO - operating with platform_type : linux_ 06:34:02 INFO - Initialising browser for kraken test... 06:34:02 INFO - TEST-INFO | started process 12599 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxeDinB/profile http://localhost:43012/getInfo.html) 06:34:06 INFO - PROCESS | 12599 | __metrics Screen width/height:1600/1200 06:34:06 INFO - PROCESS | 12599 | colorDepth:24 06:34:06 INFO - PROCESS | 12599 | Browser inner width/height: 1024/697 06:34:06 INFO - PROCESS | 12599 | __metrics 06:34:07 ERROR - PROCESS | 12599 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 06:34:08 INFO - TEST-INFO | 12599: exit 0 06:34:08 INFO - Browser initialized. 06:34:08 INFO - Running cycle 1/1 for kraken test... 06:34:08 INFO - TEST-INFO | started process 12718 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxeDinB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:34:20 INFO - PROCESS | 12718 | RSS: Main: 186245120 06:34:20 INFO - PROCESS | 12718 | 06:34:22 INFO - PROCESS | 12718 | Cycle 1(1): loaded http://localhost:43012/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43012/tests/kraken/driver.html?testName=audio-beat-detection) 06:34:23 INFO - PROCESS | 12718 | RSS: Main: 191135744 06:34:23 INFO - PROCESS | 12718 | 06:34:26 INFO - PROCESS | 12718 | Cycle 1(1): loaded http://localhost:43012/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43012/tests/kraken/driver.html?testName=audio-dft) 06:34:27 INFO - PROCESS | 12718 | RSS: Main: 190947328 06:34:27 INFO - PROCESS | 12718 | 06:34:30 INFO - PROCESS | 12718 | Cycle 1(1): loaded http://localhost:43012/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43012/tests/kraken/driver.html?testName=audio-fft) 06:34:30 INFO - PROCESS | 12718 | RSS: Main: 186220544 06:34:30 INFO - PROCESS | 12718 | 06:34:33 INFO - PROCESS | 12718 | Cycle 1(1): loaded http://localhost:43012/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43012/tests/kraken/driver.html?testName=audio-oscillator) 06:34:33 INFO - PROCESS | 12718 | RSS: Main: 186699776 06:34:33 INFO - PROCESS | 12718 | 06:34:35 INFO - PROCESS | 12718 | Cycle 1(1): loaded http://localhost:43012/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43012/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:34:36 INFO - PROCESS | 12718 | RSS: Main: 187043840 06:34:36 INFO - PROCESS | 12718 | 06:34:39 INFO - PROCESS | 12718 | Cycle 1(1): loaded http://localhost:43012/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43012/tests/kraken/driver.html?testName=imaging-darkroom) 06:34:40 INFO - PROCESS | 12718 | RSS: Main: 187113472 06:34:40 INFO - PROCESS | 12718 | 06:34:43 INFO - PROCESS | 12718 | Cycle 1(1): loaded http://localhost:43012/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43012/tests/kraken/driver.html?testName=imaging-desaturate) 06:34:44 INFO - PROCESS | 12718 | RSS: Main: 184524800 06:34:44 INFO - PROCESS | 12718 | 06:34:47 INFO - PROCESS | 12718 | Cycle 1(1): loaded http://localhost:43012/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43012/tests/kraken/driver.html?testName=json-parse-financial) 06:34:48 INFO - PROCESS | 12718 | RSS: Main: 186789888 06:34:48 INFO - PROCESS | 12718 | 06:34:49 INFO - PROCESS | 12718 | Cycle 1(1): loaded http://localhost:43012/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43012/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:34:50 INFO - PROCESS | 12718 | RSS: Main: 187076608 06:34:50 INFO - PROCESS | 12718 | 06:34:52 INFO - PROCESS | 12718 | Cycle 1(1): loaded http://localhost:43012/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43012/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:34:53 INFO - PROCESS | 12718 | RSS: Main: 186793984 06:34:53 INFO - PROCESS | 12718 | 06:34:55 INFO - PROCESS | 12718 | Cycle 1(1): loaded http://localhost:43012/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43012/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:34:56 INFO - PROCESS | 12718 | RSS: Main: 187240448 06:34:56 INFO - PROCESS | 12718 | 06:34:58 INFO - PROCESS | 12718 | Cycle 1(1): loaded http://localhost:43012/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43012/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:34:59 INFO - PROCESS | 12718 | RSS: Main: 187080704 06:34:59 INFO - PROCESS | 12718 | 06:35:02 INFO - PROCESS | 12718 | Cycle 1(1): loaded http://localhost:43012/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43012/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:35:03 INFO - PROCESS | 12718 | RSS: Main: 187129856 06:35:03 INFO - PROCESS | 12718 | 06:35:04 INFO - PROCESS | 12718 | Cycle 1(1): loaded http://localhost:43012/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43012/tests/kraken/driver.html?testName=ai-astar) 06:35:05 INFO - PROCESS | 12718 | RSS: Main: 188133376 06:35:05 INFO - PROCESS | 12718 | 06:35:05 INFO - PROCESS | 12718 | __start_tp_report 06:35:05 INFO - PROCESS | 12718 | _x_x_mozilla_page_load 06:35:05 INFO - PROCESS | 12718 | _x_x_mozilla_page_load_details 06:35:05 INFO - PROCESS | 12718 | |i|pagename|runs| 06:35:05 INFO - PROCESS | 12718 | |0;ai-astar;105;114;105;115;114;115;116;114;114;113 06:35:05 INFO - PROCESS | 12718 | |1;audio-beat-detection;158;132;158;180;133;164;178;132;202;132 06:35:05 INFO - PROCESS | 12718 | |2;audio-dft;167;167;168;162;161;163;166;164;163;163 06:35:05 INFO - PROCESS | 12718 | |3;audio-fft;75;75;85;169;77;76;82;77;164;76 06:35:05 INFO - PROCESS | 12718 | |4;audio-oscillator;88;86;135;87;86;88;131;87;86;141 06:35:05 INFO - PROCESS | 12718 | |5;imaging-gaussian-blur;118;119;119;123;117;118;119;118;117;118 06:35:05 INFO - PROCESS | 12718 | |6;imaging-darkroom;151;149;148;147;148;147;147;147;147;147 06:35:05 INFO - PROCESS | 12718 | |7;imaging-desaturate;95;96;97;96;96;96;100;96;96;96 06:35:05 INFO - PROCESS | 12718 | |8;json-parse-financial;63;63;63;63;62;64;64;64;62;64 06:35:05 INFO - PROCESS | 12718 | |9;json-stringify-tinderbox;64;65;64;65;65;66;64;65;66;65 06:35:05 INFO - PROCESS | 12718 | |10;stanford-crypto-aes;89;83;81;82;84;83;84;83;111;81 06:35:05 INFO - PROCESS | 12718 | |11;stanford-crypto-ccm;147;144;144;130;135;141;145;143;135;141 06:35:05 INFO - PROCESS | 12718 | |12;stanford-crypto-pbkdf2;183;172;171;178;172;170;175;178;171;172 06:35:05 INFO - PROCESS | 12718 | |13;stanford-crypto-sha256-iterative;67;69;68;68;70;68;72;70;71;66 06:35:05 INFO - PROCESS | 12718 | __end_tp_report 06:35:05 INFO - PROCESS | 12718 | __start_cc_report 06:35:05 INFO - PROCESS | 12718 | _x_x_mozilla_cycle_collect,975 06:35:05 INFO - PROCESS | 12718 | __end_cc_report 06:35:05 INFO - PROCESS | 12718 | __startTimestamp1466688905029__endTimestamp 06:35:05 INFO - PROCESS | 12718 | 06:35:05 INFO - PROCESS | 12718 | ------- Summary: start ------- 06:35:05 INFO - PROCESS | 12718 | Number of tests: 14 06:35:05 INFO - PROCESS | 12718 | 06:35:05 INFO - PROCESS | 12718 | [#0] ai-astar Cycles:10 Average:112.50 Median:114.00 stddev:4.03 (3.5%) stddev-sans-first:3.24 06:35:05 INFO - PROCESS | 12718 | Values: 105.0 114.0 105.0 115.0 114.0 115.0 116.0 114.0 114.0 113.0 06:35:05 INFO - PROCESS | 12718 | 06:35:05 INFO - PROCESS | 12718 | [#1] audio-beat-detection Cycles:10 Average:156.90 Median:161.00 stddev:24.71 (15.4%) stddev-sans-first:26.21 06:35:05 INFO - PROCESS | 12718 | Values: 158.0 132.0 158.0 180.0 133.0 164.0 178.0 132.0 202.0 132.0 06:35:05 INFO - PROCESS | 12718 | 06:35:05 INFO - PROCESS | 12718 | [#2] audio-dft Cycles:10 Average:164.40 Median:165.00 stddev:2.41 (1.5%) stddev-sans-first:2.37 06:35:05 INFO - PROCESS | 12718 | Values: 167.0 167.0 168.0 162.0 161.0 163.0 166.0 164.0 163.0 163.0 06:35:05 INFO - PROCESS | 12718 | 06:35:05 INFO - PROCESS | 12718 | [#3] audio-fft Cycles:10 Average:95.60 Median:76.50 stddev:37.52 (49.1%) stddev-sans-first:39.05 06:35:05 INFO - PROCESS | 12718 | Values: 75.0 75.0 85.0 169.0 77.0 76.0 82.0 77.0 164.0 76.0 06:35:05 INFO - PROCESS | 12718 | 06:35:05 INFO - PROCESS | 12718 | [#4] audio-oscillator Cycles:10 Average:101.50 Median:86.50 stddev:23.71 (27.4%) stddev-sans-first:24.64 06:35:05 INFO - PROCESS | 12718 | Values: 88.0 86.0 135.0 87.0 86.0 88.0 131.0 87.0 86.0 141.0 06:35:05 INFO - PROCESS | 12718 | 06:35:05 INFO - PROCESS | 12718 | [#5] imaging-gaussian-blur Cycles:10 Average:118.60 Median:118.50 stddev:1.71 (1.4%) stddev-sans-first:1.80 06:35:05 INFO - PROCESS | 12718 | Values: 118.0 119.0 119.0 123.0 117.0 118.0 119.0 118.0 117.0 118.0 06:35:05 INFO - PROCESS | 12718 | 06:35:05 INFO - PROCESS | 12718 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:147.50 stddev:1.32 (0.9%) stddev-sans-first:0.73 06:35:05 INFO - PROCESS | 12718 | Values: 151.0 149.0 148.0 147.0 148.0 147.0 147.0 147.0 147.0 147.0 06:35:05 INFO - PROCESS | 12718 | 06:35:05 INFO - PROCESS | 12718 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:1.35 (1.4%) stddev-sans-first:1.33 06:35:05 INFO - PROCESS | 12718 | Values: 95.0 96.0 97.0 96.0 96.0 96.0 100.0 96.0 96.0 96.0 06:35:05 INFO - PROCESS | 12718 | 06:35:05 INFO - PROCESS | 12718 | [#8] json-parse-financial Cycles:10 Average:63.20 Median:63.50 stddev:0.79 (1.2%) stddev-sans-first:0.83 06:35:05 INFO - PROCESS | 12718 | Values: 63.0 63.0 63.0 63.0 62.0 64.0 64.0 64.0 62.0 64.0 06:35:05 INFO - PROCESS | 12718 | 06:35:05 INFO - PROCESS | 12718 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 06:35:05 INFO - PROCESS | 12718 | Values: 64.0 65.0 64.0 65.0 65.0 66.0 64.0 65.0 66.0 65.0 06:35:05 INFO - PROCESS | 12718 | 06:35:05 INFO - PROCESS | 12718 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:83.00 stddev:9.04 (10.9%) stddev-sans-first:9.52 06:35:05 INFO - PROCESS | 12718 | Values: 89.0 83.0 81.0 82.0 84.0 83.0 84.0 83.0 111.0 81.0 06:35:05 INFO - PROCESS | 12718 | 06:35:05 INFO - PROCESS | 12718 | [#11] stanford-crypto-ccm Cycles:10 Average:140.50 Median:143.50 stddev:5.42 (3.8%) stddev-sans-first:5.21 06:35:05 INFO - PROCESS | 12718 | Values: 147.0 144.0 144.0 130.0 135.0 141.0 145.0 143.0 135.0 141.0 06:35:05 INFO - PROCESS | 12718 | 06:35:05 INFO - PROCESS | 12718 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.20 Median:173.50 stddev:4.21 (2.4%) stddev-sans-first:3.03 06:35:05 INFO - PROCESS | 12718 | Values: 183.0 172.0 171.0 178.0 172.0 170.0 175.0 178.0 171.0 172.0 06:35:05 INFO - PROCESS | 12718 | 06:35:05 INFO - PROCESS | 12718 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.50 stddev:1.85 (2.7%) stddev-sans-first:1.83 06:35:05 INFO - PROCESS | 12718 | Values: 67.0 69.0 68.0 68.0 70.0 68.0 72.0 70.0 71.0 66.0 06:35:05 INFO - PROCESS | 12718 | -------- Summary: end -------- 06:35:05 INFO - PROCESS | 12718 | 06:35:05 INFO - TEST-INFO | 12718: exit 0 06:35:06 INFO - TEST-OK | kraken | took 64020ms 06:35:06 INFO - SUITE-END | took 1180s 06:35:06 INFO - Completed test suite (00:19:40) 06:35:06 INFO - javascript benchmark 06:35:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6411.398092034429, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2646.5500864852975, 2687.6909155447124, 2704.1211606227967, 2707.553253713136, 2711.6881558620767, 4682.063587282544, 4729.408823897013, 4758.6906851054655, 4929.112759703252, 4954.653174277802, 4834.564889159975, 4910.2143657014885, 4919.089968355847, 4922.532359425858, 5035.521625445586, 4440.333949907507, 4481.596656300932, 4491.438570178736, 4594.58648721615, 4670.1126785910565, 4368.912621747563, 4507.774611269439, 4526.841560545382, 4567.287267274772, 4590.42619672541, 4469.396631454777, 4568.817247310104, 4600.401947746805, 4628.352030715702, 4645.210314246586, 4429.7785110744335, 4480.19356515827, 4481.2381895077915, 4488.685791994561, 4499.842505512324, 4477.977610111961, 4518.344839998214, 4532.365468834366, 4536.251518499444, 4563.904662880885, 4844.66087373884, 4897.069556784199, 4922.507749225085, 4939.382577177853, 4979.427365852937, 5361.839144825662, 5363.597730170253, 5364.7317634118135, 5370.812021579265, 5398.514133727944, 5387.0, 5396.298481197458, 5400.919816036809, 5408.648437851527, 5435.701036442994, 4868.561829435333, 4916.778744956486, 4943.826966056171, 4973.2540118981715, 5002.7498625068965, 5469.535089517356, 5493.972530137324, 5494.2857428534035, 5498.505134537911, 5509.972450137804, 5196.558292545101, 5206.323177986837, 5209.244659524424, 5214.374275087014, 5279.208118782213, 5286.629935904527, 5300.655457395257, 5321.441248668834, 5355.598330125256, 5386.407495175527, 5183.585313174937, 5192.402873669501, 5212.869678257998, 5252.0, 5267.868303292448, 5263.973680131651, 5272.578193744491, 5275.258906892606, 5276.788928442819, 5283.260343551906, 4365.9126817463475, 4382.649388048949, 4407.2507673695545, 4416.403785488982, 4501.279795232747, 3845.5000849889334, 3847.6537111660086, 3849.4995650565247, 3887.6695480883877, 3894.162755007687, 4509.210888094636, 4514.164879497303, 4518.118966801442, 4539.114872599877, 4605.032943081923, 5196.038732834438, 5291.99452104099, 5325.707086110301, 5347.0909945309395, 5374.677519348774, 4557.430321209848, 4576.839810606612, 4580.702254353457, 4600.171969045604, 4605.102005108972, 4668.85993420198, 4778.900852803805, 4786.7845946932475, 4798.064377446434, 4830.589399900978, 4892.608591312686, 4982.52665996737, 4997.150484417731, 5026.698398096126, 5038.773255203451, 5398.2442458056685, 5404.081306178038, 5421.83734487966, 5424.3761967372675, 5430.51125398716, 4869.537393947569, 5020.146575082172, 5032.3961124665275, 5041.621878359065, 5073.974630126826, 5236.659617124875, 5288.3918349390315, 5306.0, 5317.096093664164, 5349.063913814989, 5355.0, 5361.812336568201, 5372.086745253395, 5372.946270537401, 5437.510624043855, 5000.874978125576, 5073.467285934924, 5203.453637368173, 5227.137522308776, 5263.157894736823, 5120.18077107661, 5158.329417175743, 5171.224316352577, 5183.5593974512585, 5235.476452354734, 5050.065737838511, 5093.7707803148205, 5117.692938423706, 5136.178211486144, 5141.28022076902, 5093.541581257705, 5194.298769666047, 5210.27056212123, 5216.843494695166, 5229.849433124707, 5066.797328106834, 5098.107831129611, 5108.795648174031, 5121.180611102355, 5132.204508301219], "value": 4858.037427940566, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [514.2293277493898, 584.4593750780527, 591.0, 602.6805792929749, 604.474107526452, 34324.313513729714, 37496.437553436655, 37540.81229593855, 38067.0, 38280.61719382809, 37869.62130378695, 38302.04244893879, 38543.42184867229, 38646.80676596613, 38762.61237387632, 7785.922140778576, 7960.840783184332, 7962.601869906482, 7965.0, 7970.163132871052, 7741.496802707834, 7830.882536761953, 7838.255365740246, 7871.448998570102, 7887.684492620288, 7882.172371900954, 7891.526508409485, 7894.526328420285, 7945.72189973351, 7978.281954624083, 7827.960860195691, 7840.568768717718, 7890.605469726519, 7895.210478952116, 7940.880886786645, 7762.573058481781, 7904.920950790476, 7906.565138917357, 7930.841383172305, 7946.125926148119, 36756.632433675586, 36880.631193688256, 36921.44617830735, 37053.81473092617, 37311.06722331936, 3295.2915123248376, 3345.381104495652, 3658.963410365889, 3719.479272901796, 3776.169242766587, 28640.0, 28719.425611487863, 28877.711222887712, 29195.41609167826, 29236.41527169466, 3500.7549471537004, 3519.278547897675, 3588.3361578107874, 3673.834677439522, 3685.7788532688123, 257512.0, 257980.0, 258254.0, 258607.0, 259072.7046364775, 31672.524912126337, 32381.19047023796, 32416.351672966408, 34441.483377749355, 50047.49952500501, 33150.83424582861, 33166.0, 33392.49911251333, 33413.16467088342, 33539.32921341559, 13684.110532815335, 13722.794158087636, 13723.0, 13728.244946528037, 13781.379837907318, 11433.428328583537, 11465.369404682822, 11468.4839182237, 11494.13793965456, 11603.0, 7790.922090779133, 7805.609719514002, 7820.335271501986, 7886.3296619786815, 7919.2872641462545, 3089.382123575249, 3133.9529907051415, 3152.1961899715425, 3158.0999415167025, 3161.2729072313496, 882.9911700883038, 883.4213590098367, 890.7817584691662, 934.7562068210385, 1003.0339293605838, 27801.304967375574, 27993.44013119726, 28198.85900570484, 28333.858330708626, 28853.0, 949.9002604726543, 985.4186030242048, 998.5157198758596, 999.0, 1006.9446180460145, 14831.319222065194, 15039.624009399853, 15220.315085821165, 15287.847121528865, 15335.30991105403, 390177.0, 394782.0, 399397.0, 399451.0, 399705.0, 48825.267620985716, 49776.75111624419, 49905.75047124741, 49997.50012499433, 50155.74922125439, 1188.1267268557604, 1205.5539450403232, 1210.1891732539043, 1220.127608759741, 1220.780259553289, 26840.32899177536, 27659.170224893285, 27809.185161509613, 28089.0, 28197.71802281951, 41948.0, 42220.36669449899, 42306.15387692167, 42365.0, 42475.15049699051, 333700.0, 338840.0, 340171.0, 340606.0, 340928.0, 24522.632160517962, 24982.875085624455, 25070.874645626656, 25076.498470030863, 25086.121985730413, 41330.586694133875, 41857.581424185366, 41922.58077419187, 42162.156756865304, 42762.0, 36534.45198321974, 36579.085522861074, 36825.63174368329, 36882.8155859219, 37704.245915080995, 35639.64360356467, 36956.7825930445, 37096.44355334618, 37169.0, 37367.439488408236, 33857.83071084629, 35518.46722299219, 35519.11202219965, 36570.8171459141, 39344.0, 31213.375732485678, 32259.35481290314, 32444.35111297808, 32459.0, 32722.0, 24814.25557233286, 25021.249362519153, 25169.49661006733, 25462.68985031934, 25671.87164064168], "value": 16481.1953606374, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.132467014192, 373.78133791731835, 375.36188479584706, 386.8897364251189, 388.9630485103916, 15675.686486270268, 15948.920255398722, 17031.233594488247, 17050.317987280527, 17080.487585372444, 15509.146996915166, 15749.763753543706, 16503.669926601462, 16586.004839709596, 16660.333586656518, 5013.122703526896, 5216.921746173792, 5218.086834803913, 5228.633995620308, 5228.92156617651, 5051.646384753069, 5130.38435387754, 5172.844814655547, 5183.041137389576, 5204.9479505204845, 5416.404195538487, 5457.699826509541, 5463.0, 5490.0, 5491.588130890199, 5459.153831156157, 5466.234727138204, 5496.258005169291, 5552.444755524456, 5617.4944255016835, 5408.702521361323, 5433.673979561239, 5441.972790136064, 5455.890882182373, 5457.0, 12447.066470014784, 15337.923310383489, 19660.0, 19972.901490418022, 20215.0, 1762.4536393717988, 1980.5147738803942, 1998.6802111662064, 2053.7022131790955, 2288.4050146961745, 8946.821063578756, 9080.909190908073, 9215.400998935114, 9304.8604270936, 9491.050894910522, 1601.5675767542698, 1624.0336999485287, 1665.2173478465102, 1669.3739847557167, 1696.6295477307187, 62854.371456285306, 64262.0, 64860.0, 66667.66666166687, 69178.0, 9686.515674216262, 9912.405255684682, 10072.294939354322, 10145.746356341151, 10414.21893357986, 13518.121322114031, 13778.65553361174, 13823.654408639663, 13838.169709817443, 13908.235047072509, 7112.25321341262, 7368.447366447538, 7463.290987356192, 7549.131849837339, 7582.848343033108, 6989.860202795916, 7064.43484521237, 7086.574805511686, 7145.92854071463, 7204.207537170907, 4284.785760711952, 4344.3049112142535, 4362.258416069276, 4401.757903315284, 4513.119941611354, 1677.6309211973346, 1737.800152982398, 1753.6755700195504, 1778.5642517583276, 1781.0827423876715, 845.7293666026935, 872.6247713483136, 873.9344549158711, 874.5933141089297, 946.9526523673926, 16137.193140342935, 16821.32714691423, 16835.63014169045, 16859.325626974784, 16960.915195423942, 842.9873551896726, 849.7833052571679, 868.769776009358, 880.5465185429509, 921.1663444582664, 9166.22087122602, 9499.810003799885, 9547.856782148274, 9589.90410095904, 9610.423374597547, 368348.0, 400221.0, 402965.0, 406176.0, 406452.0, 52212.47787522152, 78626.0, 78759.0, 80213.59893200497, 81461.59269203617, 879.3009557401881, 884.5090974509209, 893.5085702863399, 910.2990697163148, 921.2998121427763, 14550.511116981566, 14811.703765924405, 14911.62720931942, 14913.04025135458, 15174.924125379302, 27000.054998074975, 30012.549811753277, 34247.48628770521, 34633.65366346304, 37216.813915930245, 45531.77234113941, 47215.29177062278, 50821.49178508168, 51340.0, 52101.21848172356, 7257.52826066304, 7616.885746713914, 7628.313451789366, 7674.270944260286, 7703.653335599799, 9659.0, 11125.44372781374, 11425.085993120696, 11434.0, 11451.942740286246, 9813.165880900204, 9895.109440150422, 10049.849252261076, 10051.346662466916, 10197.13324367437, 10088.192944564564, 10188.847167292348, 10223.7444063899, 10327.173826093744, 10363.896361036293, 9500.90499095028, 9659.32384733062, 9948.303618746619, 9951.353162044445, 10181.74545636365, 7501.437392195498, 7675.0, 7686.461947663834, 7713.7685869424, 7754.069511658637, 7562.848743025219, 8804.515751633722, 9762.658306959222, 9832.213422926292, 9943.254255930979], "value": 8048.7708886531855, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1399.3772771116853, 1425.9643508912277, 1528.388644542183, 1678.33705686254, 1705.9488215353529, 7014.96492517538, 7508.436867234966, 7606.201348858373, 8098.757037288883, 8107.148749381318, 7601.049868766404, 7849.9402580651595, 7873.842523149534, 7885.369170466363, 7901.288884000439, 2203.2068455356057, 2233.55328934213, 2235.7987781099696, 2239.473723674935, 2249.2914731859496, 2166.3500949715103, 2185.4208634711813, 2219.1678120704737, 2220.733511978565, 2229.0, 2194.7585765565773, 2199.098369668436, 2199.83501237407, 2210.812080973119, 2211.3034394165866, 2180.4221881201493, 2184.8201970935675, 2196.428928478591, 2198.9010494527706, 2199.3951663292723, 1883.4820424383267, 1884.1427150646423, 1886.8773080017368, 1891.6311319292743, 1897.2411035585737, 7871.448998570102, 7890.289873911375, 7955.045394552633, 7973.162817904153, 7982.521048737094, 4662.277347011219, 4808.2547205183255, 4815.036992601494, 4821.807127714887, 4833.685810422311, 3010.9247268818453, 3075.200447883544, 3096.9535456968165, 3102.867453379523, 3128.0772172209254, 934.2525979216599, 980.7401038724744, 1000.2847963705913, 1000.6597756762662, 1000.8648832407605, 11054.170937179744, 11060.944695276552, 11064.0, 11077.889221107765, 11131.387773672444, 4262.6376757975295, 4380.496242932039, 4456.9108617828115, 4467.977660111744, 4471.977640111779, 9340.065993400742, 9403.623855045722, 9421.858672119924, 9450.102240287162, 9462.52687365629, 4798.2802579613335, 4808.975955120272, 4831.106245344622, 4835.226363781778, 4851.054044461296, 3755.3615885299564, 4274.722143060691, 4359.476862776487, 4396.120775844844, 4426.955730442654, 3692.446133080006, 3698.1679122197293, 3759.436084587334, 3774.9811250944117, 3813.161104556993, 1218.141210446633, 1233.8704436034266, 1235.116891422637, 1238.2879844089684, 1238.7150955280335, 678.4165617568887, 760.1790066727921, 790.4585359029084, 808.4664121679781, 832.6211573733937, 5165.450364890593, 5198.2722418861385, 5329.54698850602, 5336.306280183551, 5387.488188622075, 816.4285000499674, 841.5665932045001, 844.5312851367427, 859.6475445067617, 889.857622780365, 3525.9823700881843, 3656.287024030342, 3677.154254521475, 3713.8514459421863, 3742.7941463219786, 9773.46245956465, 9987.750306242402, 10061.34601250931, 10096.949515252376, 10156.593736250616, 10056.34633748804, 10098.293119481712, 10103.646372376932, 10114.949425252827, 10132.797344053226, 7293.197748247689, 7672.42456815741, 7687.154413014564, 7709.190534993857, 7719.305262526287, 4975.677553856759, 5112.437631860566, 5145.614078944169, 5258.0, 5294.947050529599, 9326.906730932875, 9332.860007099764, 9414.2468602513, 9438.197753191056, 9462.858057129286, 9090.954545227232, 9472.905270947478, 9577.0, 9585.520723963913, 9607.807843842944, 6490.286068532363, 6593.80218593443, 6689.899651505134, 6716.597004179765, 6753.763618273337, 7363.153237377556, 7379.704811807467, 7381.557106573623, 7387.704491820482, 7420.851582968203, 6799.388055075067, 6811.829704257433, 6926.411255043176, 7073.469489788184, 7107.395871350786, 6905.1713794342995, 6925.515213934977, 6964.965175174092, 7060.188078371053, 7081.82295442618, 5940.8811823764145, 6000.579959402975, 6005.6396616203165, 6009.489193418608, 6011.158437818796, 4332.848350307724, 4345.608895199447, 4352.194843953878, 4370.453693288339, 4401.009772801094, 4365.716228445141, 4484.596386325246, 4486.102779444059, 4536.4102666653125, 4550.158220729176], "value": 4195.493136400629, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.7008546581618, 308.48791006928496, 313.08266778339464, 314.52506714860556, 317.35893495139817, 4919.680220785646, 5023.182381390143, 5029.371328583922, 5189.169732842751, 5191.480851914811, 4990.950090499103, 5044.82343117991, 5048.444671086178, 5061.974690126544, 5075.593952483801, 3929.5088113985753, 3932.5280966284085, 3989.8204580793936, 3992.600739925999, 3998.2403343364667, 3868.207017561393, 3963.7819919904396, 3975.5428125765475, 4000.7599544027307, 4003.219372222418, 3912.376363809016, 3926.5877082906313, 3927.4894263745814, 3931.4495970564144, 3931.8034098295116, 3865.8260378283044, 3903.5901230370687, 3905.863294784669, 3921.901952451183, 3922.37242041272, 3439.9312013759836, 3440.2603440260464, 3446.8621255149765, 3459.9827000865084, 3464.6535346465403, 4883.1698611235815, 4892.5077851255355, 4988.950110498921, 5000.2499625056535, 5036.992601479682, 4497.617702495292, 4529.320601909707, 4529.660275479319, 4541.954580454186, 4545.477270113946, 5373.3014708088085, 5379.919301210485, 5383.353997520284, 5384.246205531229, 5387.4073851876265, 3643.1784107946028, 3706.054955986206, 3757.4176002719623, 3782.8108594570162, 3827.8660246891227, 5590.161475778625, 5614.7647517546075, 5632.436756324376, 5639.887202255973, 5681.630694004918, 3850.614938506127, 3868.458415821787, 3870.6129387061633, 3874.3219936511, 3883.572806991229, 3638.599754027055, 3871.109644781716, 3905.941410878839, 3922.666573341241, 3934.3311637021775, 4430.0, 4438.844640437634, 4475.172093162775, 4498.932516012263, 4499.212637788374, 5327.227552004938, 5352.277442545284, 5416.864578385572, 5422.511973922287, 5449.427810079964, 1292.6962163891478, 1374.299107455205, 1378.676011137382, 1385.4804448331874, 1390.5480718766441, 887.600579739107, 898.7956138774074, 910.7814124610178, 910.8815853938945, 914.7987442762582, 4155.397467367215, 4163.791810409528, 4204.474440694913, 4223.936640950326, 4250.766207858597, 4843.975780121077, 4850.733209673502, 4863.708177509361, 4882.048000639841, 4926.78294767349, 4166.354290055411, 4255.191513612465, 4255.510616279167, 4265.829366825292, 4269.188854117708, 2556.961645575318, 2618.7037416478965, 2623.973760262411, 2646.5765477523887, 2652.8938842446087, 4533.274676051816, 4554.453465584151, 4574.977125114353, 4611.631069514431, 4620.607248383925, 4940.654154209171, 4963.255511673278, 4981.576565991932, 4991.128326877421, 5022.698638081727, 4256.489221293403, 4471.977640111779, 4526.660500462479, 4554.385158003627, 4598.977005115087, 4835.516448355136, 4882.951170488392, 4884.7069175849565, 4889.486603906681, 4943.281195342475, 4790.185668436305, 4794.448638406628, 4795.160846851857, 4822.8794280143275, 4840.8789780254365, 4399.0, 4533.455985281787, 4561.950751327147, 4563.908721825478, 4599.517050709761, 3617.837197326074, 3625.9093522662142, 3633.7638053526434, 3646.4684832371, 3653.178034942223, 4851.51484851512, 4875.488073752347, 4881.267809828554, 4898.902021959612, 5296.073187192303, 5200.791968321376, 5378.7579558920725, 5382.246485491956, 5385.299911011543, 5390.51485366319, 5343.572514198777, 5352.652077614943, 5356.526955087226, 5371.254342338678, 5397.946020539902, 5122.974385128051, 5269.57843372537, 5279.498447647621, 5282.366116066097, 5290.629655924048, 5364.919526207188, 5374.785008599612, 5398.757055932414, 5415.48552887475, 5426.891462170655, 5251.553617942518, 5268.341457317835, 5306.575473961997, 5316.388615309289, 5321.228421878884], "value": 3870.3904230916814, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [666.8066260784376, 710.6837457331486, 735.5108852613013, 742.6138408027825, 768.0783060327605, 12576.811347829778, 13320.666983325422, 13685.178889266626, 13712.177269363832, 13729.450821967135, 12637.241765494076, 12782.10525263232, 12783.233006019645, 12787.04097192712, 12813.679658008554, 619.5415392609459, 764.6979443119965, 772.8763397856344, 789.8578255913933, 790.324272746799, 778.7040924448702, 779.4855395439012, 785.4148659248867, 788.4796034617153, 793.3970182661191, 820.2084987986592, 820.335528222139, 823.0247157118804, 824.5547404401616, 826.5164878546058, 812.3907069697726, 816.9550674712889, 823.0411570520337, 823.555280148719, 823.9711610093677, 598.255172310472, 598.7006496751624, 599.0744300056423, 600.2406955201674, 601.629997551507, 13594.660133496742, 13809.654758631013, 13822.723545529134, 13878.444862205499, 13880.93059534706, 12872.22766634005, 13408.128471649312, 13728.931355343258, 13886.93056534721, 13920.860791392159, 10925.142725736643, 11050.502727377287, 11054.170937179662, 11141.220114591983, 11161.49773260197, 3456.412409890325, 3470.7917524948584, 3476.704480119193, 3523.3834079036064, 3582.337267605475, 64143.358566414674, 64293.35706642967, 65545.3445465544, 66167.33832661709, 66407.0, 10477.47612619366, 10700.571977120828, 10707.250492465608, 10751.193660475496, 10824.296420732628, 20493.590128197353, 20551.075201615964, 20660.276890308767, 20747.481312966996, 21317.29461643065, 6584.533794151393, 7428.591427471541, 7429.07136607924, 7447.515911465737, 7509.211532789088, 3756.981215093907, 3759.830807613664, 3839.6736277416176, 3873.748206366577, 3882.6716692694013, 2740.8629568521496, 2867.5125228711167, 2876.1515352970505, 2880.8559572021313, 2883.3656595548946, 504.080053901631, 507.0518131094876, 510.6706174517415, 511.7850502788763, 515.7885267040496, 425.7083897530202, 548.56937304216, 552.1524459953952, 572.4904834697123, 588.805694120939, 7859.764207073797, 7872.685092596346, 8011.559364235023, 8137.160162982231, 8205.753827385188, 541.7453796715538, 553.7591147850698, 554.689373950589, 556.7605929450375, 578.1530058464369, 3774.9056273592832, 3804.3722785740597, 3805.657490825839, 3928.0, 3964.0684439156776, 82338.58830705807, 92824.0, 94377.0, 95641.52179239059, 95855.0, 76307.61846190845, 78773.0, 79724.60137699274, 79910.20089799144, 80345.59827200827, 72260.63869680723, 74179.0, 74664.0, 74692.62653686697, 74743.25256747472, 7229.277072292939, 7376.114866216089, 7522.398208143226, 7686.500377475446, 7743.186965368555, 42982.0, 43587.82075794918, 44412.77793611011, 44910.55089449064, 45127.7743611293, 56583.71708141433, 59757.701211493666, 61016.0, 64011.0, 65362.0, 11546.59586914454, 11570.363630000094, 11574.305541667527, 11613.535458581562, 11744.58893938708, 13017.934910325766, 13354.283576505799, 13445.731085378433, 13469.730605387642, 13546.417060003581, 12002.526847757576, 12241.938790305992, 12304.938475307925, 12656.240625562496, 12685.302308372758, 11573.18987670855, 11777.705557361134, 11945.880541194825, 12482.126251162696, 12493.125481216228, 12062.215955962834, 12154.817677735018, 12311.261324320569, 12332.753344933231, 13103.410346534238, 10219.94890025575, 10350.482475876326, 10448.947755261175, 10952.507137179005, 11196.04833589154, 9617.0, 9877.604895804086, 10004.349717268355, 10023.599056037678, 10037.598496060076], "value": 6636.744741012705, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1591.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 105.0, 115.0, 114.0, 115.0, 116.0, 114.0, 114.0, 113.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 132.0, 158.0, 180.0, 133.0, 164.0, 178.0, 132.0, 202.0, 132.0], "value": 156.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 167.0, 168.0, 162.0, 161.0, 163.0, 166.0, 164.0, 163.0, 163.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 85.0, 169.0, 77.0, 76.0, 82.0, 77.0, 164.0, 76.0], "value": 95.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 135.0, 87.0, 86.0, 88.0, 131.0, 87.0, 86.0, 141.0], "value": 101.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 119.0, 123.0, 117.0, 118.0, 119.0, 118.0, 117.0, 118.0], "value": 118.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 149.0, 148.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 97.0, 96.0, 96.0, 96.0, 100.0, 96.0, 96.0, 96.0], "value": 96.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 62.0, 64.0, 64.0, 64.0, 62.0, 64.0], "value": 63.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 65.0, 65.0, 66.0, 64.0, 65.0, 66.0, 65.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 83.0, 81.0, 82.0, 84.0, 83.0, 84.0, 83.0, 111.0, 81.0], "value": 86.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 144.0, 144.0, 130.0, 135.0, 141.0, 145.0, 143.0, 135.0, 141.0], "value": 140.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 172.0, 171.0, 178.0, 172.0, 170.0, 175.0, 178.0, 171.0, 172.0], "value": 174.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 68.0, 68.0, 70.0, 68.0, 72.0, 70.0, 71.0, 66.0], "value": 68.9, "unit": "score"}]}]} 06:35:06 INFO - Return code: 0 06:35:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:35:06 ERROR - # TBPL SUCCESS # 06:35:06 INFO - Running post-action listener: _resource_record_post_action 06:35:06 INFO - ##### 06:35:06 INFO - ##### Finished run-tests step (success) 06:35:06 INFO - ##### 06:35:06 INFO - Running post-run listener: _resource_record_post_run 06:35:06 INFO - Total resource usage - Wall time: 1198s; CPU: 14.0%; Read bytes: 16384; Write bytes: 537640960; Read time: 20; Write time: 412908 06:35:06 INFO - TinderboxPrint: CPU usage
13.5% 06:35:06 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 20 06:35:06 INFO - TinderboxPrint: I/O write bytes / time
537,640,960 / 412,908 06:35:06 INFO - TinderboxPrint: CPU idle
8,260.2 (86.4%) 06:35:06 INFO - TinderboxPrint: CPU user
1,240.1 (13.0%) 06:35:06 INFO - TinderboxPrint: Swap in / out
0 / 0 06:35:06 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 246091776; Read time: 0; Write time: 209528 06:35:06 INFO - run-tests - Wall time: 1182s; CPU: 14.0%; Read bytes: 16384; Write bytes: 291389440; Read time: 20; Write time: 203380 06:35:06 INFO - Running post-run listener: _upload_blobber_files 06:35:06 INFO - Blob upload gear active. 06:35:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:35:06 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 06:35:06 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:35:06 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:35:07 INFO - (blobuploader) - INFO - Open directory for files ... 06:35:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:35:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:35:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:35:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:35:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:35:08 INFO - (blobuploader) - INFO - Done attempting. 06:35:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:35:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:35:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:35:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:35:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:35:08 INFO - (blobuploader) - INFO - Done attempting. 06:35:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:35:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:35:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:35:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:35:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:35:13 INFO - (blobuploader) - INFO - Done attempting. 06:35:13 INFO - (blobuploader) - INFO - Iteration through files over. 06:35:13 INFO - Return code: 0 06:35:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:35:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:35:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4c47f5b6080dd7c90c6e44be21b1e36f6aa04484234634342ee6b62cbabe9ffce3a5f29711035c351d014e850f9c41abf88c524db984592d36437ae21589ac87", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1c6c1c4929b9f35f763690d80e08002ea2b330db352bc29835caae456dffc2f2a2c97af29496569246a4d0eac1e1793d95ddd34b04900673ee5f0d83ea4a381c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ac0a338ed9af104cf887cdd4e5d7c9315947ff5874920f1c8ba14ac2bb71cae1a617b133a3f1caec22848c5f7460336c34ca9115d28c8939875f96b0d714c8db"} 06:35:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:35:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:35:13 INFO - Contents: 06:35:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4c47f5b6080dd7c90c6e44be21b1e36f6aa04484234634342ee6b62cbabe9ffce3a5f29711035c351d014e850f9c41abf88c524db984592d36437ae21589ac87", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1c6c1c4929b9f35f763690d80e08002ea2b330db352bc29835caae456dffc2f2a2c97af29496569246a4d0eac1e1793d95ddd34b04900673ee5f0d83ea4a381c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ac0a338ed9af104cf887cdd4e5d7c9315947ff5874920f1c8ba14ac2bb71cae1a617b133a3f1caec22848c5f7460336c34ca9115d28c8939875f96b0d714c8db"} 06:35:13 INFO - Running post-run listener: copy_logs_to_upload_dir 06:35:13 INFO - Copying logs to upload dir... 06:35:13 INFO - mkdir: /builds/slave/test/build/upload/logs 06:35:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.980010 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-06-23 06:35:13.236765) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 06:35:13.240150) ========= 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=0333a256a5e4f052382dd180000001b1-1466686808.693297-400966052 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/Firefox-Non-PGO/sha512/4c47f5b6080dd7c90c6e44be21b1e36f6aa04484234634342ee6b62cbabe9ffce3a5f29711035c351d014e850f9c41abf88c524db984592d36437ae21589ac87", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1c6c1c4929b9f35f763690d80e08002ea2b330db352bc29835caae456dffc2f2a2c97af29496569246a4d0eac1e1793d95ddd34b04900673ee5f0d83ea4a381c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ac0a338ed9af104cf887cdd4e5d7c9315947ff5874920f1c8ba14ac2bb71cae1a617b133a3f1caec22848c5f7460336c34ca9115d28c8939875f96b0d714c8db"} build_url:https://queue.taskcluster.net/v1/task/JZV7md5PQJaYsyxnXpF99A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011430 build_url: 'https://queue.taskcluster.net/v1/task/JZV7md5PQJaYsyxnXpF99A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4c47f5b6080dd7c90c6e44be21b1e36f6aa04484234634342ee6b62cbabe9ffce3a5f29711035c351d014e850f9c41abf88c524db984592d36437ae21589ac87", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1c6c1c4929b9f35f763690d80e08002ea2b330db352bc29835caae456dffc2f2a2c97af29496569246a4d0eac1e1793d95ddd34b04900673ee5f0d83ea4a381c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ac0a338ed9af104cf887cdd4e5d7c9315947ff5874920f1c8ba14ac2bb71cae1a617b133a3f1caec22848c5f7460336c34ca9115d28c8939875f96b0d714c8db"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 06:35:13.266163) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 06:35:13.266539) ========= 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=0333a256a5e4f052382dd180000001b1-1466686808.693297-400966052 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 06:35:13.351451) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 06:35:13.351768) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 06:35:13.352090) ========= ========= Total master_lag: 0.17 =========