builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-022 starttime: 1466805205.42 results: success (0) buildid: 20160624133259 builduid: e9573f5223514924a8f05d2dd3653582 revision: 9dac1358aaadcea90aca05b170fc8bc59e097d52 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 14:53:25.425408) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 14:53:25.425914) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 14:53:25.426378) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 14:53:25.450023) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 14:53:25.450295) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1466805109.324799-41278226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-24 14:53:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 113M=0s 2016-06-24 14:53:25 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104862 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 14:53:25.569707) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 14:53:25.570035) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1466805109.324799-41278226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017577 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 14:53:25.653912) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 14:53:25.654474) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9dac1358aaadcea90aca05b170fc8bc59e097d52 --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 9dac1358aaadcea90aca05b170fc8bc59e097d52 --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=9c43b49b387003dc8f5b4e5c000001c4-1466805109.324799-41278226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-24 14:53:25,862 truncating revision to first 12 chars 2016-06-24 14:53:25,862 Setting DEBUG logging. 2016-06-24 14:53:25,862 attempt 1/10 2016-06-24 14:53:25,862 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9dac1358aaad?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-24 14:53:26,173 unpacking tar archive at: mozilla-central-9dac1358aaad/testing/mozharness/ program finished with exit code 0 elapsedTime=0.660238 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 14:53:26.329183) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 14:53:26.329491) ========= script_repo_revision: 9dac1358aaadcea90aca05b170fc8bc59e097d52 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 14:53:26.329910) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 14:53:26.330203) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 14:53:26.340646) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 26 mins, 46 secs) (at 2016-06-24 14:53:26.340934) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=9c43b49b387003dc8f5b4e5c000001c4-1466805109.324799-41278226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:53:26 INFO - MultiFileLogger online at 20160624 14:53:26 in /builds/slave/test 14:53:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 14:53:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:53:26 INFO - {'append_to_log': False, 14:53:26 INFO - 'base_work_dir': '/builds/slave/test', 14:53:26 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 14:53:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:53:26 INFO - 'branch': 'Firefox-Non-PGO', 14:53:26 INFO - 'buildbot_json_path': 'buildprops.json', 14:53:26 INFO - 'config_files': ('talos/linux_config.py',), 14:53:26 INFO - 'default_actions': ('clobber', 14:53:26 INFO - 'read-buildbot-config', 14:53:26 INFO - 'download-and-extract', 14:53:26 INFO - 'populate-webroot', 14:53:26 INFO - 'create-virtualenv', 14:53:26 INFO - 'install', 14:53:26 INFO - 'run-tests'), 14:53:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:53:26 INFO - 'download_minidump_stackwalk': True, 14:53:26 INFO - 'download_symbols': 'ondemand', 14:53:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:53:26 INFO - 'tooltool.py': '/tools/tooltool.py', 14:53:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:53:26 INFO - '/tools/misc-python/virtualenv.py')}, 14:53:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:53:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:53:26 INFO - 'installer_path': 'installer.exe', 14:53:26 INFO - 'log_level': 'info', 14:53:26 INFO - 'log_name': 'talos', 14:53:26 INFO - 'log_to_console': True, 14:53:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:53:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:53:26 INFO - 'opt_config_files': (), 14:53:26 INFO - 'pip_index': False, 14:53:26 INFO - 'sps_profile': False, 14:53:26 INFO - 'sps_profile_interval': 0, 14:53:26 INFO - 'suite': 'dromaeojs', 14:53:26 INFO - 'system_bits': '32', 14:53:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:53:26 INFO - 'title': 'talos-linux64-ix-022', 14:53:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:53:26 INFO - 'use_talos_json': True, 14:53:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:53:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:53:26 INFO - 'work_dir': 'build'} 14:53:26 INFO - ##### 14:53:26 INFO - ##### Running clobber step. 14:53:26 INFO - ##### 14:53:26 INFO - Running pre-action listener: _resource_record_pre_action 14:53:26 INFO - Running main action method: clobber 14:53:26 INFO - rmtree: /builds/slave/test/build 14:53:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:53:27 INFO - Running post-action listener: _resource_record_post_action 14:53:27 INFO - ##### 14:53:27 INFO - ##### Finished clobber step (success) 14:53:27 INFO - ##### 14:53:27 INFO - ##### 14:53:27 INFO - ##### Running read-buildbot-config step. 14:53:27 INFO - ##### 14:53:27 INFO - Running pre-action listener: _resource_record_pre_action 14:53:27 INFO - Running main action method: read_buildbot_config 14:53:27 INFO - Using buildbot properties: 14:53:27 INFO - { 14:53:27 INFO - "project": "", 14:53:27 INFO - "product": "firefox", 14:53:27 INFO - "script_repo_revision": "production", 14:53:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 14:53:27 INFO - "repository": "", 14:53:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 14:53:27 INFO - "buildid": "20160624133259", 14:53:27 INFO - "pgo_build": "False", 14:53:27 INFO - "basedir": "/builds/slave/test", 14:53:27 INFO - "buildnumber": 127, 14:53:27 INFO - "slavename": "talos-linux64-ix-022", 14:53:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:53:27 INFO - "platform": "ubuntu64_hw", 14:53:27 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 14:53:27 INFO - "branch": "mozilla-central", 14:53:27 INFO - "repo_path": "mozilla-central", 14:53:27 INFO - "revision": "9dac1358aaadcea90aca05b170fc8bc59e097d52", 14:53:27 INFO - "stage_platform": "linux64", 14:53:27 INFO - "builduid": "e9573f5223514924a8f05d2dd3653582", 14:53:27 INFO - "slavebuilddir": "test" 14:53:27 INFO - } 14:53:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 14:53:27 INFO - Running post-action listener: _resource_record_post_action 14:53:27 INFO - ##### 14:53:27 INFO - ##### Finished read-buildbot-config step (success) 14:53:27 INFO - ##### 14:53:27 INFO - ##### 14:53:27 INFO - ##### Running download-and-extract step. 14:53:27 INFO - ##### 14:53:27 INFO - Running pre-action listener: _resource_record_pre_action 14:53:27 INFO - Running main action method: download_and_extract 14:53:27 INFO - mkdir: /builds/slave/test/build/tests 14:53:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:27 INFO - https://queue.taskcluster.net/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:53:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:53:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:53:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7j3g-8pT6a2RH4RMcF06g/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 14:53:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7j3g-8pT6a2RH4RMcF06g/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 14:53:29 INFO - Downloaded 1361 bytes. 14:53:29 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:53:29 INFO - Using the following test package requirements: 14:53:29 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:53:29 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:53:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:53:29 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:53:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:53:29 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:53:29 INFO - u'jsshell-linux-x86_64.zip'], 14:53:29 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:53:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:53:29 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:53:29 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:53:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:53:29 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:53:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:53:29 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:53:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:53:29 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:53:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:53:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:53:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:29 INFO - https://queue.taskcluster.net/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:53:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:53:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:53:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7j3g-8pT6a2RH4RMcF06g/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 14:53:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7j3g-8pT6a2RH4RMcF06g/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 14:59:26 INFO - Downloaded 22710854 bytes. 14:59:26 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'] 14:59:26 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 14:59:28 INFO - Return code: 0 14:59:28 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 14:59:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:59:28 INFO - https://queue.taskcluster.net/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:59:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:59:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:59:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7j3g-8pT6a2RH4RMcF06g/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 14:59:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7j3g-8pT6a2RH4RMcF06g/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 14:59:31 INFO - Downloaded 22710854 bytes. 14:59:31 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'] 14:59:31 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 14:59:33 INFO - Return code: 0 14:59:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:59:33 INFO - https://queue.taskcluster.net/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:59:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:59:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:59:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7j3g-8pT6a2RH4RMcF06g/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 14:59:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7j3g-8pT6a2RH4RMcF06g/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 14:59:35 INFO - Downloaded 14405518 bytes. 14:59:35 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'] 14:59:35 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 14:59:35 INFO - Return code: 0 14:59:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:59:35 INFO - https://queue.taskcluster.net/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:59:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:59:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:59:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7j3g-8pT6a2RH4RMcF06g/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 14:59:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7j3g-8pT6a2RH4RMcF06g/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 14:59:37 INFO - Downloaded 56261067 bytes. 14:59:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:59:37 INFO - mkdir: /builds/slave/test/properties 14:59:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:59:37 INFO - Writing to file /builds/slave/test/properties/build_url 14:59:37 INFO - Contents: 14:59:37 INFO - build_url:https://queue.taskcluster.net/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:59:38 INFO - Running post-action listener: _resource_record_post_action 14:59:38 INFO - Running post-action listener: set_extra_try_arguments 14:59:38 INFO - ##### 14:59:38 INFO - ##### Finished download-and-extract step (success) 14:59:38 INFO - ##### 14:59:38 INFO - ##### 14:59:38 INFO - ##### Running populate-webroot step. 14:59:38 INFO - ##### 14:59:38 INFO - Running pre-action listener: _resource_record_pre_action 14:59:38 INFO - Running main action method: populate_webroot 14:59:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:59:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:59:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:59:38 INFO - '--tppagecycles', 14:59:38 INFO - '7'], 14:59:38 INFO - 'tests': ['tsvgm']}}, 14:59:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:59:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:59:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:59:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:59:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:59:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:59:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:59:38 INFO - 'talos_options': ['--disable-e10s'], 14:59:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:59:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:59:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:59:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:59:38 INFO - 'talos_options': ['--disable-e10s'], 14:59:38 INFO - 'tests': ['damp', 'tps']}, 14:59:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:59:38 INFO - 'tests': ['damp', 'tps']}, 14:59:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:59:38 INFO - 'tests': ['dromaeo_dom']}, 14:59:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:59:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:59:38 INFO - 'tests': ['basic_compositor_video']}, 14:59:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:59:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:59:38 INFO - 'tests': ['a11yr', 14:59:38 INFO - 'ts_paint', 14:59:38 INFO - 'tpaint', 14:59:38 INFO - 'sessionrestore', 14:59:38 INFO - 'sessionrestore_no_auto_restore', 14:59:38 INFO - 'tabpaint']}, 14:59:38 INFO - 'other-e10s': {'tests': ['a11yr', 14:59:38 INFO - 'ts_paint', 14:59:38 INFO - 'tpaint', 14:59:38 INFO - 'sessionrestore', 14:59:38 INFO - 'sessionrestore_no_auto_restore', 14:59:38 INFO - 'tabpaint']}, 14:59:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:59:38 INFO - 'ts_paint', 14:59:38 INFO - 'tpaint', 14:59:38 INFO - 'sessionrestore', 14:59:38 INFO - 'sessionrestore_no_auto_restore', 14:59:38 INFO - 'tabpaint']}, 14:59:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:59:38 INFO - 'ts_paint', 14:59:38 INFO - 'tpaint', 14:59:38 INFO - 'sessionrestore', 14:59:38 INFO - 'sessionrestore_no_auto_restore', 14:59:38 INFO - 'tabpaint']}, 14:59:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:59:38 INFO - 'tests': ['a11yr', 14:59:38 INFO - 'ts_paint', 14:59:38 INFO - 'tpaint', 14:59:38 INFO - 'sessionrestore', 14:59:38 INFO - 'sessionrestore_no_auto_restore', 14:59:38 INFO - 'tabpaint']}, 14:59:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:59:38 INFO - 'tests': ['a11yr', 14:59:38 INFO - 'ts_paint', 14:59:38 INFO - 'tpaint', 14:59:38 INFO - 'sessionrestore', 14:59:38 INFO - 'sessionrestore_no_auto_restore', 14:59:38 INFO - 'tabpaint']}, 14:59:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:59:38 INFO - 'tests': ['tsvgx', 14:59:38 INFO - 'tsvgr_opacity', 14:59:38 INFO - 'tart', 14:59:38 INFO - 'tscrollx', 14:59:38 INFO - 'cart']}, 14:59:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:59:38 INFO - 'tsvgr_opacity', 14:59:38 INFO - 'tart', 14:59:38 INFO - 'tscrollx', 14:59:38 INFO - 'cart']}, 14:59:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:59:38 INFO - 'talos_options': ['--disable-e10s'], 14:59:38 INFO - 'tests': ['tp5o']}, 14:59:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:59:38 INFO - 'tests': ['tp5o']}, 14:59:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:59:38 INFO - 'talos_options': ['--disable-e10s', 14:59:38 INFO - '--xperf_path', 14:59:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:59:38 INFO - 'tests': ['tp5n']}, 14:59:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:59:38 INFO - 'talos_options': ['--xperf_path', 14:59:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:59:38 INFO - 'tests': ['tp5n']}}, 14:59:38 INFO - 'talos.zip': {'path': '', 14:59:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:59:38 INFO - Running post-action listener: _resource_record_post_action 14:59:38 INFO - ##### 14:59:38 INFO - ##### Finished populate-webroot step (success) 14:59:38 INFO - ##### 14:59:38 INFO - ##### 14:59:38 INFO - ##### Running create-virtualenv step. 14:59:38 INFO - ##### 14:59:38 INFO - Running pre-action listener: _resource_record_pre_action 14:59:38 INFO - Running main action method: create_virtualenv 14:59:38 INFO - Creating virtualenv /builds/slave/test/build/venv 14:59:38 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 14:59:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:59:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:59:38 INFO - Using real prefix '/usr' 14:59:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:59:39 INFO - Installing distribute.............................................................................................................................................................................................done. 14:59:41 INFO - Installing pip.................done. 14:59:41 INFO - Return code: 0 14:59:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:59: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')]} 14:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59: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')]} 14:59:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:41 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 0x7f867b4c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ad450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213c2c0>, '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 0x213d1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213d650>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466805109.324799-41278226', '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 14:59:41 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 14:59:41 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 14:59:41 INFO - Using env: {'DISPLAY': ':0', 14:59:41 INFO - 'HOME': '/home/cltbld', 14:59:41 INFO - 'LANG': 'en_US.UTF-8', 14:59:41 INFO - 'LANGUAGE': 'en_US:en', 14:59:41 INFO - 'LOGNAME': 'cltbld', 14:59:41 INFO - 'MAIL': '/var/mail/cltbld', 14:59:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:41 INFO - 'MOZ_NO_REMOTE': '1', 14:59:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:41 INFO - 'NO_EM_RESTART': '1', 14:59:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:41 INFO - 'PWD': '/builds/slave/test', 14:59:41 INFO - 'SHELL': '/bin/bash', 14:59:41 INFO - 'SHLVL': '1', 14:59:41 INFO - 'TERM': 'linux', 14:59:41 INFO - 'TMOUT': '86400', 14:59:41 INFO - 'USER': 'cltbld', 14:59:41 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466805109.324799-41278226', 14:59:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:41 INFO - '_': '/tools/buildbot/bin/python'} 14:59:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:41 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 14:59:41 INFO - Cleaning up... 14:59:41 INFO - Return code: 0 14:59:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:59: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')]} 14:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59: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')]} 14:59:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:41 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 0x7f867b4c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ad450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213c2c0>, '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 0x213d1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213d650>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466805109.324799-41278226', '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 14:59:41 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 14:59:41 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 14:59:41 INFO - Using env: {'DISPLAY': ':0', 14:59:41 INFO - 'HOME': '/home/cltbld', 14:59:41 INFO - 'LANG': 'en_US.UTF-8', 14:59:41 INFO - 'LANGUAGE': 'en_US:en', 14:59:41 INFO - 'LOGNAME': 'cltbld', 14:59:41 INFO - 'MAIL': '/var/mail/cltbld', 14:59:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:41 INFO - 'MOZ_NO_REMOTE': '1', 14:59:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:41 INFO - 'NO_EM_RESTART': '1', 14:59:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:41 INFO - 'PWD': '/builds/slave/test', 14:59:41 INFO - 'SHELL': '/bin/bash', 14:59:41 INFO - 'SHLVL': '1', 14:59:41 INFO - 'TERM': 'linux', 14:59:41 INFO - 'TMOUT': '86400', 14:59:41 INFO - 'USER': 'cltbld', 14:59:41 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466805109.324799-41278226', 14:59:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:41 INFO - '_': '/tools/buildbot/bin/python'} 14:59:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:41 INFO - Downloading/unpacking psutil>=3.1.1 14:59:41 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 14:59:41 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 14:59:41 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 14:59:41 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 14:59:41 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 14:59:41 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 14:59:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:59:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:59:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:59:43 INFO - Installing collected packages: psutil 14:59:43 INFO - Running setup.py install for psutil 14:59:43 INFO - building 'psutil._psutil_linux' extension 14:59:43 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 14:59:44 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 14:59:44 INFO - building 'psutil._psutil_posix' extension 14:59:44 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 14:59:44 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 14:59:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:59:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:59:44 INFO - Successfully installed psutil 14:59:44 INFO - Cleaning up... 14:59:44 INFO - Return code: 0 14:59:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:59:44 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')]} 14:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:44 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')]} 14:59:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:44 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 0x7f867b4c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ad450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213c2c0>, '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 0x213d1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213d650>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466805109.324799-41278226', '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 14:59:44 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 14:59:44 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 14:59:44 INFO - Using env: {'DISPLAY': ':0', 14:59:44 INFO - 'HOME': '/home/cltbld', 14:59:44 INFO - 'LANG': 'en_US.UTF-8', 14:59:44 INFO - 'LANGUAGE': 'en_US:en', 14:59:44 INFO - 'LOGNAME': 'cltbld', 14:59:44 INFO - 'MAIL': '/var/mail/cltbld', 14:59:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:44 INFO - 'MOZ_NO_REMOTE': '1', 14:59:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:44 INFO - 'NO_EM_RESTART': '1', 14:59:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:44 INFO - 'PWD': '/builds/slave/test', 14:59:44 INFO - 'SHELL': '/bin/bash', 14:59:44 INFO - 'SHLVL': '1', 14:59:44 INFO - 'TERM': 'linux', 14:59:44 INFO - 'TMOUT': '86400', 14:59:44 INFO - 'USER': 'cltbld', 14:59:44 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466805109.324799-41278226', 14:59:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:44 INFO - '_': '/tools/buildbot/bin/python'} 14:59:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:59:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:59:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:59:46 INFO - Installing collected packages: mozsystemmonitor 14:59:46 INFO - Running setup.py install for mozsystemmonitor 14:59:46 INFO - Successfully installed mozsystemmonitor 14:59:46 INFO - Cleaning up... 14:59:46 INFO - Return code: 0 14:59:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:59: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')]} 14:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59: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')]} 14:59:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59: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', '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 0x7f867b4c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ad450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213c2c0>, '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 0x213d1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213d650>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466805109.324799-41278226', '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 14:59: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:59: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 jsonschema==2.5.1 14:59:46 INFO - Using env: {'DISPLAY': ':0', 14:59:46 INFO - 'HOME': '/home/cltbld', 14:59:46 INFO - 'LANG': 'en_US.UTF-8', 14:59:46 INFO - 'LANGUAGE': 'en_US:en', 14:59:46 INFO - 'LOGNAME': 'cltbld', 14:59:46 INFO - 'MAIL': '/var/mail/cltbld', 14:59:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:46 INFO - 'MOZ_NO_REMOTE': '1', 14:59:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:46 INFO - 'NO_EM_RESTART': '1', 14:59:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:46 INFO - 'PWD': '/builds/slave/test', 14:59:46 INFO - 'SHELL': '/bin/bash', 14:59:46 INFO - 'SHLVL': '1', 14:59:46 INFO - 'TERM': 'linux', 14:59:46 INFO - 'TMOUT': '86400', 14:59:46 INFO - 'USER': 'cltbld', 14:59:46 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466805109.324799-41278226', 14:59:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:46 INFO - '_': '/tools/buildbot/bin/python'} 14:59:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:46 INFO - Downloading/unpacking jsonschema==2.5.1 14:59: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 14:59: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 14:59: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 14:59: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 14:59: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 14:59: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 14:59:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:59:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:59: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 14:59: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 14:59: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 14:59: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 14:59: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 14:59: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 14:59:48 INFO - Downloading functools32-3.2.3-2.tar.gz 14:59:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:59:48 INFO - warning: no files found matching '*.txt' 14:59:48 INFO - no previously-included directories found matching 'build' 14:59:48 INFO - no previously-included directories found matching 'dist' 14:59:48 INFO - no previously-included directories found matching '.git*' 14:59:49 INFO - Installing collected packages: jsonschema, functools32 14:59:49 INFO - Running setup.py install for functools32 14:59:49 INFO - warning: no files found matching '*.txt' 14:59:49 INFO - no previously-included directories found matching 'build' 14:59:49 INFO - no previously-included directories found matching 'dist' 14:59:49 INFO - no previously-included directories found matching '.git*' 14:59:49 INFO - Successfully installed jsonschema functools32 14:59:49 INFO - Cleaning up... 14:59:49 INFO - Return code: 0 14:59:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:59:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:59:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f867b4c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ad450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213c2c0>, '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 0x213d1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213d650>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466805109.324799-41278226', '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 14:59:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:59:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:59:49 INFO - Using env: {'DISPLAY': ':0', 14:59:49 INFO - 'HOME': '/home/cltbld', 14:59:49 INFO - 'LANG': 'en_US.UTF-8', 14:59:49 INFO - 'LANGUAGE': 'en_US:en', 14:59:49 INFO - 'LOGNAME': 'cltbld', 14:59:49 INFO - 'MAIL': '/var/mail/cltbld', 14:59:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:49 INFO - 'MOZ_NO_REMOTE': '1', 14:59:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:49 INFO - 'NO_EM_RESTART': '1', 14:59:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:49 INFO - 'PWD': '/builds/slave/test', 14:59:49 INFO - 'SHELL': '/bin/bash', 14:59:49 INFO - 'SHLVL': '1', 14:59:49 INFO - 'TERM': 'linux', 14:59:49 INFO - 'TMOUT': '86400', 14:59:49 INFO - 'USER': 'cltbld', 14:59:49 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466805109.324799-41278226', 14:59:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:49 INFO - '_': '/tools/buildbot/bin/python'} 14:59:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:49 INFO - Downloading/unpacking blobuploader==1.2.4 14:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:51 INFO - Downloading blobuploader-1.2.4.tar.gz 14:59:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:59:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:59: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 14:59: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 14:59: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 14:59: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 14:59: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 14:59: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 14:59:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:59:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:59: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 14:59: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 14:59: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 14:59: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 14:59: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 14:59: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 14:59:52 INFO - Downloading docopt-0.6.1.tar.gz 14:59:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:59:52 INFO - Installing collected packages: blobuploader, requests, docopt 14:59:52 INFO - Running setup.py install for blobuploader 14:59:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:59:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:59:52 INFO - Running setup.py install for requests 14:59:52 INFO - Running setup.py install for docopt 14:59:52 INFO - Successfully installed blobuploader requests docopt 14:59:52 INFO - Cleaning up... 14:59:52 INFO - Return code: 0 14:59:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:59:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:52 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 0x7f867b4c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ad450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213c2c0>, '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 0x213d1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213d650>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466805109.324799-41278226', '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 14:59:52 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 14:59:52 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 14:59:52 INFO - Using env: {'DISPLAY': ':0', 14:59:52 INFO - 'HOME': '/home/cltbld', 14:59:52 INFO - 'LANG': 'en_US.UTF-8', 14:59:52 INFO - 'LANGUAGE': 'en_US:en', 14:59:52 INFO - 'LOGNAME': 'cltbld', 14:59:52 INFO - 'MAIL': '/var/mail/cltbld', 14:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:52 INFO - 'MOZ_NO_REMOTE': '1', 14:59:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:52 INFO - 'NO_EM_RESTART': '1', 14:59:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:52 INFO - 'PWD': '/builds/slave/test', 14:59:52 INFO - 'SHELL': '/bin/bash', 14:59:52 INFO - 'SHLVL': '1', 14:59:52 INFO - 'TERM': 'linux', 14:59:52 INFO - 'TMOUT': '86400', 14:59:52 INFO - 'USER': 'cltbld', 14:59:52 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466805109.324799-41278226', 14:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:52 INFO - '_': '/tools/buildbot/bin/python'} 14:59:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:59:53 INFO - Running setup.py (path:/tmp/pip-ZYL3RS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:59:53 INFO - Running setup.py (path:/tmp/pip-A0NqBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:59:53 INFO - Running setup.py (path:/tmp/pip-trtriu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:59:53 INFO - Running setup.py (path:/tmp/pip-rTkAgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:59:53 INFO - Running setup.py (path:/tmp/pip-zX42Wb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:59:53 INFO - Running setup.py (path:/tmp/pip-Djkqjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:59:53 INFO - Running setup.py (path:/tmp/pip-7VfTNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:59:53 INFO - Running setup.py (path:/tmp/pip-h8W_jX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:59:53 INFO - Running setup.py (path:/tmp/pip-DRo3p8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:59:53 INFO - Running setup.py (path:/tmp/pip-nP6Shi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:59:53 INFO - Running setup.py (path:/tmp/pip-G_4OPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:59:53 INFO - Running setup.py (path:/tmp/pip-dfAF8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:59:53 INFO - Running setup.py (path:/tmp/pip-C_MGZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:59:53 INFO - Running setup.py (path:/tmp/pip-asewaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:59:53 INFO - Running setup.py (path:/tmp/pip-PsMqy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:59:54 INFO - Running setup.py (path:/tmp/pip-s_ooU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:59:54 INFO - Running setup.py (path:/tmp/pip-RTowXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:59:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:59:54 INFO - Running setup.py install for manifestparser 14:59:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:59:54 INFO - Running setup.py install for mozcrash 14:59:54 INFO - Running setup.py install for mozdebug 14:59:54 INFO - Running setup.py install for mozdevice 14:59:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:59:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:59:54 INFO - Running setup.py install for mozfile 14:59:54 INFO - Running setup.py install for mozhttpd 14:59:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:59:54 INFO - Running setup.py install for mozinfo 14:59:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:59:54 INFO - Running setup.py install for mozInstall 14:59:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:59:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:59:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:59:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:59:55 INFO - Running setup.py install for mozleak 14:59:55 INFO - Running setup.py install for mozlog 14:59:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:59:55 INFO - Running setup.py install for moznetwork 14:59:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:59:55 INFO - Running setup.py install for mozprocess 14:59:55 INFO - Running setup.py install for mozprofile 14:59:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:59:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:59:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:59:55 INFO - Running setup.py install for mozrunner 14:59:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:59:55 INFO - Running setup.py install for mozscreenshot 14:59:55 INFO - Running setup.py install for moztest 14:59:55 INFO - Running setup.py install for mozversion 14:59:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:59:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:59:55 INFO - Cleaning up... 14:59:55 INFO - Return code: 0 14:59:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:59:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:55 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 0x7f867b4c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ad450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213c2c0>, '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 0x213d1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213d650>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466805109.324799-41278226', '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 14:59:55 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 14:59:55 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 14:59:55 INFO - Using env: {'DISPLAY': ':0', 14:59:55 INFO - 'HOME': '/home/cltbld', 14:59:55 INFO - 'LANG': 'en_US.UTF-8', 14:59:55 INFO - 'LANGUAGE': 'en_US:en', 14:59:55 INFO - 'LOGNAME': 'cltbld', 14:59:55 INFO - 'MAIL': '/var/mail/cltbld', 14:59:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:55 INFO - 'MOZ_NO_REMOTE': '1', 14:59:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:55 INFO - 'NO_EM_RESTART': '1', 14:59:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:55 INFO - 'PWD': '/builds/slave/test', 14:59:55 INFO - 'SHELL': '/bin/bash', 14:59:55 INFO - 'SHLVL': '1', 14:59:55 INFO - 'TERM': 'linux', 14:59:55 INFO - 'TMOUT': '86400', 14:59:55 INFO - 'USER': 'cltbld', 14:59:55 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466805109.324799-41278226', 14:59:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:55 INFO - '_': '/tools/buildbot/bin/python'} 14:59:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:59:56 INFO - Running setup.py (path:/tmp/pip-g_0_RC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:59:56 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)) 14:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:59:56 INFO - Running setup.py (path:/tmp/pip-b6JUSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:59:56 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)) 14:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:59:56 INFO - Running setup.py (path:/tmp/pip-ukn5NU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:59:56 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)) 14:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:59:56 INFO - Running setup.py (path:/tmp/pip-QA0Yq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:59:56 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)) 14:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:59:56 INFO - Running setup.py (path:/tmp/pip-9qCrMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:59:56 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)) 14:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:59:56 INFO - Running setup.py (path:/tmp/pip-La1Y7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:59:56 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)) 14:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:59:56 INFO - Running setup.py (path:/tmp/pip-dW8Mh_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:59:56 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)) 14:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:59:56 INFO - Running setup.py (path:/tmp/pip-kdaQM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:59:56 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)) 14:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:59:56 INFO - Running setup.py (path:/tmp/pip-485I_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:59:56 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)) 14:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:59:56 INFO - Running setup.py (path:/tmp/pip-bODsu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:59:56 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)) 14:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:59:56 INFO - Running setup.py (path:/tmp/pip-uLsJDN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:59:56 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)) 14:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:59:57 INFO - Running setup.py (path:/tmp/pip-qy6iof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:59:57 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)) 14:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:59:57 INFO - Running setup.py (path:/tmp/pip-klSqTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:59:57 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)) 14:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:59:57 INFO - Running setup.py (path:/tmp/pip-RbTeu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:59:57 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)) 14:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:59:57 INFO - Running setup.py (path:/tmp/pip-h5F3xG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:59:57 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)) 14:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:59:57 INFO - Running setup.py (path:/tmp/pip-5fBB2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:59:57 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)) 14:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:59:57 INFO - Running setup.py (path:/tmp/pip-MFnVEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:59:57 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)) 14:59:57 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)) 14:59:57 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)) 14:59:57 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)) 14:59:57 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)) 14:59:57 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)) 14:59:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:59 INFO - Downloading blessings-1.6.tar.gz 14:59:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:59:59 INFO - Installing collected packages: blessings 14:59:59 INFO - Running setup.py install for blessings 14:59:59 INFO - Successfully installed blessings 14:59:59 INFO - Cleaning up... 14:59:59 INFO - Return code: 0 14:59:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:59:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:59:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:59:59 INFO - Reading from file tmpfile_stdout 14:59:59 INFO - Current package versions: 14:59:59 INFO - argparse == 1.2.1 14:59:59 INFO - blessings == 1.6 14:59:59 INFO - blobuploader == 1.2.4 14:59:59 INFO - docopt == 0.6.1 14:59:59 INFO - functools32 == 3.2.3-2 14:59:59 INFO - jsonschema == 2.5.1 14:59:59 INFO - manifestparser == 1.1 14:59:59 INFO - mozInstall == 1.12 14:59:59 INFO - mozcrash == 0.17 14:59:59 INFO - mozdebug == 0.1 14:59:59 INFO - mozdevice == 0.48 14:59:59 INFO - mozfile == 1.2 14:59:59 INFO - mozhttpd == 0.7 14:59:59 INFO - mozinfo == 0.9 14:59:59 INFO - mozleak == 0.1 14:59:59 INFO - mozlog == 3.2 14:59:59 INFO - moznetwork == 0.27 14:59:59 INFO - mozprocess == 0.22 14:59:59 INFO - mozprofile == 0.28 14:59:59 INFO - mozrunner == 6.11 14:59:59 INFO - mozscreenshot == 0.1 14:59:59 INFO - mozsystemmonitor == 0.3 14:59:59 INFO - moztest == 0.7 14:59:59 INFO - mozversion == 1.4 14:59:59 INFO - psutil == 3.1.1 14:59:59 INFO - requests == 1.2.3 14:59:59 INFO - wsgiref == 0.1.2 14:59:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:59:59 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')]} 14:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:59 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')]} 14:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:59 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 0x7f867b4c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ad450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213c2c0>, '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 0x213d1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213d650>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466805109.324799-41278226', '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 14:59:59 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 14:59:59 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 14:59:59 INFO - Using env: {'DISPLAY': ':0', 14:59:59 INFO - 'HOME': '/home/cltbld', 14:59:59 INFO - 'LANG': 'en_US.UTF-8', 14:59:59 INFO - 'LANGUAGE': 'en_US:en', 14:59:59 INFO - 'LOGNAME': 'cltbld', 14:59:59 INFO - 'MAIL': '/var/mail/cltbld', 14:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:59 INFO - 'MOZ_NO_REMOTE': '1', 14:59:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:59 INFO - 'NO_EM_RESTART': '1', 14:59:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:59 INFO - 'PWD': '/builds/slave/test', 14:59:59 INFO - 'SHELL': '/bin/bash', 14:59:59 INFO - 'SHLVL': '1', 14:59:59 INFO - 'TERM': 'linux', 14:59:59 INFO - 'TMOUT': '86400', 14:59:59 INFO - 'USER': 'cltbld', 14:59:59 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466805109.324799-41278226', 14:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:59 INFO - '_': '/tools/buildbot/bin/python'} 14:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:59 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)) 14:59:59 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)) 14:59:59 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)) 14:59:59 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)) 14:59:59 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)) 14:59:59 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)) 14:59:59 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)) 14:59:59 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)) 14:59:59 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)) 14:59:59 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)) 14:59:59 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)) 14:59:59 INFO - Cleaning up... 14:59:59 INFO - Return code: 0 14:59:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:59:59 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')]} 14:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:59 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')]} 14:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:59 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 0x7f867b4c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ad450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213c2c0>, '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 0x213d1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213d650>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466805109.324799-41278226', '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 14:59:59 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 14:59:59 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 14:59:59 INFO - Using env: {'DISPLAY': ':0', 14:59:59 INFO - 'HOME': '/home/cltbld', 14:59:59 INFO - 'LANG': 'en_US.UTF-8', 14:59:59 INFO - 'LANGUAGE': 'en_US:en', 14:59:59 INFO - 'LOGNAME': 'cltbld', 14:59:59 INFO - 'MAIL': '/var/mail/cltbld', 14:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:59 INFO - 'MOZ_NO_REMOTE': '1', 14:59:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:59 INFO - 'NO_EM_RESTART': '1', 14:59:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:59 INFO - 'PWD': '/builds/slave/test', 14:59:59 INFO - 'SHELL': '/bin/bash', 14:59:59 INFO - 'SHLVL': '1', 14:59:59 INFO - 'TERM': 'linux', 14:59:59 INFO - 'TMOUT': '86400', 14:59:59 INFO - 'USER': 'cltbld', 14:59:59 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466805109.324799-41278226', 14:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:59 INFO - '_': '/tools/buildbot/bin/python'} 15:00:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:00:00 INFO - Cleaning up... 15:00:00 INFO - Return code: 0 15:00:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:00: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')]} 15:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:00:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00: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')]} 15:00:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:00:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:00 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 0x7f867b4c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ad450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213c2c0>, '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 0x213d1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213d650>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466805109.324799-41278226', '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 15:00:00 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 15:00:00 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 15:00:00 INFO - Using env: {'DISPLAY': ':0', 15:00:00 INFO - 'HOME': '/home/cltbld', 15:00:00 INFO - 'LANG': 'en_US.UTF-8', 15:00:00 INFO - 'LANGUAGE': 'en_US:en', 15:00:00 INFO - 'LOGNAME': 'cltbld', 15:00:00 INFO - 'MAIL': '/var/mail/cltbld', 15:00:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:00:00 INFO - 'MOZ_NO_REMOTE': '1', 15:00:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:00:00 INFO - 'NO_EM_RESTART': '1', 15:00:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:00:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:00:00 INFO - 'PWD': '/builds/slave/test', 15:00:00 INFO - 'SHELL': '/bin/bash', 15:00:00 INFO - 'SHLVL': '1', 15:00:00 INFO - 'TERM': 'linux', 15:00:00 INFO - 'TMOUT': '86400', 15:00:00 INFO - 'USER': 'cltbld', 15:00:00 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466805109.324799-41278226', 15:00:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:00:00 INFO - '_': '/tools/buildbot/bin/python'} 15:00:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:00:00 INFO - Downloading/unpacking flake8 15:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:00:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:00:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:00:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:00:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:00:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:00:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:00: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 15:00: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 15:00: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 15:00: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 15:00: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 15:00: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 15:00:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:00:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:00: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 15:00: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 15:00: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 15:00: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 15:00: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 15:00: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 15:00:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:00: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 15:00: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 15:00: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 15:00: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 15:00: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 15:00: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 15:00:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:00:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:00:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:00:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:00:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:00:03 INFO - no previously-included directories found matching 'docs/_build' 15:00:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:00:03 INFO - Running setup.py install for pep8 15:00:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:00:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:00:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:00:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:00:03 INFO - no previously-included directories found matching 'docs/_build' 15:00:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:00:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:00:03 INFO - Cleaning up... 15:00:03 INFO - Return code: 0 15:00:03 INFO - Running post-action listener: _resource_record_post_action 15:00:03 INFO - Running post-action listener: _start_resource_monitoring 15:00:03 INFO - Starting resource monitoring. 15:00:03 INFO - ##### 15:00:03 INFO - ##### Finished create-virtualenv step (success) 15:00:03 INFO - ##### 15:00:03 INFO - ##### 15:00:03 INFO - ##### Running install step. 15:00:03 INFO - ##### 15:00:03 INFO - Running pre-action listener: _resource_record_pre_action 15:00:03 INFO - Running main action method: install 15:00:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:00:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:00:03 INFO - Reading from file tmpfile_stdout 15:00:03 INFO - Detecting whether we're running mozinstall >=1.0... 15:00:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:00:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:00:03 INFO - Reading from file tmpfile_stdout 15:00:03 INFO - Output received: 15:00:03 INFO - Usage: mozinstall [options] installer 15:00:03 INFO - Options: 15:00:03 INFO - -h, --help show this help message and exit 15:00:03 INFO - -d DEST, --destination=DEST 15:00:03 INFO - Directory to install application into. [default: 15:00:03 INFO - "/builds/slave/test"] 15:00:03 INFO - --app=APP Application being installed. [default: firefox] 15:00:03 INFO - mkdir: /builds/slave/test/build/application 15:00:03 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'] 15:00:03 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 15:00:19 INFO - Reading from file tmpfile_stdout 15:00:19 INFO - Output received: 15:00:19 INFO - /builds/slave/test/build/application/firefox/firefox 15:00:19 INFO - Running post-action listener: _resource_record_post_action 15:00:19 INFO - ##### 15:00:19 INFO - ##### Finished install step (success) 15:00:19 INFO - ##### 15:00:19 INFO - ##### 15:00:19 INFO - ##### Running run-tests step. 15:00:19 INFO - ##### 15:00:19 INFO - Running pre-action listener: _resource_record_pre_action 15:00:19 INFO - Running main action method: run_tests 15:00:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:00:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:00:19 INFO - Python 2.7.3 15:00:19 INFO - Return code: 0 15:00:19 INFO - grabbing minidump binary from tooltool 15:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:00:19 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 0x213c2c0>, '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 0x213d1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213d650>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:00:19 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 15:00:19 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 15:00:19 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 15:00:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:00:19 INFO - Return code: 0 15:00:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:00:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:00:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:00:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:00:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:00:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:00:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:00:20 INFO - Return code: 0 15:00:20 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:00:20 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:00:20 INFO - Using env: {'DISPLAY': ':0', 15:00:20 INFO - 'HOME': '/home/cltbld', 15:00:20 INFO - 'LANG': 'en_US.UTF-8', 15:00:20 INFO - 'LANGUAGE': 'en_US:en', 15:00:20 INFO - 'LOGNAME': 'cltbld', 15:00:20 INFO - 'MAIL': '/var/mail/cltbld', 15:00:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:00:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:00:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:00:20 INFO - 'MOZ_NO_REMOTE': '1', 15:00:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:00:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:00:20 INFO - 'NO_EM_RESTART': '1', 15:00:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:00:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:00:20 INFO - 'PWD': '/builds/slave/test', 15:00:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:00:20 INFO - 'SHELL': '/bin/bash', 15:00:20 INFO - 'SHLVL': '1', 15:00:20 INFO - 'TERM': 'linux', 15:00:20 INFO - 'TMOUT': '86400', 15:00:20 INFO - 'USER': 'cltbld', 15:00:20 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466805109.324799-41278226', 15:00:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:00:20 INFO - '_': '/tools/buildbot/bin/python'} 15:00:20 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:00:20 INFO - mozversion application_buildid: 20160624133259 15:00:20 INFO - mozversion application_changeset: 9dac1358aaadcea90aca05b170fc8bc59e097d52 15:00:20 INFO - mozversion application_display_name: Nightly 15:00:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:00:20 INFO - mozversion application_name: Firefox 15:00:20 INFO - mozversion application_remotingname: firefox 15:00:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:00:20 INFO - mozversion application_vendor: Mozilla 15:00:20 INFO - mozversion application_version: 50.0a1 15:00:20 INFO - mozversion platform_buildid: 20160624133259 15:00:20 INFO - mozversion platform_changeset: 9dac1358aaadcea90aca05b170fc8bc59e097d52 15:00:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:00:20 INFO - mozversion platform_version: 50.0a1 15:00:20 INFO - using testdate: 1466805620 15:00:20 INFO - actual date: 1466805620 15:00:20 INFO - starting webserver on 'localhost:53018' 15:00:20 INFO - SUITE-START | Running 2 tests 15:00:20 INFO - TEST-START | dromaeo_css 15:00:20 INFO - operating with platform_type : linux_ 15:00:20 INFO - Initialising browser for dromaeo_css test... 15:00:20 INFO - TEST-INFO | started process 3914 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZt1866/profile http://localhost:53018/getInfo.html) 15:00:25 INFO - PROCESS | 3914 | __metrics Screen width/height:1600/1200 15:00:25 INFO - PROCESS | 3914 | colorDepth:24 15:00:25 INFO - PROCESS | 3914 | Browser inner width/height: 1024/697 15:00:25 INFO - PROCESS | 3914 | __metrics 15:00:26 INFO - PROCESS | 3914 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:00:27 INFO - TEST-INFO | 3914: exit 0 15:00:27 INFO - Browser initialized. 15:00:27 INFO - Running cycle 1/1 for dromaeo_css test... 15:00:27 INFO - TEST-INFO | started process 3998 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZt1866/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:00:39 INFO - PROCESS | 3998 | RSS: Main: 175763456 15:00:39 INFO - PROCESS | 3998 | 15:01:32 INFO - PROCESS | 3998 | 1466805692124 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] 15:03:43 INFO - PROCESS | 3998 | Cycle 1(1): loaded http://localhost:53018/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53018/tests/dromaeo/cssquery-ext.html) 15:03:44 INFO - PROCESS | 3998 | RSS: Main: 290353152 15:03:44 INFO - PROCESS | 3998 | 15:06:47 INFO - PROCESS | 3998 | Cycle 1(1): loaded http://localhost:53018/tests/dromaeo/cssquery-ext.html (next: http://localhost:53018/tests/dromaeo/cssquery-jquery.html) 15:06:48 INFO - PROCESS | 3998 | RSS: Main: 259969024 15:06:48 INFO - PROCESS | 3998 | 15:09:50 INFO - PROCESS | 3998 | Cycle 1(1): loaded http://localhost:53018/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53018/tests/dromaeo/cssquery-mootools.html) 15:09:51 INFO - PROCESS | 3998 | RSS: Main: 263839744 15:09:51 INFO - PROCESS | 3998 | 15:12:53 INFO - PROCESS | 3998 | Cycle 1(1): loaded http://localhost:53018/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53018/tests/dromaeo/cssquery-prototype.html) 15:12:54 INFO - PROCESS | 3998 | RSS: Main: 252067840 15:12:54 INFO - PROCESS | 3998 | 15:15:57 INFO - PROCESS | 3998 | Cycle 1(1): loaded http://localhost:53018/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53018/tests/dromaeo/cssquery-yui.html) 15:15:57 INFO - PROCESS | 3998 | RSS: Main: 245301248 15:15:57 INFO - PROCESS | 3998 | 15:19:00 INFO - PROCESS | 3998 | Cycle 1(1): loaded http://localhost:53018/tests/dromaeo/cssquery-yui.html (next: http://localhost:53018/tests/dromaeo/cssquery-dojo.html) 15:19:01 INFO - PROCESS | 3998 | RSS: Main: 303181824 15:19:01 INFO - PROCESS | 3998 | 15:19:01 INFO - PROCESS | 3998 | __start_tp_report 15:19:01 INFO - PROCESS | 3998 | _x_x_mozilla_page_load 15:19:01 INFO - PROCESS | 3998 | _x_x_mozilla_page_load_details 15:19:01 INFO - PROCESS | 3998 | |i|pagename|runs| 15:19:01 INFO - PROCESS | 3998 | |0;dojo.html;2670.9983756091465;2682.329417645589;2711.945761084779;2739.5890616407537;2744.574590938404;4605.861824145272;4668.76656167192;4760.761961901904;4843.612510999121;4901.0687969285855;4700.788464519096;4740.051989602076;4747.905041899168;4750.90498190036;4771.642126840484;4341.739495630264;4391.0559229765595;4434.113177364524;4462.97768511157;4596.97701511492;4513.480949690778;4532.864014079583;4535.863924082283;4536.160810250114;4586.197415452282;4291.034517233628;4344;4352.151330490556;4399.758013309267;4447.933281000787;4393.5606439356125;4401.867943961654;4458.799354029076;4481.708688935209;4482.731036137842;4424.380586717862;4439.733615983051;4468.329750537413;4490.7979140938405;4495.078508905666;4628.074385122989;4843.467218605951;4887.95112048882;4900.289458028566;4900.607951363882;5018.447970723218;5019.171836646949;5031.823886164003;5109.054824857413;5153.768080436389;5136.948630513722;5140.1004824155625;5167.819126330598;5179.766910488999;5187.04039752647;4626.6298696104905;4757.643176761757;4786.0667169902235;4821.831235906727;4827.396575428072;5219.164933610604;5272.05103081449;5272.973635131876;5291.04761142998;5294.391145018372;5063.87340316495;5073.822416215415;5075.87310317245;5077.416097148875;5078.492150784966;5034.622403319766;5087.97456012725;5101.489851014869;5106.463821298785;5147.459516750762;5137.743112844343;5157.510036546522;5158.200478925773;5161.5870730341485;5182.041322355376;5113.079645663816;5122.538971492509;5129.3075434816565;5135.589152867761;5191.299174611455;4214.7471151731;4262.190183865056;4267.701260911706;4297.05464797744;4303.203907277164;3824.2351529694174;3828.502294701671;3866.38137897935;3902.375619900802;3912.237113762789;4489.6408287336935;4491.910161796745;4495.235809912323;4496.303073023687;4547.249703798836;4971.45314015458;5102.489751024942;5228.05894938907;5233.921491177635;5287.788488460418;4418.668599855024;4439.755813430293;4459.219636563588;4487.730736155841;4490.7754612269255;4605.838795642137;4609.216433206363;4615.284630882219;4617;4663.743494107856;4737.881552961204;4809.206480930748;4821.349117869113;4831.661783675109;4869.975650121727;5204.115300398866;5218.608604354765;5224.634275600672;5224.791008359623;5267.209918512254;4858.368412106403;4877.244027175793;4888.706677599355;4890.926636100533;4934.087193869145;4945.901081978413;5043.52086551777;5107.157319042316;5118.181091025418;5143.819966301162;5178.741062946762;5192.662476938987;5192.922106168335;5202.1416466282635;5203.089459344676;5045.11710450677;5046.571041461517;5066.31604733371;5068.113080211022;5070.087384270867;4892.902141957212;4898.289747986593;4945;4952;4984.975075124601;4910.361652985232;4948.529889660476;4982.352294201731;4984.750762461935;4989.451160372429;4892.119418504703;5034.14419548685;5038.672486288379;5039.84880453587;5082.517160869711;4929.827456039022;4985.551300382838;4990.076835785391;5000.64995450315;5016.749162541785 15:19:01 INFO - PROCESS | 3998 | |1;ext.html;547.051861891503;583.3553922915175;586.4487381861047;586.6861229242355;600.6066026752477;26851.19446416608;38288.808555957214;39264.607353926454;39277.99999999996;39301.21397572047;41482.377764333556;42064.57935420645;42069.7896510517;42079.36880946788;42099.78950105253;7467.066616672916;7664.463487555873;7671.347935425496;7735.729249476283;7883.566403847786;7596.696132154707;9791.216702663769;10102.69691909244;10102.797944041115;10448.425336606484;10150.644727434541;10215.182785377188;10217.693469195936;10219.182465402788;10227.488625568729;7495.775126746206;9893.911669716397;10023.047810457994;10131.746706332327;10132.94933525335;9676.516174191262;10086.243531735076;10114;10117.696469105938;10136;39250.41124383137;39671.40492892609;39704.20591588181;39712.20575588501;39714.404283935764;2980.165553644983;3024.817227831108;3116.8129912205113;3148.212946763309;3184.9203769905707;29625;29754.256143596365;30147.849260753774;30862.691373086433;31125.844370778228;3406.812625305607;3497.0732755819727;3520.119970007498;3540.6105328413855;3562.109472631842;253837;255414;255726;255769;256296;31505;32776;32785.34429311448;48246.75876620664;48497.75751121222;34063.14842128967;34339.82830085883;34455.48316775251;34471.4829277561;34480.31039379198;13068.150570212905;13134.474621015052;13173.60479185626;13219.405126769318;13236.404361803741;8947.955260223787;10495.370277783357;10866.185036122322;10883.455827208609;10948.507317170746;7793.766187014398;7879.921200787919;7889.644965976545;7938.364930805522;7959.8408031839035;3046.939061218763;3100.410921924827;3101.968980310168;3104.0532637545766;3118.5789918361183;859.8925134358205;887.3699673232078;889.2219308105408;914.3005600715458;946.2430055955208;27190.184294471197;27804.860975695396;27939;28099.43801123966;28117.297067573476;929.0570071377557;945.5083356654638;957.875476188091;965.1988849255101;968.3076600230869;14579.125252484884;14900.62748431298;14975.475858344906;14984.175870327019;15021.69956600862;121738.39130804467;121892.39053804675;121991.39004304922;122349.38825305995;122366.38816806037;49228.753856231204;49988.500114999115;50058.24912626314;50086.24870626871;50086.749566251936;1073.302353470235;1157.8321143434323;1160.271195918076;1191.0709646475764;1200.5497938273147;27875.721242787313;28930.566041509814;29113.85443072771;29211.561826573045;29854.850725746233;42367.57632423636;42935.78532107319;42992.570074298856;43036.139277214905;43061.56938430575;279071;284572;284926;285521;285664;22902.656460153445;24989.125380612317;25663.615045774703;25955.610665840406;27438.862805685843;42804.46833112606;43137;43227.35158972681;43289;43442.565574343855;33861.32277354488;35105.473417899266;35286.47070293896;35827.82086089553;36104.27791444104;36343.818280908425;36676.81661591675;37154;37172;37359.43960840535;34549.827250863586;34874.47688284729;34976.30047399089;35395.82302088473;35884.820575896956;31244.531332030492;31796.523052153774;32375.35249294954;32404.35191296208;32529.83735081404;24626.87686561556;24699.753002470465;25051;25446.363840904127;25529.87235063813 15:19:01 INFO - PROCESS | 3998 | |2;jquery.html;363.9308531379038;366.3387585408338;369.39972544614983;373.4566206170023;378.96778773804226;16606.584835379123;16872.578185545353;17836.64326713465;17861.285548578075;17908.91045544772;16138.596535086599;17064.914675426637;17209;17248.137593120355;17281.395151169712;4932.284818701286;5180.740962951856;5208.869778255536;5210.973945130288;5215.426303106655;3659.8719044833438;3929.98035009826;5075.086484432819;5644.887102257952;5964.105384192384;5984.581079324449;5986.5210783137245;6019.247594050744;6020.548458865581;6023.096535519663;5783.6240644358195;6020.7290671919645;6021.277446706424;6027.7287522061615;6027.819165425044;3321.468565029608;4927.285543596195;5283.365996080456;5292.470752924715;5303.071962406563;17384.565385865328;17398.739018914726;17544.29822807086;21063.368098957057;21096;2019.1418647074934;2058.4545095549693;2114.7161066048784;2144.2066435418997;2515.1448507507534;13064.21614703121;13149.802752958713;13242.337883105902;13372.598822035354;13904.652383690387;1717.5534361066088;1719.3638353809047;1724.8447639712485;1750.8774385793;1755.4558086993072;66982.3301766981;70871.64564177197;70908.29091709068;71367.99999999948;71424;9337.206337461392;9462.52687365629;9699.272554558294;9893.15908147801;9922;13205.415350158042;13425.86574134246;13459.192448453125;13494.595162145151;13542.932285338511;7231.63841807918;7279.426409081877;7333.726544771138;7342.632868356561;7382.630868456556;7000.859982800417;7081.468889833283;7083.220845706968;7191.9931209630695;7226.313500217471;6065.211522502046;6110.572259941761;6114.309703730344;6157.491414603451;6179.073139029092;1597;1660.7840980672436;1666.4084250091285;1690.9746353804703;1763.2594310389668;826.6610689617228;865.8874346334936;881.4623079921242;954.656323723459;1005.3415013166388;17053.7441938371;17201.397951071653;17444;17580.120993950506;17901.19444624995;873.4235404632911;874.6807415293499;884.9601767920459;920.415536134546;925.6343744220995;9730.854037189449;10164.644237451654;10183.490825458697;10218.846717299246;10290.228232882415;398285;405076;405726;406271;406899;61219.693901530205;64550;65791.67104164544;66022.33977660161;67794;904.3082042237694;918.8024574716468;923.7136487688838;941.2658126661215;941.7786820097272;15491.922540387677;15569.68860622804;15706.057636541844;15845.920770396075;16205.67588648244;35041;35955.64044359523;35977.460338094425;36493.81753091217;37055.44416833696;45460.77269613763;46156.53843461657;47533.762331188125;47559.286610700176;47784.04431911412;7721.459497835098;7749.690012399441;7789.104253010976;7826.295633393022;7944.086430060617;11516.94241528787;11723.179377443497;11824.172307938361;11867.109966752356;12250.203736757083;9623.133917947418;9941.552630131806;10000.499975001076;10005;10295.17638588896;10566.101881340172;10672.62645807393;10712.517936692711;10727.249092563758;10732.517036733521;9792;9877.259205559469;9973.252006099427;9974.750631234278;10310.639127630497;7646.082470103624;7722.652480638272;7736.1103473099065;7787.688492460238;7882.290593846581;9682.031796820262;9789.951050244703;10052.497375131068;10245.897541024495;10516.158707303244 15:19:01 INFO - PROCESS | 3998 | |3;mootools.html;1220.3349174699788;1356.1252991820277;1424.5868698077559;1480.7556753135734;1695.4320302698602;6472.902906456401;7901.683932642694;8210.999999999993;8219;8234.423590348679;7832.216778322165;8052;8055.91944080559;8064.193580641933;8066.11272759996;1823.7902641196233;1892.2052737850136;1897.1936926806052;2224.3660556741293;2253.1325439705747;1973.8124878136555;2175.5431359414465;2230.11910295434;2234.452559123017;2283.942901427461;2204.6582779669175;2226.4322597737637;2231.9776802232013;2235.485838257202;2235.6087684655204;1680.453852497943;2106.8314534837177;2137.7220961274934;2143.4212762554025;2147.3987283560627;2063.504758857878;2116;2118.6398312286947;2149.0436755643746;2151.397608669575;7987.3610111190965;8051.0741264754715;8063.95968020162;8065.798355041112;8071.112177660452;4522.140793249272;4673.182193116191;4675.976620116911;4676.719396836201;4678.111158879802;2939.441506113853;3029.439553682576;3030.424219398329;3113.34619729857;3176.8252746098956;901.3465237702678;916.573793186165;927.4388994658202;930.3950685068271;942.6088173408027;11199.66401007971;11207.495662695199;11229.719257018558;11238.943805281004;11244.606438774603;4179.2895207814745;4317.7193482423545;4391.165678521071;4434.224010798098;4441.578050085237;9407.106324899123;9452.810943781224;9453.196478299422;9475.194608458358;9479.383840050376;4593.494715581283;4597.3793537872625;4601.148787474328;4604.1252162089095;4606.401167848226;3085.969140308568;3439.7325426359535;4201.243776120327;4270.295401258758;4274.380214868889;3681.466187402865;3798.981005094957;3805.657490825839;3834.5206849143856;3853;1201.9759604807855;1208.5226335597565;1209.3106929050357;1227.9815802762967;1231.9260844349367;621.1366200980641;715.7852644206718;815.2906970935325;823.8022874510075;848.2320222487186;5243.449437809051;5291.867703307448;5348.572114230852;5431.945680543223;5497.39528651848;386.21405439929606;387.09613053520343;388.57062945445443;389.92981263372866;392.98821035368985;3542.4686297055646;3605.8557657693923;3612.6206748291575;3646.252518233756;3687.7049836013052;9703.417794932328;10050.547725352377;10068.194544436428;10176.033276838689;10189.388636681822;10040.748981275381;10072.798544029078;10073.49632518371;10085.596576136872;10091.344062635904;7219.494635375579;7243.565386076747;7244.927550724531;7292.96353518229;7313.122425308997;5262.394824595221;5314;5475.72621368922;5496.6701997880255;5595.160725891149;8699.347548933729;9035.50304733246;9057.501837399006;9263.397879137834;9335.57989890443;8562.100979397073;9007.09929007094;9012.504312262889;9411.85882211781;9443.527823608929;5991.7902873399225;6532.248791388861;6743.460523158037;6745.763898263537;6756.087928129639;7480.887786683313;7492;7517.060367454068;7524.473286869867;7561.432892532972;6432.807015789534;6438.130852335063;6476.805695829133;6543.5419520633095;6664.83337916556;6347.0479428086155;6375.9362406377195;6451.612903225821;6497.772577959749;6527.3472652734345;5893.32226793907;5938;5942;5970.432808883149;5972.34304226526;4307.763073031013;4515.841945531891;4602.309653551994;4605.861824145281;4656.627469802475;4692.085043416501;4711.717296962056;4755.643326750438;4768.856934291976;4820.325154478306 15:19:01 INFO - PROCESS | 3998 | |4;prototype.html;286.328559527907;300.7098150284975;301.66665834253166;304.14383510418185;310.0265167374444;4875.000624871902;4903.16646170151;4905.313256144138;4915.877103072425;4916.016796640668;4577.427821522309;4684.437867455901;4709.387779588648;4841.176999910015;4856.223004319309;3777.5655799583124;3797.373433383488;3799.8290076946605;3803.953912674023;3814.2180852925153;3801.2397520495874;3805.70605993962;3817.7327587068917;3823.1206822430718;3836.271108489378;3547.92904141917;3622.4385220290765;3795.6583907448326;3812.4281357796276;3815.198808250257;3749.43758436234;3771.41543060826;3776.8300426480873;3781.2815565042692;3786.1859700164596;3369.4440417331357;3370.1069216657606;3378.8817391391185;3379.4086034943784;3421.9657803422147;4510.278355463143;4691.249400095969;4727.66906316558;4795.352627395292;4800.415862765279;4328.567143285678;4336.609705126553;4341.196878577442;4355.542668019875;4367.519572846984;5042.42012168598;5078.669886457368;5080.069573562059;5085.415177254626;5093.376910890895;3579.6957258633047;3674.2651469705897;3675.7794532328144;3677.7609455385314;3678.5585729712607;5247.658902171346;5287.444818294062;5291.682499050031;5310.2831117798605;5328.227407025959;3764.4729737836724;3771.8868433947027;3774.6225377462583;3799.9240015199543;3806.923861522754;3876.972602260403;3893.824777885002;3895.35726605107;3899.947014306178;3902.2780785554196;4295.076558539929;4362.236608593484;4371.868843934687;4402.691811573159;4414.933775993362;5049.469805670426;5066.113430149783;5073.923891141562;5074.847754567295;5080.872978175501;1227.3188380448937;1274.6877015131352;1276.5914907229596;1318.723068155698;1334.359507436436;795.7745072588265;830.8629076202479;904.7466709321401;920.265299909675;947.7346343023827;4495.707778994355;4502.234620114588;4518.615917646971;4557.111363284194;4558.544145585482;5182.807954170562;5226;5262.631615786935;5266.920996184984;5310.176922577007;4504.324351347259;4538.1377538267625;4541.545845415432;4542.954570454319;4555.2711566149255;2784.3015760386147;2799.936024310749;2817.2534278416238;2826.8727907244224;2831.815931964457;4708.317293992352;4930.654854160246;4932.802687892516;4936.48166942473;4948.109340318705;5236.947630523646;5248.527632513092;5255.39562950258;5353.759080841293;5364.624476286701;4921.680090794087;4922.310876477296;4935.407751069823;4941.431735350337;4953.801847926186;4961.875953101057;5199.792008319625;5206.927912531624;5228.346456692913;5235.1623740201385;5086.160783470834;5116.181410974226;5128.051310507568;5130.281760553451;5183.196604526304;4885.706857588556;4887.144749668722;4889.266610008385;4897.608191344612;4901.411830580353;3700.2044560418562;3751.6752966078125;3805.287620570699;3835.213781174908;3843.135294558702;5147.2279158126585;5165.9483405165465;5189.4032186299055;5220.347456567929;5226.503482169188;5018.5232402921665;5021;5025.824096156617;5045.84862454127;5074.517920797518;4866.586340161126;5033.2701758245585;5045.369328833895;5058.962912602834;5069.467705890828;4802.807887684454;4929.412058669084;4956.134215312062;4978.352814134139;5035.59715222774;5095.719735414439;5145.279660847559;5148.9227661584355;5149.304843846033;5179.404368497671;4935.864751107194;5015.3480047593575;5039.420466646383;5043.218301163325;5067.567567567515 15:19:01 INFO - PROCESS | 3998 | |5;yui.html;704.9718011279546;725.8439435521362;736.3152268390397;749.7263498822931;772.6252767407806;13323.333833308345;13805.51680691176;13825.239611821346;13898.51355202568;13933.024688271813;14876.47932322369;15029.774553381709;15040.699186016273;15088.547343579683;15123.546293611209;616.5406771954899;744.0439035838948;753.7776355974974;754.6113751417996;754.728297812787;750.973715919943;771.1709911844762;771.2518856709012;771.5756334016297;774.5855967057626;796.4584082823677;798.632628990665;799.3804801278997;799.816042310269;799.8240387114826;643.427349658804;789.3369569561596;793.3732351442353;799.2487062161549;799.3445374792673;588.1853632718716;588.2764200033939;588.6615196262167;589.4900910712246;590.4567797626195;13426.798598021038;13437.865621343759;13491.662708432368;13511.932440337834;13521.661958451019;11997.160198786089;12288.631341059783;12442.626721198378;12675.429605667674;12900.935495322557;12069;12120.636380908587;12221.755564888741;12258.08064395174;12464.688382790502;4175.290200665863;4195.181939521794;4197.307444271692;4277.887749185204;4300;68795.65602172007;68929;69617;70067;70301;9220.953895230481;9259.814803703888;9610;10006.899931000597;10327.741806454898;17803.376881809076;17804.109794510223;17824.46526604204;17834;17834.28662853471;6639.734410623618;6677.632730199885;6705.765298214539;6712.261651218362;6763.72945082201;3651.8174091295327;3712.6844218241754;3771.340015497277;3779.074126838942;3785.6971442284553;2785.7075007124367;2889.8121622094495;2899.9420011600073;2900.260433589421;2904.361040571071;505.24970418927865;509.7680555347382;512.1242675025674;515.7859488312383;516.8501134670903;497.99156707667265;507.1960941907045;512.6821370750159;529.1665626638061;549.2063967566908;7124.750633727795;7305.671244793997;7390.011742074186;7509.7371591994015;7529.924700752922;454.72261920228635;480.4354883012446;521.3379008658982;536.3028063517412;541.2773946781091;3424.3151369726156;3713.591504934455;3737.2808508086587;3793.3172029034486;3984.621460961204;87446;95008.0499195013;95626.52186739161;97743;97932.51033744785;60076.69961650164;80913.59543202363;80991.5950420256;81119.18880811117;81923;52239.738801306514;73511.74058889304;76524.85212721814;76656;77733.6113319441;7502.774916752506;7594.430417718582;7661.961690191513;7893.210678932061;7974.362051036019;41592.792036039624;42514.14971700487;42603.7869810649;42800.78599606982;44878;59765;61302.38697612967;62834;63542;63549.6822515903;11158.156418217834;11436.199466037298;11597.362145082101;11720.830585049478;12019.579314723942;13137.540186093442;13152.605421837361;13584.456621735415;13912.443502259795;14012;12208.511659533875;12224.205426647239;12315.261084334968;12513.186642868184;12911.870881291066;11850.76298474043;12173.939130304292;12354.814677779661;12628.368581571069;12640.178388404724;11595.8260626089;11699.2980421175;12040.698982525157;12251.509939602316;12263.202891812003;9574.956119355342;9716.3198576099;10072.84988553589;10110.8483372748;10143.289969702346;9010.459372437675;9180.816383672156;9552.331336806357;9826.115649591571;9990.950045249727 15:19:01 INFO - PROCESS | 3998 | __end_tp_report 15:19:01 INFO - PROCESS | 3998 | __start_cc_report 15:19:01 INFO - PROCESS | 3998 | _x_x_mozilla_cycle_collect,1114 15:19:01 INFO - PROCESS | 3998 | __end_cc_report 15:19:01 INFO - PROCESS | 3998 | __startTimestamp1466806741147__endTimestamp 15:19:01 INFO - PROCESS | 3998 | 15:19:01 INFO - PROCESS | 3998 | ------- Summary: start ------- 15:19:01 INFO - PROCESS | 3998 | Number of tests: 6 15:19:01 INFO - PROCESS | 3998 | 15:19:01 INFO - PROCESS | 3998 | [#0] dojo.html Cycles:165 Average:4759.79 Median:4892.90 stddev:493.52 (10.1%) stddev-sans-first:467.04 15:19:01 INFO - PROCESS | 3998 | Values: 2671.0 2682.3 2711.9 2739.6 2744.6 4605.9 4668.8 4760.8 4843.6 4901.1 4700.8 4740.1 4747.9 4750.9 4771.6 4341.7 4391.1 4434.1 4463.0 4597.0 4513.5 4532.9 4535.9 4536.2 4586.2 4291.0 4344.0 4352.2 4399.8 4447.9 4393.6 4401.9 4458.8 4481.7 4482.7 4424.4 4439.7 4468.3 4490.8 4495.1 4628.1 4843.5 4888.0 4900.3 4900.6 5018.4 5019.2 5031.8 5109.1 5153.8 5136.9 5140.1 5167.8 5179.8 5187.0 4626.6 4757.6 4786.1 4821.8 4827.4 5219.2 5272.1 5273.0 5291.0 5294.4 5063.9 5073.8 5075.9 5077.4 5078.5 5034.6 5088.0 5101.5 5106.5 5147.5 5137.7 5157.5 5158.2 5161.6 5182.0 5113.1 5122.5 5129.3 5135.6 5191.3 4214.7 4262.2 4267.7 4297.1 4303.2 3824.2 3828.5 3866.4 3902.4 3912.2 4489.6 4491.9 4495.2 4496.3 4547.2 4971.5 5102.5 5228.1 5233.9 5287.8 4418.7 4439.8 4459.2 4487.7 4490.8 4605.8 4609.2 4615.3 4617.0 4663.7 4737.9 4809.2 4821.3 4831.7 4870.0 5204.1 5218.6 5224.6 5224.8 5267.2 4858.4 4877.2 4888.7 4890.9 4934.1 4945.9 5043.5 5107.2 5118.2 5143.8 5178.7 5192.7 5192.9 5202.1 5203.1 5045.1 5046.6 5066.3 5068.1 5070.1 4892.9 4898.3 4945.0 4952.0 4985.0 4910.4 4948.5 4982.4 4984.8 4989.5 4892.1 5034.1 5038.7 5039.8 5082.5 4929.8 4985.6 4990.1 5000.6 5016.7 15:19:01 INFO - PROCESS | 3998 | 15:19:01 INFO - PROCESS | 3998 | [#1] ext.html Cycles:180 Average:38121.18 Median:32652.92 stddev:60679.20 (185.8%) stddev-sans-first:60783.84 15:19:01 INFO - PROCESS | 3998 | Values: 547.1 583.4 586.4 586.7 600.6 26851.2 38288.8 39264.6 39278.0 39301.2 41482.4 42064.6 42069.8 42079.4 42099.8 7467.1 7664.5 7671.3 7735.7 7883.6 7596.7 9791.2 10102.7 10102.8 10448.4 10150.6 10215.2 10217.7 10219.2 10227.5 7495.8 9893.9 10023.0 10131.7 10132.9 9676.5 10086.2 10114.0 10117.7 10136.0 39250.4 39671.4 39704.2 39712.2 39714.4 2980.2 3024.8 3116.8 3148.2 3184.9 29625.0 29754.3 30147.8 30862.7 31125.8 3406.8 3497.1 3520.1 3540.6 3562.1 253837.0 255414.0 255726.0 255769.0 256296.0 31505.0 32776.0 32785.3 48246.8 48497.8 34063.1 34339.8 34455.5 34471.5 34480.3 13068.2 13134.5 13173.6 13219.4 13236.4 8948.0 10495.4 10866.2 10883.5 10948.5 7793.8 7879.9 7889.6 7938.4 7959.8 3046.9 3100.4 3102.0 3104.1 3118.6 859.9 887.4 889.2 914.3 946.2 27190.2 27804.9 27939.0 28099.4 28117.3 929.1 945.5 957.9 965.2 968.3 14579.1 14900.6 14975.5 14984.2 15021.7 121738.4 121892.4 121991.4 122349.4 122366.4 49228.8 49988.5 50058.2 50086.2 50086.7 1073.3 1157.8 1160.3 1191.1 1200.5 27875.7 28930.6 29113.9 29211.6 29854.9 42367.6 42935.8 42992.6 43036.1 43061.6 279071.0 284572.0 284926.0 285521.0 285664.0 22902.7 24989.1 25663.6 25955.6 27438.9 42804.5 43137.0 43227.4 43289.0 43442.6 33861.3 35105.5 35286.5 35827.8 36104.3 36343.8 36676.8 37154.0 37172.0 37359.4 34549.8 34874.5 34976.3 35395.8 35884.8 31244.5 31796.5 32375.4 32404.4 32529.8 24626.9 24699.8 25051.0 25446.4 25529.9 15:19:01 INFO - PROCESS | 3998 | 15:19:01 INFO - PROCESS | 3998 | [#2] jquery.html Cycles:180 Average:24445.57 Median:45808.66 stddev:66392.51 (144.9%) stddev-sans-first:66554.14 15:19:01 INFO - PROCESS | 3998 | Values: 363.9 366.3 369.4 373.5 379.0 16606.6 16872.6 17836.6 17861.3 17908.9 16138.6 17064.9 17209.0 17248.1 17281.4 4932.3 5180.7 5208.9 5211.0 5215.4 3659.9 3930.0 5075.1 5644.9 5964.1 5984.6 5986.5 6019.2 6020.5 6023.1 5783.6 6020.7 6021.3 6027.7 6027.8 3321.5 4927.3 5283.4 5292.5 5303.1 17384.6 17398.7 17544.3 21063.4 21096.0 2019.1 2058.5 2114.7 2144.2 2515.1 13064.2 13149.8 13242.3 13372.6 13904.7 1717.6 1719.4 1724.8 1750.9 1755.5 66982.3 70871.6 70908.3 71368.0 71424.0 9337.2 9462.5 9699.3 9893.2 9922.0 13205.4 13425.9 13459.2 13494.6 13542.9 7231.6 7279.4 7333.7 7342.6 7382.6 7000.9 7081.5 7083.2 7192.0 7226.3 6065.2 6110.6 6114.3 6157.5 6179.1 1597.0 1660.8 1666.4 1691.0 1763.3 826.7 865.9 881.5 954.7 1005.3 17053.7 17201.4 17444.0 17580.1 17901.2 873.4 874.7 885.0 920.4 925.6 9730.9 10164.6 10183.5 10218.8 10290.2 398285.0 405076.0 405726.0 406271.0 406899.0 61219.7 64550.0 65791.7 66022.3 67794.0 904.3 918.8 923.7 941.3 941.8 15491.9 15569.7 15706.1 15845.9 16205.7 35041.0 35955.6 35977.5 36493.8 37055.4 45460.8 46156.5 47533.8 47559.3 47784.0 7721.5 7749.7 7789.1 7826.3 7944.1 11516.9 11723.2 11824.2 11867.1 12250.2 9623.1 9941.6 10000.5 10005.0 10295.2 10566.1 10672.6 10712.5 10727.2 10732.5 9792.0 9877.3 9973.3 9974.8 10310.6 7646.1 7722.7 7736.1 7787.7 7882.3 9682.0 9790.0 10052.5 10245.9 10516.2 15:19:01 INFO - PROCESS | 3998 | 15:19:01 INFO - PROCESS | 3998 | [#3] mootools.html Cycles:180 Average:5176.92 Median:4674.58 stddev:3001.85 (64.2%) stddev-sans-first:2995.55 15:19:01 INFO - PROCESS | 3998 | Values: 1220.3 1356.1 1424.6 1480.8 1695.4 6472.9 7901.7 8211.0 8219.0 8234.4 7832.2 8052.0 8055.9 8064.2 8066.1 1823.8 1892.2 1897.2 2224.4 2253.1 1973.8 2175.5 2230.1 2234.5 2283.9 2204.7 2226.4 2232.0 2235.5 2235.6 1680.5 2106.8 2137.7 2143.4 2147.4 2063.5 2116.0 2118.6 2149.0 2151.4 7987.4 8051.1 8064.0 8065.8 8071.1 4522.1 4673.2 4676.0 4676.7 4678.1 2939.4 3029.4 3030.4 3113.3 3176.8 901.3 916.6 927.4 930.4 942.6 11199.7 11207.5 11229.7 11238.9 11244.6 4179.3 4317.7 4391.2 4434.2 4441.6 9407.1 9452.8 9453.2 9475.2 9479.4 4593.5 4597.4 4601.1 4604.1 4606.4 3086.0 3439.7 4201.2 4270.3 4274.4 3681.5 3799.0 3805.7 3834.5 3853.0 1202.0 1208.5 1209.3 1228.0 1231.9 621.1 715.8 815.3 823.8 848.2 5243.4 5291.9 5348.6 5431.9 5497.4 386.2 387.1 388.6 389.9 393.0 3542.5 3605.9 3612.6 3646.3 3687.7 9703.4 10050.5 10068.2 10176.0 10189.4 10040.7 10072.8 10073.5 10085.6 10091.3 7219.5 7243.6 7244.9 7293.0 7313.1 5262.4 5314.0 5475.7 5496.7 5595.2 8699.3 9035.5 9057.5 9263.4 9335.6 8562.1 9007.1 9012.5 9411.9 9443.5 5991.8 6532.2 6743.5 6745.8 6756.1 7480.9 7492.0 7517.1 7524.5 7561.4 6432.8 6438.1 6476.8 6543.5 6664.8 6347.0 6375.9 6451.6 6497.8 6527.3 5893.3 5938.0 5942.0 5970.4 5972.3 4307.8 4515.8 4602.3 4605.9 4656.6 4692.1 4711.7 4755.6 4768.9 4820.3 15:19:01 INFO - PROCESS | 3998 | 15:19:01 INFO - PROCESS | 3998 | [#4] prototype.html Cycles:180 Average:4231.97 Median:4848.70 stddev:1215.40 (25.1%) stddev-sans-first:1182.18 15:19:01 INFO - PROCESS | 3998 | Values: 286.3 300.7 301.7 304.1 310.0 4875.0 4903.2 4905.3 4915.9 4916.0 4577.4 4684.4 4709.4 4841.2 4856.2 3777.6 3797.4 3799.8 3804.0 3814.2 3801.2 3805.7 3817.7 3823.1 3836.3 3547.9 3622.4 3795.7 3812.4 3815.2 3749.4 3771.4 3776.8 3781.3 3786.2 3369.4 3370.1 3378.9 3379.4 3422.0 4510.3 4691.2 4727.7 4795.4 4800.4 4328.6 4336.6 4341.2 4355.5 4367.5 5042.4 5078.7 5080.1 5085.4 5093.4 3579.7 3674.3 3675.8 3677.8 3678.6 5247.7 5287.4 5291.7 5310.3 5328.2 3764.5 3771.9 3774.6 3799.9 3806.9 3877.0 3893.8 3895.4 3899.9 3902.3 4295.1 4362.2 4371.9 4402.7 4414.9 5049.5 5066.1 5073.9 5074.8 5080.9 1227.3 1274.7 1276.6 1318.7 1334.4 795.8 830.9 904.7 920.3 947.7 4495.7 4502.2 4518.6 4557.1 4558.5 5182.8 5226.0 5262.6 5266.9 5310.2 4504.3 4538.1 4541.5 4543.0 4555.3 2784.3 2799.9 2817.3 2826.9 2831.8 4708.3 4930.7 4932.8 4936.5 4948.1 5236.9 5248.5 5255.4 5353.8 5364.6 4921.7 4922.3 4935.4 4941.4 4953.8 4961.9 5199.8 5206.9 5228.3 5235.2 5086.2 5116.2 5128.1 5130.3 5183.2 4885.7 4887.1 4889.3 4897.6 4901.4 3700.2 3751.7 3805.3 3835.2 3843.1 5147.2 5165.9 5189.4 5220.3 5226.5 5018.5 5021.0 5025.8 5045.8 5074.5 4866.6 5033.3 5045.4 5059.0 5069.5 4802.8 4929.4 4956.1 4978.4 5035.6 5095.7 5145.3 5148.9 5149.3 5179.4 4935.9 5015.3 5039.4 5043.2 5067.6 15:19:01 INFO - PROCESS | 3998 | 15:19:01 INFO - PROCESS | 3998 | [#5] yui.html Cycles:180 Average:17660.51 Median:510.95 stddev:24779.68 (4849.8%) stddev-sans-first:24816.49 15:19:01 INFO - PROCESS | 3998 | Values: 705.0 725.8 736.3 749.7 772.6 13323.3 13805.5 13825.2 13898.5 13933.0 14876.5 15029.8 15040.7 15088.5 15123.5 616.5 744.0 753.8 754.6 754.7 751.0 771.2 771.3 771.6 774.6 796.5 798.6 799.4 799.8 799.8 643.4 789.3 793.4 799.2 799.3 588.2 588.3 588.7 589.5 590.5 13426.8 13437.9 13491.7 13511.9 13521.7 11997.2 12288.6 12442.6 12675.4 12900.9 12069.0 12120.6 12221.8 12258.1 12464.7 4175.3 4195.2 4197.3 4277.9 4300.0 68795.7 68929.0 69617.0 70067.0 70301.0 9221.0 9259.8 9610.0 10006.9 10327.7 17803.4 17804.1 17824.5 17834.0 17834.3 6639.7 6677.6 6705.8 6712.3 6763.7 3651.8 3712.7 3771.3 3779.1 3785.7 2785.7 2889.8 2899.9 2900.3 2904.4 505.2 509.8 512.1 515.8 516.9 498.0 507.2 512.7 529.2 549.2 7124.8 7305.7 7390.0 7509.7 7529.9 454.7 480.4 521.3 536.3 541.3 3424.3 3713.6 3737.3 3793.3 3984.6 87446.0 95008.0 95626.5 97743.0 97932.5 60076.7 80913.6 80991.6 81119.2 81923.0 52239.7 73511.7 76524.9 76656.0 77733.6 7502.8 7594.4 7662.0 7893.2 7974.4 41592.8 42514.1 42603.8 42800.8 44878.0 59765.0 61302.4 62834.0 63542.0 63549.7 11158.2 11436.2 11597.4 11720.8 12019.6 13137.5 13152.6 13584.5 13912.4 14012.0 12208.5 12224.2 12315.3 12513.2 12911.9 11850.8 12173.9 12354.8 12628.4 12640.2 11595.8 11699.3 12040.7 12251.5 12263.2 9575.0 9716.3 10072.8 10110.8 10143.3 9010.5 9180.8 9552.3 9826.1 9991.0 15:19:01 INFO - PROCESS | 3998 | -------- Summary: end -------- 15:19:01 INFO - PROCESS | 3998 | 15:19:01 INFO - TEST-INFO | 3998: exit 0 15:19:01 INFO - TEST-OK | dromaeo_css | took 1121013ms 15:19:01 INFO - TEST-START | kraken 15:19:01 INFO - operating with platform_type : linux_ 15:19:01 INFO - Initialising browser for kraken test... 15:19:01 INFO - TEST-INFO | started process 4181 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0UipRZ/profile http://localhost:53018/getInfo.html) 15:19:06 INFO - PROCESS | 4181 | __metrics Screen width/height:1600/1200 15:19:06 INFO - PROCESS | 4181 | colorDepth:24 15:19:06 INFO - PROCESS | 4181 | Browser inner width/height: 1024/697 15:19:06 INFO - PROCESS | 4181 | __metrics 15:19:07 INFO - PROCESS | 4181 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:19:08 INFO - TEST-INFO | 4181: exit 0 15:19:08 INFO - Browser initialized. 15:19:08 INFO - Running cycle 1/1 for kraken test... 15:19:08 INFO - TEST-INFO | started process 4260 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0UipRZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:19:20 INFO - PROCESS | 4260 | RSS: Main: 175988736 15:19:20 INFO - PROCESS | 4260 | 15:19:23 INFO - PROCESS | 4260 | Cycle 1(1): loaded http://localhost:53018/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53018/tests/kraken/driver.html?testName=audio-beat-detection) 15:19:24 INFO - PROCESS | 4260 | RSS: Main: 233902080 15:19:24 INFO - PROCESS | 4260 | 15:19:27 INFO - PROCESS | 4260 | Cycle 1(1): loaded http://localhost:53018/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53018/tests/kraken/driver.html?testName=audio-dft) 15:19:27 INFO - PROCESS | 4260 | RSS: Main: 221958144 15:19:27 INFO - PROCESS | 4260 | 15:19:31 INFO - PROCESS | 4260 | Cycle 1(1): loaded http://localhost:53018/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53018/tests/kraken/driver.html?testName=audio-fft) 15:19:31 INFO - PROCESS | 4260 | RSS: Main: 288739328 15:19:31 INFO - PROCESS | 4260 | 15:19:33 INFO - PROCESS | 4260 | Cycle 1(1): loaded http://localhost:53018/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53018/tests/kraken/driver.html?testName=audio-oscillator) 15:19:34 INFO - PROCESS | 4260 | RSS: Main: 199106560 15:19:34 INFO - PROCESS | 4260 | 15:19:36 INFO - PROCESS | 4260 | Cycle 1(1): loaded http://localhost:53018/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53018/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:19:37 INFO - PROCESS | 4260 | RSS: Main: 202182656 15:19:37 INFO - PROCESS | 4260 | 15:19:40 INFO - PROCESS | 4260 | Cycle 1(1): loaded http://localhost:53018/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53018/tests/kraken/driver.html?testName=imaging-darkroom) 15:19:41 INFO - PROCESS | 4260 | RSS: Main: 238252032 15:19:41 INFO - PROCESS | 4260 | 15:19:44 INFO - PROCESS | 4260 | Cycle 1(1): loaded http://localhost:53018/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53018/tests/kraken/driver.html?testName=imaging-desaturate) 15:19:45 INFO - PROCESS | 4260 | RSS: Main: 238665728 15:19:45 INFO - PROCESS | 4260 | 15:19:48 INFO - PROCESS | 4260 | Cycle 1(1): loaded http://localhost:53018/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53018/tests/kraken/driver.html?testName=json-parse-financial) 15:19:48 INFO - PROCESS | 4260 | RSS: Main: 238190592 15:19:48 INFO - PROCESS | 4260 | 15:19:50 INFO - PROCESS | 4260 | Cycle 1(1): loaded http://localhost:53018/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53018/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:19:51 INFO - PROCESS | 4260 | RSS: Main: 227069952 15:19:51 INFO - PROCESS | 4260 | 15:19:52 INFO - PROCESS | 4260 | Cycle 1(1): loaded http://localhost:53018/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53018/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:19:53 INFO - PROCESS | 4260 | RSS: Main: 231362560 15:19:53 INFO - PROCESS | 4260 | 15:19:55 INFO - PROCESS | 4260 | Cycle 1(1): loaded http://localhost:53018/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53018/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:19:56 INFO - PROCESS | 4260 | RSS: Main: 238690304 15:19:56 INFO - PROCESS | 4260 | 15:19:59 INFO - PROCESS | 4260 | Cycle 1(1): loaded http://localhost:53018/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53018/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:19:59 INFO - PROCESS | 4260 | RSS: Main: 241393664 15:19:59 INFO - PROCESS | 4260 | 15:20:02 INFO - PROCESS | 4260 | Cycle 1(1): loaded http://localhost:53018/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53018/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:20:03 INFO - PROCESS | 4260 | RSS: Main: 240078848 15:20:03 INFO - PROCESS | 4260 | 15:20:05 INFO - PROCESS | 4260 | Cycle 1(1): loaded http://localhost:53018/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53018/tests/kraken/driver.html?testName=ai-astar) 15:20:05 INFO - PROCESS | 4260 | RSS: Main: 283250688 15:20:05 INFO - PROCESS | 4260 | 15:20:05 INFO - PROCESS | 4260 | __start_tp_report 15:20:05 INFO - PROCESS | 4260 | _x_x_mozilla_page_load 15:20:05 INFO - PROCESS | 4260 | _x_x_mozilla_page_load_details 15:20:05 INFO - PROCESS | 4260 | |i|pagename|runs| 15:20:05 INFO - PROCESS | 4260 | |0;ai-astar;104;115;114;114;115;112;114;115;113;114 15:20:05 INFO - PROCESS | 4260 | |1;audio-beat-detection;166;137;137;183;140;156;155;132;201;133 15:20:05 INFO - PROCESS | 4260 | |2;audio-dft;161;171;162;163;162;163;164;162;161;162 15:20:05 INFO - PROCESS | 4260 | |3;audio-fft;76;76;80;106;76;76;78;77;99;75 15:20:05 INFO - PROCESS | 4260 | |4;audio-oscillator;89;87;121;86;87;85;122;85;87;120 15:20:05 INFO - PROCESS | 4260 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;116;117 15:20:05 INFO - PROCESS | 4260 | |6;imaging-darkroom;146;146;146;147;146;146;146;145;146;145 15:20:05 INFO - PROCESS | 4260 | |7;imaging-desaturate;95;95;95;94;96;95;95;96;95;95 15:20:05 INFO - PROCESS | 4260 | |8;json-parse-financial;63;63;69;64;64;66;64;63;63;63 15:20:05 INFO - PROCESS | 4260 | |9;json-stringify-tinderbox;65;64;64;65;65;64;66;64;65;64 15:20:05 INFO - PROCESS | 4260 | |10;stanford-crypto-aes;86;88;82;83;81;84;83;88;116;85 15:20:05 INFO - PROCESS | 4260 | |11;stanford-crypto-ccm;137;145;144;130;130;134;137;128;132;133 15:20:05 INFO - PROCESS | 4260 | |12;stanford-crypto-pbkdf2;170;173;174;173;169;167;169;172;168;166 15:20:05 INFO - PROCESS | 4260 | |13;stanford-crypto-sha256-iterative;69;70;68;70;67;67;68;67;67;69 15:20:05 INFO - PROCESS | 4260 | __end_tp_report 15:20:05 INFO - PROCESS | 4260 | __start_cc_report 15:20:05 INFO - PROCESS | 4260 | _x_x_mozilla_cycle_collect,1910 15:20:05 INFO - PROCESS | 4260 | __end_cc_report 15:20:05 INFO - PROCESS | 4260 | __startTimestamp1466806805395__endTimestamp 15:20:05 INFO - PROCESS | 4260 | 15:20:05 INFO - PROCESS | 4260 | ------- Summary: start ------- 15:20:05 INFO - PROCESS | 4260 | Number of tests: 14 15:20:05 INFO - PROCESS | 4260 | 15:20:05 INFO - PROCESS | 4260 | [#0] ai-astar Cycles:10 Average:113.00 Median:114.00 stddev:3.30 (2.9%) stddev-sans-first:1.00 15:20:05 INFO - PROCESS | 4260 | Values: 104.0 115.0 114.0 114.0 115.0 112.0 114.0 115.0 113.0 114.0 15:20:05 INFO - PROCESS | 4260 | 15:20:05 INFO - PROCESS | 4260 | [#1] audio-beat-detection Cycles:10 Average:154.00 Median:155.50 stddev:23.33 (15.0%) stddev-sans-first:24.34 15:20:05 INFO - PROCESS | 4260 | Values: 166.0 137.0 137.0 183.0 140.0 156.0 155.0 132.0 201.0 133.0 15:20:05 INFO - PROCESS | 4260 | 15:20:05 INFO - PROCESS | 4260 | [#2] audio-dft Cycles:10 Average:163.10 Median:162.50 stddev:2.92 (1.8%) stddev-sans-first:3.00 15:20:05 INFO - PROCESS | 4260 | Values: 161.0 171.0 162.0 163.0 162.0 163.0 164.0 162.0 161.0 162.0 15:20:05 INFO - PROCESS | 4260 | 15:20:05 INFO - PROCESS | 4260 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.50 stddev:11.07 (14.5%) stddev-sans-first:11.53 15:20:05 INFO - PROCESS | 4260 | Values: 76.0 76.0 80.0 106.0 76.0 76.0 78.0 77.0 99.0 75.0 15:20:05 INFO - PROCESS | 4260 | 15:20:05 INFO - PROCESS | 4260 | [#4] audio-oscillator Cycles:10 Average:96.90 Median:86.50 stddev:16.68 (19.3%) stddev-sans-first:17.44 15:20:05 INFO - PROCESS | 4260 | Values: 89.0 87.0 121.0 86.0 87.0 85.0 122.0 85.0 87.0 120.0 15:20:05 INFO - PROCESS | 4260 | 15:20:05 INFO - PROCESS | 4260 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 15:20:05 INFO - PROCESS | 4260 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 15:20:05 INFO - PROCESS | 4260 | 15:20:05 INFO - PROCESS | 4260 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 15:20:05 INFO - PROCESS | 4260 | Values: 146.0 146.0 146.0 147.0 146.0 146.0 146.0 145.0 146.0 145.0 15:20:05 INFO - PROCESS | 4260 | 15:20:05 INFO - PROCESS | 4260 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 15:20:05 INFO - PROCESS | 4260 | Values: 95.0 95.0 95.0 94.0 96.0 95.0 95.0 96.0 95.0 95.0 15:20:05 INFO - PROCESS | 4260 | 15:20:05 INFO - PROCESS | 4260 | [#8] json-parse-financial Cycles:10 Average:64.20 Median:64.00 stddev:1.93 (3.0%) stddev-sans-first:2.00 15:20:05 INFO - PROCESS | 4260 | Values: 63.0 63.0 69.0 64.0 64.0 66.0 64.0 63.0 63.0 63.0 15:20:05 INFO - PROCESS | 4260 | 15:20:05 INFO - PROCESS | 4260 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 15:20:05 INFO - PROCESS | 4260 | Values: 65.0 64.0 64.0 65.0 65.0 64.0 66.0 64.0 65.0 64.0 15:20:05 INFO - PROCESS | 4260 | 15:20:05 INFO - PROCESS | 4260 | [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:84.50 stddev:10.25 (12.1%) stddev-sans-first:10.86 15:20:05 INFO - PROCESS | 4260 | Values: 86.0 88.0 82.0 83.0 81.0 84.0 83.0 88.0 116.0 85.0 15:20:05 INFO - PROCESS | 4260 | 15:20:05 INFO - PROCESS | 4260 | [#11] stanford-crypto-ccm Cycles:10 Average:135.00 Median:135.50 stddev:5.79 (4.3%) stddev-sans-first:6.10 15:20:05 INFO - PROCESS | 4260 | Values: 137.0 145.0 144.0 130.0 130.0 134.0 137.0 128.0 132.0 133.0 15:20:05 INFO - PROCESS | 4260 | 15:20:05 INFO - PROCESS | 4260 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.10 Median:171.00 stddev:2.77 (1.6%) stddev-sans-first:2.93 15:20:05 INFO - PROCESS | 4260 | Values: 170.0 173.0 174.0 173.0 169.0 167.0 169.0 172.0 168.0 166.0 15:20:05 INFO - PROCESS | 4260 | 15:20:05 INFO - PROCESS | 4260 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.50 stddev:1.23 (1.8%) stddev-sans-first:1.27 15:20:05 INFO - PROCESS | 4260 | Values: 69.0 70.0 68.0 70.0 67.0 67.0 68.0 67.0 67.0 69.0 15:20:05 INFO - PROCESS | 4260 | -------- Summary: end -------- 15:20:05 INFO - PROCESS | 4260 | 15:20:06 INFO - TEST-INFO | 4260: exit 0 15:20:06 INFO - TEST-OK | kraken | took 64567ms 15:20:06 INFO - SUITE-END | took 1185s 15:20:06 INFO - Completed test suite (00:19:45) 15:20:06 INFO - javascript benchmark 15:20:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2670.9983756091465, 2682.329417645589, 2711.945761084779, 2739.5890616407537, 2744.574590938404, 4605.861824145272, 4668.76656167192, 4760.761961901904, 4843.612510999121, 4901.0687969285855, 4700.788464519096, 4740.051989602076, 4747.905041899168, 4750.90498190036, 4771.642126840484, 4341.739495630264, 4391.0559229765595, 4434.113177364524, 4462.97768511157, 4596.97701511492, 4513.480949690778, 4532.864014079583, 4535.863924082283, 4536.160810250114, 4586.197415452282, 4291.034517233628, 4344.0, 4352.151330490556, 4399.758013309267, 4447.933281000787, 4393.5606439356125, 4401.867943961654, 4458.799354029076, 4481.708688935209, 4482.731036137842, 4424.380586717862, 4439.733615983051, 4468.329750537413, 4490.7979140938405, 4495.078508905666, 4628.074385122989, 4843.467218605951, 4887.95112048882, 4900.289458028566, 4900.607951363882, 5018.447970723218, 5019.171836646949, 5031.823886164003, 5109.054824857413, 5153.768080436389, 5136.948630513722, 5140.1004824155625, 5167.819126330598, 5179.766910488999, 5187.04039752647, 4626.6298696104905, 4757.643176761757, 4786.0667169902235, 4821.831235906727, 4827.396575428072, 5219.164933610604, 5272.05103081449, 5272.973635131876, 5291.04761142998, 5294.391145018372, 5063.87340316495, 5073.822416215415, 5075.87310317245, 5077.416097148875, 5078.492150784966, 5034.622403319766, 5087.97456012725, 5101.489851014869, 5106.463821298785, 5147.459516750762, 5137.743112844343, 5157.510036546522, 5158.200478925773, 5161.5870730341485, 5182.041322355376, 5113.079645663816, 5122.538971492509, 5129.3075434816565, 5135.589152867761, 5191.299174611455, 4214.7471151731, 4262.190183865056, 4267.701260911706, 4297.05464797744, 4303.203907277164, 3824.2351529694174, 3828.502294701671, 3866.38137897935, 3902.375619900802, 3912.237113762789, 4489.6408287336935, 4491.910161796745, 4495.235809912323, 4496.303073023687, 4547.249703798836, 4971.45314015458, 5102.489751024942, 5228.05894938907, 5233.921491177635, 5287.788488460418, 4418.668599855024, 4439.755813430293, 4459.219636563588, 4487.730736155841, 4490.7754612269255, 4605.838795642137, 4609.216433206363, 4615.284630882219, 4617.0, 4663.743494107856, 4737.881552961204, 4809.206480930748, 4821.349117869113, 4831.661783675109, 4869.975650121727, 5204.115300398866, 5218.608604354765, 5224.634275600672, 5224.791008359623, 5267.209918512254, 4858.368412106403, 4877.244027175793, 4888.706677599355, 4890.926636100533, 4934.087193869145, 4945.901081978413, 5043.52086551777, 5107.157319042316, 5118.181091025418, 5143.819966301162, 5178.741062946762, 5192.662476938987, 5192.922106168335, 5202.1416466282635, 5203.089459344676, 5045.11710450677, 5046.571041461517, 5066.31604733371, 5068.113080211022, 5070.087384270867, 4892.902141957212, 4898.289747986593, 4945.0, 4952.0, 4984.975075124601, 4910.361652985232, 4948.529889660476, 4982.352294201731, 4984.750762461935, 4989.451160372429, 4892.119418504703, 5034.14419548685, 5038.672486288379, 5039.84880453587, 5082.517160869711, 4929.827456039022, 4985.551300382838, 4990.076835785391, 5000.64995450315, 5016.749162541785], "value": 4728.775817075161, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.051861891503, 583.3553922915175, 586.4487381861047, 586.6861229242355, 600.6066026752477, 26851.19446416608, 38288.808555957214, 39264.607353926454, 39277.99999999996, 39301.21397572047, 41482.377764333556, 42064.57935420645, 42069.7896510517, 42079.36880946788, 42099.78950105253, 7467.066616672916, 7664.463487555873, 7671.347935425496, 7735.729249476283, 7883.566403847786, 7596.696132154707, 9791.216702663769, 10102.69691909244, 10102.797944041115, 10448.425336606484, 10150.644727434541, 10215.182785377188, 10217.693469195936, 10219.182465402788, 10227.488625568729, 7495.775126746206, 9893.911669716397, 10023.047810457994, 10131.746706332327, 10132.94933525335, 9676.516174191262, 10086.243531735076, 10114.0, 10117.696469105938, 10136.0, 39250.41124383137, 39671.40492892609, 39704.20591588181, 39712.20575588501, 39714.404283935764, 2980.165553644983, 3024.817227831108, 3116.8129912205113, 3148.212946763309, 3184.9203769905707, 29625.0, 29754.256143596365, 30147.849260753774, 30862.691373086433, 31125.844370778228, 3406.812625305607, 3497.0732755819727, 3520.119970007498, 3540.6105328413855, 3562.109472631842, 253837.0, 255414.0, 255726.0, 255769.0, 256296.0, 31505.0, 32776.0, 32785.34429311448, 48246.75876620664, 48497.75751121222, 34063.14842128967, 34339.82830085883, 34455.48316775251, 34471.4829277561, 34480.31039379198, 13068.150570212905, 13134.474621015052, 13173.60479185626, 13219.405126769318, 13236.404361803741, 8947.955260223787, 10495.370277783357, 10866.185036122322, 10883.455827208609, 10948.507317170746, 7793.766187014398, 7879.921200787919, 7889.644965976545, 7938.364930805522, 7959.8408031839035, 3046.939061218763, 3100.410921924827, 3101.968980310168, 3104.0532637545766, 3118.5789918361183, 859.8925134358205, 887.3699673232078, 889.2219308105408, 914.3005600715458, 946.2430055955208, 27190.184294471197, 27804.860975695396, 27939.0, 28099.43801123966, 28117.297067573476, 929.0570071377557, 945.5083356654638, 957.875476188091, 965.1988849255101, 968.3076600230869, 14579.125252484884, 14900.62748431298, 14975.475858344906, 14984.175870327019, 15021.69956600862, 121738.39130804467, 121892.39053804675, 121991.39004304922, 122349.38825305995, 122366.38816806037, 49228.753856231204, 49988.500114999115, 50058.24912626314, 50086.24870626871, 50086.749566251936, 1073.302353470235, 1157.8321143434323, 1160.271195918076, 1191.0709646475764, 1200.5497938273147, 27875.721242787313, 28930.566041509814, 29113.85443072771, 29211.561826573045, 29854.850725746233, 42367.57632423636, 42935.78532107319, 42992.570074298856, 43036.139277214905, 43061.56938430575, 279071.0, 284572.0, 284926.0, 285521.0, 285664.0, 22902.656460153445, 24989.125380612317, 25663.615045774703, 25955.610665840406, 27438.862805685843, 42804.46833112606, 43137.0, 43227.35158972681, 43289.0, 43442.565574343855, 33861.32277354488, 35105.473417899266, 35286.47070293896, 35827.82086089553, 36104.27791444104, 36343.818280908425, 36676.81661591675, 37154.0, 37172.0, 37359.43960840535, 34549.827250863586, 34874.47688284729, 34976.30047399089, 35395.82302088473, 35884.820575896956, 31244.531332030492, 31796.523052153774, 32375.35249294954, 32404.35191296208, 32529.83735081404, 24626.87686561556, 24699.753002470465, 25051.0, 25446.363840904127, 25529.87235063813], "value": 16190.182180935784, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.9308531379038, 366.3387585408338, 369.39972544614983, 373.4566206170023, 378.96778773804226, 16606.584835379123, 16872.578185545353, 17836.64326713465, 17861.285548578075, 17908.91045544772, 16138.596535086599, 17064.914675426637, 17209.0, 17248.137593120355, 17281.395151169712, 4932.284818701286, 5180.740962951856, 5208.869778255536, 5210.973945130288, 5215.426303106655, 3659.8719044833438, 3929.98035009826, 5075.086484432819, 5644.887102257952, 5964.105384192384, 5984.581079324449, 5986.5210783137245, 6019.247594050744, 6020.548458865581, 6023.096535519663, 5783.6240644358195, 6020.7290671919645, 6021.277446706424, 6027.7287522061615, 6027.819165425044, 3321.468565029608, 4927.285543596195, 5283.365996080456, 5292.470752924715, 5303.071962406563, 17384.565385865328, 17398.739018914726, 17544.29822807086, 21063.368098957057, 21096.0, 2019.1418647074934, 2058.4545095549693, 2114.7161066048784, 2144.2066435418997, 2515.1448507507534, 13064.21614703121, 13149.802752958713, 13242.337883105902, 13372.598822035354, 13904.652383690387, 1717.5534361066088, 1719.3638353809047, 1724.8447639712485, 1750.8774385793, 1755.4558086993072, 66982.3301766981, 70871.64564177197, 70908.29091709068, 71367.99999999948, 71424.0, 9337.206337461392, 9462.52687365629, 9699.272554558294, 9893.15908147801, 9922.0, 13205.415350158042, 13425.86574134246, 13459.192448453125, 13494.595162145151, 13542.932285338511, 7231.63841807918, 7279.426409081877, 7333.726544771138, 7342.632868356561, 7382.630868456556, 7000.859982800417, 7081.468889833283, 7083.220845706968, 7191.9931209630695, 7226.313500217471, 6065.211522502046, 6110.572259941761, 6114.309703730344, 6157.491414603451, 6179.073139029092, 1597.0, 1660.7840980672436, 1666.4084250091285, 1690.9746353804703, 1763.2594310389668, 826.6610689617228, 865.8874346334936, 881.4623079921242, 954.656323723459, 1005.3415013166388, 17053.7441938371, 17201.397951071653, 17444.0, 17580.120993950506, 17901.19444624995, 873.4235404632911, 874.6807415293499, 884.9601767920459, 920.415536134546, 925.6343744220995, 9730.854037189449, 10164.644237451654, 10183.490825458697, 10218.846717299246, 10290.228232882415, 398285.0, 405076.0, 405726.0, 406271.0, 406899.0, 61219.693901530205, 64550.0, 65791.67104164544, 66022.33977660161, 67794.0, 904.3082042237694, 918.8024574716468, 923.7136487688838, 941.2658126661215, 941.7786820097272, 15491.922540387677, 15569.68860622804, 15706.057636541844, 15845.920770396075, 16205.67588648244, 35041.0, 35955.64044359523, 35977.460338094425, 36493.81753091217, 37055.44416833696, 45460.77269613763, 46156.53843461657, 47533.762331188125, 47559.286610700176, 47784.04431911412, 7721.459497835098, 7749.690012399441, 7789.104253010976, 7826.295633393022, 7944.086430060617, 11516.94241528787, 11723.179377443497, 11824.172307938361, 11867.109966752356, 12250.203736757083, 9623.133917947418, 9941.552630131806, 10000.499975001076, 10005.0, 10295.17638588896, 10566.101881340172, 10672.62645807393, 10712.517936692711, 10727.249092563758, 10732.517036733521, 9792.0, 9877.259205559469, 9973.252006099427, 9974.750631234278, 10310.639127630497, 7646.082470103624, 7722.652480638272, 7736.1103473099065, 7787.688492460238, 7882.290593846581, 9682.031796820262, 9789.951050244703, 10052.497375131068, 10245.897541024495, 10516.158707303244], "value": 8359.372034610265, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1220.3349174699788, 1356.1252991820277, 1424.5868698077559, 1480.7556753135734, 1695.4320302698602, 6472.902906456401, 7901.683932642694, 8210.999999999993, 8219.0, 8234.423590348679, 7832.216778322165, 8052.0, 8055.91944080559, 8064.193580641933, 8066.11272759996, 1823.7902641196233, 1892.2052737850136, 1897.1936926806052, 2224.3660556741293, 2253.1325439705747, 1973.8124878136555, 2175.5431359414465, 2230.11910295434, 2234.452559123017, 2283.942901427461, 2204.6582779669175, 2226.4322597737637, 2231.9776802232013, 2235.485838257202, 2235.6087684655204, 1680.453852497943, 2106.8314534837177, 2137.7220961274934, 2143.4212762554025, 2147.3987283560627, 2063.504758857878, 2116.0, 2118.6398312286947, 2149.0436755643746, 2151.397608669575, 7987.3610111190965, 8051.0741264754715, 8063.95968020162, 8065.798355041112, 8071.112177660452, 4522.140793249272, 4673.182193116191, 4675.976620116911, 4676.719396836201, 4678.111158879802, 2939.441506113853, 3029.439553682576, 3030.424219398329, 3113.34619729857, 3176.8252746098956, 901.3465237702678, 916.573793186165, 927.4388994658202, 930.3950685068271, 942.6088173408027, 11199.66401007971, 11207.495662695199, 11229.719257018558, 11238.943805281004, 11244.606438774603, 4179.2895207814745, 4317.7193482423545, 4391.165678521071, 4434.224010798098, 4441.578050085237, 9407.106324899123, 9452.810943781224, 9453.196478299422, 9475.194608458358, 9479.383840050376, 4593.494715581283, 4597.3793537872625, 4601.148787474328, 4604.1252162089095, 4606.401167848226, 3085.969140308568, 3439.7325426359535, 4201.243776120327, 4270.295401258758, 4274.380214868889, 3681.466187402865, 3798.981005094957, 3805.657490825839, 3834.5206849143856, 3853.0, 1201.9759604807855, 1208.5226335597565, 1209.3106929050357, 1227.9815802762967, 1231.9260844349367, 621.1366200980641, 715.7852644206718, 815.2906970935325, 823.8022874510075, 848.2320222487186, 5243.449437809051, 5291.867703307448, 5348.572114230852, 5431.945680543223, 5497.39528651848, 386.21405439929606, 387.09613053520343, 388.57062945445443, 389.92981263372866, 392.98821035368985, 3542.4686297055646, 3605.8557657693923, 3612.6206748291575, 3646.252518233756, 3687.7049836013052, 9703.417794932328, 10050.547725352377, 10068.194544436428, 10176.033276838689, 10189.388636681822, 10040.748981275381, 10072.798544029078, 10073.49632518371, 10085.596576136872, 10091.344062635904, 7219.494635375579, 7243.565386076747, 7244.927550724531, 7292.96353518229, 7313.122425308997, 5262.394824595221, 5314.0, 5475.72621368922, 5496.6701997880255, 5595.160725891149, 8699.347548933729, 9035.50304733246, 9057.501837399006, 9263.397879137834, 9335.57989890443, 8562.100979397073, 9007.09929007094, 9012.504312262889, 9411.85882211781, 9443.527823608929, 5991.7902873399225, 6532.248791388861, 6743.460523158037, 6745.763898263537, 6756.087928129639, 7480.887786683313, 7492.0, 7517.060367454068, 7524.473286869867, 7561.432892532972, 6432.807015789534, 6438.130852335063, 6476.805695829133, 6543.5419520633095, 6664.83337916556, 6347.0479428086155, 6375.9362406377195, 6451.612903225821, 6497.772577959749, 6527.3472652734345, 5893.32226793907, 5938.0, 5942.0, 5970.432808883149, 5972.34304226526, 4307.763073031013, 4515.841945531891, 4602.309653551994, 4605.861824145281, 4656.627469802475, 4692.085043416501, 4711.717296962056, 4755.643326750438, 4768.856934291976, 4820.325154478306], "value": 4054.2708794618197, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.328559527907, 300.7098150284975, 301.66665834253166, 304.14383510418185, 310.0265167374444, 4875.000624871902, 4903.16646170151, 4905.313256144138, 4915.877103072425, 4916.016796640668, 4577.427821522309, 4684.437867455901, 4709.387779588648, 4841.176999910015, 4856.223004319309, 3777.5655799583124, 3797.373433383488, 3799.8290076946605, 3803.953912674023, 3814.2180852925153, 3801.2397520495874, 3805.70605993962, 3817.7327587068917, 3823.1206822430718, 3836.271108489378, 3547.92904141917, 3622.4385220290765, 3795.6583907448326, 3812.4281357796276, 3815.198808250257, 3749.43758436234, 3771.41543060826, 3776.8300426480873, 3781.2815565042692, 3786.1859700164596, 3369.4440417331357, 3370.1069216657606, 3378.8817391391185, 3379.4086034943784, 3421.9657803422147, 4510.278355463143, 4691.249400095969, 4727.66906316558, 4795.352627395292, 4800.415862765279, 4328.567143285678, 4336.609705126553, 4341.196878577442, 4355.542668019875, 4367.519572846984, 5042.42012168598, 5078.669886457368, 5080.069573562059, 5085.415177254626, 5093.376910890895, 3579.6957258633047, 3674.2651469705897, 3675.7794532328144, 3677.7609455385314, 3678.5585729712607, 5247.658902171346, 5287.444818294062, 5291.682499050031, 5310.2831117798605, 5328.227407025959, 3764.4729737836724, 3771.8868433947027, 3774.6225377462583, 3799.9240015199543, 3806.923861522754, 3876.972602260403, 3893.824777885002, 3895.35726605107, 3899.947014306178, 3902.2780785554196, 4295.076558539929, 4362.236608593484, 4371.868843934687, 4402.691811573159, 4414.933775993362, 5049.469805670426, 5066.113430149783, 5073.923891141562, 5074.847754567295, 5080.872978175501, 1227.3188380448937, 1274.6877015131352, 1276.5914907229596, 1318.723068155698, 1334.359507436436, 795.7745072588265, 830.8629076202479, 904.7466709321401, 920.265299909675, 947.7346343023827, 4495.707778994355, 4502.234620114588, 4518.615917646971, 4557.111363284194, 4558.544145585482, 5182.807954170562, 5226.0, 5262.631615786935, 5266.920996184984, 5310.176922577007, 4504.324351347259, 4538.1377538267625, 4541.545845415432, 4542.954570454319, 4555.2711566149255, 2784.3015760386147, 2799.936024310749, 2817.2534278416238, 2826.8727907244224, 2831.815931964457, 4708.317293992352, 4930.654854160246, 4932.802687892516, 4936.48166942473, 4948.109340318705, 5236.947630523646, 5248.527632513092, 5255.39562950258, 5353.759080841293, 5364.624476286701, 4921.680090794087, 4922.310876477296, 4935.407751069823, 4941.431735350337, 4953.801847926186, 4961.875953101057, 5199.792008319625, 5206.927912531624, 5228.346456692913, 5235.1623740201385, 5086.160783470834, 5116.181410974226, 5128.051310507568, 5130.281760553451, 5183.196604526304, 4885.706857588556, 4887.144749668722, 4889.266610008385, 4897.608191344612, 4901.411830580353, 3700.2044560418562, 3751.6752966078125, 3805.287620570699, 3835.213781174908, 3843.135294558702, 5147.2279158126585, 5165.9483405165465, 5189.4032186299055, 5220.347456567929, 5226.503482169188, 5018.5232402921665, 5021.0, 5025.824096156617, 5045.84862454127, 5074.517920797518, 4866.586340161126, 5033.2701758245585, 5045.369328833895, 5058.962912602834, 5069.467705890828, 4802.807887684454, 4929.412058669084, 4956.134215312062, 4978.352814134139, 5035.59715222774, 5095.719735414439, 5145.279660847559, 5148.9227661584355, 5149.304843846033, 5179.404368497671, 4935.864751107194, 5015.3480047593575, 5039.420466646383, 5043.218301163325, 5067.567567567515], "value": 3844.8395303166226, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.9718011279546, 725.8439435521362, 736.3152268390397, 749.7263498822931, 772.6252767407806, 13323.333833308345, 13805.51680691176, 13825.239611821346, 13898.51355202568, 13933.024688271813, 14876.47932322369, 15029.774553381709, 15040.699186016273, 15088.547343579683, 15123.546293611209, 616.5406771954899, 744.0439035838948, 753.7776355974974, 754.6113751417996, 754.728297812787, 750.973715919943, 771.1709911844762, 771.2518856709012, 771.5756334016297, 774.5855967057626, 796.4584082823677, 798.632628990665, 799.3804801278997, 799.816042310269, 799.8240387114826, 643.427349658804, 789.3369569561596, 793.3732351442353, 799.2487062161549, 799.3445374792673, 588.1853632718716, 588.2764200033939, 588.6615196262167, 589.4900910712246, 590.4567797626195, 13426.798598021038, 13437.865621343759, 13491.662708432368, 13511.932440337834, 13521.661958451019, 11997.160198786089, 12288.631341059783, 12442.626721198378, 12675.429605667674, 12900.935495322557, 12069.0, 12120.636380908587, 12221.755564888741, 12258.08064395174, 12464.688382790502, 4175.290200665863, 4195.181939521794, 4197.307444271692, 4277.887749185204, 4300.0, 68795.65602172007, 68929.0, 69617.0, 70067.0, 70301.0, 9220.953895230481, 9259.814803703888, 9610.0, 10006.899931000597, 10327.741806454898, 17803.376881809076, 17804.109794510223, 17824.46526604204, 17834.0, 17834.28662853471, 6639.734410623618, 6677.632730199885, 6705.765298214539, 6712.261651218362, 6763.72945082201, 3651.8174091295327, 3712.6844218241754, 3771.340015497277, 3779.074126838942, 3785.6971442284553, 2785.7075007124367, 2889.8121622094495, 2899.9420011600073, 2900.260433589421, 2904.361040571071, 505.24970418927865, 509.7680555347382, 512.1242675025674, 515.7859488312383, 516.8501134670903, 497.99156707667265, 507.1960941907045, 512.6821370750159, 529.1665626638061, 549.2063967566908, 7124.750633727795, 7305.671244793997, 7390.011742074186, 7509.7371591994015, 7529.924700752922, 454.72261920228635, 480.4354883012446, 521.3379008658982, 536.3028063517412, 541.2773946781091, 3424.3151369726156, 3713.591504934455, 3737.2808508086587, 3793.3172029034486, 3984.621460961204, 87446.0, 95008.0499195013, 95626.52186739161, 97743.0, 97932.51033744785, 60076.69961650164, 80913.59543202363, 80991.5950420256, 81119.18880811117, 81923.0, 52239.738801306514, 73511.74058889304, 76524.85212721814, 76656.0, 77733.6113319441, 7502.774916752506, 7594.430417718582, 7661.961690191513, 7893.210678932061, 7974.362051036019, 41592.792036039624, 42514.14971700487, 42603.7869810649, 42800.78599606982, 44878.0, 59765.0, 61302.38697612967, 62834.0, 63542.0, 63549.6822515903, 11158.156418217834, 11436.199466037298, 11597.362145082101, 11720.830585049478, 12019.579314723942, 13137.540186093442, 13152.605421837361, 13584.456621735415, 13912.443502259795, 14012.0, 12208.511659533875, 12224.205426647239, 12315.261084334968, 12513.186642868184, 12911.870881291066, 11850.76298474043, 12173.939130304292, 12354.814677779661, 12628.368581571069, 12640.178388404724, 11595.8260626089, 11699.2980421175, 12040.698982525157, 12251.509939602316, 12263.202891812003, 9574.956119355342, 9716.3198576099, 10072.84988553589, 10110.8483372748, 10143.289969702346, 9010.459372437675, 9180.816383672156, 9552.331336806357, 9826.115649591571, 9990.950045249727], "value": 6556.384015360334, "unit": "score"}], "name": "dromaeo_css", "value": 6347.6452604203005, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 114.0, 114.0, 115.0, 112.0, 114.0, 115.0, 113.0, 114.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 137.0, 137.0, 183.0, 140.0, 156.0, 155.0, 132.0, 201.0, 133.0], "value": 154.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 171.0, 162.0, 163.0, 162.0, 163.0, 164.0, 162.0, 161.0, 162.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 80.0, 106.0, 76.0, 76.0, 78.0, 77.0, 99.0, 75.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 121.0, 86.0, 87.0, 85.0, 122.0, 85.0, 87.0, 120.0], "value": 96.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 69.0, 64.0, 64.0, 66.0, 64.0, 63.0, 63.0, 63.0], "value": 64.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 65.0, 65.0, 64.0, 66.0, 64.0, 65.0, 64.0], "value": 64.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 82.0, 83.0, 81.0, 84.0, 83.0, 88.0, 116.0, 85.0], "value": 87.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 145.0, 144.0, 130.0, 130.0, 134.0, 137.0, 128.0, 132.0, 133.0], "value": 135.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 173.0, 174.0, 173.0, 169.0, 167.0, 169.0, 172.0, 168.0, 166.0], "value": 170.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 68.0, 70.0, 67.0, 67.0, 68.0, 67.0, 67.0, 69.0], "value": 68.2, "unit": "score"}], "name": "kraken", "value": 1556.4999999999998, "alertThreshold": 2.0}]} 15:20:06 INFO - Return code: 0 15:20:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:20:06 INFO - # TBPL SUCCESS # 15:20:06 INFO - Running post-action listener: _resource_record_post_action 15:20:06 INFO - ##### 15:20:06 INFO - ##### Finished run-tests step (success) 15:20:06 INFO - ##### 15:20:06 INFO - Running post-run listener: _resource_record_post_run 15:20:06 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 543891456; Read time: 12; Write time: 414772 15:20:06 INFO - TinderboxPrint: CPU usage
13.2% 15:20:06 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 15:20:06 INFO - TinderboxPrint: I/O write bytes / time
543,891,456 / 414,772 15:20:06 INFO - TinderboxPrint: CPU idle
8,336.0 (86.8%) 15:20:06 INFO - TinderboxPrint: CPU user
1,215.7 (12.7%) 15:20:06 INFO - TinderboxPrint: Swap in / out
0 / 0 15:20:06 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 229625856; Read time: 0; Write time: 212736 15:20:06 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 297713664; Read time: 12; Write time: 190208 15:20:07 INFO - Running post-run listener: _upload_blobber_files 15:20:07 INFO - Blob upload gear active. 15:20:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:20:07 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 15:20:07 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'] 15:20:07 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 15:20:07 INFO - (blobuploader) - INFO - Open directory for files ... 15:20:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:20:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:20:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:20:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:20:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:20:08 INFO - (blobuploader) - INFO - Done attempting. 15:20:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:20:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:20:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:20:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:20:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:20:12 INFO - (blobuploader) - INFO - Done attempting. 15:20:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:20:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:20:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:20:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:20:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:20:12 INFO - (blobuploader) - INFO - Done attempting. 15:20:12 INFO - (blobuploader) - INFO - Iteration through files over. 15:20:12 INFO - Return code: 0 15:20:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:20:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:20:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2733d3d80f0dccfddbdeea146bce8ca015fc3c23af3b06dea56faf55d8ad2d51688623dba228aa6e924a8215a25b321049beac54e79d07945c524233ace21e9b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/124516716fcf51cc4cfd21c9687b58cd6283a596705fd95c1e954ce36196dc3fe5a1a5fc14edbbee5c2ba6d078a67461df72ea95f45a36aa119683cfcd1111cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ae41219b4f5e61e6509e7b0ab50a4c37b617ad202fd00b31478a4ae5c396c9a2aa94bfb36a1a4ebe051f30525f3c1eac81452427473d2de62b22a136fcda8f6b"} 15:20:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:20:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:20:12 INFO - Contents: 15:20:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2733d3d80f0dccfddbdeea146bce8ca015fc3c23af3b06dea56faf55d8ad2d51688623dba228aa6e924a8215a25b321049beac54e79d07945c524233ace21e9b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/124516716fcf51cc4cfd21c9687b58cd6283a596705fd95c1e954ce36196dc3fe5a1a5fc14edbbee5c2ba6d078a67461df72ea95f45a36aa119683cfcd1111cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ae41219b4f5e61e6509e7b0ab50a4c37b617ad202fd00b31478a4ae5c396c9a2aa94bfb36a1a4ebe051f30525f3c1eac81452427473d2de62b22a136fcda8f6b"} 15:20:12 INFO - Running post-run listener: copy_logs_to_upload_dir 15:20:12 INFO - Copying logs to upload dir... 15:20:12 INFO - mkdir: /builds/slave/test/build/upload/logs 15:20:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1606.341414 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 26 mins, 46 secs) (at 2016-06-24 15:20:12.697559) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 15:20:12.701404) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1466805109.324799-41278226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2733d3d80f0dccfddbdeea146bce8ca015fc3c23af3b06dea56faf55d8ad2d51688623dba228aa6e924a8215a25b321049beac54e79d07945c524233ace21e9b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/124516716fcf51cc4cfd21c9687b58cd6283a596705fd95c1e954ce36196dc3fe5a1a5fc14edbbee5c2ba6d078a67461df72ea95f45a36aa119683cfcd1111cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ae41219b4f5e61e6509e7b0ab50a4c37b617ad202fd00b31478a4ae5c396c9a2aa94bfb36a1a4ebe051f30525f3c1eac81452427473d2de62b22a136fcda8f6b"} build_url:https://queue.taskcluster.net/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011425 build_url: 'https://queue.taskcluster.net/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2733d3d80f0dccfddbdeea146bce8ca015fc3c23af3b06dea56faf55d8ad2d51688623dba228aa6e924a8215a25b321049beac54e79d07945c524233ace21e9b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/124516716fcf51cc4cfd21c9687b58cd6283a596705fd95c1e954ce36196dc3fe5a1a5fc14edbbee5c2ba6d078a67461df72ea95f45a36aa119683cfcd1111cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ae41219b4f5e61e6509e7b0ab50a4c37b617ad202fd00b31478a4ae5c396c9a2aa94bfb36a1a4ebe051f30525f3c1eac81452427473d2de62b22a136fcda8f6b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 15:20:12.730780) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 15:20:12.731108) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1466805109.324799-41278226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004497 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 15:20:12.816858) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 15:20:12.817266) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 15:20:12.817626) ========= ========= Total master_lag: 0.21 =========