builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-036 starttime: 1466489125.59 results: success (0) buildid: 20160620203028 builduid: 225ecab999204cee827564fb449f0f2b revision: 027db1e33f89606c4996feae0203e5f3bb5db43d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-20 23:05:25.586338) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-20 23:05:25.586825) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-20 23:05:25.587143) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-20 23:05:25.644660) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 23:05:25.645432) ========= 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=14ef55db36f7623abb31b9cf000001d5-1466486930.62391-1051532762 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-20 23:05: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% 22.8M=0.001s 2016-06-20 23:05:25 (22.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.088796 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 23:05:25.780237) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 23:05:25.780594) ========= 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=14ef55db36f7623abb31b9cf000001d5-1466486930.62391-1051532762 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015684 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 23:05:25.833775) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 23:05:25.834118) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 027db1e33f89606c4996feae0203e5f3bb5db43d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 027db1e33f89606c4996feae0203e5f3bb5db43d --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=14ef55db36f7623abb31b9cf000001d5-1466486930.62391-1051532762 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-20 23:05:25,883 truncating revision to first 12 chars 2016-06-20 23:05:25,883 Setting DEBUG logging. 2016-06-20 23:05:25,883 attempt 1/10 2016-06-20 23:05:25,884 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/027db1e33f89?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-20 23:05:26,187 unpacking tar archive at: fx-team-027db1e33f89/testing/mozharness/ program finished with exit code 0 elapsedTime=0.672999 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 23:05:26.525531) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-20 23:05:26.526002) ========= script_repo_revision: 027db1e33f89606c4996feae0203e5f3bb5db43d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-20 23:05:26.526427) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-20 23:05:26.526756) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-20 23:05:26.537484) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-06-20 23:05:26.537822) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=14ef55db36f7623abb31b9cf000001d5-1466486930.62391-1051532762 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:05:26 INFO - MultiFileLogger online at 20160620 23:05:26 in /builds/slave/test 23:05:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:05:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:05:26 INFO - {'append_to_log': False, 23:05:26 INFO - 'base_work_dir': '/builds/slave/test', 23:05:26 INFO - 'blob_upload_branch': 'Fx-Team', 23:05:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:05:26 INFO - 'branch': 'Fx-Team', 23:05:26 INFO - 'buildbot_json_path': 'buildprops.json', 23:05:26 INFO - 'config_files': ('talos/linux_config.py',), 23:05:26 INFO - 'default_actions': ('clobber', 23:05:26 INFO - 'read-buildbot-config', 23:05:26 INFO - 'download-and-extract', 23:05:26 INFO - 'populate-webroot', 23:05:26 INFO - 'create-virtualenv', 23:05:26 INFO - 'install', 23:05:26 INFO - 'run-tests'), 23:05:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:05:26 INFO - 'download_minidump_stackwalk': True, 23:05:26 INFO - 'download_symbols': 'ondemand', 23:05:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:05:26 INFO - 'tooltool.py': '/tools/tooltool.py', 23:05:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:05:26 INFO - '/tools/misc-python/virtualenv.py')}, 23:05:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:05:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:05:26 INFO - 'installer_path': 'installer.exe', 23:05:26 INFO - 'log_level': 'info', 23:05:26 INFO - 'log_name': 'talos', 23:05:26 INFO - 'log_to_console': True, 23:05:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:05:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:05:26 INFO - 'opt_config_files': (), 23:05:26 INFO - 'pip_index': False, 23:05:26 INFO - 'sps_profile': False, 23:05:26 INFO - 'sps_profile_interval': 0, 23:05:26 INFO - 'suite': 'dromaeojs', 23:05:26 INFO - 'system_bits': '32', 23:05:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:05:26 INFO - 'title': 'talos-linux64-ix-036', 23:05:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:05:26 INFO - 'use_talos_json': True, 23:05:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:05:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:05:26 INFO - 'work_dir': 'build'} 23:05:26 INFO - ##### 23:05:26 INFO - ##### Running clobber step. 23:05:26 INFO - ##### 23:05:26 INFO - Running pre-action listener: _resource_record_pre_action 23:05:26 INFO - Running main action method: clobber 23:05:26 INFO - rmtree: /builds/slave/test/build 23:05:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:05:27 INFO - Running post-action listener: _resource_record_post_action 23:05:27 INFO - ##### 23:05:27 INFO - ##### Finished clobber step (success) 23:05:27 INFO - ##### 23:05:27 INFO - ##### 23:05:27 INFO - ##### Running read-buildbot-config step. 23:05:27 INFO - ##### 23:05:27 INFO - Running pre-action listener: _resource_record_pre_action 23:05:27 INFO - Running main action method: read_buildbot_config 23:05:27 INFO - Using buildbot properties: 23:05:27 INFO - { 23:05:27 INFO - "project": "", 23:05:27 INFO - "product": "firefox", 23:05:27 INFO - "script_repo_revision": "production", 23:05:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 23:05:27 INFO - "repository": "", 23:05:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 23:05:27 INFO - "buildid": "20160620203028", 23:05:27 INFO - "pgo_build": "True", 23:05:27 INFO - "basedir": "/builds/slave/test", 23:05:27 INFO - "buildnumber": 200, 23:05:27 INFO - "slavename": "talos-linux64-ix-036", 23:05:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:05:27 INFO - "platform": "ubuntu64_hw", 23:05:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:05:27 INFO - "branch": "fx-team", 23:05:27 INFO - "repo_path": "integration/fx-team", 23:05:27 INFO - "revision": "027db1e33f89606c4996feae0203e5f3bb5db43d", 23:05:27 INFO - "stage_platform": "linux64-pgo", 23:05:27 INFO - "builduid": "225ecab999204cee827564fb449f0f2b", 23:05:27 INFO - "slavebuilddir": "test" 23:05:27 INFO - } 23:05:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/NTvU2dyrRhaM0Py_fAIzmg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 23:05:27 INFO - Running post-action listener: _resource_record_post_action 23:05:27 INFO - ##### 23:05:27 INFO - ##### Finished read-buildbot-config step (success) 23:05:27 INFO - ##### 23:05:27 INFO - ##### 23:05:27 INFO - ##### Running download-and-extract step. 23:05:27 INFO - ##### 23:05:27 INFO - Running pre-action listener: _resource_record_pre_action 23:05:27 INFO - Running main action method: download_and_extract 23:05:27 INFO - mkdir: /builds/slave/test/build/tests 23:05: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')]} 23:05:27 INFO - https://queue.taskcluster.net/v1/task/NTvU2dyrRhaM0Py_fAIzmg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:05:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTvU2dyrRhaM0Py_fAIzmg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:05:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTvU2dyrRhaM0Py_fAIzmg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:05:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTvU2dyrRhaM0Py_fAIzmg/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 23:05:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTvU2dyrRhaM0Py_fAIzmg/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 23:05:36 INFO - Downloaded 1361 bytes. 23:05:36 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:05:36 INFO - Using the following test package requirements: 23:05:36 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:05:36 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:05:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:05:36 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:05:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:05:36 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:05:36 INFO - u'jsshell-linux-x86_64.zip'], 23:05:36 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:05:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:05:36 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:05:36 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:05:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:05:36 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:05:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:05:36 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:05:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:05:36 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:05:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:05:36 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:05:36 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')]} 23:05:36 INFO - https://queue.taskcluster.net/v1/task/NTvU2dyrRhaM0Py_fAIzmg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:05:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTvU2dyrRhaM0Py_fAIzmg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:05:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTvU2dyrRhaM0Py_fAIzmg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:05:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTvU2dyrRhaM0Py_fAIzmg/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 23:05:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTvU2dyrRhaM0Py_fAIzmg/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 23:05:40 INFO - Downloaded 24221315 bytes. 23:05:40 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'] 23:05:40 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 23:05:41 INFO - Return code: 0 23:05:41 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 23:05: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')]} 23:05:41 INFO - https://queue.taskcluster.net/v1/task/NTvU2dyrRhaM0Py_fAIzmg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:05:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTvU2dyrRhaM0Py_fAIzmg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:05:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTvU2dyrRhaM0Py_fAIzmg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:05:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTvU2dyrRhaM0Py_fAIzmg/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 23:05:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTvU2dyrRhaM0Py_fAIzmg/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 23:05:43 INFO - Downloaded 24221315 bytes. 23:05:43 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'] 23:05:43 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 23:05:44 INFO - Return code: 0 23:05: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')]} 23:05:44 INFO - https://queue.taskcluster.net/v1/task/NTvU2dyrRhaM0Py_fAIzmg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:05:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTvU2dyrRhaM0Py_fAIzmg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:05:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTvU2dyrRhaM0Py_fAIzmg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:05:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTvU2dyrRhaM0Py_fAIzmg/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 23:05:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTvU2dyrRhaM0Py_fAIzmg/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 23:05:46 INFO - Downloaded 14405384 bytes. 23:05:46 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'] 23:05:46 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 23:05:46 INFO - Return code: 0 23:05: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')]} 23:05:46 INFO - https://queue.taskcluster.net/v1/task/NTvU2dyrRhaM0Py_fAIzmg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:05:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTvU2dyrRhaM0Py_fAIzmg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:05:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTvU2dyrRhaM0Py_fAIzmg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:05:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTvU2dyrRhaM0Py_fAIzmg/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 23:05:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NTvU2dyrRhaM0Py_fAIzmg/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 23:05:48 INFO - Downloaded 60125066 bytes. 23:05:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NTvU2dyrRhaM0Py_fAIzmg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:05:48 INFO - mkdir: /builds/slave/test/properties 23:05:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:05:48 INFO - Writing to file /builds/slave/test/properties/build_url 23:05:48 INFO - Contents: 23:05:48 INFO - build_url:https://queue.taskcluster.net/v1/task/NTvU2dyrRhaM0Py_fAIzmg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:05:48 INFO - Running post-action listener: _resource_record_post_action 23:05:48 INFO - Running post-action listener: set_extra_try_arguments 23:05:48 INFO - ##### 23:05:48 INFO - ##### Finished download-and-extract step (success) 23:05:48 INFO - ##### 23:05:48 INFO - ##### 23:05:48 INFO - ##### Running populate-webroot step. 23:05:48 INFO - ##### 23:05:48 INFO - Running pre-action listener: _resource_record_pre_action 23:05:48 INFO - Running main action method: populate_webroot 23:05:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:05:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:05:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:05:48 INFO - '--tppagecycles', 23:05:48 INFO - '7'], 23:05:48 INFO - 'tests': ['tsvgm']}}, 23:05:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:05:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:05:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:05:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:05:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:05:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:05:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:48 INFO - 'talos_options': ['--disable-e10s'], 23:05:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:05:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:05:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:48 INFO - 'talos_options': ['--disable-e10s'], 23:05:48 INFO - 'tests': ['damp', 'tps']}, 23:05:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:48 INFO - 'tests': ['damp', 'tps']}, 23:05:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:05:48 INFO - 'tests': ['dromaeo_dom']}, 23:05:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:05:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:05:48 INFO - 'tests': ['basic_compositor_video']}, 23:05:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:05:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:05:48 INFO - 'tests': ['a11yr', 23:05:48 INFO - 'ts_paint', 23:05:48 INFO - 'tpaint', 23:05:48 INFO - 'sessionrestore', 23:05:48 INFO - 'sessionrestore_no_auto_restore', 23:05:48 INFO - 'tabpaint']}, 23:05:48 INFO - 'other-e10s': {'tests': ['a11yr', 23:05:48 INFO - 'ts_paint', 23:05:48 INFO - 'tpaint', 23:05:48 INFO - 'sessionrestore', 23:05:48 INFO - 'sessionrestore_no_auto_restore', 23:05:48 INFO - 'tabpaint']}, 23:05:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:05:48 INFO - 'ts_paint', 23:05:48 INFO - 'tpaint', 23:05:48 INFO - 'sessionrestore', 23:05:48 INFO - 'sessionrestore_no_auto_restore', 23:05:48 INFO - 'tabpaint']}, 23:05:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:05:48 INFO - 'ts_paint', 23:05:48 INFO - 'tpaint', 23:05:48 INFO - 'sessionrestore', 23:05:48 INFO - 'sessionrestore_no_auto_restore', 23:05:48 INFO - 'tabpaint']}, 23:05:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:05:48 INFO - 'tests': ['a11yr', 23:05:48 INFO - 'ts_paint', 23:05:48 INFO - 'tpaint', 23:05:48 INFO - 'sessionrestore', 23:05:48 INFO - 'sessionrestore_no_auto_restore', 23:05:48 INFO - 'tabpaint']}, 23:05:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:05:48 INFO - 'tests': ['a11yr', 23:05:48 INFO - 'ts_paint', 23:05:48 INFO - 'tpaint', 23:05:48 INFO - 'sessionrestore', 23:05:48 INFO - 'sessionrestore_no_auto_restore', 23:05:48 INFO - 'tabpaint']}, 23:05:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:05:48 INFO - 'tests': ['tsvgx', 23:05:48 INFO - 'tsvgr_opacity', 23:05:48 INFO - 'tart', 23:05:48 INFO - 'tscrollx', 23:05:48 INFO - 'cart']}, 23:05:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:05:48 INFO - 'tsvgr_opacity', 23:05:48 INFO - 'tart', 23:05:48 INFO - 'tscrollx', 23:05:48 INFO - 'cart']}, 23:05:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:48 INFO - 'talos_options': ['--disable-e10s'], 23:05:48 INFO - 'tests': ['tp5o']}, 23:05:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:48 INFO - 'tests': ['tp5o']}, 23:05:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:48 INFO - 'talos_options': ['--disable-e10s', 23:05:48 INFO - '--xperf_path', 23:05:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:05:48 INFO - 'tests': ['tp5n']}, 23:05:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:48 INFO - 'talos_options': ['--xperf_path', 23:05:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:05:48 INFO - 'tests': ['tp5n']}}, 23:05:48 INFO - 'talos.zip': {'path': '', 23:05:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:05:48 INFO - Running post-action listener: _resource_record_post_action 23:05:48 INFO - ##### 23:05:48 INFO - ##### Finished populate-webroot step (success) 23:05:48 INFO - ##### 23:05:48 INFO - ##### 23:05:48 INFO - ##### Running create-virtualenv step. 23:05:48 INFO - ##### 23:05:48 INFO - Running pre-action listener: _resource_record_pre_action 23:05:48 INFO - Running main action method: create_virtualenv 23:05:48 INFO - Creating virtualenv /builds/slave/test/build/venv 23:05:48 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 23:05:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:05:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:05:49 INFO - Using real prefix '/usr' 23:05:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:05:49 INFO - Installing distribute.............................................................................................................................................................................................done. 23:05:51 INFO - Installing pip.................done. 23:05:51 INFO - Return code: 0 23:05:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:05:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f68bbfa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3f190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd1110>, '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 0xd3d230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd3d6c0>, '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': '14ef55db36f7623abb31b9cf000001d5-1466486930.62391-1051532762', '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 23:05:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:05:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:05:51 INFO - Using env: {'DISPLAY': ':0', 23:05:51 INFO - 'HOME': '/home/cltbld', 23:05:51 INFO - 'LANG': 'en_US.UTF-8', 23:05:51 INFO - 'LANGUAGE': 'en_US:en', 23:05:51 INFO - 'LOGNAME': 'cltbld', 23:05:51 INFO - 'MAIL': '/var/mail/cltbld', 23:05:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:51 INFO - 'MOZ_NO_REMOTE': '1', 23:05:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:51 INFO - 'NO_EM_RESTART': '1', 23:05:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:05:51 INFO - 'PWD': '/builds/slave/test', 23:05:51 INFO - 'SHELL': '/bin/bash', 23:05:51 INFO - 'SHLVL': '1', 23:05:51 INFO - 'TERM': 'linux', 23:05:51 INFO - 'TMOUT': '86400', 23:05:51 INFO - 'USER': 'cltbld', 23:05:51 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1466486930.62391-1051532762', 23:05:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:51 INFO - '_': '/tools/buildbot/bin/python'} 23:05:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:51 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 23:05:51 INFO - Cleaning up... 23:05:51 INFO - Return code: 0 23:05:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:05:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f68bbfa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3f190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd1110>, '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 0xd3d230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd3d6c0>, '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': '14ef55db36f7623abb31b9cf000001d5-1466486930.62391-1051532762', '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 23:05:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:05:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:05:51 INFO - Using env: {'DISPLAY': ':0', 23:05:51 INFO - 'HOME': '/home/cltbld', 23:05:51 INFO - 'LANG': 'en_US.UTF-8', 23:05:51 INFO - 'LANGUAGE': 'en_US:en', 23:05:51 INFO - 'LOGNAME': 'cltbld', 23:05:51 INFO - 'MAIL': '/var/mail/cltbld', 23:05:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:51 INFO - 'MOZ_NO_REMOTE': '1', 23:05:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:51 INFO - 'NO_EM_RESTART': '1', 23:05:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:05:51 INFO - 'PWD': '/builds/slave/test', 23:05:51 INFO - 'SHELL': '/bin/bash', 23:05:51 INFO - 'SHLVL': '1', 23:05:51 INFO - 'TERM': 'linux', 23:05:51 INFO - 'TMOUT': '86400', 23:05:51 INFO - 'USER': 'cltbld', 23:05:51 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1466486930.62391-1051532762', 23:05:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:51 INFO - '_': '/tools/buildbot/bin/python'} 23:05:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:51 INFO - Downloading/unpacking psutil>=3.1.1 23:05: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 23:05: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 23:05: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 23:05: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 23:05: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 23:05: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 23:05:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:05:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:05:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:05:53 INFO - Installing collected packages: psutil 23:05:53 INFO - Running setup.py install for psutil 23:05:54 INFO - building 'psutil._psutil_linux' extension 23:05:54 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 23:05:54 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 23:05:54 INFO - building 'psutil._psutil_posix' extension 23:05:54 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 23:05:54 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 23:05:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:05:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:05:54 INFO - Successfully installed psutil 23:05:54 INFO - Cleaning up... 23:05:54 INFO - Return code: 0 23:05:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:05:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f68bbfa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3f190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd1110>, '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 0xd3d230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd3d6c0>, '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': '14ef55db36f7623abb31b9cf000001d5-1466486930.62391-1051532762', '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 23:05:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:05:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:05:54 INFO - Using env: {'DISPLAY': ':0', 23:05:54 INFO - 'HOME': '/home/cltbld', 23:05:54 INFO - 'LANG': 'en_US.UTF-8', 23:05:54 INFO - 'LANGUAGE': 'en_US:en', 23:05:54 INFO - 'LOGNAME': 'cltbld', 23:05:54 INFO - 'MAIL': '/var/mail/cltbld', 23:05:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:54 INFO - 'MOZ_NO_REMOTE': '1', 23:05:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:54 INFO - 'NO_EM_RESTART': '1', 23:05:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:05:54 INFO - 'PWD': '/builds/slave/test', 23:05:54 INFO - 'SHELL': '/bin/bash', 23:05:54 INFO - 'SHLVL': '1', 23:05:54 INFO - 'TERM': 'linux', 23:05:54 INFO - 'TMOUT': '86400', 23:05:54 INFO - 'USER': 'cltbld', 23:05:54 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1466486930.62391-1051532762', 23:05:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:54 INFO - '_': '/tools/buildbot/bin/python'} 23:05:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:05:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:05:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:05:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:05:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:05:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:05:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:05:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:05:56 INFO - Installing collected packages: mozsystemmonitor 23:05:56 INFO - Running setup.py install for mozsystemmonitor 23:05:56 INFO - Successfully installed mozsystemmonitor 23:05:56 INFO - Cleaning up... 23:05:56 INFO - Return code: 0 23:05:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:05:56 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')]} 23:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:56 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')]} 23:05:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:56 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 0x7f68bbfa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3f190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd1110>, '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 0xd3d230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd3d6c0>, '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': '14ef55db36f7623abb31b9cf000001d5-1466486930.62391-1051532762', '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 23:05:56 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 23:05:56 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 23:05:56 INFO - Using env: {'DISPLAY': ':0', 23:05:56 INFO - 'HOME': '/home/cltbld', 23:05:56 INFO - 'LANG': 'en_US.UTF-8', 23:05:56 INFO - 'LANGUAGE': 'en_US:en', 23:05:56 INFO - 'LOGNAME': 'cltbld', 23:05:56 INFO - 'MAIL': '/var/mail/cltbld', 23:05:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:56 INFO - 'MOZ_NO_REMOTE': '1', 23:05:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:56 INFO - 'NO_EM_RESTART': '1', 23:05:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:05:56 INFO - 'PWD': '/builds/slave/test', 23:05:56 INFO - 'SHELL': '/bin/bash', 23:05:56 INFO - 'SHLVL': '1', 23:05:56 INFO - 'TERM': 'linux', 23:05:56 INFO - 'TMOUT': '86400', 23:05:56 INFO - 'USER': 'cltbld', 23:05:56 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1466486930.62391-1051532762', 23:05:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:56 INFO - '_': '/tools/buildbot/bin/python'} 23:05:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:57 INFO - Downloading/unpacking jsonschema==2.5.1 23:05: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 23:05: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 23:05: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 23:05: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 23:05: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 23:05: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 23:05:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:05:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:05:58 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 23:05:58 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 23:05:58 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 23:05:58 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 23:05:58 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 23:05:58 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 23:05:59 INFO - Downloading functools32-3.2.3-2.tar.gz 23:05:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:05:59 INFO - warning: no files found matching '*.txt' 23:05:59 INFO - no previously-included directories found matching 'build' 23:05:59 INFO - no previously-included directories found matching 'dist' 23:05:59 INFO - no previously-included directories found matching '.git*' 23:05:59 INFO - Installing collected packages: jsonschema, functools32 23:05:59 INFO - Running setup.py install for functools32 23:05:59 INFO - warning: no files found matching '*.txt' 23:05:59 INFO - no previously-included directories found matching 'build' 23:05:59 INFO - no previously-included directories found matching 'dist' 23:05:59 INFO - no previously-included directories found matching '.git*' 23:05:59 INFO - Successfully installed jsonschema functools32 23:05:59 INFO - Cleaning up... 23:05:59 INFO - Return code: 0 23:05:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:05: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')]} 23:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05: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')]} 23:05:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05: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', '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 0x7f68bbfa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3f190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd1110>, '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 0xd3d230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd3d6c0>, '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': '14ef55db36f7623abb31b9cf000001d5-1466486930.62391-1051532762', '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 23:05: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:05: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 blobuploader==1.2.4 23:05:59 INFO - Using env: {'DISPLAY': ':0', 23:05:59 INFO - 'HOME': '/home/cltbld', 23:05:59 INFO - 'LANG': 'en_US.UTF-8', 23:05:59 INFO - 'LANGUAGE': 'en_US:en', 23:05:59 INFO - 'LOGNAME': 'cltbld', 23:05:59 INFO - 'MAIL': '/var/mail/cltbld', 23:05:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:59 INFO - 'MOZ_NO_REMOTE': '1', 23:05:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:59 INFO - 'NO_EM_RESTART': '1', 23:05:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:05:59 INFO - 'PWD': '/builds/slave/test', 23:05:59 INFO - 'SHELL': '/bin/bash', 23:05:59 INFO - 'SHLVL': '1', 23:05:59 INFO - 'TERM': 'linux', 23:05:59 INFO - 'TMOUT': '86400', 23:05:59 INFO - 'USER': 'cltbld', 23:05:59 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1466486930.62391-1051532762', 23:05:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:59 INFO - '_': '/tools/buildbot/bin/python'} 23:05:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:59 INFO - Downloading/unpacking blobuploader==1.2.4 23:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:05:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:05:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:05:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:05:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:01 INFO - Downloading blobuploader-1.2.4.tar.gz 23:06:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:06:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:06:01 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 23:06:01 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 23:06:01 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 23:06:01 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 23:06:01 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 23:06:01 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 23:06:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:06:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:06:01 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 23:06:01 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 23:06:01 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 23:06:01 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 23:06:01 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 23:06:01 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 23:06:02 INFO - Downloading docopt-0.6.1.tar.gz 23:06:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:06:02 INFO - Installing collected packages: blobuploader, requests, docopt 23:06:02 INFO - Running setup.py install for blobuploader 23:06:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:06:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:06:02 INFO - Running setup.py install for requests 23:06:02 INFO - Running setup.py install for docopt 23:06:02 INFO - Successfully installed blobuploader requests docopt 23:06:02 INFO - Cleaning up... 23:06:02 INFO - Return code: 0 23:06:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:06:02 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')]} 23:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:02 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')]} 23:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:02 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 0x7f68bbfa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3f190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd1110>, '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 0xd3d230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd3d6c0>, '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': '14ef55db36f7623abb31b9cf000001d5-1466486930.62391-1051532762', '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 23:06:02 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 23:06:02 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 23:06:02 INFO - Using env: {'DISPLAY': ':0', 23:06:02 INFO - 'HOME': '/home/cltbld', 23:06:02 INFO - 'LANG': 'en_US.UTF-8', 23:06:02 INFO - 'LANGUAGE': 'en_US:en', 23:06:02 INFO - 'LOGNAME': 'cltbld', 23:06:02 INFO - 'MAIL': '/var/mail/cltbld', 23:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:02 INFO - 'MOZ_NO_REMOTE': '1', 23:06:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:02 INFO - 'NO_EM_RESTART': '1', 23:06:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:02 INFO - 'PWD': '/builds/slave/test', 23:06:02 INFO - 'SHELL': '/bin/bash', 23:06:02 INFO - 'SHLVL': '1', 23:06:02 INFO - 'TERM': 'linux', 23:06:02 INFO - 'TMOUT': '86400', 23:06:02 INFO - 'USER': 'cltbld', 23:06:02 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1466486930.62391-1051532762', 23:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:02 INFO - '_': '/tools/buildbot/bin/python'} 23:06:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:06:03 INFO - Running setup.py (path:/tmp/pip-vgGXGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:06:03 INFO - Running setup.py (path:/tmp/pip-sNCBnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:06:03 INFO - Running setup.py (path:/tmp/pip-bKv10R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:06:03 INFO - Running setup.py (path:/tmp/pip-UsEltB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:06:03 INFO - Running setup.py (path:/tmp/pip-pCd3y2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:06:03 INFO - Running setup.py (path:/tmp/pip-l8G4gD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:06:03 INFO - Running setup.py (path:/tmp/pip-B0AwKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:06:03 INFO - Running setup.py (path:/tmp/pip-wgcvLS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:06:03 INFO - Running setup.py (path:/tmp/pip-SZPrZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:06:03 INFO - Running setup.py (path:/tmp/pip-FGkz6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:06:03 INFO - Running setup.py (path:/tmp/pip-pGpHEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:06:03 INFO - Running setup.py (path:/tmp/pip-Irs3Im-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:06:03 INFO - Running setup.py (path:/tmp/pip-wxc2Tl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:06:04 INFO - Running setup.py (path:/tmp/pip-spGxm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:06:04 INFO - Running setup.py (path:/tmp/pip-JF4VIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:06:04 INFO - Running setup.py (path:/tmp/pip-o6XXHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:06:04 INFO - Running setup.py (path:/tmp/pip-UE1v92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:06:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:06:04 INFO - Running setup.py install for manifestparser 23:06:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:06:04 INFO - Running setup.py install for mozcrash 23:06:04 INFO - Running setup.py install for mozdebug 23:06:04 INFO - Running setup.py install for mozdevice 23:06:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:06:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:06:04 INFO - Running setup.py install for mozfile 23:06:04 INFO - Running setup.py install for mozhttpd 23:06:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:06:04 INFO - Running setup.py install for mozinfo 23:06:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:06:05 INFO - Running setup.py install for mozInstall 23:06:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:06:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:06:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:06:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:06:05 INFO - Running setup.py install for mozleak 23:06:05 INFO - Running setup.py install for mozlog 23:06:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:06:05 INFO - Running setup.py install for moznetwork 23:06:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:06:05 INFO - Running setup.py install for mozprocess 23:06:05 INFO - Running setup.py install for mozprofile 23:06:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:06:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:06:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:06:05 INFO - Running setup.py install for mozrunner 23:06:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:06:05 INFO - Running setup.py install for mozscreenshot 23:06:05 INFO - Running setup.py install for moztest 23:06:06 INFO - Running setup.py install for mozversion 23:06:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:06:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:06:06 INFO - Cleaning up... 23:06:06 INFO - Return code: 0 23:06:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:06:06 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')]} 23:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:06 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')]} 23:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:06 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 0x7f68bbfa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3f190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd1110>, '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 0xd3d230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd3d6c0>, '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': '14ef55db36f7623abb31b9cf000001d5-1466486930.62391-1051532762', '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 23:06:06 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 23:06:06 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 23:06:06 INFO - Using env: {'DISPLAY': ':0', 23:06:06 INFO - 'HOME': '/home/cltbld', 23:06:06 INFO - 'LANG': 'en_US.UTF-8', 23:06:06 INFO - 'LANGUAGE': 'en_US:en', 23:06:06 INFO - 'LOGNAME': 'cltbld', 23:06:06 INFO - 'MAIL': '/var/mail/cltbld', 23:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:06 INFO - 'MOZ_NO_REMOTE': '1', 23:06:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:06 INFO - 'NO_EM_RESTART': '1', 23:06:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:06 INFO - 'PWD': '/builds/slave/test', 23:06:06 INFO - 'SHELL': '/bin/bash', 23:06:06 INFO - 'SHLVL': '1', 23:06:06 INFO - 'TERM': 'linux', 23:06:06 INFO - 'TMOUT': '86400', 23:06:06 INFO - 'USER': 'cltbld', 23:06:06 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1466486930.62391-1051532762', 23:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:06 INFO - '_': '/tools/buildbot/bin/python'} 23:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:06:06 INFO - Running setup.py (path:/tmp/pip-F0_0no-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:06:06 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)) 23:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:06:06 INFO - Running setup.py (path:/tmp/pip-IFxHwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:06:06 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)) 23:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:06:06 INFO - Running setup.py (path:/tmp/pip-EONvNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:06:06 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)) 23:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:06:06 INFO - Running setup.py (path:/tmp/pip-kT4vHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:06:06 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)) 23:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:06:06 INFO - Running setup.py (path:/tmp/pip-a_YoVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:06:06 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)) 23:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:06:06 INFO - Running setup.py (path:/tmp/pip-75mLTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:06:06 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)) 23:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:06:06 INFO - Running setup.py (path:/tmp/pip-IiZSic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:06:06 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)) 23:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:06:06 INFO - Running setup.py (path:/tmp/pip-nkCSNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:06:06 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)) 23:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:06:06 INFO - Running setup.py (path:/tmp/pip-mNkZVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:06:06 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)) 23:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:06:07 INFO - Running setup.py (path:/tmp/pip-vD3_7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:06:07 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)) 23:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:06:07 INFO - Running setup.py (path:/tmp/pip-zfsz35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:06:07 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)) 23:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:06:07 INFO - Running setup.py (path:/tmp/pip-57dDdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:06:07 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)) 23:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:06:07 INFO - Running setup.py (path:/tmp/pip-FxwnlB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:06:07 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)) 23:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:06:07 INFO - Running setup.py (path:/tmp/pip-oNv0Y_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:06:07 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)) 23:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:06:07 INFO - Running setup.py (path:/tmp/pip-nvBmpi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:06:07 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)) 23:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:06:07 INFO - Running setup.py (path:/tmp/pip-53VQ6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:06:07 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)) 23:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:06:07 INFO - Running setup.py (path:/tmp/pip-6EQwzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:06:07 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)) 23:06:07 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)) 23:06:07 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)) 23:06:07 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)) 23:06:07 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)) 23:06:07 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)) 23:06:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:09 INFO - Downloading blessings-1.6.tar.gz 23:06:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:06:09 INFO - Installing collected packages: blessings 23:06:09 INFO - Running setup.py install for blessings 23:06:09 INFO - Successfully installed blessings 23:06:09 INFO - Cleaning up... 23:06:09 INFO - Return code: 0 23:06:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:06:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:06:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:06:09 INFO - Reading from file tmpfile_stdout 23:06:09 INFO - Current package versions: 23:06:09 INFO - argparse == 1.2.1 23:06:09 INFO - blessings == 1.6 23:06:09 INFO - blobuploader == 1.2.4 23:06:09 INFO - docopt == 0.6.1 23:06:09 INFO - functools32 == 3.2.3-2 23:06:09 INFO - jsonschema == 2.5.1 23:06:09 INFO - manifestparser == 1.1 23:06:09 INFO - mozInstall == 1.12 23:06:09 INFO - mozcrash == 0.17 23:06:09 INFO - mozdebug == 0.1 23:06:09 INFO - mozdevice == 0.48 23:06:09 INFO - mozfile == 1.2 23:06:09 INFO - mozhttpd == 0.7 23:06:09 INFO - mozinfo == 0.9 23:06:09 INFO - mozleak == 0.1 23:06:09 INFO - mozlog == 3.2 23:06:09 INFO - moznetwork == 0.27 23:06:09 INFO - mozprocess == 0.22 23:06:09 INFO - mozprofile == 0.28 23:06:09 INFO - mozrunner == 6.11 23:06:09 INFO - mozscreenshot == 0.1 23:06:09 INFO - mozsystemmonitor == 0.3 23:06:09 INFO - moztest == 0.7 23:06:09 INFO - mozversion == 1.4 23:06:09 INFO - psutil == 3.1.1 23:06:09 INFO - requests == 1.2.3 23:06:09 INFO - wsgiref == 0.1.2 23:06:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:06:09 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')]} 23:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:09 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')]} 23:06:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:09 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 0x7f68bbfa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3f190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd1110>, '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 0xd3d230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd3d6c0>, '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': '14ef55db36f7623abb31b9cf000001d5-1466486930.62391-1051532762', '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 23:06:09 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 23:06:09 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 23:06:09 INFO - Using env: {'DISPLAY': ':0', 23:06:09 INFO - 'HOME': '/home/cltbld', 23:06:09 INFO - 'LANG': 'en_US.UTF-8', 23:06:09 INFO - 'LANGUAGE': 'en_US:en', 23:06:09 INFO - 'LOGNAME': 'cltbld', 23:06:09 INFO - 'MAIL': '/var/mail/cltbld', 23:06:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:09 INFO - 'MOZ_NO_REMOTE': '1', 23:06:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:09 INFO - 'NO_EM_RESTART': '1', 23:06:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:09 INFO - 'PWD': '/builds/slave/test', 23:06:09 INFO - 'SHELL': '/bin/bash', 23:06:09 INFO - 'SHLVL': '1', 23:06:09 INFO - 'TERM': 'linux', 23:06:09 INFO - 'TMOUT': '86400', 23:06:09 INFO - 'USER': 'cltbld', 23:06:09 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1466486930.62391-1051532762', 23:06:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:09 INFO - '_': '/tools/buildbot/bin/python'} 23:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:10 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)) 23:06:10 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)) 23:06:10 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)) 23:06:10 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)) 23:06:10 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)) 23:06:10 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)) 23:06:10 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)) 23:06:10 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)) 23:06:10 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)) 23:06:10 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)) 23:06:10 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)) 23:06:10 INFO - Cleaning up... 23:06:10 INFO - Return code: 0 23:06:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:06:10 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')]} 23:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:10 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')]} 23:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:10 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 0x7f68bbfa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3f190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd1110>, '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 0xd3d230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd3d6c0>, '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': '14ef55db36f7623abb31b9cf000001d5-1466486930.62391-1051532762', '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 23:06:10 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 23:06:10 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 23:06:10 INFO - Using env: {'DISPLAY': ':0', 23:06:10 INFO - 'HOME': '/home/cltbld', 23:06:10 INFO - 'LANG': 'en_US.UTF-8', 23:06:10 INFO - 'LANGUAGE': 'en_US:en', 23:06:10 INFO - 'LOGNAME': 'cltbld', 23:06:10 INFO - 'MAIL': '/var/mail/cltbld', 23:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:10 INFO - 'MOZ_NO_REMOTE': '1', 23:06:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:10 INFO - 'NO_EM_RESTART': '1', 23:06:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:10 INFO - 'PWD': '/builds/slave/test', 23:06:10 INFO - 'SHELL': '/bin/bash', 23:06:10 INFO - 'SHLVL': '1', 23:06:10 INFO - 'TERM': 'linux', 23:06:10 INFO - 'TMOUT': '86400', 23:06:10 INFO - 'USER': 'cltbld', 23:06:10 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1466486930.62391-1051532762', 23:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:10 INFO - '_': '/tools/buildbot/bin/python'} 23:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:06:10 INFO - Cleaning up... 23:06:10 INFO - Return code: 0 23:06:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:06:10 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')]} 23:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:10 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')]} 23:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:10 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 0x7f68bbfa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3f190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd1110>, '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 0xd3d230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd3d6c0>, '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': '14ef55db36f7623abb31b9cf000001d5-1466486930.62391-1051532762', '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 23:06:10 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 23:06:10 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 23:06:10 INFO - Using env: {'DISPLAY': ':0', 23:06:10 INFO - 'HOME': '/home/cltbld', 23:06:10 INFO - 'LANG': 'en_US.UTF-8', 23:06:10 INFO - 'LANGUAGE': 'en_US:en', 23:06:10 INFO - 'LOGNAME': 'cltbld', 23:06:10 INFO - 'MAIL': '/var/mail/cltbld', 23:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:10 INFO - 'MOZ_NO_REMOTE': '1', 23:06:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:10 INFO - 'NO_EM_RESTART': '1', 23:06:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:10 INFO - 'PWD': '/builds/slave/test', 23:06:10 INFO - 'SHELL': '/bin/bash', 23:06:10 INFO - 'SHLVL': '1', 23:06:10 INFO - 'TERM': 'linux', 23:06:10 INFO - 'TMOUT': '86400', 23:06:10 INFO - 'USER': 'cltbld', 23:06:10 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1466486930.62391-1051532762', 23:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:10 INFO - '_': '/tools/buildbot/bin/python'} 23:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:10 INFO - Downloading/unpacking flake8 23:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:06:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:06:12 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 23:06:12 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 23:06:12 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 23:06:12 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 23:06:12 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 23:06:12 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 23:06:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:06:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:06:12 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 23:06:12 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 23:06:12 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 23:06:12 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 23:06:12 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 23:06:12 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 23:06:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:06:12 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 23:06:12 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 23:06:12 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 23:06:12 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 23:06:12 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 23:06:12 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 23:06:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:06:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:06:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:06:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:06:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:06:13 INFO - no previously-included directories found matching 'docs/_build' 23:06:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:06:13 INFO - Running setup.py install for pep8 23:06:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:06:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:06:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:06:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:06:13 INFO - no previously-included directories found matching 'docs/_build' 23:06:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:06:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:06:13 INFO - Cleaning up... 23:06:13 INFO - Return code: 0 23:06:13 INFO - Running post-action listener: _resource_record_post_action 23:06:13 INFO - Running post-action listener: _start_resource_monitoring 23:06:13 INFO - Starting resource monitoring. 23:06:13 INFO - ##### 23:06:13 INFO - ##### Finished create-virtualenv step (success) 23:06:13 INFO - ##### 23:06:13 INFO - ##### 23:06:13 INFO - ##### Running install step. 23:06:13 INFO - ##### 23:06:13 INFO - Running pre-action listener: _resource_record_pre_action 23:06:13 INFO - Running main action method: install 23:06:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:06:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:06:13 INFO - Reading from file tmpfile_stdout 23:06:13 INFO - Detecting whether we're running mozinstall >=1.0... 23:06:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:06:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:06:13 INFO - Reading from file tmpfile_stdout 23:06:13 INFO - Output received: 23:06:13 INFO - Usage: mozinstall [options] installer 23:06:13 INFO - Options: 23:06:13 INFO - -h, --help show this help message and exit 23:06:13 INFO - -d DEST, --destination=DEST 23:06:13 INFO - Directory to install application into. [default: 23:06:13 INFO - "/builds/slave/test"] 23:06:13 INFO - --app=APP Application being installed. [default: firefox] 23:06:13 INFO - mkdir: /builds/slave/test/build/application 23:06:13 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'] 23:06:13 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 23:06:30 INFO - Reading from file tmpfile_stdout 23:06:30 INFO - Output received: 23:06:30 INFO - /builds/slave/test/build/application/firefox/firefox 23:06:30 INFO - Running post-action listener: _resource_record_post_action 23:06:30 INFO - ##### 23:06:30 INFO - ##### Finished install step (success) 23:06:30 INFO - ##### 23:06:30 INFO - ##### 23:06:30 INFO - ##### Running run-tests step. 23:06:30 INFO - ##### 23:06:30 INFO - Running pre-action listener: _resource_record_pre_action 23:06:30 INFO - Running main action method: run_tests 23:06:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:06:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:06:30 INFO - Python 2.7.3 23:06:30 INFO - Return code: 0 23:06:30 INFO - grabbing minidump binary from tooltool 23:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:30 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 0xdd1110>, '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 0xd3d230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd3d6c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:06:30 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 23:06:30 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 23:06:30 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 23:06:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:06:30 INFO - Return code: 0 23:06:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:06:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:06:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:06:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:06:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:06:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:06:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:06:31 INFO - Return code: 0 23:06:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NTvU2dyrRhaM0Py_fAIzmg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 23:06:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NTvU2dyrRhaM0Py_fAIzmg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 23:06:31 INFO - Using env: {'DISPLAY': ':0', 23:06:31 INFO - 'HOME': '/home/cltbld', 23:06:31 INFO - 'LANG': 'en_US.UTF-8', 23:06:31 INFO - 'LANGUAGE': 'en_US:en', 23:06:31 INFO - 'LOGNAME': 'cltbld', 23:06:31 INFO - 'MAIL': '/var/mail/cltbld', 23:06:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:06:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:06:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:31 INFO - 'MOZ_NO_REMOTE': '1', 23:06:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:06:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:31 INFO - 'NO_EM_RESTART': '1', 23:06:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:31 INFO - 'PWD': '/builds/slave/test', 23:06:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:06:31 INFO - 'SHELL': '/bin/bash', 23:06:31 INFO - 'SHLVL': '1', 23:06:31 INFO - 'TERM': 'linux', 23:06:31 INFO - 'TMOUT': '86400', 23:06:31 INFO - 'USER': 'cltbld', 23:06:31 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1466486930.62391-1051532762', 23:06:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:31 INFO - '_': '/tools/buildbot/bin/python'} 23:06:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NTvU2dyrRhaM0Py_fAIzmg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 23:06:32 INFO - mozversion application_buildid: 20160620203028 23:06:32 INFO - mozversion application_changeset: 027db1e33f89606c4996feae0203e5f3bb5db43d 23:06:32 INFO - mozversion application_display_name: Nightly 23:06:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:06:32 INFO - mozversion application_name: Firefox 23:06:32 INFO - mozversion application_remotingname: firefox 23:06:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:06:32 INFO - mozversion application_vendor: Mozilla 23:06:32 INFO - mozversion application_version: 50.0a1 23:06:32 INFO - mozversion platform_buildid: 20160620203028 23:06:32 INFO - mozversion platform_changeset: 027db1e33f89606c4996feae0203e5f3bb5db43d 23:06:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:06:32 INFO - mozversion platform_version: 50.0a1 23:06:32 INFO - using testdate: 1466489192 23:06:32 INFO - actual date: 1466489192 23:06:32 INFO - starting webserver on 'localhost:45907' 23:06:32 INFO - SUITE-START | Running 2 tests 23:06:32 INFO - TEST-START | dromaeo_css 23:06:32 INFO - operating with platform_type : linux_ 23:06:32 INFO - Initialising browser for dromaeo_css test... 23:06:32 INFO - TEST-INFO | started process 15420 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWppeIy/profile http://localhost:45907/getInfo.html) 23:06:36 INFO - PROCESS | 15420 | __metrics Screen width/height:1600/1200 23:06:36 INFO - PROCESS | 15420 | colorDepth:24 23:06:36 INFO - PROCESS | 15420 | Browser inner width/height: 1024/697 23:06:36 INFO - PROCESS | 15420 | __metrics 23:06:37 INFO - PROCESS | 15420 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:06:38 INFO - TEST-INFO | 15420: exit 0 23:06:38 INFO - Browser initialized. 23:06:38 INFO - Running cycle 1/1 for dromaeo_css test... 23:06:38 INFO - TEST-INFO | started process 15504 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWppeIy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:06:50 INFO - PROCESS | 15504 | RSS: Main: 173477888 23:06:50 INFO - PROCESS | 15504 | 23:07:42 INFO - PROCESS | 15504 | 1466489262293 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] 23:09:50 INFO - PROCESS | 15504 | Cycle 1(1): loaded http://localhost:45907/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45907/tests/dromaeo/cssquery-ext.html) 23:09:51 INFO - PROCESS | 15504 | RSS: Main: 272703488 23:09:51 INFO - PROCESS | 15504 | 23:12:53 INFO - PROCESS | 15504 | Cycle 1(1): loaded http://localhost:45907/tests/dromaeo/cssquery-ext.html (next: http://localhost:45907/tests/dromaeo/cssquery-jquery.html) 23:12:54 INFO - PROCESS | 15504 | RSS: Main: 264019968 23:12:54 INFO - PROCESS | 15504 | 23:15:56 INFO - PROCESS | 15504 | Cycle 1(1): loaded http://localhost:45907/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45907/tests/dromaeo/cssquery-mootools.html) 23:15:56 INFO - PROCESS | 15504 | RSS: Main: 258744320 23:15:56 INFO - PROCESS | 15504 | 23:18:58 INFO - PROCESS | 15504 | Cycle 1(1): loaded http://localhost:45907/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45907/tests/dromaeo/cssquery-prototype.html) 23:18:59 INFO - PROCESS | 15504 | RSS: Main: 261111808 23:18:59 INFO - PROCESS | 15504 | 23:22:02 INFO - PROCESS | 15504 | Cycle 1(1): loaded http://localhost:45907/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45907/tests/dromaeo/cssquery-yui.html) 23:22:02 INFO - PROCESS | 15504 | RSS: Main: 238899200 23:22:02 INFO - PROCESS | 15504 | 23:25:05 INFO - PROCESS | 15504 | Cycle 1(1): loaded http://localhost:45907/tests/dromaeo/cssquery-yui.html (next: http://localhost:45907/tests/dromaeo/cssquery-dojo.html) 23:25:05 INFO - PROCESS | 15504 | RSS: Main: 295534592 23:25:05 INFO - PROCESS | 15504 | 23:25:05 INFO - PROCESS | 15504 | __start_tp_report 23:25:05 INFO - PROCESS | 15504 | _x_x_mozilla_page_load 23:25:05 INFO - PROCESS | 15504 | _x_x_mozilla_page_load_details 23:25:05 INFO - PROCESS | 15504 | |i|pagename|runs| 23:25:05 INFO - PROCESS | 15504 | |0;dojo.html;3101.875924963;3113.7664675149367;3121.859516321766;3135.529670549419;3161.66802485739;5274.393444753854;5360.839174824751;5418.458154184579;5427.9185812212845;5518.310211223602;5355.6251062425545;5364.088105022146;5404.729763511818;5408.756605952732;5459.808906688267;4845.927311090337;4963;4966.15575352191;4979.950200498003;5134.691918484884;5053.696778193302;5060;5090.490950904898;5105.106606343875;5116.283720279164;4799.544043315879;4827.03459308138;4873.926891096637;4958.181899986498;5050.318207042076;4864.0515099555605;4960.826371077031;4961.652684312099;4973.229149481836;4991.251312303148;4835.46204366135;4877.073356062337;4882.487338829407;4915.655904086715;4916.918277978874;5272.235525848769;5447.645903016291;5511.807086751985;5519;5533.529649979757;5872.647641141545;5873.060310350366;5892.793752218652;5902.704864756745;5923.437273459014;5574.804881829116;5913.9112913306335;5951.345352011275;5958.910616340759;5968.045112781934;5312.4687531246955;5416;5424.891502169974;5433.429489903582;5476.808311709071;5925.940740592625;5937.406259374028;5975.043992961106;5995.040793473024;6004.3395226525045;5605.747741351567;5702.7433765480655;5781.595288329777;5822.068469045017;5854.326752423441;5845.853853653608;5900.085486749561;5943.970280148572;5947.256592925884;5948.434898684618;5816.651000939957;5834.212381328466;5837.211976383134;5841.853953651193;5845.912311315334;5634;5797.130430435468;5844.1233814927255;5872.207252021008;5872.442117998783;4486.080353527519;4487.147441986012;4494.483134439516;4523.660725445605;4526.683132180781;3984.2230765000545;3991.720579559461;3992.5608183099835;4002.7398219115667;4030.3954406839207;5374.623776335698;5424.186372044225;5430.104032834538;5498.862528436821;5560.555155587544;5881.2942446906645;5887.911681324784;5889.469947704727;5915.733791979371;5918.319393269743;5531.1426728857095;5536.723163841792;5547.334319881559;5564.165375193753;5568.49883510486;4813.4945830687975;4897.657163998557;4929.605631549467;4936.851894443173;4939.506049395031;6066;6075.544334174954;6087.573869829158;6111.236095488064;6118.326984031664;5885;5906.7341969612335;5909.940900590939;5912.763489460373;5914.615549989237;5799.565032622654;5911.231539899785;5913.91129133072;5926.911096333644;6018.157457955977;5703.372629010889;5754.395788442321;5755.769769209185;5761.683107429131;5763.452472015152;5687.7724891005555;5845.883082338244;5853.473187413153;5856.385079566584;5858.209141765978;5657.2928383952;5723.6851973141875;5725.19847221381;5746.511546518425;5749.8275051748515;5628.690422026828;5698.8290351289525;5700.287464066992;5705.600607957404;5705.885882282248;5529.834104976857;5610.13042978339;5655.264815573949;5657.660540367427;5666.575006874418;5750.453706897838;5848.0350742127075;5853.590248682552;5853.64878107315;5867.471927526372;5594.748236329294;5612.915806262828;5633.2113504110275;5641.661500309994;5655.886882262414 23:25:05 INFO - PROCESS | 15504 | |1;ext.html;585.9443352881477;606.4572207873953;609.871926895352;621.6301300726068;622.9439350458459;32200.516992245106;35226;35258.47112293317;43523;43814.34278485825;44941.55058449414;45493.54506454935;45510.54489455104;45541.54458455415;45621.54378456214;8885.955570222171;9006.86489702655;9032.8645070324;9039.457632542035;9042.005379408292;8749.693760718375;8897.866532002025;8898.28813694906;8898.688545900895;8901.910980890205;8916.55417229136;8932.955335223314;8952.910470895305;8957.19385255327;8961.910380896174;8796.604152813139;8852.734417967438;8890.199882010651;8897.599608017623;8899.021107678183;8779.561021948877;8828.646854125827;8855.291576673915;8871.822563548692;8873.334499912467;41936.16127677429;42196.36705449421;42283.788581057204;42349.36475952863;42363.57636423627;3511.20997775501;3680.871169509054;3704.0924973381425;3709.536307961505;3998.5601583825755;31110.37779244425;33390.33219335624;33759.1432471214;33981.15047123842;34076.318473630636;4373.322135069069;4376.781160941972;4476.7761611919595;4480.126375356806;4651.790669419885;334073;335345;339911;342537;343002;62904.68547657324;63544;63989;64034.35965640284;64109.679451602446;36692.266154676756;37296.62703372932;37316.25367492635;38671.80664096661;67779.66110169418;17702.114894255235;17730.290788368322;17824.732629010574;17863.642727145383;17871;13338.733225335633;13391.196528208338;13397;13418.731625367438;13429.26139062361;20659.380218593466;20716.06777694977;20825;20849.79150208509;20880.89559552223;7430.145533263636;7469.887951680729;7567.545947243183;7620.771376858592;7876.09424916142;951.70497145885;1009.6264382178641;1094.874089479704;1114.5486078138367;1118.8183043065892;32055.51916721251;32483.837580811945;32528.34943301168;32530;33054.669453305156;1086.766345235778;1098.8626421697288;1114.7046032801313;1121.7307846116873;1152.2107356460851;15672.138032408327;16265.51203463898;16315.918420407823;16385.59036024085;16538.421155259508;531248;540989;541733;541811;543883;59296;60603;60607;60665.696671517246;60798;1207.3540655749307;1210.1649861595472;1240.8759124087699;1359.6736783171968;1376.779715245576;22751.772482274966;32173.839130804197;33431.49852752259;33494.497582536766;33854.3229135411;51349.22976155286;51421.22868157055;52004.739976299876;52010.739946300026;52049;416035;416117;417437;417655;418456;22980.310590682308;28304.716952831033;28462.715372846007;28941.710582894742;29393.11820645384;46882.53117468918;47057.76471117623;48815.5118448811;48842.26736599025;51356;40730.38904416496;43146.4898728543;44600.776996114815;44713.55286447094;45748.31377529273;42884.52942637199;43481.56518434775;43573.12853742971;44402.77798610986;44808.551914481744;38534.42198367083;43781.78109109434;43973;44406;44552;35587.288254234256;38733.612663874126;39320.05099617483;40067.39898901577;40305.395419069326;28719.71280287254;29282;29336.413271734873;29340.7065929338;29440.852795735886 23:25:05 INFO - PROCESS | 15504 | |2;jquery.html;384.98460061597535;387.9437481565174;401.80311647292837;406.48782534007154;411.7118017387829;14605.707885842277;17996.190171442282;18423.539411514717;20198.89900550497;20258.594828103447;19142.904285478555;19581.70627440586;19860.20559177631;19988.60022799543;20045.599088018233;5595.552355811536;5791.739371728261;5802.854928626776;5819.476247137757;5839.211706419643;4166.500019997605;5752.5110365618975;5813.709314534278;6187.381261873822;6496.187976502937;6552.246491653474;6554.442872355856;6593.604383736991;6622.867542649168;6625.536212465129;6297.149884765544;6446.548741588091;6459.289478157399;6466.838329041764;6471.061696054069;5655.519280861132;5702.54379649627;5706.1440783882335;5709.086546152637;5740.913886291709;23487.882560587088;23721.7627823723;23965.16121935724;24007.879960600087;24067.87966060176;2283.178055899875;2312.364099872532;2388.2238272561485;2417.7703118203744;2939.1770304314614;14397.424103035866;14526.564203073925;14733;14761.335739891623;15090.54728358151;1887.7545919030576;1902.0965041605266;1914.100372824784;1927.2483731344787;1976.1996391461337;70617.64691176562;72618.63690681565;73693;76595.6170219151;84880.15119848785;10843.512041957973;10968.23222374426;11123.919020743817;11145.387003714712;11173.888261117447;15493.302801373966;15575.454859079879;15638.139902305255;15672.216389180496;15684;8167.714130005421;8234.300084492885;8378.8324233515;8444.451110677786;8582.227599516074;7973.681052757825;8059.879101813477;8069.959650201711;8232.135625759209;8295.668173273121;4748.622899359216;4767.332573439652;4788.760561971888;4853.563179313879;4936.086823937583;1924.6535623587888;1930.571377180876;1978.574606459618;2009.7186393904865;2017.878927264369;888.6090120347027;961.8749562556823;979.5004547680734;1008.9747756306151;1030.9175265978704;19270.61458770817;19698.40904772859;19971.101300441514;19995.60008799816;20519.281825136048;969;996.0836030851634;996.3523709588825;1038.6053299746047;1048.2871647279924;10620.468976551141;11157.330560166416;11190.328580285046;11191.608293709682;11381.829272560919;479720;488695;493123;499361;507231;88889;91517;92281;93365.5331723337;93803.53098234601;921.9308551858503;926.2543652359915;946.7585765629858;948.2414068744977;948.4250260542523;17630.3554466831;17678.292868285123;17842.19710113022;17936.372226971995;18332.541686457946;37187.81406092952;38635.2272954545;40347.59652403439;41514.58485415107;43474.782626086664;54700.452995471125;57226;58105.709471454065;58132.4186758127;58212.70893645505;8552.871706924278;8795.296376289754;8882.955585222291;8898.110188981309;9068.863967040632;9716.805663886824;13519.121257118255;13580.25308608036;13903.652408689864;14248.073875198079;11246.493907774005;11367.943160284145;11740.471678774305;11897.94051029774;12012.75974480523;11301;11366.659000230007;11637.825432618349;11793.11551633648;12068.275903445821;11069.944650276697;11450;11851.111166662362;11959.402029898645;12203.75592488163;8660.181361914068;8839.381243312906;8876.112388761072;8879.591582617357;8954;9204.447733136034;10795.244332896622;10920.50857711389;11441.542338306708;11804.763904721685 23:25:05 INFO - PROCESS | 15504 | |3;mootools.html;1336.124838230958;1460.2844606142994;1499.6850661361113;1628.1289510112085;1777.4578753480191;8536.31709463243;8879.91120088799;8883.600237989282;9181.173694367506;9195.40229885057;8919.509426981513;9131.086891310866;9133.725988220347;9161.679341223058;9164.908350916488;2181.8472706910484;2201.8678879267213;2204;2204.3166618348364;2206.2829580386438;2289.1873384948353;2322.105989194164;2350.2596682045187;2354.505553833697;2357.5874222011166;2315.305408377488;2317.2237300504353;2340.543593999162;2357.7760112789256;2359.587072262347;2264.07173059045;2276.886155692217;2292.6790249365104;2297.035245197021;2298.8160947124275;2218.4453886528368;2245.292732789166;2245.887705614729;2251.8423710340285;2270.012544543129;9046.32152588552;9076.954615226881;9116.954415227949;9139.908600913972;9250.35247532673;5350.143976963706;5454.754536045887;5457.126859702468;5458.153986132116;5461.399246082928;3392.23674673199;3414.4195486767308;3499;3549.0417587251554;3563.6436356364416;1140.8060629692973;1167.334619267018;1181.2676140792678;1182.2020136407891;1186.2763714134458;12652.620421387373;12820.743585128339;12832.486700531968;12847.164934279335;12848.935755321163;4554.157480866051;4659.697119687209;4711.764411779397;4723;4737.95262047382;9903.554340054714;9968.202543796478;10005.749856253506;10010.899891001143;10021.699349019542;5084.745762711849;5170.121079416433;5186.118359878829;5306.8142615009065;5307.522322990872;4280.935785963213;4365.454318210223;4904.068227036852;4923.310736496894;4965.230389289666;3682.779033258013;3709.703223742094;3749.043993781568;3790.1093243087853;3805.0867791729784;1075.9031687148195;1077.665923563682;1087.5486673030762;1106.1095817866694;1108.9279196852178;976.2434113562047;985.6845809340942;1004.2618675273668;1012.7012531303283;1014.9188064954786;6007.128966299862;6123.969380153071;6233.532485063638;6288.52836037299;6320.178376810985;432.7014360091527;433.0948318015363;443.62292051756395;445.6323533085218;453.5238000099948;4066.898327541835;4069.5726948670554;4099.1596722672375;4104.712670113064;4122.855700050483;10717.83923241152;11414.315141091562;11419.657410277705;11435.485403156878;11460.484278207501;11078.778424431466;11172.329660220414;11236.325820450798;11322.377269250106;11495.252808567417;8331.416800823885;8337.416380853281;8366.623501942428;8445.873311900326;8449.53527555978;5934.465898069195;6032.155498230163;6063.575549711478;6178.104174894705;6186.659733714689;10260.486975651336;10477.895221047693;10646.627368042082;10664.520096595827;10823.67528974132;10660.946695266473;10833.729156771144;10891.67324980252;10946.781064378827;10986.615468458565;7659.846803064019;7691.9615401924875;7763.262490063435;7765.0681918170185;7769.572673502786;8701.47791132534;8723.476591404537;8784;8834;8907.287417006753;7458.552486850806;7659.502132361378;7807.063152421746;7808.88286675689;7808.9609551954145;7633.732819351296;7642.65608047628;7668.271514206142;7679.692812287446;7920.683172673029;7120.1099862517185;7197.280271972761;7209.819754506179;7216.96391518039;7218.205997340393;5119.334486516729;5263.605229607718;5282.709450980233;5398.13629819227;5496.697681627549;5399.379071406838;5454.181872719124;5460.836174914759;5521.978433989725;5658.717064146858 23:25:05 INFO - PROCESS | 15504 | |4;prototype.html;312.2957730318132;321.0592962619524;324.11516559791784;336.40792205717935;339.8750137046376;5342.759575819087;5350.277712508815;5374.677519348842;5410.513053825155;5411.215373770801;5246.449122842104;5271.762770675319;5289.576833853293;5312.760925758341;5320.255164276995;3936.8031598420107;4121.7634709587155;4178.310578754517;4197.748135111888;4216.093539888923;4113.9177216455655;4121.856634550032;4138.441310423084;4160.646345060658;4173.770442625654;4096.75419474831;4097.774622395767;4101.487314085739;4109.534279432347;4120.526139493966;3910.3938889472033;3952.6245006724316;4058.5738497457933;4066.674666026711;4112.444819949314;3581.033121057326;3587.910302242439;3591.3356029134693;3591.44332628443;3593.5328407306883;5099.69401835891;5114.744262786883;5120.743962801882;5132.127538318495;5135;4431.756253406062;4534.274516077445;4704.811807527695;4706.176419126673;4739.691920025221;5524.475174858382;5534.1975413565215;5538.695371754552;5541.307336582927;5558.221848941152;3972.900677483086;3991.1618560102415;3998.4801975742967;4004.739691920045;4032.0927791247027;5523.536262890338;5714.428532153691;5753.165790960329;5766.740496677659;5777.393373695743;4033;4033.737807042533;4034.374671925856;4064.9593504065174;4075.633193012584;4099.815508302134;4123.773192474443;4130.132672138884;4137.586241375899;4157.646600039031;4490.956614740286;4680.882977925511;4697;4730.030343779517;4740.3837501124635;5494.423085575957;5515.531179849678;5558.527525160326;5596.104623260258;5658.490735833795;1425.4298280687808;1439.1365180891592;1443.81952255968;1445.8771004464527;1450.2531196433845;917.7567944494714;921.4609453469795;926.420986883198;929.707142250189;936.4334577580602;4855.465898751135;4862.17343051682;4867.028853314413;4909.926351104737;4911.165101932608;5145.331106956147;5148.716820574904;5157.716325602128;5196.818111366084;5201.115810312256;4681.742504162304;4824.778318970901;4854.68444551103;5135.4094279157625;5153.201253805666;3019.8977373258604;3032.7118923702656;3056.43455960648;3058.510638297906;3062.3262882165886;5838.737256823453;5851.38560451155;5866.354700982888;5876;5877.9118313225335;5652.97173514138;5854.882902341929;5872.882542349129;5907.291125064934;5949.553783466171;5898.316266098915;5915.053591425437;5921.615095018982;5933.317668468181;5938.61399009063;5693.1460280956535;5794.82615521535;5795.420457954339;5815.331236907809;5825;5694.231278777478;5702.714864256687;5714.485696287354;5735.272073152484;5761.884762304814;5613.214150019082;5728.4819522825655;5741.411617738913;5879.941200587939;5911.497522710618;3662.1943172502006;3836.2327534492656;4019.256437559061;4083.89790255246;4140.267423500595;5569.579757161898;5695.686737229492;5730.512906402836;5735.9139612905;5738.598298119092;5431.293931788842;5596.328440586993;5596.776128954796;5640.661560306395;5678.346990096192;5628.240187574625;5637.774489020393;5638.407967163389;5657.349404818334;5660.094384898561;5289.497497737709;5539.612227144061;5541.5843811715085;5564.304461942257;5573.21974923503;5488.298627425511;5564.693941833238;5665.235193248858;5681.630694004876;5718.685472298897;5432.158015507603;5445;5464.590155738256;5503.422140675331;5518.420565840529 23:25:05 INFO - PROCESS | 15504 | |5;yui.html;684.1721516964476;716.5270921192015;753.2016062973246;763.3015790551646;839.4543546694648;13923.512677056306;14034.929825350859;14148;14416.062955907884;14429.63925901853;13779.44882204713;13856.515021974208;13891.652708682263;13920.651983700413;13940.442382304696;652.5106170372221;785.2540086917451;789.3014682006437;793.167174466809;804.5534728225832;796.0328201235498;797.8563858505466;798.648594618366;799.0810567846993;799.7640695994695;842.2546046748611;849.3417601358965;849.430881309521;849.7535714642746;850.4557083466556;694.4305669351135;710.9182444018952;808.1595141053298;828.2628460670009;843.1905370843997;602.7709470401263;602.9698515074273;603.1616053685381;603.1736520966305;604.0154548086634;13525.59423217305;13584.660383490493;13620.727585448236;13626.18242905419;13738.10702304357;13837;14201.573952781433;14485.203313817736;14512.927435362755;14666.19335936523;12890.484380624765;13024.088313818036;13064.86935130646;13318.800217996737;13367.398467069006;4460.576245256695;4501.257292546726;4572.468223145251;4603.746793926332;4673.135469938073;72900.63549682271;73136.99999999946;73437;77362;77683.22316776817;11503.942480287713;11728.12039097054;11900;11910.46402911871;12026.819597706042;21280.893595531925;21305.573888522144;21351.89324053401;21364.893175534024;21373.358799236048;7867.685292588347;8035.758927232192;8079.030516338077;8134.267915887599;8323.625436855356;4536.251518499476;4544.113897789899;4604.286335617918;4607.470140933769;4629.953700463019;3333.7333013358875;3446.5691788526433;3467.7225821934185;3560.661737134968;3569.23261498779;636.7293900092442;639.9648019358887;640.4908098062052;643.5366536094004;645.493287769099;551.9337679478489;637.9266384365858;674.8515326628134;686.5571706249441;694.5207806613421;8755.168259015383;9002.819943601091;9414.858777118348;10172.931842156615;10198.847017294747;646.1019183335168;721.1310371002929;721.6716394040699;746.555799299416;751.7218629107265;4415.337699345124;4439.955600443955;4512.616427603691;4605.263157894721;4723.669343145947;106843;107922.46038769756;110516;111201.44399278113;111387;97635.51182244043;98559;98929.50535247277;99306;99387;55985.440145598026;57950.7102464485;71860.28139718641;78767.21232787713;79145.60427197827;8507.617157227816;8536.189062039097;8560.14398560139;8636.697715579925;8730.781730456789;49655;49803.501964979885;49821;50223.49776502188;51581.74209128931;66051;74707.2529274722;77845.61077194805;78252.60873695595;78765;11855.110866685205;11946.820797687868;12321.568745093879;12335.136540442083;12344.135910486539;13746.175229486264;13932.164070155823;14144.858551414765;14439.350229239919;14782.03916745408;12511.93744031274;12631.305278209788;12872.806907896576;12951.41718622683;13135.802962955755;12437.502499899903;12678.175918565265;12701.55544555973;12812.935935320264;12917.354132293536;12798.296093714935;12831;12903;13601.659958501117;13793.24137172425;9540.522973851419;9618.374805637612;9761.365511241747;9947.154491868272;10032.1974242059;10034.347767395097;10250.282480226313;10283.280170388001;10365.481725913825;10396.896031039592 23:25:05 INFO - PROCESS | 15504 | __end_tp_report 23:25:05 INFO - PROCESS | 15504 | __start_cc_report 23:25:05 INFO - PROCESS | 15504 | _x_x_mozilla_cycle_collect,846 23:25:05 INFO - PROCESS | 15504 | __end_cc_report 23:25:05 INFO - PROCESS | 15504 | __startTimestamp1466490305895__endTimestamp 23:25:05 INFO - PROCESS | 15504 | 23:25:05 INFO - PROCESS | 15504 | ------- Summary: start ------- 23:25:05 INFO - PROCESS | 15504 | Number of tests: 6 23:25:05 INFO - PROCESS | 15504 | 23:25:05 INFO - PROCESS | 15504 | [#0] dojo.html Cycles:165 Average:5422.01 Median:5633.21 stddev:625.77 (11.1%) stddev-sans-first:600.63 23:25:05 INFO - PROCESS | 15504 | Values: 3101.9 3113.8 3121.9 3135.5 3161.7 5274.4 5360.8 5418.5 5427.9 5518.3 5355.6 5364.1 5404.7 5408.8 5459.8 4845.9 4963.0 4966.2 4980.0 5134.7 5053.7 5060.0 5090.5 5105.1 5116.3 4799.5 4827.0 4873.9 4958.2 5050.3 4864.1 4960.8 4961.7 4973.2 4991.3 4835.5 4877.1 4882.5 4915.7 4916.9 5272.2 5447.6 5511.8 5519.0 5533.5 5872.6 5873.1 5892.8 5902.7 5923.4 5574.8 5913.9 5951.3 5958.9 5968.0 5312.5 5416.0 5424.9 5433.4 5476.8 5925.9 5937.4 5975.0 5995.0 6004.3 5605.7 5702.7 5781.6 5822.1 5854.3 5845.9 5900.1 5944.0 5947.3 5948.4 5816.7 5834.2 5837.2 5841.9 5845.9 5634.0 5797.1 5844.1 5872.2 5872.4 4486.1 4487.1 4494.5 4523.7 4526.7 3984.2 3991.7 3992.6 4002.7 4030.4 5374.6 5424.2 5430.1 5498.9 5560.6 5881.3 5887.9 5889.5 5915.7 5918.3 5531.1 5536.7 5547.3 5564.2 5568.5 4813.5 4897.7 4929.6 4936.9 4939.5 6066.0 6075.5 6087.6 6111.2 6118.3 5885.0 5906.7 5909.9 5912.8 5914.6 5799.6 5911.2 5913.9 5926.9 6018.2 5703.4 5754.4 5755.8 5761.7 5763.5 5687.8 5845.9 5853.5 5856.4 5858.2 5657.3 5723.7 5725.2 5746.5 5749.8 5628.7 5698.8 5700.3 5705.6 5705.9 5529.8 5610.1 5655.3 5657.7 5666.6 5750.5 5848.0 5853.6 5853.6 5867.5 5594.7 5612.9 5633.2 5641.7 5655.9 23:25:05 INFO - PROCESS | 15504 | 23:25:05 INFO - PROCESS | 15504 | [#1] ext.html Cycles:180 Average:59598.59 Median:42316.58 stddev:116558.71 (275.4%) stddev-sans-first:116801.47 23:25:05 INFO - PROCESS | 15504 | Values: 585.9 606.5 609.9 621.6 622.9 32200.5 35226.0 35258.5 43523.0 43814.3 44941.6 45493.5 45510.5 45541.5 45621.5 8886.0 9006.9 9032.9 9039.5 9042.0 8749.7 8897.9 8898.3 8898.7 8901.9 8916.6 8933.0 8952.9 8957.2 8961.9 8796.6 8852.7 8890.2 8897.6 8899.0 8779.6 8828.6 8855.3 8871.8 8873.3 41936.2 42196.4 42283.8 42349.4 42363.6 3511.2 3680.9 3704.1 3709.5 3998.6 31110.4 33390.3 33759.1 33981.2 34076.3 4373.3 4376.8 4476.8 4480.1 4651.8 334073.0 335345.0 339911.0 342537.0 343002.0 62904.7 63544.0 63989.0 64034.4 64109.7 36692.3 37296.6 37316.3 38671.8 67779.7 17702.1 17730.3 17824.7 17863.6 17871.0 13338.7 13391.2 13397.0 13418.7 13429.3 20659.4 20716.1 20825.0 20849.8 20880.9 7430.1 7469.9 7567.5 7620.8 7876.1 951.7 1009.6 1094.9 1114.5 1118.8 32055.5 32483.8 32528.3 32530.0 33054.7 1086.8 1098.9 1114.7 1121.7 1152.2 15672.1 16265.5 16315.9 16385.6 16538.4 531248.0 540989.0 541733.0 541811.0 543883.0 59296.0 60603.0 60607.0 60665.7 60798.0 1207.4 1210.2 1240.9 1359.7 1376.8 22751.8 32173.8 33431.5 33494.5 33854.3 51349.2 51421.2 52004.7 52010.7 52049.0 416035.0 416117.0 417437.0 417655.0 418456.0 22980.3 28304.7 28462.7 28941.7 29393.1 46882.5 47057.8 48815.5 48842.3 51356.0 40730.4 43146.5 44600.8 44713.6 45748.3 42884.5 43481.6 43573.1 44402.8 44808.6 38534.4 43781.8 43973.0 44406.0 44552.0 35587.3 38733.6 39320.1 40067.4 40305.4 28719.7 29282.0 29336.4 29340.7 29440.9 23:25:05 INFO - PROCESS | 15504 | 23:25:05 INFO - PROCESS | 15504 | [#2] jquery.html Cycles:180 Average:29126.93 Median:394.87 stddev:81237.72 (20573.1%) stddev-sans-first:81436.94 23:25:05 INFO - PROCESS | 15504 | Values: 385.0 387.9 401.8 406.5 411.7 14605.7 17996.2 18423.5 20198.9 20258.6 19142.9 19581.7 19860.2 19988.6 20045.6 5595.6 5791.7 5802.9 5819.5 5839.2 4166.5 5752.5 5813.7 6187.4 6496.2 6552.2 6554.4 6593.6 6622.9 6625.5 6297.1 6446.5 6459.3 6466.8 6471.1 5655.5 5702.5 5706.1 5709.1 5740.9 23487.9 23721.8 23965.2 24007.9 24067.9 2283.2 2312.4 2388.2 2417.8 2939.2 14397.4 14526.6 14733.0 14761.3 15090.5 1887.8 1902.1 1914.1 1927.2 1976.2 70617.6 72618.6 73693.0 76595.6 84880.2 10843.5 10968.2 11123.9 11145.4 11173.9 15493.3 15575.5 15638.1 15672.2 15684.0 8167.7 8234.3 8378.8 8444.5 8582.2 7973.7 8059.9 8070.0 8232.1 8295.7 4748.6 4767.3 4788.8 4853.6 4936.1 1924.7 1930.6 1978.6 2009.7 2017.9 888.6 961.9 979.5 1009.0 1030.9 19270.6 19698.4 19971.1 19995.6 20519.3 969.0 996.1 996.4 1038.6 1048.3 10620.5 11157.3 11190.3 11191.6 11381.8 479720.0 488695.0 493123.0 499361.0 507231.0 88889.0 91517.0 92281.0 93365.5 93803.5 921.9 926.3 946.8 948.2 948.4 17630.4 17678.3 17842.2 17936.4 18332.5 37187.8 38635.2 40347.6 41514.6 43474.8 54700.5 57226.0 58105.7 58132.4 58212.7 8552.9 8795.3 8883.0 8898.1 9068.9 9716.8 13519.1 13580.3 13903.7 14248.1 11246.5 11367.9 11740.5 11897.9 12012.8 11301.0 11366.7 11637.8 11793.1 12068.3 11069.9 11450.0 11851.1 11959.4 12203.8 8660.2 8839.4 8876.1 8879.6 8954.0 9204.4 10795.2 10920.5 11441.5 11804.8 23:25:05 INFO - PROCESS | 15504 | 23:25:05 INFO - PROCESS | 15504 | [#3] mootools.html Cycles:180 Average:5903.35 Median:444.63 stddev:3452.83 (776.6%) stddev-sans-first:3445.46 23:25:05 INFO - PROCESS | 15504 | Values: 1336.1 1460.3 1499.7 1628.1 1777.5 8536.3 8879.9 8883.6 9181.2 9195.4 8919.5 9131.1 9133.7 9161.7 9164.9 2181.8 2201.9 2204.0 2204.3 2206.3 2289.2 2322.1 2350.3 2354.5 2357.6 2315.3 2317.2 2340.5 2357.8 2359.6 2264.1 2276.9 2292.7 2297.0 2298.8 2218.4 2245.3 2245.9 2251.8 2270.0 9046.3 9077.0 9117.0 9139.9 9250.4 5350.1 5454.8 5457.1 5458.2 5461.4 3392.2 3414.4 3499.0 3549.0 3563.6 1140.8 1167.3 1181.3 1182.2 1186.3 12652.6 12820.7 12832.5 12847.2 12848.9 4554.2 4659.7 4711.8 4723.0 4738.0 9903.6 9968.2 10005.7 10010.9 10021.7 5084.7 5170.1 5186.1 5306.8 5307.5 4280.9 4365.5 4904.1 4923.3 4965.2 3682.8 3709.7 3749.0 3790.1 3805.1 1075.9 1077.7 1087.5 1106.1 1108.9 976.2 985.7 1004.3 1012.7 1014.9 6007.1 6124.0 6233.5 6288.5 6320.2 432.7 433.1 443.6 445.6 453.5 4066.9 4069.6 4099.2 4104.7 4122.9 10717.8 11414.3 11419.7 11435.5 11460.5 11078.8 11172.3 11236.3 11322.4 11495.3 8331.4 8337.4 8366.6 8445.9 8449.5 5934.5 6032.2 6063.6 6178.1 6186.7 10260.5 10477.9 10646.6 10664.5 10823.7 10660.9 10833.7 10891.7 10946.8 10986.6 7659.8 7692.0 7763.3 7765.1 7769.6 8701.5 8723.5 8784.0 8834.0 8907.3 7458.6 7659.5 7807.1 7808.9 7809.0 7633.7 7642.7 7668.3 7679.7 7920.7 7120.1 7197.3 7209.8 7217.0 7218.2 5119.3 5263.6 5282.7 5398.1 5496.7 5399.4 5454.2 5460.8 5522.0 5658.7 23:25:05 INFO - PROCESS | 15504 | 23:25:05 INFO - PROCESS | 15504 | [#4] prototype.html Cycles:180 Average:4643.33 Median:5259.11 stddev:1371.46 (26.1%) stddev-sans-first:1336.23 23:25:05 INFO - PROCESS | 15504 | Values: 312.3 321.1 324.1 336.4 339.9 5342.8 5350.3 5374.7 5410.5 5411.2 5246.4 5271.8 5289.6 5312.8 5320.3 3936.8 4121.8 4178.3 4197.7 4216.1 4113.9 4121.9 4138.4 4160.6 4173.8 4096.8 4097.8 4101.5 4109.5 4120.5 3910.4 3952.6 4058.6 4066.7 4112.4 3581.0 3587.9 3591.3 3591.4 3593.5 5099.7 5114.7 5120.7 5132.1 5135.0 4431.8 4534.3 4704.8 4706.2 4739.7 5524.5 5534.2 5538.7 5541.3 5558.2 3972.9 3991.2 3998.5 4004.7 4032.1 5523.5 5714.4 5753.2 5766.7 5777.4 4033.0 4033.7 4034.4 4065.0 4075.6 4099.8 4123.8 4130.1 4137.6 4157.6 4491.0 4680.9 4697.0 4730.0 4740.4 5494.4 5515.5 5558.5 5596.1 5658.5 1425.4 1439.1 1443.8 1445.9 1450.3 917.8 921.5 926.4 929.7 936.4 4855.5 4862.2 4867.0 4909.9 4911.2 5145.3 5148.7 5157.7 5196.8 5201.1 4681.7 4824.8 4854.7 5135.4 5153.2 3019.9 3032.7 3056.4 3058.5 3062.3 5838.7 5851.4 5866.4 5876.0 5877.9 5653.0 5854.9 5872.9 5907.3 5949.6 5898.3 5915.1 5921.6 5933.3 5938.6 5693.1 5794.8 5795.4 5815.3 5825.0 5694.2 5702.7 5714.5 5735.3 5761.9 5613.2 5728.5 5741.4 5879.9 5911.5 3662.2 3836.2 4019.3 4083.9 4140.3 5569.6 5695.7 5730.5 5735.9 5738.6 5431.3 5596.3 5596.8 5640.7 5678.3 5628.2 5637.8 5638.4 5657.3 5660.1 5289.5 5539.6 5541.6 5564.3 5573.2 5488.3 5564.7 5665.2 5681.6 5718.7 5432.2 5445.0 5464.6 5503.4 5518.4 23:25:05 INFO - PROCESS | 15504 | 23:25:05 INFO - PROCESS | 15504 | [#5] yui.html Cycles:180 Average:19851.93 Median:4651.54 stddev:28519.64 (613.1%) stddev-sans-first:28563.33 23:25:05 INFO - PROCESS | 15504 | Values: 684.2 716.5 753.2 763.3 839.5 13923.5 14034.9 14148.0 14416.1 14429.6 13779.4 13856.5 13891.7 13920.7 13940.4 652.5 785.3 789.3 793.2 804.6 796.0 797.9 798.6 799.1 799.8 842.3 849.3 849.4 849.8 850.5 694.4 710.9 808.2 828.3 843.2 602.8 603.0 603.2 603.2 604.0 13525.6 13584.7 13620.7 13626.2 13738.1 13837.0 14201.6 14485.2 14512.9 14666.2 12890.5 13024.1 13064.9 13318.8 13367.4 4460.6 4501.3 4572.5 4603.7 4673.1 72900.6 73137.0 73437.0 77362.0 77683.2 11503.9 11728.1 11900.0 11910.5 12026.8 21280.9 21305.6 21351.9 21364.9 21373.4 7867.7 8035.8 8079.0 8134.3 8323.6 4536.3 4544.1 4604.3 4607.5 4630.0 3333.7 3446.6 3467.7 3560.7 3569.2 636.7 640.0 640.5 643.5 645.5 551.9 637.9 674.9 686.6 694.5 8755.2 9002.8 9414.9 10172.9 10198.8 646.1 721.1 721.7 746.6 751.7 4415.3 4440.0 4512.6 4605.3 4723.7 106843.0 107922.5 110516.0 111201.4 111387.0 97635.5 98559.0 98929.5 99306.0 99387.0 55985.4 57950.7 71860.3 78767.2 79145.6 8507.6 8536.2 8560.1 8636.7 8730.8 49655.0 49803.5 49821.0 50223.5 51581.7 66051.0 74707.3 77845.6 78252.6 78765.0 11855.1 11946.8 12321.6 12335.1 12344.1 13746.2 13932.2 14144.9 14439.4 14782.0 12511.9 12631.3 12872.8 12951.4 13135.8 12437.5 12678.2 12701.6 12812.9 12917.4 12798.3 12831.0 12903.0 13601.7 13793.2 9540.5 9618.4 9761.4 9947.2 10032.2 10034.3 10250.3 10283.3 10365.5 10396.9 23:25:05 INFO - PROCESS | 15504 | -------- Summary: end -------- 23:25:05 INFO - PROCESS | 15504 | 23:25:06 INFO - TEST-INFO | 15504: exit 0 23:25:06 INFO - TEST-OK | dromaeo_css | took 1114638ms 23:25:06 INFO - TEST-START | kraken 23:25:06 INFO - operating with platform_type : linux_ 23:25:06 INFO - Initialising browser for kraken test... 23:25:06 INFO - TEST-INFO | started process 15687 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfT3LSV/profile http://localhost:45907/getInfo.html) 23:25:10 INFO - PROCESS | 15687 | __metrics Screen width/height:1600/1200 23:25:10 INFO - PROCESS | 15687 | colorDepth:24 23:25:10 INFO - PROCESS | 15687 | Browser inner width/height: 1024/697 23:25:10 INFO - PROCESS | 15687 | __metrics 23:25:11 INFO - PROCESS | 15687 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:25:12 INFO - TEST-INFO | 15687: exit 0 23:25:12 INFO - Browser initialized. 23:25:12 INFO - Running cycle 1/1 for kraken test... 23:25:12 INFO - TEST-INFO | started process 15769 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfT3LSV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:25:24 INFO - PROCESS | 15769 | RSS: Main: 174571520 23:25:24 INFO - PROCESS | 15769 | 23:25:27 INFO - PROCESS | 15769 | Cycle 1(1): loaded http://localhost:45907/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45907/tests/kraken/driver.html?testName=audio-beat-detection) 23:25:28 INFO - PROCESS | 15769 | RSS: Main: 232751104 23:25:28 INFO - PROCESS | 15769 | 23:25:30 INFO - PROCESS | 15769 | Cycle 1(1): loaded http://localhost:45907/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45907/tests/kraken/driver.html?testName=audio-dft) 23:25:31 INFO - PROCESS | 15769 | RSS: Main: 222048256 23:25:31 INFO - PROCESS | 15769 | 23:25:34 INFO - PROCESS | 15769 | Cycle 1(1): loaded http://localhost:45907/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45907/tests/kraken/driver.html?testName=audio-fft) 23:25:35 INFO - PROCESS | 15769 | RSS: Main: 287846400 23:25:35 INFO - PROCESS | 15769 | 23:25:37 INFO - PROCESS | 15769 | Cycle 1(1): loaded http://localhost:45907/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45907/tests/kraken/driver.html?testName=audio-oscillator) 23:25:37 INFO - PROCESS | 15769 | RSS: Main: 197992448 23:25:37 INFO - PROCESS | 15769 | 23:25:40 INFO - PROCESS | 15769 | Cycle 1(1): loaded http://localhost:45907/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45907/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:25:40 INFO - PROCESS | 15769 | RSS: Main: 202129408 23:25:40 INFO - PROCESS | 15769 | 23:25:43 INFO - PROCESS | 15769 | Cycle 1(1): loaded http://localhost:45907/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45907/tests/kraken/driver.html?testName=imaging-darkroom) 23:25:44 INFO - PROCESS | 15769 | RSS: Main: 238235648 23:25:44 INFO - PROCESS | 15769 | 23:25:47 INFO - PROCESS | 15769 | Cycle 1(1): loaded http://localhost:45907/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45907/tests/kraken/driver.html?testName=imaging-desaturate) 23:25:48 INFO - PROCESS | 15769 | RSS: Main: 239378432 23:25:48 INFO - PROCESS | 15769 | 23:25:51 INFO - PROCESS | 15769 | Cycle 1(1): loaded http://localhost:45907/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45907/tests/kraken/driver.html?testName=json-parse-financial) 23:25:51 INFO - PROCESS | 15769 | RSS: Main: 238972928 23:25:51 INFO - PROCESS | 15769 | 23:25:53 INFO - PROCESS | 15769 | Cycle 1(1): loaded http://localhost:45907/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45907/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:25:53 INFO - PROCESS | 15769 | RSS: Main: 230408192 23:25:53 INFO - PROCESS | 15769 | 23:25:55 INFO - PROCESS | 15769 | Cycle 1(1): loaded http://localhost:45907/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45907/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:25:56 INFO - PROCESS | 15769 | RSS: Main: 230191104 23:25:56 INFO - PROCESS | 15769 | 23:25:58 INFO - PROCESS | 15769 | Cycle 1(1): loaded http://localhost:45907/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45907/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:25:58 INFO - PROCESS | 15769 | RSS: Main: 237531136 23:25:58 INFO - PROCESS | 15769 | 23:26:01 INFO - PROCESS | 15769 | Cycle 1(1): loaded http://localhost:45907/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45907/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:26:02 INFO - PROCESS | 15769 | RSS: Main: 239849472 23:26:02 INFO - PROCESS | 15769 | 23:26:04 INFO - PROCESS | 15769 | Cycle 1(1): loaded http://localhost:45907/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45907/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:26:05 INFO - PROCESS | 15769 | RSS: Main: 239448064 23:26:05 INFO - PROCESS | 15769 | 23:26:07 INFO - PROCESS | 15769 | Cycle 1(1): loaded http://localhost:45907/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45907/tests/kraken/driver.html?testName=ai-astar) 23:26:07 INFO - PROCESS | 15769 | RSS: Main: 282292224 23:26:07 INFO - PROCESS | 15769 | 23:26:07 INFO - PROCESS | 15769 | __start_tp_report 23:26:07 INFO - PROCESS | 15769 | _x_x_mozilla_page_load 23:26:07 INFO - PROCESS | 15769 | _x_x_mozilla_page_load_details 23:26:07 INFO - PROCESS | 15769 | |i|pagename|runs| 23:26:07 INFO - PROCESS | 15769 | |0;ai-astar;110;107;109;111;112;112;109;111;112;111 23:26:07 INFO - PROCESS | 15769 | |1;audio-beat-detection;156;125;128;201;126;131;161;125;156;125 23:26:07 INFO - PROCESS | 15769 | |2;audio-dft;162;163;162;162;160;161;161;161;161;160 23:26:07 INFO - PROCESS | 15769 | |3;audio-fft;75;74;75;127;77;75;83;75;98;74 23:26:07 INFO - PROCESS | 15769 | |4;audio-oscillator;86;86;117;85;86;86;120;86;92;126 23:26:07 INFO - PROCESS | 15769 | |5;imaging-gaussian-blur;117;117;117;116;117;116;117;118;118;118 23:26:07 INFO - PROCESS | 15769 | |6;imaging-darkroom;147;148;147;145;146;145;146;145;146;145 23:26:07 INFO - PROCESS | 15769 | |7;imaging-desaturate;95;94;95;95;94;94;95;96;94;94 23:26:07 INFO - PROCESS | 15769 | |8;json-parse-financial;54;54;55;55;55;55;55;55;54;55 23:26:07 INFO - PROCESS | 15769 | |9;json-stringify-tinderbox;62;62;62;63;62;62;63;62;62;62 23:26:07 INFO - PROCESS | 15769 | |10;stanford-crypto-aes;80;79;79;79;78;80;79;84;110;80 23:26:07 INFO - PROCESS | 15769 | |11;stanford-crypto-ccm;133;122;137;123;131;132;124;122;140;129 23:26:07 INFO - PROCESS | 15769 | |12;stanford-crypto-pbkdf2;169;159;160;162;158;166;157;159;164;159 23:26:07 INFO - PROCESS | 15769 | |13;stanford-crypto-sha256-iterative;64;63;63;63;62;63;63;63;62;62 23:26:07 INFO - PROCESS | 15769 | __end_tp_report 23:26:07 INFO - PROCESS | 15769 | __start_cc_report 23:26:07 INFO - PROCESS | 15769 | _x_x_mozilla_cycle_collect,1661 23:26:07 INFO - PROCESS | 15769 | __end_cc_report 23:26:07 INFO - PROCESS | 15769 | __startTimestamp1466490367381__endTimestamp 23:26:07 INFO - PROCESS | 15769 | 23:26:07 INFO - PROCESS | 15769 | ------- Summary: start ------- 23:26:07 INFO - PROCESS | 15769 | Number of tests: 14 23:26:07 INFO - PROCESS | 15769 | 23:26:07 INFO - PROCESS | 15769 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:1.65 (1.5%) stddev-sans-first:1.74 23:26:07 INFO - PROCESS | 15769 | Values: 110.0 107.0 109.0 111.0 112.0 112.0 109.0 111.0 112.0 111.0 23:26:07 INFO - PROCESS | 15769 | 23:26:07 INFO - PROCESS | 15769 | [#1] audio-beat-detection Cycles:10 Average:143.40 Median:143.50 stddev:25.07 (17.5%) stddev-sans-first:26.17 23:26:07 INFO - PROCESS | 15769 | Values: 156.0 125.0 128.0 201.0 126.0 131.0 161.0 125.0 156.0 125.0 23:26:07 INFO - PROCESS | 15769 | 23:26:07 INFO - PROCESS | 15769 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.95 (0.6%) stddev-sans-first:0.97 23:26:07 INFO - PROCESS | 15769 | Values: 162.0 163.0 162.0 162.0 160.0 161.0 161.0 161.0 161.0 160.0 23:26:07 INFO - PROCESS | 15769 | 23:26:07 INFO - PROCESS | 15769 | [#3] audio-fft Cycles:10 Average:83.30 Median:75.00 stddev:17.04 (22.7%) stddev-sans-first:17.81 23:26:07 INFO - PROCESS | 15769 | Values: 75.0 74.0 75.0 127.0 77.0 75.0 83.0 75.0 98.0 74.0 23:26:07 INFO - PROCESS | 15769 | 23:26:07 INFO - PROCESS | 15769 | [#4] audio-oscillator Cycles:10 Average:97.00 Median:86.00 stddev:16.81 (19.5%) stddev-sans-first:17.35 23:26:07 INFO - PROCESS | 15769 | Values: 86.0 86.0 117.0 85.0 86.0 86.0 120.0 86.0 92.0 126.0 23:26:07 INFO - PROCESS | 15769 | 23:26:07 INFO - PROCESS | 15769 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 23:26:07 INFO - PROCESS | 15769 | Values: 117.0 117.0 117.0 116.0 117.0 116.0 117.0 118.0 118.0 118.0 23:26:07 INFO - PROCESS | 15769 | 23:26:07 INFO - PROCESS | 15769 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:1.05 (0.7%) stddev-sans-first:1.05 23:26:07 INFO - PROCESS | 15769 | Values: 147.0 148.0 147.0 145.0 146.0 145.0 146.0 145.0 146.0 145.0 23:26:07 INFO - PROCESS | 15769 | 23:26:07 INFO - PROCESS | 15769 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 23:26:07 INFO - PROCESS | 15769 | Values: 95.0 94.0 95.0 95.0 94.0 94.0 95.0 96.0 94.0 94.0 23:26:07 INFO - PROCESS | 15769 | 23:26:07 INFO - PROCESS | 15769 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:0.48 (0.9%) stddev-sans-first:0.44 23:26:07 INFO - PROCESS | 15769 | Values: 54.0 54.0 55.0 55.0 55.0 55.0 55.0 55.0 54.0 55.0 23:26:07 INFO - PROCESS | 15769 | 23:26:07 INFO - PROCESS | 15769 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 23:26:07 INFO - PROCESS | 15769 | Values: 62.0 62.0 62.0 63.0 62.0 62.0 63.0 62.0 62.0 62.0 23:26:07 INFO - PROCESS | 15769 | 23:26:07 INFO - PROCESS | 15769 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:79.50 stddev:9.69 (12.2%) stddev-sans-first:10.23 23:26:07 INFO - PROCESS | 15769 | Values: 80.0 79.0 79.0 79.0 78.0 80.0 79.0 84.0 110.0 80.0 23:26:07 INFO - PROCESS | 15769 | 23:26:07 INFO - PROCESS | 15769 | [#11] stanford-crypto-ccm Cycles:10 Average:129.30 Median:131.50 stddev:6.43 (4.9%) stddev-sans-first:6.68 23:26:07 INFO - PROCESS | 15769 | Values: 133.0 122.0 137.0 123.0 131.0 132.0 124.0 122.0 140.0 129.0 23:26:07 INFO - PROCESS | 15769 | 23:26:07 INFO - PROCESS | 15769 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.30 Median:161.00 stddev:3.89 (2.4%) stddev-sans-first:2.96 23:26:07 INFO - PROCESS | 15769 | Values: 169.0 159.0 160.0 162.0 158.0 166.0 157.0 159.0 164.0 159.0 23:26:07 INFO - PROCESS | 15769 | 23:26:07 INFO - PROCESS | 15769 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:63.00 stddev:0.63 (1.0%) stddev-sans-first:0.50 23:26:07 INFO - PROCESS | 15769 | Values: 64.0 63.0 63.0 63.0 62.0 63.0 63.0 63.0 62.0 62.0 23:26:07 INFO - PROCESS | 15769 | -------- Summary: end -------- 23:26:07 INFO - PROCESS | 15769 | 23:26:08 INFO - TEST-INFO | 15769: exit 0 23:26:08 INFO - TEST-OK | kraken | took 61691ms 23:26:08 INFO - SUITE-END | took 1176s 23:26:08 INFO - Completed test suite (00:19:36) 23:26:08 INFO - javascript benchmark 23:26:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3101.875924963, 3113.7664675149367, 3121.859516321766, 3135.529670549419, 3161.66802485739, 5274.393444753854, 5360.839174824751, 5418.458154184579, 5427.9185812212845, 5518.310211223602, 5355.6251062425545, 5364.088105022146, 5404.729763511818, 5408.756605952732, 5459.808906688267, 4845.927311090337, 4963.0, 4966.15575352191, 4979.950200498003, 5134.691918484884, 5053.696778193302, 5060.0, 5090.490950904898, 5105.106606343875, 5116.283720279164, 4799.544043315879, 4827.03459308138, 4873.926891096637, 4958.181899986498, 5050.318207042076, 4864.0515099555605, 4960.826371077031, 4961.652684312099, 4973.229149481836, 4991.251312303148, 4835.46204366135, 4877.073356062337, 4882.487338829407, 4915.655904086715, 4916.918277978874, 5272.235525848769, 5447.645903016291, 5511.807086751985, 5519.0, 5533.529649979757, 5872.647641141545, 5873.060310350366, 5892.793752218652, 5902.704864756745, 5923.437273459014, 5574.804881829116, 5913.9112913306335, 5951.345352011275, 5958.910616340759, 5968.045112781934, 5312.4687531246955, 5416.0, 5424.891502169974, 5433.429489903582, 5476.808311709071, 5925.940740592625, 5937.406259374028, 5975.043992961106, 5995.040793473024, 6004.3395226525045, 5605.747741351567, 5702.7433765480655, 5781.595288329777, 5822.068469045017, 5854.326752423441, 5845.853853653608, 5900.085486749561, 5943.970280148572, 5947.256592925884, 5948.434898684618, 5816.651000939957, 5834.212381328466, 5837.211976383134, 5841.853953651193, 5845.912311315334, 5634.0, 5797.130430435468, 5844.1233814927255, 5872.207252021008, 5872.442117998783, 4486.080353527519, 4487.147441986012, 4494.483134439516, 4523.660725445605, 4526.683132180781, 3984.2230765000545, 3991.720579559461, 3992.5608183099835, 4002.7398219115667, 4030.3954406839207, 5374.623776335698, 5424.186372044225, 5430.104032834538, 5498.862528436821, 5560.555155587544, 5881.2942446906645, 5887.911681324784, 5889.469947704727, 5915.733791979371, 5918.319393269743, 5531.1426728857095, 5536.723163841792, 5547.334319881559, 5564.165375193753, 5568.49883510486, 4813.4945830687975, 4897.657163998557, 4929.605631549467, 4936.851894443173, 4939.506049395031, 6066.0, 6075.544334174954, 6087.573869829158, 6111.236095488064, 6118.326984031664, 5885.0, 5906.7341969612335, 5909.940900590939, 5912.763489460373, 5914.615549989237, 5799.565032622654, 5911.231539899785, 5913.91129133072, 5926.911096333644, 6018.157457955977, 5703.372629010889, 5754.395788442321, 5755.769769209185, 5761.683107429131, 5763.452472015152, 5687.7724891005555, 5845.883082338244, 5853.473187413153, 5856.385079566584, 5858.209141765978, 5657.2928383952, 5723.6851973141875, 5725.19847221381, 5746.511546518425, 5749.8275051748515, 5628.690422026828, 5698.8290351289525, 5700.287464066992, 5705.600607957404, 5705.885882282248, 5529.834104976857, 5610.13042978339, 5655.264815573949, 5657.660540367427, 5666.575006874418, 5750.453706897838, 5848.0350742127075, 5853.590248682552, 5853.64878107315, 5867.471927526372, 5594.748236329294, 5612.915806262828, 5633.2113504110275, 5641.661500309994, 5655.886882262414], "value": 5379.137030080339, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.9443352881477, 606.4572207873953, 609.871926895352, 621.6301300726068, 622.9439350458459, 32200.516992245106, 35226.0, 35258.47112293317, 43523.0, 43814.34278485825, 44941.55058449414, 45493.54506454935, 45510.54489455104, 45541.54458455415, 45621.54378456214, 8885.955570222171, 9006.86489702655, 9032.8645070324, 9039.457632542035, 9042.005379408292, 8749.693760718375, 8897.866532002025, 8898.28813694906, 8898.688545900895, 8901.910980890205, 8916.55417229136, 8932.955335223314, 8952.910470895305, 8957.19385255327, 8961.910380896174, 8796.604152813139, 8852.734417967438, 8890.199882010651, 8897.599608017623, 8899.021107678183, 8779.561021948877, 8828.646854125827, 8855.291576673915, 8871.822563548692, 8873.334499912467, 41936.16127677429, 42196.36705449421, 42283.788581057204, 42349.36475952863, 42363.57636423627, 3511.20997775501, 3680.871169509054, 3704.0924973381425, 3709.536307961505, 3998.5601583825755, 31110.37779244425, 33390.33219335624, 33759.1432471214, 33981.15047123842, 34076.318473630636, 4373.322135069069, 4376.781160941972, 4476.7761611919595, 4480.126375356806, 4651.790669419885, 334073.0, 335345.0, 339911.0, 342537.0, 343002.0, 62904.68547657324, 63544.0, 63989.0, 64034.35965640284, 64109.679451602446, 36692.266154676756, 37296.62703372932, 37316.25367492635, 38671.80664096661, 67779.66110169418, 17702.114894255235, 17730.290788368322, 17824.732629010574, 17863.642727145383, 17871.0, 13338.733225335633, 13391.196528208338, 13397.0, 13418.731625367438, 13429.26139062361, 20659.380218593466, 20716.06777694977, 20825.0, 20849.79150208509, 20880.89559552223, 7430.145533263636, 7469.887951680729, 7567.545947243183, 7620.771376858592, 7876.09424916142, 951.70497145885, 1009.6264382178641, 1094.874089479704, 1114.5486078138367, 1118.8183043065892, 32055.51916721251, 32483.837580811945, 32528.34943301168, 32530.0, 33054.669453305156, 1086.766345235778, 1098.8626421697288, 1114.7046032801313, 1121.7307846116873, 1152.2107356460851, 15672.138032408327, 16265.51203463898, 16315.918420407823, 16385.59036024085, 16538.421155259508, 531248.0, 540989.0, 541733.0, 541811.0, 543883.0, 59296.0, 60603.0, 60607.0, 60665.696671517246, 60798.0, 1207.3540655749307, 1210.1649861595472, 1240.8759124087699, 1359.6736783171968, 1376.779715245576, 22751.772482274966, 32173.839130804197, 33431.49852752259, 33494.497582536766, 33854.3229135411, 51349.22976155286, 51421.22868157055, 52004.739976299876, 52010.739946300026, 52049.0, 416035.0, 416117.0, 417437.0, 417655.0, 418456.0, 22980.310590682308, 28304.716952831033, 28462.715372846007, 28941.710582894742, 29393.11820645384, 46882.53117468918, 47057.76471117623, 48815.5118448811, 48842.26736599025, 51356.0, 40730.38904416496, 43146.4898728543, 44600.776996114815, 44713.55286447094, 45748.31377529273, 42884.52942637199, 43481.56518434775, 43573.12853742971, 44402.77798610986, 44808.551914481744, 38534.42198367083, 43781.78109109434, 43973.0, 44406.0, 44552.0, 35587.288254234256, 38733.612663874126, 39320.05099617483, 40067.39898901577, 40305.395419069326, 28719.71280287254, 29282.0, 29336.413271734873, 29340.7065929338, 29440.852795735886], "value": 20249.91420524449, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.98460061597535, 387.9437481565174, 401.80311647292837, 406.48782534007154, 411.7118017387829, 14605.707885842277, 17996.190171442282, 18423.539411514717, 20198.89900550497, 20258.594828103447, 19142.904285478555, 19581.70627440586, 19860.20559177631, 19988.60022799543, 20045.599088018233, 5595.552355811536, 5791.739371728261, 5802.854928626776, 5819.476247137757, 5839.211706419643, 4166.500019997605, 5752.5110365618975, 5813.709314534278, 6187.381261873822, 6496.187976502937, 6552.246491653474, 6554.442872355856, 6593.604383736991, 6622.867542649168, 6625.536212465129, 6297.149884765544, 6446.548741588091, 6459.289478157399, 6466.838329041764, 6471.061696054069, 5655.519280861132, 5702.54379649627, 5706.1440783882335, 5709.086546152637, 5740.913886291709, 23487.882560587088, 23721.7627823723, 23965.16121935724, 24007.879960600087, 24067.87966060176, 2283.178055899875, 2312.364099872532, 2388.2238272561485, 2417.7703118203744, 2939.1770304314614, 14397.424103035866, 14526.564203073925, 14733.0, 14761.335739891623, 15090.54728358151, 1887.7545919030576, 1902.0965041605266, 1914.100372824784, 1927.2483731344787, 1976.1996391461337, 70617.64691176562, 72618.63690681565, 73693.0, 76595.6170219151, 84880.15119848785, 10843.512041957973, 10968.23222374426, 11123.919020743817, 11145.387003714712, 11173.888261117447, 15493.302801373966, 15575.454859079879, 15638.139902305255, 15672.216389180496, 15684.0, 8167.714130005421, 8234.300084492885, 8378.8324233515, 8444.451110677786, 8582.227599516074, 7973.681052757825, 8059.879101813477, 8069.959650201711, 8232.135625759209, 8295.668173273121, 4748.622899359216, 4767.332573439652, 4788.760561971888, 4853.563179313879, 4936.086823937583, 1924.6535623587888, 1930.571377180876, 1978.574606459618, 2009.7186393904865, 2017.878927264369, 888.6090120347027, 961.8749562556823, 979.5004547680734, 1008.9747756306151, 1030.9175265978704, 19270.61458770817, 19698.40904772859, 19971.101300441514, 19995.60008799816, 20519.281825136048, 969.0, 996.0836030851634, 996.3523709588825, 1038.6053299746047, 1048.2871647279924, 10620.468976551141, 11157.330560166416, 11190.328580285046, 11191.608293709682, 11381.829272560919, 479720.0, 488695.0, 493123.0, 499361.0, 507231.0, 88889.0, 91517.0, 92281.0, 93365.5331723337, 93803.53098234601, 921.9308551858503, 926.2543652359915, 946.7585765629858, 948.2414068744977, 948.4250260542523, 17630.3554466831, 17678.292868285123, 17842.19710113022, 17936.372226971995, 18332.541686457946, 37187.81406092952, 38635.2272954545, 40347.59652403439, 41514.58485415107, 43474.782626086664, 54700.452995471125, 57226.0, 58105.709471454065, 58132.4186758127, 58212.70893645505, 8552.871706924278, 8795.296376289754, 8882.955585222291, 8898.110188981309, 9068.863967040632, 9716.805663886824, 13519.121257118255, 13580.25308608036, 13903.652408689864, 14248.073875198079, 11246.493907774005, 11367.943160284145, 11740.471678774305, 11897.94051029774, 12012.75974480523, 11301.0, 11366.659000230007, 11637.825432618349, 11793.11551633648, 12068.275903445821, 11069.944650276697, 11450.0, 11851.111166662362, 11959.402029898645, 12203.75592488163, 8660.181361914068, 8839.381243312906, 8876.112388761072, 8879.591582617357, 8954.0, 9204.447733136034, 10795.244332896622, 10920.50857711389, 11441.542338306708, 11804.763904721685], "value": 9398.132667371869, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1336.124838230958, 1460.2844606142994, 1499.6850661361113, 1628.1289510112085, 1777.4578753480191, 8536.31709463243, 8879.91120088799, 8883.600237989282, 9181.173694367506, 9195.40229885057, 8919.509426981513, 9131.086891310866, 9133.725988220347, 9161.679341223058, 9164.908350916488, 2181.8472706910484, 2201.8678879267213, 2204.0, 2204.3166618348364, 2206.2829580386438, 2289.1873384948353, 2322.105989194164, 2350.2596682045187, 2354.505553833697, 2357.5874222011166, 2315.305408377488, 2317.2237300504353, 2340.543593999162, 2357.7760112789256, 2359.587072262347, 2264.07173059045, 2276.886155692217, 2292.6790249365104, 2297.035245197021, 2298.8160947124275, 2218.4453886528368, 2245.292732789166, 2245.887705614729, 2251.8423710340285, 2270.012544543129, 9046.32152588552, 9076.954615226881, 9116.954415227949, 9139.908600913972, 9250.35247532673, 5350.143976963706, 5454.754536045887, 5457.126859702468, 5458.153986132116, 5461.399246082928, 3392.23674673199, 3414.4195486767308, 3499.0, 3549.0417587251554, 3563.6436356364416, 1140.8060629692973, 1167.334619267018, 1181.2676140792678, 1182.2020136407891, 1186.2763714134458, 12652.620421387373, 12820.743585128339, 12832.486700531968, 12847.164934279335, 12848.935755321163, 4554.157480866051, 4659.697119687209, 4711.764411779397, 4723.0, 4737.95262047382, 9903.554340054714, 9968.202543796478, 10005.749856253506, 10010.899891001143, 10021.699349019542, 5084.745762711849, 5170.121079416433, 5186.118359878829, 5306.8142615009065, 5307.522322990872, 4280.935785963213, 4365.454318210223, 4904.068227036852, 4923.310736496894, 4965.230389289666, 3682.779033258013, 3709.703223742094, 3749.043993781568, 3790.1093243087853, 3805.0867791729784, 1075.9031687148195, 1077.665923563682, 1087.5486673030762, 1106.1095817866694, 1108.9279196852178, 976.2434113562047, 985.6845809340942, 1004.2618675273668, 1012.7012531303283, 1014.9188064954786, 6007.128966299862, 6123.969380153071, 6233.532485063638, 6288.52836037299, 6320.178376810985, 432.7014360091527, 433.0948318015363, 443.62292051756395, 445.6323533085218, 453.5238000099948, 4066.898327541835, 4069.5726948670554, 4099.1596722672375, 4104.712670113064, 4122.855700050483, 10717.83923241152, 11414.315141091562, 11419.657410277705, 11435.485403156878, 11460.484278207501, 11078.778424431466, 11172.329660220414, 11236.325820450798, 11322.377269250106, 11495.252808567417, 8331.416800823885, 8337.416380853281, 8366.623501942428, 8445.873311900326, 8449.53527555978, 5934.465898069195, 6032.155498230163, 6063.575549711478, 6178.104174894705, 6186.659733714689, 10260.486975651336, 10477.895221047693, 10646.627368042082, 10664.520096595827, 10823.67528974132, 10660.946695266473, 10833.729156771144, 10891.67324980252, 10946.781064378827, 10986.615468458565, 7659.846803064019, 7691.9615401924875, 7763.262490063435, 7765.0681918170185, 7769.572673502786, 8701.47791132534, 8723.476591404537, 8784.0, 8834.0, 8907.287417006753, 7458.552486850806, 7659.502132361378, 7807.063152421746, 7808.88286675689, 7808.9609551954145, 7633.732819351296, 7642.65608047628, 7668.271514206142, 7679.692812287446, 7920.683172673029, 7120.1099862517185, 7197.280271972761, 7209.819754506179, 7216.96391518039, 7218.205997340393, 5119.334486516729, 5263.605229607718, 5282.709450980233, 5398.13629819227, 5496.697681627549, 5399.379071406838, 5454.181872719124, 5460.836174914759, 5521.978433989725, 5658.717064146858], "value": 4588.761458294539, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.2957730318132, 321.0592962619524, 324.11516559791784, 336.40792205717935, 339.8750137046376, 5342.759575819087, 5350.277712508815, 5374.677519348842, 5410.513053825155, 5411.215373770801, 5246.449122842104, 5271.762770675319, 5289.576833853293, 5312.760925758341, 5320.255164276995, 3936.8031598420107, 4121.7634709587155, 4178.310578754517, 4197.748135111888, 4216.093539888923, 4113.9177216455655, 4121.856634550032, 4138.441310423084, 4160.646345060658, 4173.770442625654, 4096.75419474831, 4097.774622395767, 4101.487314085739, 4109.534279432347, 4120.526139493966, 3910.3938889472033, 3952.6245006724316, 4058.5738497457933, 4066.674666026711, 4112.444819949314, 3581.033121057326, 3587.910302242439, 3591.3356029134693, 3591.44332628443, 3593.5328407306883, 5099.69401835891, 5114.744262786883, 5120.743962801882, 5132.127538318495, 5135.0, 4431.756253406062, 4534.274516077445, 4704.811807527695, 4706.176419126673, 4739.691920025221, 5524.475174858382, 5534.1975413565215, 5538.695371754552, 5541.307336582927, 5558.221848941152, 3972.900677483086, 3991.1618560102415, 3998.4801975742967, 4004.739691920045, 4032.0927791247027, 5523.536262890338, 5714.428532153691, 5753.165790960329, 5766.740496677659, 5777.393373695743, 4033.0, 4033.737807042533, 4034.374671925856, 4064.9593504065174, 4075.633193012584, 4099.815508302134, 4123.773192474443, 4130.132672138884, 4137.586241375899, 4157.646600039031, 4490.956614740286, 4680.882977925511, 4697.0, 4730.030343779517, 4740.3837501124635, 5494.423085575957, 5515.531179849678, 5558.527525160326, 5596.104623260258, 5658.490735833795, 1425.4298280687808, 1439.1365180891592, 1443.81952255968, 1445.8771004464527, 1450.2531196433845, 917.7567944494714, 921.4609453469795, 926.420986883198, 929.707142250189, 936.4334577580602, 4855.465898751135, 4862.17343051682, 4867.028853314413, 4909.926351104737, 4911.165101932608, 5145.331106956147, 5148.716820574904, 5157.716325602128, 5196.818111366084, 5201.115810312256, 4681.742504162304, 4824.778318970901, 4854.68444551103, 5135.4094279157625, 5153.201253805666, 3019.8977373258604, 3032.7118923702656, 3056.43455960648, 3058.510638297906, 3062.3262882165886, 5838.737256823453, 5851.38560451155, 5866.354700982888, 5876.0, 5877.9118313225335, 5652.97173514138, 5854.882902341929, 5872.882542349129, 5907.291125064934, 5949.553783466171, 5898.316266098915, 5915.053591425437, 5921.615095018982, 5933.317668468181, 5938.61399009063, 5693.1460280956535, 5794.82615521535, 5795.420457954339, 5815.331236907809, 5825.0, 5694.231278777478, 5702.714864256687, 5714.485696287354, 5735.272073152484, 5761.884762304814, 5613.214150019082, 5728.4819522825655, 5741.411617738913, 5879.941200587939, 5911.497522710618, 3662.1943172502006, 3836.2327534492656, 4019.256437559061, 4083.89790255246, 4140.267423500595, 5569.579757161898, 5695.686737229492, 5730.512906402836, 5735.9139612905, 5738.598298119092, 5431.293931788842, 5596.328440586993, 5596.776128954796, 5640.661560306395, 5678.346990096192, 5628.240187574625, 5637.774489020393, 5638.407967163389, 5657.349404818334, 5660.094384898561, 5289.497497737709, 5539.612227144061, 5541.5843811715085, 5564.304461942257, 5573.21974923503, 5488.298627425511, 5564.693941833238, 5665.235193248858, 5681.630694004876, 5718.685472298897, 5432.158015507603, 5445.0, 5464.590155738256, 5503.422140675331, 5518.420565840529], "value": 4206.565508023774, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [684.1721516964476, 716.5270921192015, 753.2016062973246, 763.3015790551646, 839.4543546694648, 13923.512677056306, 14034.929825350859, 14148.0, 14416.062955907884, 14429.63925901853, 13779.44882204713, 13856.515021974208, 13891.652708682263, 13920.651983700413, 13940.442382304696, 652.5106170372221, 785.2540086917451, 789.3014682006437, 793.167174466809, 804.5534728225832, 796.0328201235498, 797.8563858505466, 798.648594618366, 799.0810567846993, 799.7640695994695, 842.2546046748611, 849.3417601358965, 849.430881309521, 849.7535714642746, 850.4557083466556, 694.4305669351135, 710.9182444018952, 808.1595141053298, 828.2628460670009, 843.1905370843997, 602.7709470401263, 602.9698515074273, 603.1616053685381, 603.1736520966305, 604.0154548086634, 13525.59423217305, 13584.660383490493, 13620.727585448236, 13626.18242905419, 13738.10702304357, 13837.0, 14201.573952781433, 14485.203313817736, 14512.927435362755, 14666.19335936523, 12890.484380624765, 13024.088313818036, 13064.86935130646, 13318.800217996737, 13367.398467069006, 4460.576245256695, 4501.257292546726, 4572.468223145251, 4603.746793926332, 4673.135469938073, 72900.63549682271, 73136.99999999946, 73437.0, 77362.0, 77683.22316776817, 11503.942480287713, 11728.12039097054, 11900.0, 11910.46402911871, 12026.819597706042, 21280.893595531925, 21305.573888522144, 21351.89324053401, 21364.893175534024, 21373.358799236048, 7867.685292588347, 8035.758927232192, 8079.030516338077, 8134.267915887599, 8323.625436855356, 4536.251518499476, 4544.113897789899, 4604.286335617918, 4607.470140933769, 4629.953700463019, 3333.7333013358875, 3446.5691788526433, 3467.7225821934185, 3560.661737134968, 3569.23261498779, 636.7293900092442, 639.9648019358887, 640.4908098062052, 643.5366536094004, 645.493287769099, 551.9337679478489, 637.9266384365858, 674.8515326628134, 686.5571706249441, 694.5207806613421, 8755.168259015383, 9002.819943601091, 9414.858777118348, 10172.931842156615, 10198.847017294747, 646.1019183335168, 721.1310371002929, 721.6716394040699, 746.555799299416, 751.7218629107265, 4415.337699345124, 4439.955600443955, 4512.616427603691, 4605.263157894721, 4723.669343145947, 106843.0, 107922.46038769756, 110516.0, 111201.44399278113, 111387.0, 97635.51182244043, 98559.0, 98929.50535247277, 99306.0, 99387.0, 55985.440145598026, 57950.7102464485, 71860.28139718641, 78767.21232787713, 79145.60427197827, 8507.617157227816, 8536.189062039097, 8560.14398560139, 8636.697715579925, 8730.781730456789, 49655.0, 49803.501964979885, 49821.0, 50223.49776502188, 51581.74209128931, 66051.0, 74707.2529274722, 77845.61077194805, 78252.60873695595, 78765.0, 11855.110866685205, 11946.820797687868, 12321.568745093879, 12335.136540442083, 12344.135910486539, 13746.175229486264, 13932.164070155823, 14144.858551414765, 14439.350229239919, 14782.03916745408, 12511.93744031274, 12631.305278209788, 12872.806907896576, 12951.41718622683, 13135.802962955755, 12437.502499899903, 12678.175918565265, 12701.55544555973, 12812.935935320264, 12917.354132293536, 12798.296093714935, 12831.0, 12903.0, 13601.659958501117, 13793.24137172425, 9540.522973851419, 9618.374805637612, 9761.365511241747, 9947.154491868272, 10032.1974242059, 10034.347767395097, 10250.282480226313, 10283.280170388001, 10365.481725913825, 10396.896031039592], "value": 7299.311640820816, "unit": "score"}], "name": "dromaeo_css", "value": 7241.936737298313, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 107.0, 109.0, 111.0, 112.0, 112.0, 109.0, 111.0, 112.0, 111.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 125.0, 128.0, 201.0, 126.0, 131.0, 161.0, 125.0, 156.0, 125.0], "value": 143.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 162.0, 160.0, 161.0, 161.0, 161.0, 161.0, 160.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 127.0, 77.0, 75.0, 83.0, 75.0, 98.0, 74.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 117.0, 85.0, 86.0, 86.0, 120.0, 86.0, 92.0, 126.0], "value": 97.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 118.0, 118.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 96.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 55.0, 55.0, 55.0, 55.0, 55.0, 54.0, 55.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 63.0, 62.0, 62.0, 63.0, 62.0, 62.0, 62.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 79.0, 78.0, 80.0, 79.0, 84.0, 110.0, 80.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 122.0, 137.0, 123.0, 131.0, 132.0, 124.0, 122.0, 140.0, 129.0], "value": 129.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 159.0, 160.0, 162.0, 158.0, 166.0, 157.0, 159.0, 164.0, 159.0], "value": 161.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 63.0, 62.0, 63.0, 63.0, 63.0, 62.0, 62.0], "value": 62.8, "unit": "score"}], "name": "kraken", "value": 1506.2, "alertThreshold": 2.0}]} 23:26:08 INFO - Return code: 0 23:26:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:26:08 INFO - # TBPL SUCCESS # 23:26:08 INFO - Running post-action listener: _resource_record_post_action 23:26:08 INFO - ##### 23:26:08 INFO - ##### Finished run-tests step (success) 23:26:08 INFO - ##### 23:26:08 INFO - Running post-run listener: _resource_record_post_run 23:26:08 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 551411712; Read time: 20; Write time: 507672 23:26:08 INFO - TinderboxPrint: CPU usage
13.2% 23:26:08 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 23:26:08 INFO - TinderboxPrint: I/O write bytes / time
551,411,712 / 507,672 23:26:08 INFO - TinderboxPrint: CPU idle
8,277.6 (86.8%) 23:26:08 INFO - TinderboxPrint: CPU user
1,208.2 (12.7%) 23:26:08 INFO - TinderboxPrint: Swap in / out
0 / 0 23:26:08 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 256004096; Read time: 0; Write time: 261336 23:26:08 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295251968; Read time: 20; Write time: 246316 23:26:09 INFO - Running post-run listener: _upload_blobber_files 23:26:09 INFO - Blob upload gear active. 23:26:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:26:09 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 23:26:09 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:26:09 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:26:09 INFO - (blobuploader) - INFO - Open directory for files ... 23:26:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:26:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:26:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:26:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:26:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:26:10 INFO - (blobuploader) - INFO - Done attempting. 23:26:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:26:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:26:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:26:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:26:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:26:11 INFO - (blobuploader) - INFO - Done attempting. 23:26:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:26:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:26:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:26:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:26:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:26:14 INFO - (blobuploader) - INFO - Done attempting. 23:26:14 INFO - (blobuploader) - INFO - Iteration through files over. 23:26:14 INFO - Return code: 0 23:26:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:26:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:26:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cdd2bc1365093b593bf7dfd809e275a26cc5ee6c70db1c32704899a66680919ee83bca73c0b27614ac58d2a6400a07727e0aedc86aaaf06a4d1cbc715e45dedf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/47f32516ba15cade03cb17d68e1f5f524677dd346c99ea3070ac02a36eee2d4c29b58fe118e6fbcb5263d0931dd5f5a1e40e9210aa137f6a1254a976dd218d7c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e6b56f62569d4dab829a88caa29ad83b06f1dc36686f6c14ae3efef4b1dfdd8b6f2510c54c2f5cf08b61a62bad9eefa82bcd03103d9a3000a39d1ab6b605bebc"} 23:26:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:26:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:26:14 INFO - Contents: 23:26:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cdd2bc1365093b593bf7dfd809e275a26cc5ee6c70db1c32704899a66680919ee83bca73c0b27614ac58d2a6400a07727e0aedc86aaaf06a4d1cbc715e45dedf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/47f32516ba15cade03cb17d68e1f5f524677dd346c99ea3070ac02a36eee2d4c29b58fe118e6fbcb5263d0931dd5f5a1e40e9210aa137f6a1254a976dd218d7c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e6b56f62569d4dab829a88caa29ad83b06f1dc36686f6c14ae3efef4b1dfdd8b6f2510c54c2f5cf08b61a62bad9eefa82bcd03103d9a3000a39d1ab6b605bebc"} 23:26:14 INFO - Running post-run listener: copy_logs_to_upload_dir 23:26:14 INFO - Copying logs to upload dir... 23:26:14 INFO - mkdir: /builds/slave/test/build/upload/logs 23:26:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.288942 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-06-20 23:26:14.848097) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-20 23:26:14.851974) ========= 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=14ef55db36f7623abb31b9cf000001d5-1466486930.62391-1051532762 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cdd2bc1365093b593bf7dfd809e275a26cc5ee6c70db1c32704899a66680919ee83bca73c0b27614ac58d2a6400a07727e0aedc86aaaf06a4d1cbc715e45dedf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/47f32516ba15cade03cb17d68e1f5f524677dd346c99ea3070ac02a36eee2d4c29b58fe118e6fbcb5263d0931dd5f5a1e40e9210aa137f6a1254a976dd218d7c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e6b56f62569d4dab829a88caa29ad83b06f1dc36686f6c14ae3efef4b1dfdd8b6f2510c54c2f5cf08b61a62bad9eefa82bcd03103d9a3000a39d1ab6b605bebc"} build_url:https://queue.taskcluster.net/v1/task/NTvU2dyrRhaM0Py_fAIzmg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011400 build_url: 'https://queue.taskcluster.net/v1/task/NTvU2dyrRhaM0Py_fAIzmg/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/Fx-Team/sha512/cdd2bc1365093b593bf7dfd809e275a26cc5ee6c70db1c32704899a66680919ee83bca73c0b27614ac58d2a6400a07727e0aedc86aaaf06a4d1cbc715e45dedf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/47f32516ba15cade03cb17d68e1f5f524677dd346c99ea3070ac02a36eee2d4c29b58fe118e6fbcb5263d0931dd5f5a1e40e9210aa137f6a1254a976dd218d7c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e6b56f62569d4dab829a88caa29ad83b06f1dc36686f6c14ae3efef4b1dfdd8b6f2510c54c2f5cf08b61a62bad9eefa82bcd03103d9a3000a39d1ab6b605bebc"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-20 23:26:14.877666) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 23:26:14.878017) ========= 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=14ef55db36f7623abb31b9cf000001d5-1466486930.62391-1051532762 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004474 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 23:26:14.960547) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-20 23:26:14.960908) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-20 23:26:14.961210) ========= ========= Total master_lag: 0.22 =========