builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-050 starttime: 1467116230.45 results: success (0) buildid: 20160628023022 builduid: f5e652a6268145d5bb8629873399540b revision: 4db7a29c60ddf136d49d24d901c93b4acdfe664a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 05:17:10.448981) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 05:17:10.449459) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 05:17:10.449745) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 05:17:10.495851) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 05:17:10.496156) ========= 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=6dbc10da6d83fee962c624be000001a8-1467116051.559059-1093339788 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-28 05:17:10-- 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% 19.7M=0.001s 2016-06-28 05:17:10 (19.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122193 ========= master_lag: 0.17 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 05:17:10.789523) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 05:17:10.789826) ========= 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=6dbc10da6d83fee962c624be000001a8-1467116051.559059-1093339788 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.149712 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 05:17:10.948849) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 05:17:10.949219) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4db7a29c60ddf136d49d24d901c93b4acdfe664a --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 4db7a29c60ddf136d49d24d901c93b4acdfe664a --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=6dbc10da6d83fee962c624be000001a8-1467116051.559059-1093339788 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-28 05:17:11,009 truncating revision to first 12 chars 2016-06-28 05:17:11,009 Setting DEBUG logging. 2016-06-28 05:17:11,009 attempt 1/10 2016-06-28 05:17:11,009 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4db7a29c60dd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-28 05:17:11,445 unpacking tar archive at: fx-team-4db7a29c60dd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.800017 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 05:17:11.764387) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 05:17:11.764720) ========= script_repo_revision: 4db7a29c60ddf136d49d24d901c93b4acdfe664a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 05:17:11.765162) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 05:17:11.765458) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 05:17:11.774414) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-28 05:17:11.774819) ========= /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=6dbc10da6d83fee962c624be000001a8-1467116051.559059-1093339788 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:17:12 INFO - MultiFileLogger online at 20160628 05:17:12 in /builds/slave/test 05:17:12 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 05:17:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:17:12 INFO - {'append_to_log': False, 05:17:12 INFO - 'base_work_dir': '/builds/slave/test', 05:17:12 INFO - 'blob_upload_branch': 'Fx-Team', 05:17:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:17:12 INFO - 'branch': 'Fx-Team', 05:17:12 INFO - 'buildbot_json_path': 'buildprops.json', 05:17:12 INFO - 'config_files': ('talos/linux_config.py',), 05:17:12 INFO - 'default_actions': ('clobber', 05:17:12 INFO - 'read-buildbot-config', 05:17:12 INFO - 'download-and-extract', 05:17:12 INFO - 'populate-webroot', 05:17:12 INFO - 'create-virtualenv', 05:17:12 INFO - 'install', 05:17:12 INFO - 'run-tests'), 05:17:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:17:12 INFO - 'download_minidump_stackwalk': True, 05:17:12 INFO - 'download_symbols': 'ondemand', 05:17:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:17:12 INFO - 'tooltool.py': '/tools/tooltool.py', 05:17:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:17:12 INFO - '/tools/misc-python/virtualenv.py')}, 05:17:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:17:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:17:12 INFO - 'installer_path': 'installer.exe', 05:17:12 INFO - 'log_level': 'info', 05:17:12 INFO - 'log_name': 'talos', 05:17:12 INFO - 'log_to_console': True, 05:17:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:17:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:17:12 INFO - 'opt_config_files': (), 05:17:12 INFO - 'pip_index': False, 05:17:12 INFO - 'sps_profile': False, 05:17:12 INFO - 'sps_profile_interval': 0, 05:17:12 INFO - 'suite': 'dromaeojs', 05:17:12 INFO - 'system_bits': '32', 05:17:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:17:12 INFO - 'title': 'talos-linux64-ix-050', 05:17:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:17:12 INFO - 'use_talos_json': True, 05:17:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:17:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:17:12 INFO - 'work_dir': 'build'} 05:17:12 INFO - ##### 05:17:12 INFO - ##### Running clobber step. 05:17:12 INFO - ##### 05:17:12 INFO - Running pre-action listener: _resource_record_pre_action 05:17:12 INFO - Running main action method: clobber 05:17:12 INFO - rmtree: /builds/slave/test/build 05:17:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:17:13 INFO - Running post-action listener: _resource_record_post_action 05:17:13 INFO - ##### 05:17:13 INFO - ##### Finished clobber step (success) 05:17:13 INFO - ##### 05:17:13 INFO - ##### 05:17:13 INFO - ##### Running read-buildbot-config step. 05:17:13 INFO - ##### 05:17:13 INFO - Running pre-action listener: _resource_record_pre_action 05:17:13 INFO - Running main action method: read_buildbot_config 05:17:13 INFO - Using buildbot properties: 05:17:13 INFO - { 05:17:13 INFO - "project": "", 05:17:13 INFO - "product": "firefox", 05:17:13 INFO - "script_repo_revision": "production", 05:17:13 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:17:13 INFO - "repository": "", 05:17:13 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:17:13 INFO - "buildid": "20160628023022", 05:17:13 INFO - "pgo_build": "True", 05:17:13 INFO - "basedir": "/builds/slave/test", 05:17:13 INFO - "buildnumber": 840, 05:17:13 INFO - "slavename": "talos-linux64-ix-050", 05:17:13 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:17:13 INFO - "platform": "ubuntu64_hw", 05:17:13 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:17:13 INFO - "branch": "fx-team", 05:17:13 INFO - "repo_path": "integration/fx-team", 05:17:13 INFO - "revision": "4db7a29c60ddf136d49d24d901c93b4acdfe664a", 05:17:13 INFO - "stage_platform": "linux64-pgo", 05:17:13 INFO - "builduid": "f5e652a6268145d5bb8629873399540b", 05:17:13 INFO - "slavebuilddir": "test" 05:17:13 INFO - } 05:17:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/CNNwy5leRmWazIi41CW1Bg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:17:13 INFO - Running post-action listener: _resource_record_post_action 05:17:13 INFO - ##### 05:17:13 INFO - ##### Finished read-buildbot-config step (success) 05:17:13 INFO - ##### 05:17:13 INFO - ##### 05:17:13 INFO - ##### Running download-and-extract step. 05:17:13 INFO - ##### 05:17:13 INFO - Running pre-action listener: _resource_record_pre_action 05:17:13 INFO - Running main action method: download_and_extract 05:17:13 INFO - mkdir: /builds/slave/test/build/tests 05:17:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:13 INFO - https://queue.taskcluster.net/v1/task/CNNwy5leRmWazIi41CW1Bg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:17:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CNNwy5leRmWazIi41CW1Bg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:17:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CNNwy5leRmWazIi41CW1Bg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:17:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CNNwy5leRmWazIi41CW1Bg/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 05:17:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CNNwy5leRmWazIi41CW1Bg/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 05:17:13 INFO - Downloaded 1361 bytes. 05:17:13 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:17:13 INFO - Using the following test package requirements: 05:17:13 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:17:13 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:17:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:17:13 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:17:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:17:13 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:17:13 INFO - u'jsshell-linux-x86_64.zip'], 05:17:13 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:17:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:17:13 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:17:13 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:17:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:17:13 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:17:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:17:13 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:17:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:17:13 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:17:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:17:13 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:17:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:13 INFO - https://queue.taskcluster.net/v1/task/CNNwy5leRmWazIi41CW1Bg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:17:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CNNwy5leRmWazIi41CW1Bg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:17:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CNNwy5leRmWazIi41CW1Bg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:17:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CNNwy5leRmWazIi41CW1Bg/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 05:17:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CNNwy5leRmWazIi41CW1Bg/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 05:17:14 INFO - Downloaded 24279790 bytes. 05:17:14 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'] 05:17:14 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 05:17:16 INFO - Return code: 0 05:17:16 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 05:17:16 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')]} 05:17:16 INFO - https://queue.taskcluster.net/v1/task/CNNwy5leRmWazIi41CW1Bg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:17:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CNNwy5leRmWazIi41CW1Bg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:17:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CNNwy5leRmWazIi41CW1Bg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:17:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CNNwy5leRmWazIi41CW1Bg/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 05:17:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CNNwy5leRmWazIi41CW1Bg/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 05:17:17 INFO - Downloaded 24279790 bytes. 05:17:17 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'] 05:17:17 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 05:17:19 INFO - Return code: 0 05:17:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:19 INFO - https://queue.taskcluster.net/v1/task/CNNwy5leRmWazIi41CW1Bg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:17:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CNNwy5leRmWazIi41CW1Bg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:17:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CNNwy5leRmWazIi41CW1Bg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:17:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CNNwy5leRmWazIi41CW1Bg/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 05:17:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CNNwy5leRmWazIi41CW1Bg/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 05:17:20 INFO - Downloaded 14405245 bytes. 05:17:20 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'] 05:17:20 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 05:17:20 INFO - Return code: 0 05:17:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:20 INFO - https://queue.taskcluster.net/v1/task/CNNwy5leRmWazIi41CW1Bg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:17:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CNNwy5leRmWazIi41CW1Bg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:17:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CNNwy5leRmWazIi41CW1Bg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:17:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CNNwy5leRmWazIi41CW1Bg/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 05:17:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CNNwy5leRmWazIi41CW1Bg/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 05:17:21 INFO - Downloaded 60300712 bytes. 05:17:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CNNwy5leRmWazIi41CW1Bg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:17:21 INFO - mkdir: /builds/slave/test/properties 05:17:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:17:21 INFO - Writing to file /builds/slave/test/properties/build_url 05:17:21 INFO - Contents: 05:17:21 INFO - build_url:https://queue.taskcluster.net/v1/task/CNNwy5leRmWazIi41CW1Bg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:17:22 INFO - Running post-action listener: _resource_record_post_action 05:17:22 INFO - Running post-action listener: set_extra_try_arguments 05:17:22 INFO - ##### 05:17:22 INFO - ##### Finished download-and-extract step (success) 05:17:22 INFO - ##### 05:17:22 INFO - ##### 05:17:22 INFO - ##### Running populate-webroot step. 05:17:22 INFO - ##### 05:17:22 INFO - Running pre-action listener: _resource_record_pre_action 05:17:22 INFO - Running main action method: populate_webroot 05:17:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:17:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:17:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:17:22 INFO - '--tppagecycles', 05:17:22 INFO - '7'], 05:17:22 INFO - 'tests': ['tsvgm']}}, 05:17:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:17:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:17:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:17:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:17:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:17:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:17:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:22 INFO - 'talos_options': ['--disable-e10s'], 05:17:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:17:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:17:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:22 INFO - 'talos_options': ['--disable-e10s'], 05:17:22 INFO - 'tests': ['damp', 'tps']}, 05:17:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:22 INFO - 'tests': ['damp', 'tps']}, 05:17:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:17:22 INFO - 'tests': ['dromaeo_dom']}, 05:17:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:17:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:17:22 INFO - 'tests': ['basic_compositor_video']}, 05:17:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:17:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:17:22 INFO - 'tests': ['a11yr', 05:17:22 INFO - 'ts_paint', 05:17:22 INFO - 'tpaint', 05:17:22 INFO - 'sessionrestore', 05:17:22 INFO - 'sessionrestore_no_auto_restore', 05:17:22 INFO - 'tabpaint']}, 05:17:22 INFO - 'other-e10s': {'tests': ['a11yr', 05:17:22 INFO - 'ts_paint', 05:17:22 INFO - 'tpaint', 05:17:22 INFO - 'sessionrestore', 05:17:22 INFO - 'sessionrestore_no_auto_restore', 05:17:22 INFO - 'tabpaint']}, 05:17:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:17:22 INFO - 'ts_paint', 05:17:22 INFO - 'tpaint', 05:17:22 INFO - 'sessionrestore', 05:17:22 INFO - 'sessionrestore_no_auto_restore', 05:17:22 INFO - 'tabpaint']}, 05:17:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:17:22 INFO - 'ts_paint', 05:17:22 INFO - 'tpaint', 05:17:22 INFO - 'sessionrestore', 05:17:22 INFO - 'sessionrestore_no_auto_restore', 05:17:22 INFO - 'tabpaint']}, 05:17:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:17:22 INFO - 'tests': ['a11yr', 05:17:22 INFO - 'ts_paint', 05:17:22 INFO - 'tpaint', 05:17:22 INFO - 'sessionrestore', 05:17:22 INFO - 'sessionrestore_no_auto_restore', 05:17:22 INFO - 'tabpaint']}, 05:17:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:17:22 INFO - 'tests': ['a11yr', 05:17:22 INFO - 'ts_paint', 05:17:22 INFO - 'tpaint', 05:17:22 INFO - 'sessionrestore', 05:17:22 INFO - 'sessionrestore_no_auto_restore', 05:17:22 INFO - 'tabpaint']}, 05:17:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:17:22 INFO - 'tests': ['tsvgx', 05:17:22 INFO - 'tsvgr_opacity', 05:17:22 INFO - 'tart', 05:17:22 INFO - 'tscrollx', 05:17:22 INFO - 'cart']}, 05:17:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:17:22 INFO - 'tsvgr_opacity', 05:17:22 INFO - 'tart', 05:17:22 INFO - 'tscrollx', 05:17:22 INFO - 'cart']}, 05:17:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:22 INFO - 'talos_options': ['--disable-e10s'], 05:17:22 INFO - 'tests': ['tp5o']}, 05:17:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:22 INFO - 'tests': ['tp5o']}, 05:17:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:22 INFO - 'talos_options': ['--disable-e10s', 05:17:22 INFO - '--xperf_path', 05:17:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:17:22 INFO - 'tests': ['tp5n']}, 05:17:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:22 INFO - 'talos_options': ['--xperf_path', 05:17:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:17:22 INFO - 'tests': ['tp5n']}}, 05:17:22 INFO - 'talos.zip': {'path': '', 05:17:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:17:22 INFO - Running post-action listener: _resource_record_post_action 05:17:22 INFO - ##### 05:17:22 INFO - ##### Finished populate-webroot step (success) 05:17:22 INFO - ##### 05:17:22 INFO - ##### 05:17:22 INFO - ##### Running create-virtualenv step. 05:17:22 INFO - ##### 05:17:22 INFO - Running pre-action listener: _resource_record_pre_action 05:17:22 INFO - Running main action method: create_virtualenv 05:17:22 INFO - Creating virtualenv /builds/slave/test/build/venv 05:17:22 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 05:17:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:17:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:17:23 INFO - Using real prefix '/usr' 05:17:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:17:23 INFO - Installing distribute.............................................................................................................................................................................................done. 05:17:25 INFO - Installing pip.................done. 05:17:25 INFO - Return code: 0 05:17:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:17:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:25 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 0x7fbfd4737f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11fe480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128d6f0>, '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 0x128e5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x128eaa0>, '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': '6dbc10da6d83fee962c624be000001a8-1467116051.559059-1093339788', '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 05:17:25 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 05:17:25 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 05:17:25 INFO - Using env: {'DISPLAY': ':0', 05:17:25 INFO - 'HOME': '/home/cltbld', 05:17:25 INFO - 'LANG': 'en_US.UTF-8', 05:17:25 INFO - 'LANGUAGE': 'en_US:en', 05:17:25 INFO - 'LOGNAME': 'cltbld', 05:17:25 INFO - 'MAIL': '/var/mail/cltbld', 05:17:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:25 INFO - 'MOZ_NO_REMOTE': '1', 05:17:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:25 INFO - 'NO_EM_RESTART': '1', 05:17:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:25 INFO - 'PWD': '/builds/slave/test', 05:17:25 INFO - 'SHELL': '/bin/bash', 05:17:25 INFO - 'SHLVL': '1', 05:17:25 INFO - 'TERM': 'linux', 05:17:25 INFO - 'TMOUT': '86400', 05:17:25 INFO - 'USER': 'cltbld', 05:17:25 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467116051.559059-1093339788', 05:17:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:25 INFO - '_': '/tools/buildbot/bin/python'} 05:17:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:26 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 05:17:26 INFO - Cleaning up... 05:17:26 INFO - Return code: 0 05:17:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:17:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:26 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 0x7fbfd4737f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11fe480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128d6f0>, '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 0x128e5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x128eaa0>, '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': '6dbc10da6d83fee962c624be000001a8-1467116051.559059-1093339788', '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 05:17:26 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 05:17:26 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 05:17:26 INFO - Using env: {'DISPLAY': ':0', 05:17:26 INFO - 'HOME': '/home/cltbld', 05:17:26 INFO - 'LANG': 'en_US.UTF-8', 05:17:26 INFO - 'LANGUAGE': 'en_US:en', 05:17:26 INFO - 'LOGNAME': 'cltbld', 05:17:26 INFO - 'MAIL': '/var/mail/cltbld', 05:17:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:26 INFO - 'MOZ_NO_REMOTE': '1', 05:17:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:26 INFO - 'NO_EM_RESTART': '1', 05:17:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:26 INFO - 'PWD': '/builds/slave/test', 05:17:26 INFO - 'SHELL': '/bin/bash', 05:17:26 INFO - 'SHLVL': '1', 05:17:26 INFO - 'TERM': 'linux', 05:17:26 INFO - 'TMOUT': '86400', 05:17:26 INFO - 'USER': 'cltbld', 05:17:26 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467116051.559059-1093339788', 05:17:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:26 INFO - '_': '/tools/buildbot/bin/python'} 05:17:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:26 INFO - Downloading/unpacking psutil>=3.1.1 05:17:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:17:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:17:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:17:28 INFO - Installing collected packages: psutil 05:17:28 INFO - Running setup.py install for psutil 05:17:28 INFO - building 'psutil._psutil_linux' extension 05:17:28 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 05:17:29 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 05:17:29 INFO - building 'psutil._psutil_posix' extension 05:17:29 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 05:17:30 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 05:17:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:17:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:17:30 INFO - Successfully installed psutil 05:17:30 INFO - Cleaning up... 05:17:30 INFO - Return code: 0 05:17:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:17: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')]} 05:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17: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')]} 05:17:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:30 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 0x7fbfd4737f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11fe480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128d6f0>, '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 0x128e5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x128eaa0>, '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': '6dbc10da6d83fee962c624be000001a8-1467116051.559059-1093339788', '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 05:17:30 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 05:17:30 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 05:17:30 INFO - Using env: {'DISPLAY': ':0', 05:17:30 INFO - 'HOME': '/home/cltbld', 05:17:30 INFO - 'LANG': 'en_US.UTF-8', 05:17:30 INFO - 'LANGUAGE': 'en_US:en', 05:17:30 INFO - 'LOGNAME': 'cltbld', 05:17:30 INFO - 'MAIL': '/var/mail/cltbld', 05:17:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:30 INFO - 'MOZ_NO_REMOTE': '1', 05:17:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:30 INFO - 'NO_EM_RESTART': '1', 05:17:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:30 INFO - 'PWD': '/builds/slave/test', 05:17:30 INFO - 'SHELL': '/bin/bash', 05:17:30 INFO - 'SHLVL': '1', 05:17:30 INFO - 'TERM': 'linux', 05:17:30 INFO - 'TMOUT': '86400', 05:17:30 INFO - 'USER': 'cltbld', 05:17:30 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467116051.559059-1093339788', 05:17:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:30 INFO - '_': '/tools/buildbot/bin/python'} 05:17:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:17:30 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 05:17:30 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 05:17:30 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 05:17:30 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 05:17:30 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 05:17:30 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 05:17:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:17:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:17:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:17:32 INFO - Installing collected packages: mozsystemmonitor 05:17:32 INFO - Running setup.py install for mozsystemmonitor 05:17:32 INFO - Successfully installed mozsystemmonitor 05:17:32 INFO - Cleaning up... 05:17:32 INFO - Return code: 0 05:17:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:17:32 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')]} 05:17:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:32 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')]} 05:17:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:32 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 0x7fbfd4737f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11fe480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128d6f0>, '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 0x128e5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x128eaa0>, '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': '6dbc10da6d83fee962c624be000001a8-1467116051.559059-1093339788', '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 05:17:32 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 05:17:32 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 05:17:32 INFO - Using env: {'DISPLAY': ':0', 05:17:32 INFO - 'HOME': '/home/cltbld', 05:17:32 INFO - 'LANG': 'en_US.UTF-8', 05:17:32 INFO - 'LANGUAGE': 'en_US:en', 05:17:32 INFO - 'LOGNAME': 'cltbld', 05:17:32 INFO - 'MAIL': '/var/mail/cltbld', 05:17:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:32 INFO - 'MOZ_NO_REMOTE': '1', 05:17:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:32 INFO - 'NO_EM_RESTART': '1', 05:17:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:32 INFO - 'PWD': '/builds/slave/test', 05:17:32 INFO - 'SHELL': '/bin/bash', 05:17:32 INFO - 'SHLVL': '1', 05:17:32 INFO - 'TERM': 'linux', 05:17:32 INFO - 'TMOUT': '86400', 05:17:32 INFO - 'USER': 'cltbld', 05:17:32 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467116051.559059-1093339788', 05:17:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:32 INFO - '_': '/tools/buildbot/bin/python'} 05:17:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:32 INFO - Downloading/unpacking jsonschema==2.5.1 05:17:32 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 05:17:32 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 05:17:32 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 05:17:32 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 05:17:32 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 05:17:32 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 05:17:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:17:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:17:34 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 05:17:34 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 05:17:34 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 05:17:34 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 05:17:34 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 05:17:34 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 05:17:34 INFO - Downloading functools32-3.2.3-2.tar.gz 05:17:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:17:34 INFO - warning: no files found matching '*.txt' 05:17:34 INFO - no previously-included directories found matching 'build' 05:17:34 INFO - no previously-included directories found matching 'dist' 05:17:34 INFO - no previously-included directories found matching '.git*' 05:17:34 INFO - Installing collected packages: jsonschema, functools32 05:17:34 INFO - Running setup.py install for functools32 05:17:35 INFO - warning: no files found matching '*.txt' 05:17:35 INFO - no previously-included directories found matching 'build' 05:17:35 INFO - no previously-included directories found matching 'dist' 05:17:35 INFO - no previously-included directories found matching '.git*' 05:17:35 INFO - Successfully installed jsonschema functools32 05:17:35 INFO - Cleaning up... 05:17:35 INFO - Return code: 0 05:17:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:17:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbfd4737f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11fe480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128d6f0>, '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 0x128e5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x128eaa0>, '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': '6dbc10da6d83fee962c624be000001a8-1467116051.559059-1093339788', '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 05:17:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:17:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:17:35 INFO - Using env: {'DISPLAY': ':0', 05:17:35 INFO - 'HOME': '/home/cltbld', 05:17:35 INFO - 'LANG': 'en_US.UTF-8', 05:17:35 INFO - 'LANGUAGE': 'en_US:en', 05:17:35 INFO - 'LOGNAME': 'cltbld', 05:17:35 INFO - 'MAIL': '/var/mail/cltbld', 05:17:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:35 INFO - 'MOZ_NO_REMOTE': '1', 05:17:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:35 INFO - 'NO_EM_RESTART': '1', 05:17:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:35 INFO - 'PWD': '/builds/slave/test', 05:17:35 INFO - 'SHELL': '/bin/bash', 05:17:35 INFO - 'SHLVL': '1', 05:17:35 INFO - 'TERM': 'linux', 05:17:35 INFO - 'TMOUT': '86400', 05:17:35 INFO - 'USER': 'cltbld', 05:17:35 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467116051.559059-1093339788', 05:17:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:35 INFO - '_': '/tools/buildbot/bin/python'} 05:17:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:35 INFO - Downloading/unpacking blobuploader==1.2.4 05:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:37 INFO - Downloading blobuploader-1.2.4.tar.gz 05:17:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:17:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:17:37 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 05:17:37 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 05:17:37 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 05:17:37 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 05:17:37 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 05:17:37 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 05:17:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:17:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:17:37 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 05:17:37 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 05:17:37 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 05:17:37 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 05:17:37 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 05:17:37 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 05:17:37 INFO - Downloading docopt-0.6.1.tar.gz 05:17:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:17:37 INFO - Installing collected packages: blobuploader, requests, docopt 05:17:37 INFO - Running setup.py install for blobuploader 05:17:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:17:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:17:38 INFO - Running setup.py install for requests 05:17:38 INFO - Running setup.py install for docopt 05:17:38 INFO - Successfully installed blobuploader requests docopt 05:17:38 INFO - Cleaning up... 05:17:38 INFO - Return code: 0 05:17:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:38 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 0x7fbfd4737f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11fe480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128d6f0>, '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 0x128e5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x128eaa0>, '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': '6dbc10da6d83fee962c624be000001a8-1467116051.559059-1093339788', '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 05:17:38 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 05:17:38 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 05:17:38 INFO - Using env: {'DISPLAY': ':0', 05:17:38 INFO - 'HOME': '/home/cltbld', 05:17:38 INFO - 'LANG': 'en_US.UTF-8', 05:17:38 INFO - 'LANGUAGE': 'en_US:en', 05:17:38 INFO - 'LOGNAME': 'cltbld', 05:17:38 INFO - 'MAIL': '/var/mail/cltbld', 05:17:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:38 INFO - 'MOZ_NO_REMOTE': '1', 05:17:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:38 INFO - 'NO_EM_RESTART': '1', 05:17:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:38 INFO - 'PWD': '/builds/slave/test', 05:17:38 INFO - 'SHELL': '/bin/bash', 05:17:38 INFO - 'SHLVL': '1', 05:17:38 INFO - 'TERM': 'linux', 05:17:38 INFO - 'TMOUT': '86400', 05:17:38 INFO - 'USER': 'cltbld', 05:17:38 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467116051.559059-1093339788', 05:17:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:38 INFO - '_': '/tools/buildbot/bin/python'} 05:17:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:17:38 INFO - Running setup.py (path:/tmp/pip-qU1rBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:17:38 INFO - Running setup.py (path:/tmp/pip-eCwyte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:17:38 INFO - Running setup.py (path:/tmp/pip-4wfT24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:17:38 INFO - Running setup.py (path:/tmp/pip-7kifZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:17:39 INFO - Running setup.py (path:/tmp/pip-4APdaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:17:39 INFO - Running setup.py (path:/tmp/pip-2B4jV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:17:39 INFO - Running setup.py (path:/tmp/pip-XwTrPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:17:39 INFO - Running setup.py (path:/tmp/pip-qODnZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:17:39 INFO - Running setup.py (path:/tmp/pip-KdNrod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:17:39 INFO - Running setup.py (path:/tmp/pip-uvr1el-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:17:39 INFO - Running setup.py (path:/tmp/pip-fRVu4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:17:39 INFO - Running setup.py (path:/tmp/pip-UM7Y_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:17:39 INFO - Running setup.py (path:/tmp/pip-1RBW4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:17:39 INFO - Running setup.py (path:/tmp/pip-ZtVgoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:39 INFO - Running setup.py (path:/tmp/pip-U6AmOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:17:39 INFO - Running setup.py (path:/tmp/pip-ZGpgs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:17:39 INFO - Running setup.py (path:/tmp/pip-fnyVQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:17:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:17:39 INFO - Running setup.py install for manifestparser 05:17:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:17:40 INFO - Running setup.py install for mozcrash 05:17:40 INFO - Running setup.py install for mozdebug 05:17:40 INFO - Running setup.py install for mozdevice 05:17:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:17:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:17:40 INFO - Running setup.py install for mozfile 05:17:40 INFO - Running setup.py install for mozhttpd 05:17:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:17:40 INFO - Running setup.py install for mozinfo 05:17:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:17:40 INFO - Running setup.py install for mozInstall 05:17:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:17:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:17:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:17:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:17:40 INFO - Running setup.py install for mozleak 05:17:40 INFO - Running setup.py install for mozlog 05:17:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:17:41 INFO - Running setup.py install for moznetwork 05:17:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:17:41 INFO - Running setup.py install for mozprocess 05:17:41 INFO - Running setup.py install for mozprofile 05:17:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:17:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:17:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:17:41 INFO - Running setup.py install for mozrunner 05:17:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:17:41 INFO - Running setup.py install for mozscreenshot 05:17:41 INFO - Running setup.py install for moztest 05:17:41 INFO - Running setup.py install for mozversion 05:17:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:17:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:17:41 INFO - Cleaning up... 05:17:41 INFO - Return code: 0 05:17:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17: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')]} 05:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17: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')]} 05:17:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:41 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 0x7fbfd4737f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11fe480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128d6f0>, '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 0x128e5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x128eaa0>, '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': '6dbc10da6d83fee962c624be000001a8-1467116051.559059-1093339788', '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 05:17:41 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 05:17:41 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 05:17:41 INFO - Using env: {'DISPLAY': ':0', 05:17:41 INFO - 'HOME': '/home/cltbld', 05:17:41 INFO - 'LANG': 'en_US.UTF-8', 05:17:41 INFO - 'LANGUAGE': 'en_US:en', 05:17:41 INFO - 'LOGNAME': 'cltbld', 05:17:41 INFO - 'MAIL': '/var/mail/cltbld', 05:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:41 INFO - 'MOZ_NO_REMOTE': '1', 05:17:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:41 INFO - 'NO_EM_RESTART': '1', 05:17:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:41 INFO - 'PWD': '/builds/slave/test', 05:17:41 INFO - 'SHELL': '/bin/bash', 05:17:41 INFO - 'SHLVL': '1', 05:17:41 INFO - 'TERM': 'linux', 05:17:41 INFO - 'TMOUT': '86400', 05:17:41 INFO - 'USER': 'cltbld', 05:17:41 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467116051.559059-1093339788', 05:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:41 INFO - '_': '/tools/buildbot/bin/python'} 05:17:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:17:42 INFO - Running setup.py (path:/tmp/pip-pFWljf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:17:42 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)) 05:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:17:42 INFO - Running setup.py (path:/tmp/pip-Oc4VNb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:17:42 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)) 05:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:17:42 INFO - Running setup.py (path:/tmp/pip-iXatiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:17:42 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)) 05:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:17:42 INFO - Running setup.py (path:/tmp/pip-zYRPN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:17:42 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)) 05:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:17:42 INFO - Running setup.py (path:/tmp/pip-rw3hwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:17:42 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)) 05:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:17:42 INFO - Running setup.py (path:/tmp/pip-wR8OaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:17:42 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)) 05:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:17:42 INFO - Running setup.py (path:/tmp/pip-_N4LYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:17:42 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)) 05:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:17:42 INFO - Running setup.py (path:/tmp/pip-78INsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:17:42 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)) 05:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:17:42 INFO - Running setup.py (path:/tmp/pip-UD4u2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:17:42 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)) 05:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:17:42 INFO - Running setup.py (path:/tmp/pip-K0MLlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:17:42 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)) 05:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:17:42 INFO - Running setup.py (path:/tmp/pip-SCSX_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:17:42 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)) 05:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:17:42 INFO - Running setup.py (path:/tmp/pip-rrERtT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:17:42 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)) 05:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:17:42 INFO - Running setup.py (path:/tmp/pip-3D3qDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:17:42 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)) 05:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:17:42 INFO - Running setup.py (path:/tmp/pip-glXqNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:17:43 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)) 05:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:43 INFO - Running setup.py (path:/tmp/pip-hRT46Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:43 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)) 05:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:17:43 INFO - Running setup.py (path:/tmp/pip-xcrITk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:17:43 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)) 05:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:17:43 INFO - Running setup.py (path:/tmp/pip-ufEeY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:17:43 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)) 05:17:43 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)) 05:17:43 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)) 05:17:43 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)) 05:17:43 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)) 05:17:43 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)) 05:17:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:45 INFO - Downloading blessings-1.6.tar.gz 05:17:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:17:45 INFO - Installing collected packages: blessings 05:17:45 INFO - Running setup.py install for blessings 05:17:45 INFO - Successfully installed blessings 05:17:45 INFO - Cleaning up... 05:17:45 INFO - Return code: 0 05:17:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:17:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:17:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:17:45 INFO - Reading from file tmpfile_stdout 05:17:45 INFO - Current package versions: 05:17:45 INFO - argparse == 1.2.1 05:17:45 INFO - blessings == 1.6 05:17:45 INFO - blobuploader == 1.2.4 05:17:45 INFO - docopt == 0.6.1 05:17:45 INFO - functools32 == 3.2.3-2 05:17:45 INFO - jsonschema == 2.5.1 05:17:45 INFO - manifestparser == 1.1 05:17:45 INFO - mozInstall == 1.12 05:17:45 INFO - mozcrash == 0.17 05:17:45 INFO - mozdebug == 0.1 05:17:45 INFO - mozdevice == 0.48 05:17:45 INFO - mozfile == 1.2 05:17:45 INFO - mozhttpd == 0.7 05:17:45 INFO - mozinfo == 0.9 05:17:45 INFO - mozleak == 0.1 05:17:45 INFO - mozlog == 3.2 05:17:45 INFO - moznetwork == 0.27 05:17:45 INFO - mozprocess == 0.22 05:17:45 INFO - mozprofile == 0.28 05:17:45 INFO - mozrunner == 6.11 05:17:45 INFO - mozscreenshot == 0.1 05:17:45 INFO - mozsystemmonitor == 0.3 05:17:45 INFO - moztest == 0.7 05:17:45 INFO - mozversion == 1.4 05:17:45 INFO - psutil == 3.1.1 05:17:45 INFO - requests == 1.2.3 05:17:45 INFO - wsgiref == 0.1.2 05:17:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:45 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 0x7fbfd4737f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11fe480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128d6f0>, '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 0x128e5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x128eaa0>, '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': '6dbc10da6d83fee962c624be000001a8-1467116051.559059-1093339788', '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 05:17:45 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 05:17:45 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 05:17:45 INFO - Using env: {'DISPLAY': ':0', 05:17:45 INFO - 'HOME': '/home/cltbld', 05:17:45 INFO - 'LANG': 'en_US.UTF-8', 05:17:45 INFO - 'LANGUAGE': 'en_US:en', 05:17:45 INFO - 'LOGNAME': 'cltbld', 05:17:45 INFO - 'MAIL': '/var/mail/cltbld', 05:17:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:45 INFO - 'MOZ_NO_REMOTE': '1', 05:17:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:45 INFO - 'NO_EM_RESTART': '1', 05:17:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:45 INFO - 'PWD': '/builds/slave/test', 05:17:45 INFO - 'SHELL': '/bin/bash', 05:17:45 INFO - 'SHLVL': '1', 05:17:45 INFO - 'TERM': 'linux', 05:17:45 INFO - 'TMOUT': '86400', 05:17:45 INFO - 'USER': 'cltbld', 05:17:45 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467116051.559059-1093339788', 05:17:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:45 INFO - '_': '/tools/buildbot/bin/python'} 05:17:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:45 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)) 05:17:45 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)) 05:17:45 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)) 05:17:45 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)) 05:17:45 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)) 05:17:45 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)) 05:17:45 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)) 05:17:45 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)) 05:17:45 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)) 05:17:45 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)) 05:17:45 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)) 05:17:45 INFO - Cleaning up... 05:17:45 INFO - Return code: 0 05:17:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfd4737f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11fe480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128d6f0>, '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 0x128e5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x128eaa0>, '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': '6dbc10da6d83fee962c624be000001a8-1467116051.559059-1093339788', '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 05:17:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:17:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:17:45 INFO - Using env: {'DISPLAY': ':0', 05:17:45 INFO - 'HOME': '/home/cltbld', 05:17:45 INFO - 'LANG': 'en_US.UTF-8', 05:17:45 INFO - 'LANGUAGE': 'en_US:en', 05:17:45 INFO - 'LOGNAME': 'cltbld', 05:17:45 INFO - 'MAIL': '/var/mail/cltbld', 05:17:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:45 INFO - 'MOZ_NO_REMOTE': '1', 05:17:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:45 INFO - 'NO_EM_RESTART': '1', 05:17:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:45 INFO - 'PWD': '/builds/slave/test', 05:17:45 INFO - 'SHELL': '/bin/bash', 05:17:45 INFO - 'SHLVL': '1', 05:17:45 INFO - 'TERM': 'linux', 05:17:45 INFO - 'TMOUT': '86400', 05:17:45 INFO - 'USER': 'cltbld', 05:17:45 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467116051.559059-1093339788', 05:17:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:45 INFO - '_': '/tools/buildbot/bin/python'} 05:17:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:17:46 INFO - Cleaning up... 05:17:46 INFO - Return code: 0 05:17:46 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:17: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')]} 05:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17: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')]} 05:17:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfd4737f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11fe480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128d6f0>, '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 0x128e5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x128eaa0>, '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': '6dbc10da6d83fee962c624be000001a8-1467116051.559059-1093339788', '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 05:17:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:17:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:17:46 INFO - Using env: {'DISPLAY': ':0', 05:17:46 INFO - 'HOME': '/home/cltbld', 05:17:46 INFO - 'LANG': 'en_US.UTF-8', 05:17:46 INFO - 'LANGUAGE': 'en_US:en', 05:17:46 INFO - 'LOGNAME': 'cltbld', 05:17:46 INFO - 'MAIL': '/var/mail/cltbld', 05:17:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:46 INFO - 'MOZ_NO_REMOTE': '1', 05:17:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:46 INFO - 'NO_EM_RESTART': '1', 05:17:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:46 INFO - 'PWD': '/builds/slave/test', 05:17:46 INFO - 'SHELL': '/bin/bash', 05:17:46 INFO - 'SHLVL': '1', 05:17:46 INFO - 'TERM': 'linux', 05:17:46 INFO - 'TMOUT': '86400', 05:17:46 INFO - 'USER': 'cltbld', 05:17:46 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467116051.559059-1093339788', 05:17:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:46 INFO - '_': '/tools/buildbot/bin/python'} 05:17:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:46 INFO - Downloading/unpacking flake8 05:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:17:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:17:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:17:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:17:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:17:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:17:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:17:48 INFO - no previously-included directories found matching 'docs/_build' 05:17:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:17:49 INFO - Running setup.py install for pep8 05:17:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:17:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:17:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:17:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:17:49 INFO - no previously-included directories found matching 'docs/_build' 05:17:49 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:17:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:17:49 INFO - Cleaning up... 05:17:49 INFO - Return code: 0 05:17:49 INFO - Running post-action listener: _resource_record_post_action 05:17:49 INFO - Running post-action listener: _start_resource_monitoring 05:17:49 INFO - Starting resource monitoring. 05:17:49 INFO - ##### 05:17:49 INFO - ##### Finished create-virtualenv step (success) 05:17:49 INFO - ##### 05:17:49 INFO - ##### 05:17:49 INFO - ##### Running install step. 05:17:49 INFO - ##### 05:17:49 INFO - Running pre-action listener: _resource_record_pre_action 05:17:49 INFO - Running main action method: install 05:17:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:17:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:17:49 INFO - Reading from file tmpfile_stdout 05:17:49 INFO - Detecting whether we're running mozinstall >=1.0... 05:17:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:17:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:17:49 INFO - Reading from file tmpfile_stdout 05:17:49 INFO - Output received: 05:17:49 INFO - Usage: mozinstall [options] installer 05:17:49 INFO - Options: 05:17:49 INFO - -h, --help show this help message and exit 05:17:49 INFO - -d DEST, --destination=DEST 05:17:49 INFO - Directory to install application into. [default: 05:17:49 INFO - "/builds/slave/test"] 05:17:49 INFO - --app=APP Application being installed. [default: firefox] 05:17:49 INFO - mkdir: /builds/slave/test/build/application 05:17:49 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'] 05:17:49 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 05:18:06 INFO - Reading from file tmpfile_stdout 05:18:06 INFO - Output received: 05:18:06 INFO - /builds/slave/test/build/application/firefox/firefox 05:18:06 INFO - Running post-action listener: _resource_record_post_action 05:18:06 INFO - ##### 05:18:06 INFO - ##### Finished install step (success) 05:18:06 INFO - ##### 05:18:06 INFO - ##### 05:18:06 INFO - ##### Running run-tests step. 05:18:06 INFO - ##### 05:18:06 INFO - Running pre-action listener: _resource_record_pre_action 05:18:06 INFO - Running main action method: run_tests 05:18:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:18:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:18:06 INFO - Python 2.7.3 05:18:06 INFO - Return code: 0 05:18:06 INFO - grabbing minidump binary from tooltool 05:18: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')]} 05:18:06 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 0x128d6f0>, '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 0x128e5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x128eaa0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:18:06 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 05:18:06 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 05:18:06 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 05:18:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:18:06 INFO - Return code: 0 05:18:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:18:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:18:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:18:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:18:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:18:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:18:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:18:07 INFO - Return code: 0 05:18:07 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/CNNwy5leRmWazIi41CW1Bg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 05:18:07 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/CNNwy5leRmWazIi41CW1Bg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 05:18:07 INFO - Using env: {'DISPLAY': ':0', 05:18:07 INFO - 'HOME': '/home/cltbld', 05:18:07 INFO - 'LANG': 'en_US.UTF-8', 05:18:07 INFO - 'LANGUAGE': 'en_US:en', 05:18:07 INFO - 'LOGNAME': 'cltbld', 05:18:07 INFO - 'MAIL': '/var/mail/cltbld', 05:18:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:18:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:18:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:07 INFO - 'MOZ_NO_REMOTE': '1', 05:18:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:18:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:07 INFO - 'NO_EM_RESTART': '1', 05:18:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:07 INFO - 'PWD': '/builds/slave/test', 05:18:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:18:07 INFO - 'SHELL': '/bin/bash', 05:18:07 INFO - 'SHLVL': '1', 05:18:07 INFO - 'TERM': 'linux', 05:18:07 INFO - 'TMOUT': '86400', 05:18:07 INFO - 'USER': 'cltbld', 05:18:07 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467116051.559059-1093339788', 05:18:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:07 INFO - '_': '/tools/buildbot/bin/python'} 05:18:07 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/CNNwy5leRmWazIi41CW1Bg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 05:18:08 INFO - mozversion application_buildid: 20160628023022 05:18:08 INFO - mozversion application_changeset: 4db7a29c60ddf136d49d24d901c93b4acdfe664a 05:18:08 INFO - mozversion application_display_name: Nightly 05:18:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:18:08 INFO - mozversion application_name: Firefox 05:18:08 INFO - mozversion application_remotingname: firefox 05:18:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:18:08 INFO - mozversion application_vendor: Mozilla 05:18:08 INFO - mozversion application_version: 50.0a1 05:18:08 INFO - mozversion platform_buildid: 20160628023022 05:18:08 INFO - mozversion platform_changeset: 4db7a29c60ddf136d49d24d901c93b4acdfe664a 05:18:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:18:08 INFO - mozversion platform_version: 50.0a1 05:18:08 INFO - using testdate: 1467116288 05:18:08 INFO - actual date: 1467116288 05:18:08 INFO - starting webserver on 'localhost:43080' 05:18:08 INFO - SUITE-START | Running 2 tests 05:18:08 INFO - TEST-START | dromaeo_css 05:18:08 INFO - operating with platform_type : linux_ 05:18:08 INFO - Initialising browser for dromaeo_css test... 05:18:08 INFO - TEST-INFO | started process 3335 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY9raws/profile http://localhost:43080/getInfo.html) 05:18:15 INFO - PROCESS | 3335 | __metrics Screen width/height:1600/1200 05:18:15 INFO - PROCESS | 3335 | colorDepth:24 05:18:15 INFO - PROCESS | 3335 | Browser inner width/height: 1024/697 05:18:15 INFO - PROCESS | 3335 | __metrics 05:18:16 INFO - PROCESS | 3335 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:18:17 INFO - TEST-INFO | 3335: exit 0 05:18:17 INFO - Browser initialized. 05:18:17 INFO - Running cycle 1/1 for dromaeo_css test... 05:18:17 INFO - TEST-INFO | started process 3451 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY9raws/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:18:29 INFO - PROCESS | 3451 | RSS: Main: 174788608 05:18:29 INFO - PROCESS | 3451 | 05:19:20 INFO - PROCESS | 3451 | 1467116360027 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] 05:21:29 INFO - PROCESS | 3451 | Cycle 1(1): loaded http://localhost:43080/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43080/tests/dromaeo/cssquery-ext.html) 05:21:30 INFO - PROCESS | 3451 | RSS: Main: 312360960 05:21:30 INFO - PROCESS | 3451 | 05:24:32 INFO - PROCESS | 3451 | Cycle 1(1): loaded http://localhost:43080/tests/dromaeo/cssquery-ext.html (next: http://localhost:43080/tests/dromaeo/cssquery-jquery.html) 05:24:33 INFO - PROCESS | 3451 | RSS: Main: 263196672 05:24:33 INFO - PROCESS | 3451 | 05:27:35 INFO - PROCESS | 3451 | Cycle 1(1): loaded http://localhost:43080/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43080/tests/dromaeo/cssquery-mootools.html) 05:27:35 INFO - PROCESS | 3451 | RSS: Main: 257581056 05:27:35 INFO - PROCESS | 3451 | 05:30:37 INFO - PROCESS | 3451 | Cycle 1(1): loaded http://localhost:43080/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43080/tests/dromaeo/cssquery-prototype.html) 05:30:38 INFO - PROCESS | 3451 | RSS: Main: 250527744 05:30:38 INFO - PROCESS | 3451 | 05:33:40 INFO - PROCESS | 3451 | Cycle 1(1): loaded http://localhost:43080/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43080/tests/dromaeo/cssquery-yui.html) 05:33:41 INFO - PROCESS | 3451 | RSS: Main: 248877056 05:33:41 INFO - PROCESS | 3451 | 05:36:43 INFO - PROCESS | 3451 | Cycle 1(1): loaded http://localhost:43080/tests/dromaeo/cssquery-yui.html (next: http://localhost:43080/tests/dromaeo/cssquery-dojo.html) 05:36:44 INFO - PROCESS | 3451 | RSS: Main: 293732352 05:36:44 INFO - PROCESS | 3451 | 05:36:44 INFO - PROCESS | 3451 | __start_tp_report 05:36:44 INFO - PROCESS | 3451 | _x_x_mozilla_page_load 05:36:44 INFO - PROCESS | 3451 | _x_x_mozilla_page_load_details 05:36:44 INFO - PROCESS | 3451 | |i|pagename|runs| 05:36:44 INFO - PROCESS | 3451 | |0;dojo.html;3133.185371803331;3145.2923092304236;3155.6528781833995;3174.6349169845475;3202.4075546023973;5297.735113244342;5389.73051347432;5396.541293990011;5461.208124821898;5520.861978450535;5362.0616392131315;5370.03339398909;5386.380566234884;5400.91898621521;5437.592180586462;4759.547842954914;4896.1186986342445;4899.975500122495;4905.215165573509;5070.670406423589;4961.652684312099;5018.071656743514;5030.874228144307;5046.3187469691675;5052.823151189709;4790.305405716186;4817.807287708488;4885.316055752198;4950.4059512858685;4952.059108769322;4826.638002149853;4840.177169881129;4844;4912.803487860481;4973.079980203674;4883.975580122076;4914.778834952435;4916.287138364917;4954.380702412199;4979.4771548987555;5292.047431462335;5296.205569164617;5321;5422.566194704415;5423.078076726966;5716.914246286309;5759;5767.423257674241;5767.480926716574;5774.220480235199;5786.652800831964;5801.7389217485315;5825.242718446617;5838.620489668158;5843.152742852305;5280;5441.727913604304;5445.591580631469;5515.283013208257;5516.613837031369;6051.606645568024;6061.239939437416;6067.334066776581;6070.659478472913;6114.571979961449;5806.738696758656;5860.677662728505;5863.853403664857;5866.530677545786;5871.383504732027;5697.173909783059;5718.485336319751;5732.656040637575;5740.655560666373;5790.36306006339;5767.192593036978;5771.913421298684;5774.451427114417;5774.740136693859;5775.047117225695;5651.745671444713;5728.083506638918;5754.74103665336;5779.682117483495;5779.826605201851;4290.699651024461;4335.848245311462;4359.237133501688;4368.7815609219415;4381.21138195128;3884.0678237222864;3893.7079719021185;3903.434002069684;3934.8622798201927;3939.054626889526;5326.840194794162;5417.783288668409;5425.213344065089;5426;5432.1580155075235;5733.0540460823495;5795.797147099831;5807.912881306784;5821.2141360916585;5846.824595262149;5512.062949298629;5532.806351777668;5534.08687566547;5536.833894983157;5538.833834984957;4929.482404347564;4966.726830024383;5046.899062018739;5051.444341122474;5090.516400941905;5971.701414929236;6043.939560604514;6049.153118563405;6052.546059045501;6106.358832322631;5839.124131380327;5851.707414629337;5852.092925596539;5853;5854.4730974212525;5751.079827227623;5812.593118481665;5912.231409916683;6038.69806509664;6042.1540984261355;5674.517665998271;5680.715964201856;5683.5453163747625;5731.3408957968695;5732.512736417451;5722.828315150552;5730.598858079894;5757.913631295618;5770.855728606818;5785.56608254391;5503.559715222693;5569.470900264469;5578.665280083208;5640.943590564042;5668.631538949955;5575;5627.831165065055;5635.520980716685;5672.744726487235;5673.404292549223;5527.8894422112135;5530.668159910419;5532.391436942014;5538.058530049821;5538.584606154474;5512.228288039758;5568.16477528374;5651.491365777099;5696.658200507983;5708.54331653475;5485.506304432461;5542.695151766691;5542.722863856871;5564.944350556442;5568.248286481273 05:36:44 INFO - PROCESS | 3451 | |1;ext.html;557.7741014888971;588.485075558886;596.9044952807552;601.5999360425318;621.5121129913018;28973.826962977757;29599.26001849955;29667.703322966765;29690.10929672108;35530.2893942121;37092;37877.053073673174;37945;37966.81016594913;37987.430188547194;8519.659213631447;8687.391882568223;8688.435251708619;8691.56542172892;8700.086490918457;8425.747227583182;8535.615897284637;8536.402451828344;8537.701180458685;8541.487510749344;8557.614907329185;8586.656533738644;8589.95705021474;8593.742187734346;8596.355273354524;8494.490330580154;8501.107383724682;8506.362022848249;8532.914670853273;8534.487930724177;8555.657773689045;8608.311335093178;8624.525651089187;8635.352348573882;8637.913620863774;36149.81925090358;36392.45411318832;36438.63561364405;36457.81771091154;36496.81751591252;3171.5559821624993;3292.6048874135017;3325.152086217999;3379.020084175586;3485.6688614581576;29114.563281550792;29271;29521.409571808657;29557.70442295571;29737.40525189484;4253.3619957006695;4406.801693923781;4410.140022695576;4438.755868427235;4486.147631949919;240077;240361;241030;241491;241602;58161.70919145462;58424.41575584275;58435.415645843845;58466.70766646139;58667.70666146727;35750.8212458936;36855.26289474249;36904.26191476209;38405;38449.42325865114;17551.122443877754;17636.38272660451;17645.470635880945;17749.467515974542;17759.644807103785;12772.169808962388;12818;12819.487220511262;12823.679408014688;12824.23054616726;16965.575860603585;17079.65840683204;17112.14439278056;17117.400890968755;17194.1402929853;7010.263922288188;7112.182099058571;7130.360017196074;7190;7277.963610181915;993.2699465892563;1000.6297669862198;1040.54216144896;1084.0622861224983;1094.9124070074374;32023.839880800446;33628.49557256643;33734;35199.82400087983;35483.82258088745;1060.2578195263347;1078.9190810689229;1115.4478533126155;1168.1881092640704;1194.9283043017274;14883.553493395215;15330.080195188324;15406.845931540542;15529.922350388175;15649.217539122998;510321;513786;514401;514718;514804;58319.125213121835;58544.56009838914;59026.40973590295;59346;59347;1236.2953116723381;1335.8998075144402;1346.7508510925313;1368.2337890781193;1382.709630977506;29211.85394073016;33171.66828331686;33345.28826324694;33428.1642958928;33825.77177852768;48850.511494884595;49873;49898.5091341781;49964.500354997435;49973;421037;425617;425618;426707;428791;24579.385515361544;26473.602895956963;27560.448791024468;27594.448111037265;27756;46522.30216546822;46613;47213.52786472091;47885;47980.760096199294;39503.2099358017;39786.40320395254;40171;40565;41213.175736485704;39928.800355998035;40460;40900.38649420321;40989.38515922204;41174.58825411707;39664.60335396609;39777.80111099426;40580.3912941312;40799.79600101981;40846.79576602098;34445.48331774975;35529.46705799467;35838.64161358353;36127.27745445129;36162;24386;24505.632415514137;24756.38109047288;25024.74975250297;25030.62454063154 05:36:44 INFO - PROCESS | 3451 | |2;jquery.html;374.3093991585525;376.5970411659525;376.9472273881657;384.13761106316286;391.35426546198784;16816;18771.906140469313;18826.246950121997;19832.504187395323;19856.20575176993;10925.890741092586;11014.724631884206;11111.499982500787;11166.497507612157;11235.606753763619;4638.489766125724;5728.283964504437;5729.713514324288;5734.713264336788;5739.540836733072;5479.671219726809;5592.384837667853;5669.433056694318;5678.971605141989;5682;5623.8594035149035;5631.352394474627;5644.266245388114;5658.377578466386;5659.462351076641;5239.21411788231;5246.606504512139;5649.830505084834;5650.039493286131;5650.406707295716;5068.670536415121;5082.542571168613;5089.898202035975;5095.159298715707;5109.9489005109845;13072.08495405322;13137.60587182386;21032.474188145265;22431.775682243133;22447.326580202458;2312.236961802601;2449.2284930246915;2579.7162312145647;2696.7438093381097;3025.3646734185845;10149.949250253701;10510.369377837354;10513.684589462327;12595.370231488389;13559.728805423934;1935.9709604355946;2009.447401964457;2009.4976255936017;2034.745656792901;2064.215598072723;64185;75616.24383756203;76003.23996760017;76343.23656763417;77534.22465775326;10457.424841633783;10500.894991050145;10554.833549935141;10752.301100428447;10988.450577471094;14189;14423.206723630092;14429.35067921946;14474.565763027125;14490.130592164503;8237.423380363318;8305.916940830635;8311.750647480585;8422.157784221652;8490.745277641681;8079.232472915063;8150.736635821457;8273.1726827318;8326.916730832736;8347.54088525137;4654.930176047362;4745;4754.429468463806;4756.025014871943;4847.660663753574;1904.7904730479636;1922.8173323534243;1957.471482699663;1962.8625996180415;1974.2695202775064;839.2572573272697;917.8623206518942;943.0710749911332;950.4392408479031;958.1424624960761;17020.829791702174;17550.473485795446;18197.3622373987;18269.360572379905;19293.614127717367;909.3134683314056;961.6393852305386;965.1313817564109;991.1575161113141;1015.7359086637528;10149.746256343502;10589.417582032907;10748.623798167027;10938.890611093788;10945.671629851116;391547;393672;393674;519693;560234.3742188356;61594.38405615976;87618.56190719006;98374.50812746033;99507.50246248723;101480;1025.8461230815437;1027.6505987964129;1046.220565678559;1059.2003037706481;1061.8141825180562;17354.479365619052;17682.469525914243;18032.36886708959;18068.728969065738;18329.541761456072;39531.80234098811;41551.85859110991;42338.364924525544;42352.1529569413;43902.56097439113;57657.711711442855;58504.4149558516;59447.40552594419;59515.40484595272;59707.10439343326;8157.75526734199;8309.626066827128;8425.620847061775;8539.957300213458;8544.359173061921;8942.73171804847;13669.589912302647;13683.931580342034;13862.584122476343;13965.3715582797;5187.066328060834;8654.48073115615;11437.485313161094;11647.30116193031;11774.882251177378;11730.941345293219;11949;12030.458629361525;12045.578404755792;12107.636770896886;11623.709407264885;12010.879891200977;12017.579384721494;12296.508139674313;12424.813627795409;8664.78338041554;8678.652853886026;8806.295496360404;8812.289097947996;8895.154960278764;8679.045305016316;10746.408947507649;11312.547498099984;11446.82829757571;11669.241499302518 05:36:44 INFO - PROCESS | 3451 | |3;mootools.html;1107.545906178467;1216.9209001414908;1230.34791560473;1239.6652903715994;1438.5252866554038;8165.305948994335;8600.182982616649;8601.827963440728;8807.07525709801;8845.557722113901;8565.957170214157;8685.652573897052;8722.65109395625;8742.650293988248;8746.956265218665;1986.0864002558767;2185.366243789307;2310.630299152136;2313.710786151731;2335.4044718596733;2350.882455877208;2354.1407386303963;2361.1853910400882;2361.208994986673;2364.3498038039506;2244.9102035918545;2255.5037891663806;2275.590393729128;2277.237125562938;2278.6695929090274;1951.9902400487977;2027.5032617008853;2159.4817243861517;2195.5938151441956;2225.376894469551;2256.0637335505744;2270.738865030526;2274.54509098181;2275.5107651854933;2276.3853759484846;8714.172153645393;8757.211850933383;8762.912370876336;8777;8782.165694259034;5051.090803655341;5177.352830896138;5185.299984502081;5186.273921650972;5187.48125187482;3061.234691327168;3169.1760142362923;3180.761442891769;3223.5003574446;3242.1732458223237;1112.3937454087543;1119.9608013719562;1136.891995260449;1140.378493720924;1146.6273461125168;12692.746145077139;12756.936215318958;12778.361081945866;12779.23324600527;12807.807882881763;4667.346571479996;4712.293156026555;4713.175194340976;4814.494478079751;4846.588040016568;10605.25763196569;10617.469126543641;10657.893421065844;10676.252662313718;10715.517801698943;5256.9737151314;5265.341832270966;5269.1569348903995;5273.499017593323;5276.234945932818;4328.783560822009;4701.976490117528;4865.95134048662;4911.87720306988;4973.950260497421;3940.645341919241;3990.840366385312;4081.6530594899173;4097.13960068383;4119.876403707894;1260.615512268767;1279.2644229568036;1282.3075539208724;1290.619267316144;1296.461968283152;833.2500749325534;923.9907600923905;940.520334629344;949.2832911152036;974.2011550528499;5999.4101563085815;6002.459778619946;6005.519558435402;6024.909626355608;6286.779962701284;452.58362306677935;456.8812108851656;459.69660024383745;461.65375968023983;465.15806390433426;3858.8649397271524;4006.0786019215743;4127.5666055064385;4164.250434921682;4219.767912764827;10909.127269818395;11116.166287528467;11233.269837460539;11345.829812552818;11349.262297950772;11126.61056863006;11137.331760094421;11160.832587511193;11164.330140191614;11171.16216283782;7945.682172713026;8285.62714677841;8320.209580090002;8368.748937531884;8383.077861435237;5845.590808643354;5946.494547963472;5963.105534169909;6077.24034495688;6095.891095541395;10585.100266477435;10773.084287835622;10778.784424311627;10780.083692886192;10780.676579702622;10119.949400252952;10372.792544148924;10839.620613278497;10839.783204335712;10869.239153259512;7141.143062832493;7463.469988652205;7671.2712292332135;7726.343260822893;7917.445778795429;8627.95686021566;8645.351598630003;8669.306455483673;8762.386632935888;8780.912190878009;7600.42996775233;7846.607669616382;7875.054993400829;7892.644830982735;7948.165442628672;7557.319841214317;7578.734744284144;7645.961770191114;7770.611469426393;7780.533168009937;6768.4585233182215;6782.898256526255;6804.6257455840405;6812.625305608239;6836.863262734817;4753.239481682914;4792.616590672668;4864.489228630943;4879.438864530624;4940.2342636891335;4727.976360118178;4860.513948605253;4861.611071114373;4947.307376967299;4975.527324904128 05:36:44 INFO - PROCESS | 3451 | |4;prototype.html;296.54628418519667;299.33248855053233;307.09254153975;309.6995913963456;312.369014590527;5283.177303830177;5314.5748340132795;5343.599230057742;5350.839474815752;5360.517553420192;5266.367426097912;5270.5520030797425;5301.1783173608055;5306.885554033648;5309.681419114856;4098.303288440958;4135.8759237222785;4139.917201655965;4141.9378709319235;4161.105362347094;3983.223271462066;4156.521999969997;4165.875023749292;4171.165766846628;4177.310743727281;4075.8587595473314;4114.691398145136;4119.237940980913;4130.876073717794;4146.854860079898;3876.9030774230587;4051.650042975067;4059.147579008412;4060.1473690525027;4158.043649960496;3491.790492570454;3620.674139327447;3622.4023036198996;3625.0574850538787;3628.5827129880136;5012.949870501321;5059.822906198302;5160.354955630546;5165.431802501722;5168.9741551292;4469.865904022852;4552.655382478027;4673.6027437667835;4675.298705194214;4681.618922417895;5470.908936450933;5485.670859748388;5489.298317521581;5531.446855314477;5535.889282214373;4006.419069234974;4019.789115986196;4024.6176613221696;4028.113814960704;4034.850067730712;5562.7774889004795;5720.685362305072;5748.223989761371;5786.710664466802;5797.826065218008;4064.8170832312617;4068.7965601719798;4085.611866872642;4095.9590404096175;4103.199876024147;4142.08874047709;4142.937855932163;4144.544100148981;4158.958410415918;4160.625543701081;4583.885402864888;4610.76946152691;4714.81140754366;4722.7874745635845;4724.472407262098;5465.207544906046;5498.917516237259;5510.972445137749;5513.696746678891;5563.610547261734;1390.9652258693613;1422.871941525247;1424.230915305744;1431.6206205355588;1432.596055865258;899.6491368366343;913.488446469979;916.7845556294266;929.8140371925507;936.5036530638772;4698.788554515055;4710.5760481556135;4737.810487580458;4760.547747963938;4773.284007398918;4942.8764280893265;5000.64995450315;5006.799728010911;5018.874528136753;5060.836007718245;4708.599769019672;4750.976245118822;4814.325994360793;4854.514548545118;4992.201247800334;2866.7959457028096;2960.718731720483;2961.8074825136296;3028.530577760451;3033.4388138194504;5771.509421699118;5803.738831752581;5816.476517113396;5821.243238378984;5835.737391817378;5580.469855363734;5647.136444973149;5737.627054241544;5766.481016708516;5778.971105144447;5751.4823665869435;5753.798617048467;5771.249737534094;5804.564657650609;5816.76732930678;5608.439156084522;5623.409541998031;5637.02704053578;5694.259746232963;5702.45826646468;5400.459954004568;5619.831405057855;5637.605367624391;5637.842808027518;5642.319898048394;5786.971065144648;5859;5860.8571328592225;5861.6189947653265;5882.470557655126;3940.665043471337;3957.92084158321;3965.40518922164;3966.504186976628;3975.8409663613133;5417.51242388187;5649.870025994735;5675.517581005495;5681.715914204191;5701.771929122789;5414.3232095988005;5518.172274158908;5532.3637781655625;5538.6399884007415;5545.390007099297;5326.866828329323;5336.466353364633;5410.188471729272;5472.589555783412;5473.397926228032;5370.677759334452;5408.513233808819;5417.214503896834;5440.619156658996;5447.155690867922;5396.64921780083;5436.700981446058;5515.25544051564;5531.308586426697;5548.4174161712435;5240.213967904845;5345.1714984177515;5345.839624811262;5358.7674834788995;5360.839174824761 05:36:44 INFO - PROCESS | 3451 | |5;yui.html;625.7590827531401;643.4369926314475;656.8850451171045;661.5237029338874;681.3935597318384;13638.522651707191;14629;14640.633984150389;15083.170425626586;16044.679106417865;15743.527694169165;16356.263968121433;16501.0924399158;16537.090460024694;16538.66922661546;638.0206383201786;772.7025095338307;818.5129847740615;819.9672013119483;825.5872063968015;819.1726356380069;819.9918000819976;822.3339095332769;823.1768231768232;823.505896462121;849.3969281809923;850.0606829453427;850.3707256630111;851.5188918261163;851.5231470376578;666.7932940788347;795.7254747112266;836.7029704454952;839.7270886961762;844.6621351459404;614.0482252508639;614.1402037147984;614.8155553333982;614.9852742974084;614.9907751383732;13601.183928964196;13680.452781888713;13685;13730.970177236748;13856.584302470941;11801.173917825756;12288.877111228863;12912;13035.15271507349;13061.542846000439;11026.44867756609;11932.880671193263;12009.93995030028;12100.031997440183;12102.152849300552;4309.482862056542;4355.73865568067;4400.09797991411;4416.514183439819;4524.140413321458;74496;75303;75396.62301688512;76903.6154819228;77327.6133619334;9518;9522.476263805418;9594.328397012143;9725.367851089657;9943.950280248697;16264.430744923871;16283.511494655178;16318.918405408134;16364.018158910503;16474.58813529671;7559.357454616419;7560.735374261874;7584.81037974044;7911.248431399008;7970.84058318842;4483.293669206198;4538.931916021263;4539.500654927955;4601.562851529099;4618.214903466419;3301.323228738103;3342.364950659367;3425.3663072331697;3427.6572342765526;3430.091025878144;580.135597959038;584.5323741007177;585.8652509922741;594.5273507561499;600.9969950150221;607.259143844509;611.5260672978477;616.4236438929615;622.5797586629097;635.9141515895295;8428.704995325133;8446.873296900552;8574.314054875595;8600.440971336968;8811.515366654896;563.8026690658237;594.381842883405;601.9217501724835;608.9756409743561;635.9951276982449;4135;4403.911921761547;4432.601065904019;4433.933490997638;4485.753283569435;112116;113283;115345.4232728831;116686.41656791832;117361;97763;98540.50729746449;100998.49500752595;101768.66831140031;101865;54701.90596188133;70202.29797701958;83751.58124209462;86271;88750.55624721835;8256.380771442286;8292.380838227627;8336.249737523653;8408.495490270603;8499.660013599387;49024.2646360312;50305.74847125741;50460;50885.74557127191;51042.48957510526;69549.65225173841;69956;76777;78470;79122;11146.49840757184;11235.438228088726;11327.830082548933;11556.653300401002;11643.76712465729;9657.420554766737;12157.81763273534;12458.875411246134;12462.052742354836;12597.496100156257;11391.145664075062;11497.770044598894;11687.18189726745;12356.25862448256;12428.689282767642;12485;12496.375181241083;12547.623571292876;12569.162121963313;12692.111552191258;12039.879601203877;12048.337341446304;12049.156559041134;12118.091143164122;12532;10873.891261087289;11047.116230701364;11261;11378.829317560077;11598.789760738775;10269.332493387907;10537.104346130665;10553.155747540024;10560.10239129652;10585.682429527127 05:36:44 INFO - PROCESS | 3451 | __end_tp_report 05:36:44 INFO - PROCESS | 3451 | __start_cc_report 05:36:44 INFO - PROCESS | 3451 | _x_x_mozilla_cycle_collect,1075 05:36:44 INFO - PROCESS | 3451 | __end_cc_report 05:36:44 INFO - PROCESS | 3451 | __startTimestamp1467117404094__endTimestamp 05:36:44 INFO - PROCESS | 3451 | 05:36:44 INFO - PROCESS | 3451 | ------- Summary: start ------- 05:36:44 INFO - PROCESS | 3451 | Number of tests: 6 05:36:44 INFO - PROCESS | 3451 | 05:36:44 INFO - PROCESS | 3451 | [#0] dojo.html Cycles:165 Average:5373.59 Median:5538.83 stddev:616.69 (11.1%) stddev-sans-first:593.00 05:36:44 INFO - PROCESS | 3451 | Values: 3133.2 3145.3 3155.7 3174.6 3202.4 5297.7 5389.7 5396.5 5461.2 5520.9 5362.1 5370.0 5386.4 5400.9 5437.6 4759.5 4896.1 4900.0 4905.2 5070.7 4961.7 5018.1 5030.9 5046.3 5052.8 4790.3 4817.8 4885.3 4950.4 4952.1 4826.6 4840.2 4844.0 4912.8 4973.1 4884.0 4914.8 4916.3 4954.4 4979.5 5292.0 5296.2 5321.0 5422.6 5423.1 5716.9 5759.0 5767.4 5767.5 5774.2 5786.7 5801.7 5825.2 5838.6 5843.2 5280.0 5441.7 5445.6 5515.3 5516.6 6051.6 6061.2 6067.3 6070.7 6114.6 5806.7 5860.7 5863.9 5866.5 5871.4 5697.2 5718.5 5732.7 5740.7 5790.4 5767.2 5771.9 5774.5 5774.7 5775.0 5651.7 5728.1 5754.7 5779.7 5779.8 4290.7 4335.8 4359.2 4368.8 4381.2 3884.1 3893.7 3903.4 3934.9 3939.1 5326.8 5417.8 5425.2 5426.0 5432.2 5733.1 5795.8 5807.9 5821.2 5846.8 5512.1 5532.8 5534.1 5536.8 5538.8 4929.5 4966.7 5046.9 5051.4 5090.5 5971.7 6043.9 6049.2 6052.5 6106.4 5839.1 5851.7 5852.1 5853.0 5854.5 5751.1 5812.6 5912.2 6038.7 6042.2 5674.5 5680.7 5683.5 5731.3 5732.5 5722.8 5730.6 5757.9 5770.9 5785.6 5503.6 5569.5 5578.7 5640.9 5668.6 5575.0 5627.8 5635.5 5672.7 5673.4 5527.9 5530.7 5532.4 5538.1 5538.6 5512.2 5568.2 5651.5 5696.7 5708.5 5485.5 5542.7 5542.7 5564.9 5568.2 05:36:44 INFO - PROCESS | 3451 | 05:36:44 INFO - PROCESS | 3451 | [#1] ext.html Cycles:180 Average:54604.53 Median:37977.12 stddev:108870.23 (286.7%) stddev-sans-first:109100.02 05:36:44 INFO - PROCESS | 3451 | Values: 557.8 588.5 596.9 601.6 621.5 28973.8 29599.3 29667.7 29690.1 35530.3 37092.0 37877.1 37945.0 37966.8 37987.4 8519.7 8687.4 8688.4 8691.6 8700.1 8425.7 8535.6 8536.4 8537.7 8541.5 8557.6 8586.7 8590.0 8593.7 8596.4 8494.5 8501.1 8506.4 8532.9 8534.5 8555.7 8608.3 8624.5 8635.4 8637.9 36149.8 36392.5 36438.6 36457.8 36496.8 3171.6 3292.6 3325.2 3379.0 3485.7 29114.6 29271.0 29521.4 29557.7 29737.4 4253.4 4406.8 4410.1 4438.8 4486.1 240077.0 240361.0 241030.0 241491.0 241602.0 58161.7 58424.4 58435.4 58466.7 58667.7 35750.8 36855.3 36904.3 38405.0 38449.4 17551.1 17636.4 17645.5 17749.5 17759.6 12772.2 12818.0 12819.5 12823.7 12824.2 16965.6 17079.7 17112.1 17117.4 17194.1 7010.3 7112.2 7130.4 7190.0 7278.0 993.3 1000.6 1040.5 1084.1 1094.9 32023.8 33628.5 33734.0 35199.8 35483.8 1060.3 1078.9 1115.4 1168.2 1194.9 14883.6 15330.1 15406.8 15529.9 15649.2 510321.0 513786.0 514401.0 514718.0 514804.0 58319.1 58544.6 59026.4 59346.0 59347.0 1236.3 1335.9 1346.8 1368.2 1382.7 29211.9 33171.7 33345.3 33428.2 33825.8 48850.5 49873.0 49898.5 49964.5 49973.0 421037.0 425617.0 425618.0 426707.0 428791.0 24579.4 26473.6 27560.4 27594.4 27756.0 46522.3 46613.0 47213.5 47885.0 47980.8 39503.2 39786.4 40171.0 40565.0 41213.2 39928.8 40460.0 40900.4 40989.4 41174.6 39664.6 39777.8 40580.4 40799.8 40846.8 34445.5 35529.5 35838.6 36127.3 36162.0 24386.0 24505.6 24756.4 25024.7 25030.6 05:36:44 INFO - PROCESS | 3451 | 05:36:44 INFO - PROCESS | 3451 | [#2] jquery.html Cycles:180 Average:27248.16 Median:380.54 stddev:75656.53 (19881.2%) stddev-sans-first:75841.86 05:36:44 INFO - PROCESS | 3451 | Values: 374.3 376.6 376.9 384.1 391.4 16816.0 18771.9 18826.2 19832.5 19856.2 10925.9 11014.7 11111.5 11166.5 11235.6 4638.5 5728.3 5729.7 5734.7 5739.5 5479.7 5592.4 5669.4 5679.0 5682.0 5623.9 5631.4 5644.3 5658.4 5659.5 5239.2 5246.6 5649.8 5650.0 5650.4 5068.7 5082.5 5089.9 5095.2 5109.9 13072.1 13137.6 21032.5 22431.8 22447.3 2312.2 2449.2 2579.7 2696.7 3025.4 10149.9 10510.4 10513.7 12595.4 13559.7 1936.0 2009.4 2009.5 2034.7 2064.2 64185.0 75616.2 76003.2 76343.2 77534.2 10457.4 10500.9 10554.8 10752.3 10988.5 14189.0 14423.2 14429.4 14474.6 14490.1 8237.4 8305.9 8311.8 8422.2 8490.7 8079.2 8150.7 8273.2 8326.9 8347.5 4654.9 4745.0 4754.4 4756.0 4847.7 1904.8 1922.8 1957.5 1962.9 1974.3 839.3 917.9 943.1 950.4 958.1 17020.8 17550.5 18197.4 18269.4 19293.6 909.3 961.6 965.1 991.2 1015.7 10149.7 10589.4 10748.6 10938.9 10945.7 391547.0 393672.0 393674.0 519693.0 560234.4 61594.4 87618.6 98374.5 99507.5 101480.0 1025.8 1027.7 1046.2 1059.2 1061.8 17354.5 17682.5 18032.4 18068.7 18329.5 39531.8 41551.9 42338.4 42352.2 43902.6 57657.7 58504.4 59447.4 59515.4 59707.1 8157.8 8309.6 8425.6 8540.0 8544.4 8942.7 13669.6 13683.9 13862.6 13965.4 5187.1 8654.5 11437.5 11647.3 11774.9 11730.9 11949.0 12030.5 12045.6 12107.6 11623.7 12010.9 12017.6 12296.5 12424.8 8664.8 8678.7 8806.3 8812.3 8895.2 8679.0 10746.4 11312.5 11446.8 11669.2 05:36:44 INFO - PROCESS | 3451 | 05:36:44 INFO - PROCESS | 3451 | [#3] mootools.html Cycles:180 Average:5813.39 Median:2566.25 stddev:3445.82 (134.3%) stddev-sans-first:3437.33 05:36:44 INFO - PROCESS | 3451 | Values: 1107.5 1216.9 1230.3 1239.7 1438.5 8165.3 8600.2 8601.8 8807.1 8845.6 8566.0 8685.7 8722.7 8742.7 8747.0 1986.1 2185.4 2310.6 2313.7 2335.4 2350.9 2354.1 2361.2 2361.2 2364.3 2244.9 2255.5 2275.6 2277.2 2278.7 1952.0 2027.5 2159.5 2195.6 2225.4 2256.1 2270.7 2274.5 2275.5 2276.4 8714.2 8757.2 8762.9 8777.0 8782.2 5051.1 5177.4 5185.3 5186.3 5187.5 3061.2 3169.2 3180.8 3223.5 3242.2 1112.4 1120.0 1136.9 1140.4 1146.6 12692.7 12756.9 12778.4 12779.2 12807.8 4667.3 4712.3 4713.2 4814.5 4846.6 10605.3 10617.5 10657.9 10676.3 10715.5 5257.0 5265.3 5269.2 5273.5 5276.2 4328.8 4702.0 4866.0 4911.9 4974.0 3940.6 3990.8 4081.7 4097.1 4119.9 1260.6 1279.3 1282.3 1290.6 1296.5 833.3 924.0 940.5 949.3 974.2 5999.4 6002.5 6005.5 6024.9 6286.8 452.6 456.9 459.7 461.7 465.2 3858.9 4006.1 4127.6 4164.3 4219.8 10909.1 11116.2 11233.3 11345.8 11349.3 11126.6 11137.3 11160.8 11164.3 11171.2 7945.7 8285.6 8320.2 8368.7 8383.1 5845.6 5946.5 5963.1 6077.2 6095.9 10585.1 10773.1 10778.8 10780.1 10780.7 10119.9 10372.8 10839.6 10839.8 10869.2 7141.1 7463.5 7671.3 7726.3 7917.4 8628.0 8645.4 8669.3 8762.4 8780.9 7600.4 7846.6 7875.1 7892.6 7948.2 7557.3 7578.7 7646.0 7770.6 7780.5 6768.5 6782.9 6804.6 6812.6 6836.9 4753.2 4792.6 4864.5 4879.4 4940.2 4728.0 4860.5 4861.6 4947.3 4975.5 05:36:44 INFO - PROCESS | 3451 | 05:36:44 INFO - PROCESS | 3451 | [#4] prototype.html Cycles:180 Average:4592.47 Median:5253.29 stddev:1344.36 (25.6%) stddev-sans-first:1308.89 05:36:44 INFO - PROCESS | 3451 | Values: 296.5 299.3 307.1 309.7 312.4 5283.2 5314.6 5343.6 5350.8 5360.5 5266.4 5270.6 5301.2 5306.9 5309.7 4098.3 4135.9 4139.9 4141.9 4161.1 3983.2 4156.5 4165.9 4171.2 4177.3 4075.9 4114.7 4119.2 4130.9 4146.9 3876.9 4051.7 4059.1 4060.1 4158.0 3491.8 3620.7 3622.4 3625.1 3628.6 5012.9 5059.8 5160.4 5165.4 5169.0 4469.9 4552.7 4673.6 4675.3 4681.6 5470.9 5485.7 5489.3 5531.4 5535.9 4006.4 4019.8 4024.6 4028.1 4034.9 5562.8 5720.7 5748.2 5786.7 5797.8 4064.8 4068.8 4085.6 4096.0 4103.2 4142.1 4142.9 4144.5 4159.0 4160.6 4583.9 4610.8 4714.8 4722.8 4724.5 5465.2 5498.9 5511.0 5513.7 5563.6 1391.0 1422.9 1424.2 1431.6 1432.6 899.6 913.5 916.8 929.8 936.5 4698.8 4710.6 4737.8 4760.5 4773.3 4942.9 5000.6 5006.8 5018.9 5060.8 4708.6 4751.0 4814.3 4854.5 4992.2 2866.8 2960.7 2961.8 3028.5 3033.4 5771.5 5803.7 5816.5 5821.2 5835.7 5580.5 5647.1 5737.6 5766.5 5779.0 5751.5 5753.8 5771.2 5804.6 5816.8 5608.4 5623.4 5637.0 5694.3 5702.5 5400.5 5619.8 5637.6 5637.8 5642.3 5787.0 5859.0 5860.9 5861.6 5882.5 3940.7 3957.9 3965.4 3966.5 3975.8 5417.5 5649.9 5675.5 5681.7 5701.8 5414.3 5518.2 5532.4 5538.6 5545.4 5326.9 5336.5 5410.2 5472.6 5473.4 5370.7 5408.5 5417.2 5440.6 5447.2 5396.6 5436.7 5515.3 5531.3 5548.4 5240.2 5345.2 5345.8 5358.8 5360.8 05:36:44 INFO - PROCESS | 3451 | 05:36:44 INFO - PROCESS | 3451 | [#5] yui.html Cycles:180 Average:19929.29 Median:4609.89 stddev:29655.25 (643.3%) stddev-sans-first:29703.02 05:36:44 INFO - PROCESS | 3451 | Values: 625.8 643.4 656.9 661.5 681.4 13638.5 14629.0 14640.6 15083.2 16044.7 15743.5 16356.3 16501.1 16537.1 16538.7 638.0 772.7 818.5 820.0 825.6 819.2 820.0 822.3 823.2 823.5 849.4 850.1 850.4 851.5 851.5 666.8 795.7 836.7 839.7 844.7 614.0 614.1 614.8 615.0 615.0 13601.2 13680.5 13685.0 13731.0 13856.6 11801.2 12288.9 12912.0 13035.2 13061.5 11026.4 11932.9 12009.9 12100.0 12102.2 4309.5 4355.7 4400.1 4416.5 4524.1 74496.0 75303.0 75396.6 76903.6 77327.6 9518.0 9522.5 9594.3 9725.4 9944.0 16264.4 16283.5 16318.9 16364.0 16474.6 7559.4 7560.7 7584.8 7911.2 7970.8 4483.3 4538.9 4539.5 4601.6 4618.2 3301.3 3342.4 3425.4 3427.7 3430.1 580.1 584.5 585.9 594.5 601.0 607.3 611.5 616.4 622.6 635.9 8428.7 8446.9 8574.3 8600.4 8811.5 563.8 594.4 601.9 609.0 636.0 4135.0 4403.9 4432.6 4433.9 4485.8 112116.0 113283.0 115345.4 116686.4 117361.0 97763.0 98540.5 100998.5 101768.7 101865.0 54701.9 70202.3 83751.6 86271.0 88750.6 8256.4 8292.4 8336.2 8408.5 8499.7 49024.3 50305.7 50460.0 50885.7 51042.5 69549.7 69956.0 76777.0 78470.0 79122.0 11146.5 11235.4 11327.8 11556.7 11643.8 9657.4 12157.8 12458.9 12462.1 12597.5 11391.1 11497.8 11687.2 12356.3 12428.7 12485.0 12496.4 12547.6 12569.2 12692.1 12039.9 12048.3 12049.2 12118.1 12532.0 10873.9 11047.1 11261.0 11378.8 11598.8 10269.3 10537.1 10553.2 10560.1 10585.7 05:36:44 INFO - PROCESS | 3451 | -------- Summary: end -------- 05:36:44 INFO - PROCESS | 3451 | 05:36:44 INFO - TEST-INFO | 3451: exit 0 05:36:44 INFO - TEST-OK | dromaeo_css | took 1116743ms 05:36:44 INFO - TEST-START | kraken 05:36:44 INFO - operating with platform_type : linux_ 05:36:44 INFO - Initialising browser for kraken test... 05:36:44 INFO - TEST-INFO | started process 3636 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeR4F12/profile http://localhost:43080/getInfo.html) 05:36:48 INFO - PROCESS | 3636 | __metrics Screen width/height:1600/1200 05:36:48 INFO - PROCESS | 3636 | colorDepth:24 05:36:48 INFO - PROCESS | 3636 | Browser inner width/height: 1024/697 05:36:48 INFO - PROCESS | 3636 | __metrics 05:36:49 INFO - PROCESS | 3636 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:36:50 INFO - TEST-INFO | 3636: exit 0 05:36:50 INFO - Browser initialized. 05:36:50 INFO - Running cycle 1/1 for kraken test... 05:36:50 INFO - TEST-INFO | started process 3719 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeR4F12/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:37:02 INFO - PROCESS | 3719 | RSS: Main: 174239744 05:37:02 INFO - PROCESS | 3719 | 05:37:05 INFO - PROCESS | 3719 | Cycle 1(1): loaded http://localhost:43080/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43080/tests/kraken/driver.html?testName=audio-beat-detection) 05:37:06 INFO - PROCESS | 3719 | RSS: Main: 231972864 05:37:06 INFO - PROCESS | 3719 | 05:37:08 INFO - PROCESS | 3719 | Cycle 1(1): loaded http://localhost:43080/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43080/tests/kraken/driver.html?testName=audio-dft) 05:37:09 INFO - PROCESS | 3719 | RSS: Main: 220868608 05:37:09 INFO - PROCESS | 3719 | 05:37:12 INFO - PROCESS | 3719 | Cycle 1(1): loaded http://localhost:43080/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43080/tests/kraken/driver.html?testName=audio-fft) 05:37:13 INFO - PROCESS | 3719 | RSS: Main: 285794304 05:37:13 INFO - PROCESS | 3719 | 05:37:15 INFO - PROCESS | 3719 | Cycle 1(1): loaded http://localhost:43080/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43080/tests/kraken/driver.html?testName=audio-oscillator) 05:37:15 INFO - PROCESS | 3719 | RSS: Main: 196956160 05:37:15 INFO - PROCESS | 3719 | 05:37:17 INFO - PROCESS | 3719 | Cycle 1(1): loaded http://localhost:43080/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43080/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:37:18 INFO - PROCESS | 3719 | RSS: Main: 201347072 05:37:18 INFO - PROCESS | 3719 | 05:37:21 INFO - PROCESS | 3719 | Cycle 1(1): loaded http://localhost:43080/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43080/tests/kraken/driver.html?testName=imaging-darkroom) 05:37:22 INFO - PROCESS | 3719 | RSS: Main: 235945984 05:37:22 INFO - PROCESS | 3719 | 05:37:25 INFO - PROCESS | 3719 | Cycle 1(1): loaded http://localhost:43080/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43080/tests/kraken/driver.html?testName=imaging-desaturate) 05:37:26 INFO - PROCESS | 3719 | RSS: Main: 237735936 05:37:26 INFO - PROCESS | 3719 | 05:37:29 INFO - PROCESS | 3719 | Cycle 1(1): loaded http://localhost:43080/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43080/tests/kraken/driver.html?testName=json-parse-financial) 05:37:29 INFO - PROCESS | 3719 | RSS: Main: 237678592 05:37:29 INFO - PROCESS | 3719 | 05:37:31 INFO - PROCESS | 3719 | Cycle 1(1): loaded http://localhost:43080/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43080/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:37:31 INFO - PROCESS | 3719 | RSS: Main: 224243712 05:37:31 INFO - PROCESS | 3719 | 05:37:33 INFO - PROCESS | 3719 | Cycle 1(1): loaded http://localhost:43080/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43080/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:37:34 INFO - PROCESS | 3719 | RSS: Main: 228057088 05:37:34 INFO - PROCESS | 3719 | 05:37:36 INFO - PROCESS | 3719 | Cycle 1(1): loaded http://localhost:43080/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43080/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:37:36 INFO - PROCESS | 3719 | RSS: Main: 236175360 05:37:36 INFO - PROCESS | 3719 | 05:37:39 INFO - PROCESS | 3719 | Cycle 1(1): loaded http://localhost:43080/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43080/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:37:39 INFO - PROCESS | 3719 | RSS: Main: 238215168 05:37:39 INFO - PROCESS | 3719 | 05:37:42 INFO - PROCESS | 3719 | Cycle 1(1): loaded http://localhost:43080/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43080/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:37:43 INFO - PROCESS | 3719 | RSS: Main: 240009216 05:37:43 INFO - PROCESS | 3719 | 05:37:44 INFO - PROCESS | 3719 | Cycle 1(1): loaded http://localhost:43080/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43080/tests/kraken/driver.html?testName=ai-astar) 05:37:45 INFO - PROCESS | 3719 | RSS: Main: 283668480 05:37:45 INFO - PROCESS | 3719 | 05:37:45 INFO - PROCESS | 3719 | __start_tp_report 05:37:45 INFO - PROCESS | 3719 | _x_x_mozilla_page_load 05:37:45 INFO - PROCESS | 3719 | _x_x_mozilla_page_load_details 05:37:45 INFO - PROCESS | 3719 | |i|pagename|runs| 05:37:45 INFO - PROCESS | 3719 | |0;ai-astar;101;110;110;111;112;110;111;110;110;111 05:37:45 INFO - PROCESS | 3719 | |1;audio-beat-detection;151;123;135;179;131;130;146;124;153;126 05:37:45 INFO - PROCESS | 3719 | |2;audio-dft;161;161;161;160;160;164;161;162;161;162 05:37:45 INFO - PROCESS | 3719 | |3;audio-fft;74;74;75;121;75;76;73;74;101;75 05:37:45 INFO - PROCESS | 3719 | |4;audio-oscillator;85;85;122;84;84;85;112;85;85;133 05:37:45 INFO - PROCESS | 3719 | |5;imaging-gaussian-blur;116;116;117;119;118;118;117;117;116;116 05:37:45 INFO - PROCESS | 3719 | |6;imaging-darkroom;147;147;147;147;148;147;146;146;146;148 05:37:45 INFO - PROCESS | 3719 | |7;imaging-desaturate;96;94;95;94;95;95;95;95;95;94 05:37:45 INFO - PROCESS | 3719 | |8;json-parse-financial;54;53;53;53;53;53;55;54;52;53 05:37:45 INFO - PROCESS | 3719 | |9;json-stringify-tinderbox;63;62;64;63;63;63;64;63;63;63 05:37:45 INFO - PROCESS | 3719 | |10;stanford-crypto-aes;84;80;79;80;79;79;80;81;94;78 05:37:45 INFO - PROCESS | 3719 | |11;stanford-crypto-ccm;132;124;135;126;122;121;118;124;135;132 05:37:45 INFO - PROCESS | 3719 | |12;stanford-crypto-pbkdf2;160;156;162;165;158;160;161;158;159;159 05:37:45 INFO - PROCESS | 3719 | |13;stanford-crypto-sha256-iterative;65;65;64;65;65;66;64;66;63;68 05:37:45 INFO - PROCESS | 3719 | __end_tp_report 05:37:45 INFO - PROCESS | 3719 | __start_cc_report 05:37:45 INFO - PROCESS | 3719 | _x_x_mozilla_cycle_collect,1618 05:37:45 INFO - PROCESS | 3719 | __end_cc_report 05:37:45 INFO - PROCESS | 3719 | __startTimestamp1467117465153__endTimestamp 05:37:45 INFO - PROCESS | 3719 | 05:37:45 INFO - PROCESS | 3719 | ------- Summary: start ------- 05:37:45 INFO - PROCESS | 3719 | Number of tests: 14 05:37:45 INFO - PROCESS | 3719 | 05:37:45 INFO - PROCESS | 3719 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.50 stddev:3.10 (2.8%) stddev-sans-first:0.73 05:37:45 INFO - PROCESS | 3719 | Values: 101.0 110.0 110.0 111.0 112.0 110.0 111.0 110.0 110.0 111.0 05:37:45 INFO - PROCESS | 3719 | 05:37:45 INFO - PROCESS | 3719 | [#1] audio-beat-detection Cycles:10 Average:139.80 Median:140.50 stddev:17.62 (12.5%) stddev-sans-first:18.21 05:37:45 INFO - PROCESS | 3719 | Values: 151.0 123.0 135.0 179.0 131.0 130.0 146.0 124.0 153.0 126.0 05:37:45 INFO - PROCESS | 3719 | 05:37:45 INFO - PROCESS | 3719 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:1.16 (0.7%) stddev-sans-first:1.22 05:37:45 INFO - PROCESS | 3719 | Values: 161.0 161.0 161.0 160.0 160.0 164.0 161.0 162.0 161.0 162.0 05:37:45 INFO - PROCESS | 3719 | 05:37:45 INFO - PROCESS | 3719 | [#3] audio-fft Cycles:10 Average:81.80 Median:74.50 stddev:16.12 (21.6%) stddev-sans-first:16.84 05:37:45 INFO - PROCESS | 3719 | Values: 74.0 74.0 75.0 121.0 75.0 76.0 73.0 74.0 101.0 75.0 05:37:45 INFO - PROCESS | 3719 | 05:37:45 INFO - PROCESS | 3719 | [#4] audio-oscillator Cycles:10 Average:96.00 Median:85.00 stddev:18.84 (22.2%) stddev-sans-first:19.56 05:37:45 INFO - PROCESS | 3719 | Values: 85.0 85.0 122.0 84.0 84.0 85.0 112.0 85.0 85.0 133.0 05:37:45 INFO - PROCESS | 3719 | 05:37:45 INFO - PROCESS | 3719 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:1.05 (0.9%) stddev-sans-first:1.05 05:37:45 INFO - PROCESS | 3719 | Values: 116.0 116.0 117.0 119.0 118.0 118.0 117.0 117.0 116.0 116.0 05:37:45 INFO - PROCESS | 3719 | 05:37:45 INFO - PROCESS | 3719 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 05:37:45 INFO - PROCESS | 3719 | Values: 147.0 147.0 147.0 147.0 148.0 147.0 146.0 146.0 146.0 148.0 05:37:45 INFO - PROCESS | 3719 | 05:37:45 INFO - PROCESS | 3719 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 05:37:45 INFO - PROCESS | 3719 | Values: 96.0 94.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 94.0 05:37:45 INFO - PROCESS | 3719 | 05:37:45 INFO - PROCESS | 3719 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:53.00 stddev:0.82 (1.6%) stddev-sans-first:0.83 05:37:45 INFO - PROCESS | 3719 | Values: 54.0 53.0 53.0 53.0 53.0 53.0 55.0 54.0 52.0 53.0 05:37:45 INFO - PROCESS | 3719 | 05:37:45 INFO - PROCESS | 3719 | [#9] json-stringify-tinderbox Cycles:10 Average:63.10 Median:63.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 05:37:45 INFO - PROCESS | 3719 | Values: 63.0 62.0 64.0 63.0 63.0 63.0 64.0 63.0 63.0 63.0 05:37:45 INFO - PROCESS | 3719 | 05:37:45 INFO - PROCESS | 3719 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:80.00 stddev:4.72 (5.9%) stddev-sans-first:4.91 05:37:45 INFO - PROCESS | 3719 | Values: 84.0 80.0 79.0 80.0 79.0 79.0 80.0 81.0 94.0 78.0 05:37:45 INFO - PROCESS | 3719 | 05:37:45 INFO - PROCESS | 3719 | [#11] stanford-crypto-ccm Cycles:10 Average:126.90 Median:129.00 stddev:6.14 (4.8%) stddev-sans-first:6.22 05:37:45 INFO - PROCESS | 3719 | Values: 132.0 124.0 135.0 126.0 122.0 121.0 118.0 124.0 135.0 132.0 05:37:45 INFO - PROCESS | 3719 | 05:37:45 INFO - PROCESS | 3719 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.80 Median:160.00 stddev:2.49 (1.6%) stddev-sans-first:2.64 05:37:45 INFO - PROCESS | 3719 | Values: 160.0 156.0 162.0 165.0 158.0 160.0 161.0 158.0 159.0 159.0 05:37:45 INFO - PROCESS | 3719 | 05:37:45 INFO - PROCESS | 3719 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:65.00 stddev:1.37 (2.1%) stddev-sans-first:1.45 05:37:45 INFO - PROCESS | 3719 | Values: 65.0 65.0 64.0 65.0 65.0 66.0 64.0 66.0 63.0 68.0 05:37:45 INFO - PROCESS | 3719 | -------- Summary: end -------- 05:37:45 INFO - PROCESS | 3719 | 05:37:46 INFO - TEST-INFO | 3719: exit 0 05:37:46 INFO - TEST-OK | kraken | took 61258ms 05:37:46 INFO - SUITE-END | took 1178s 05:37:46 INFO - Completed test suite (00:19:38) 05:37:46 INFO - javascript benchmark 05:37:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3133.185371803331, 3145.2923092304236, 3155.6528781833995, 3174.6349169845475, 3202.4075546023973, 5297.735113244342, 5389.73051347432, 5396.541293990011, 5461.208124821898, 5520.861978450535, 5362.0616392131315, 5370.03339398909, 5386.380566234884, 5400.91898621521, 5437.592180586462, 4759.547842954914, 4896.1186986342445, 4899.975500122495, 4905.215165573509, 5070.670406423589, 4961.652684312099, 5018.071656743514, 5030.874228144307, 5046.3187469691675, 5052.823151189709, 4790.305405716186, 4817.807287708488, 4885.316055752198, 4950.4059512858685, 4952.059108769322, 4826.638002149853, 4840.177169881129, 4844.0, 4912.803487860481, 4973.079980203674, 4883.975580122076, 4914.778834952435, 4916.287138364917, 4954.380702412199, 4979.4771548987555, 5292.047431462335, 5296.205569164617, 5321.0, 5422.566194704415, 5423.078076726966, 5716.914246286309, 5759.0, 5767.423257674241, 5767.480926716574, 5774.220480235199, 5786.652800831964, 5801.7389217485315, 5825.242718446617, 5838.620489668158, 5843.152742852305, 5280.0, 5441.727913604304, 5445.591580631469, 5515.283013208257, 5516.613837031369, 6051.606645568024, 6061.239939437416, 6067.334066776581, 6070.659478472913, 6114.571979961449, 5806.738696758656, 5860.677662728505, 5863.853403664857, 5866.530677545786, 5871.383504732027, 5697.173909783059, 5718.485336319751, 5732.656040637575, 5740.655560666373, 5790.36306006339, 5767.192593036978, 5771.913421298684, 5774.451427114417, 5774.740136693859, 5775.047117225695, 5651.745671444713, 5728.083506638918, 5754.74103665336, 5779.682117483495, 5779.826605201851, 4290.699651024461, 4335.848245311462, 4359.237133501688, 4368.7815609219415, 4381.21138195128, 3884.0678237222864, 3893.7079719021185, 3903.434002069684, 3934.8622798201927, 3939.054626889526, 5326.840194794162, 5417.783288668409, 5425.213344065089, 5426.0, 5432.1580155075235, 5733.0540460823495, 5795.797147099831, 5807.912881306784, 5821.2141360916585, 5846.824595262149, 5512.062949298629, 5532.806351777668, 5534.08687566547, 5536.833894983157, 5538.833834984957, 4929.482404347564, 4966.726830024383, 5046.899062018739, 5051.444341122474, 5090.516400941905, 5971.701414929236, 6043.939560604514, 6049.153118563405, 6052.546059045501, 6106.358832322631, 5839.124131380327, 5851.707414629337, 5852.092925596539, 5853.0, 5854.4730974212525, 5751.079827227623, 5812.593118481665, 5912.231409916683, 6038.69806509664, 6042.1540984261355, 5674.517665998271, 5680.715964201856, 5683.5453163747625, 5731.3408957968695, 5732.512736417451, 5722.828315150552, 5730.598858079894, 5757.913631295618, 5770.855728606818, 5785.56608254391, 5503.559715222693, 5569.470900264469, 5578.665280083208, 5640.943590564042, 5668.631538949955, 5575.0, 5627.831165065055, 5635.520980716685, 5672.744726487235, 5673.404292549223, 5527.8894422112135, 5530.668159910419, 5532.391436942014, 5538.058530049821, 5538.584606154474, 5512.228288039758, 5568.16477528374, 5651.491365777099, 5696.658200507983, 5708.54331653475, 5485.506304432461, 5542.695151766691, 5542.722863856871, 5564.944350556442, 5568.248286481273], "value": 5331.759884079047, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.7741014888971, 588.485075558886, 596.9044952807552, 601.5999360425318, 621.5121129913018, 28973.826962977757, 29599.26001849955, 29667.703322966765, 29690.10929672108, 35530.2893942121, 37092.0, 37877.053073673174, 37945.0, 37966.81016594913, 37987.430188547194, 8519.659213631447, 8687.391882568223, 8688.435251708619, 8691.56542172892, 8700.086490918457, 8425.747227583182, 8535.615897284637, 8536.402451828344, 8537.701180458685, 8541.487510749344, 8557.614907329185, 8586.656533738644, 8589.95705021474, 8593.742187734346, 8596.355273354524, 8494.490330580154, 8501.107383724682, 8506.362022848249, 8532.914670853273, 8534.487930724177, 8555.657773689045, 8608.311335093178, 8624.525651089187, 8635.352348573882, 8637.913620863774, 36149.81925090358, 36392.45411318832, 36438.63561364405, 36457.81771091154, 36496.81751591252, 3171.5559821624993, 3292.6048874135017, 3325.152086217999, 3379.020084175586, 3485.6688614581576, 29114.563281550792, 29271.0, 29521.409571808657, 29557.70442295571, 29737.40525189484, 4253.3619957006695, 4406.801693923781, 4410.140022695576, 4438.755868427235, 4486.147631949919, 240077.0, 240361.0, 241030.0, 241491.0, 241602.0, 58161.70919145462, 58424.41575584275, 58435.415645843845, 58466.70766646139, 58667.70666146727, 35750.8212458936, 36855.26289474249, 36904.26191476209, 38405.0, 38449.42325865114, 17551.122443877754, 17636.38272660451, 17645.470635880945, 17749.467515974542, 17759.644807103785, 12772.169808962388, 12818.0, 12819.487220511262, 12823.679408014688, 12824.23054616726, 16965.575860603585, 17079.65840683204, 17112.14439278056, 17117.400890968755, 17194.1402929853, 7010.263922288188, 7112.182099058571, 7130.360017196074, 7190.0, 7277.963610181915, 993.2699465892563, 1000.6297669862198, 1040.54216144896, 1084.0622861224983, 1094.9124070074374, 32023.839880800446, 33628.49557256643, 33734.0, 35199.82400087983, 35483.82258088745, 1060.2578195263347, 1078.9190810689229, 1115.4478533126155, 1168.1881092640704, 1194.9283043017274, 14883.553493395215, 15330.080195188324, 15406.845931540542, 15529.922350388175, 15649.217539122998, 510321.0, 513786.0, 514401.0, 514718.0, 514804.0, 58319.125213121835, 58544.56009838914, 59026.40973590295, 59346.0, 59347.0, 1236.2953116723381, 1335.8998075144402, 1346.7508510925313, 1368.2337890781193, 1382.709630977506, 29211.85394073016, 33171.66828331686, 33345.28826324694, 33428.1642958928, 33825.77177852768, 48850.511494884595, 49873.0, 49898.5091341781, 49964.500354997435, 49973.0, 421037.0, 425617.0, 425618.0, 426707.0, 428791.0, 24579.385515361544, 26473.602895956963, 27560.448791024468, 27594.448111037265, 27756.0, 46522.30216546822, 46613.0, 47213.52786472091, 47885.0, 47980.760096199294, 39503.2099358017, 39786.40320395254, 40171.0, 40565.0, 41213.175736485704, 39928.800355998035, 40460.0, 40900.38649420321, 40989.38515922204, 41174.58825411707, 39664.60335396609, 39777.80111099426, 40580.3912941312, 40799.79600101981, 40846.79576602098, 34445.48331774975, 35529.46705799467, 35838.64161358353, 36127.27745445129, 36162.0, 24386.0, 24505.632415514137, 24756.38109047288, 25024.74975250297, 25030.62454063154], "value": 18911.309221431955, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.3093991585525, 376.5970411659525, 376.9472273881657, 384.13761106316286, 391.35426546198784, 16816.0, 18771.906140469313, 18826.246950121997, 19832.504187395323, 19856.20575176993, 10925.890741092586, 11014.724631884206, 11111.499982500787, 11166.497507612157, 11235.606753763619, 4638.489766125724, 5728.283964504437, 5729.713514324288, 5734.713264336788, 5739.540836733072, 5479.671219726809, 5592.384837667853, 5669.433056694318, 5678.971605141989, 5682.0, 5623.8594035149035, 5631.352394474627, 5644.266245388114, 5658.377578466386, 5659.462351076641, 5239.21411788231, 5246.606504512139, 5649.830505084834, 5650.039493286131, 5650.406707295716, 5068.670536415121, 5082.542571168613, 5089.898202035975, 5095.159298715707, 5109.9489005109845, 13072.08495405322, 13137.60587182386, 21032.474188145265, 22431.775682243133, 22447.326580202458, 2312.236961802601, 2449.2284930246915, 2579.7162312145647, 2696.7438093381097, 3025.3646734185845, 10149.949250253701, 10510.369377837354, 10513.684589462327, 12595.370231488389, 13559.728805423934, 1935.9709604355946, 2009.447401964457, 2009.4976255936017, 2034.745656792901, 2064.215598072723, 64185.0, 75616.24383756203, 76003.23996760017, 76343.23656763417, 77534.22465775326, 10457.424841633783, 10500.894991050145, 10554.833549935141, 10752.301100428447, 10988.450577471094, 14189.0, 14423.206723630092, 14429.35067921946, 14474.565763027125, 14490.130592164503, 8237.423380363318, 8305.916940830635, 8311.750647480585, 8422.157784221652, 8490.745277641681, 8079.232472915063, 8150.736635821457, 8273.1726827318, 8326.916730832736, 8347.54088525137, 4654.930176047362, 4745.0, 4754.429468463806, 4756.025014871943, 4847.660663753574, 1904.7904730479636, 1922.8173323534243, 1957.471482699663, 1962.8625996180415, 1974.2695202775064, 839.2572573272697, 917.8623206518942, 943.0710749911332, 950.4392408479031, 958.1424624960761, 17020.829791702174, 17550.473485795446, 18197.3622373987, 18269.360572379905, 19293.614127717367, 909.3134683314056, 961.6393852305386, 965.1313817564109, 991.1575161113141, 1015.7359086637528, 10149.746256343502, 10589.417582032907, 10748.623798167027, 10938.890611093788, 10945.671629851116, 391547.0, 393672.0, 393674.0, 519693.0, 560234.3742188356, 61594.38405615976, 87618.56190719006, 98374.50812746033, 99507.50246248723, 101480.0, 1025.8461230815437, 1027.6505987964129, 1046.220565678559, 1059.2003037706481, 1061.8141825180562, 17354.479365619052, 17682.469525914243, 18032.36886708959, 18068.728969065738, 18329.541761456072, 39531.80234098811, 41551.85859110991, 42338.364924525544, 42352.1529569413, 43902.56097439113, 57657.711711442855, 58504.4149558516, 59447.40552594419, 59515.40484595272, 59707.10439343326, 8157.75526734199, 8309.626066827128, 8425.620847061775, 8539.957300213458, 8544.359173061921, 8942.73171804847, 13669.589912302647, 13683.931580342034, 13862.584122476343, 13965.3715582797, 5187.066328060834, 8654.48073115615, 11437.485313161094, 11647.30116193031, 11774.882251177378, 11730.941345293219, 11949.0, 12030.458629361525, 12045.578404755792, 12107.636770896886, 11623.709407264885, 12010.879891200977, 12017.579384721494, 12296.508139674313, 12424.813627795409, 8664.78338041554, 8678.652853886026, 8806.295496360404, 8812.289097947996, 8895.154960278764, 8679.045305016316, 10746.408947507649, 11312.547498099984, 11446.82829757571, 11669.241499302518], "value": 8889.16671135963, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1107.545906178467, 1216.9209001414908, 1230.34791560473, 1239.6652903715994, 1438.5252866554038, 8165.305948994335, 8600.182982616649, 8601.827963440728, 8807.07525709801, 8845.557722113901, 8565.957170214157, 8685.652573897052, 8722.65109395625, 8742.650293988248, 8746.956265218665, 1986.0864002558767, 2185.366243789307, 2310.630299152136, 2313.710786151731, 2335.4044718596733, 2350.882455877208, 2354.1407386303963, 2361.1853910400882, 2361.208994986673, 2364.3498038039506, 2244.9102035918545, 2255.5037891663806, 2275.590393729128, 2277.237125562938, 2278.6695929090274, 1951.9902400487977, 2027.5032617008853, 2159.4817243861517, 2195.5938151441956, 2225.376894469551, 2256.0637335505744, 2270.738865030526, 2274.54509098181, 2275.5107651854933, 2276.3853759484846, 8714.172153645393, 8757.211850933383, 8762.912370876336, 8777.0, 8782.165694259034, 5051.090803655341, 5177.352830896138, 5185.299984502081, 5186.273921650972, 5187.48125187482, 3061.234691327168, 3169.1760142362923, 3180.761442891769, 3223.5003574446, 3242.1732458223237, 1112.3937454087543, 1119.9608013719562, 1136.891995260449, 1140.378493720924, 1146.6273461125168, 12692.746145077139, 12756.936215318958, 12778.361081945866, 12779.23324600527, 12807.807882881763, 4667.346571479996, 4712.293156026555, 4713.175194340976, 4814.494478079751, 4846.588040016568, 10605.25763196569, 10617.469126543641, 10657.893421065844, 10676.252662313718, 10715.517801698943, 5256.9737151314, 5265.341832270966, 5269.1569348903995, 5273.499017593323, 5276.234945932818, 4328.783560822009, 4701.976490117528, 4865.95134048662, 4911.87720306988, 4973.950260497421, 3940.645341919241, 3990.840366385312, 4081.6530594899173, 4097.13960068383, 4119.876403707894, 1260.615512268767, 1279.2644229568036, 1282.3075539208724, 1290.619267316144, 1296.461968283152, 833.2500749325534, 923.9907600923905, 940.520334629344, 949.2832911152036, 974.2011550528499, 5999.4101563085815, 6002.459778619946, 6005.519558435402, 6024.909626355608, 6286.779962701284, 452.58362306677935, 456.8812108851656, 459.69660024383745, 461.65375968023983, 465.15806390433426, 3858.8649397271524, 4006.0786019215743, 4127.5666055064385, 4164.250434921682, 4219.767912764827, 10909.127269818395, 11116.166287528467, 11233.269837460539, 11345.829812552818, 11349.262297950772, 11126.61056863006, 11137.331760094421, 11160.832587511193, 11164.330140191614, 11171.16216283782, 7945.682172713026, 8285.62714677841, 8320.209580090002, 8368.748937531884, 8383.077861435237, 5845.590808643354, 5946.494547963472, 5963.105534169909, 6077.24034495688, 6095.891095541395, 10585.100266477435, 10773.084287835622, 10778.784424311627, 10780.083692886192, 10780.676579702622, 10119.949400252952, 10372.792544148924, 10839.620613278497, 10839.783204335712, 10869.239153259512, 7141.143062832493, 7463.469988652205, 7671.2712292332135, 7726.343260822893, 7917.445778795429, 8627.95686021566, 8645.351598630003, 8669.306455483673, 8762.386632935888, 8780.912190878009, 7600.42996775233, 7846.607669616382, 7875.054993400829, 7892.644830982735, 7948.165442628672, 7557.319841214317, 7578.734744284144, 7645.961770191114, 7770.611469426393, 7780.533168009937, 6768.4585233182215, 6782.898256526255, 6804.6257455840405, 6812.625305608239, 6836.863262734817, 4753.239481682914, 4792.616590672668, 4864.489228630943, 4879.438864530624, 4940.2342636891335, 4727.976360118178, 4860.513948605253, 4861.611071114373, 4947.307376967299, 4975.527324904128], "value": 4505.087570596367, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.54628418519667, 299.33248855053233, 307.09254153975, 309.6995913963456, 312.369014590527, 5283.177303830177, 5314.5748340132795, 5343.599230057742, 5350.839474815752, 5360.517553420192, 5266.367426097912, 5270.5520030797425, 5301.1783173608055, 5306.885554033648, 5309.681419114856, 4098.303288440958, 4135.8759237222785, 4139.917201655965, 4141.9378709319235, 4161.105362347094, 3983.223271462066, 4156.521999969997, 4165.875023749292, 4171.165766846628, 4177.310743727281, 4075.8587595473314, 4114.691398145136, 4119.237940980913, 4130.876073717794, 4146.854860079898, 3876.9030774230587, 4051.650042975067, 4059.147579008412, 4060.1473690525027, 4158.043649960496, 3491.790492570454, 3620.674139327447, 3622.4023036198996, 3625.0574850538787, 3628.5827129880136, 5012.949870501321, 5059.822906198302, 5160.354955630546, 5165.431802501722, 5168.9741551292, 4469.865904022852, 4552.655382478027, 4673.6027437667835, 4675.298705194214, 4681.618922417895, 5470.908936450933, 5485.670859748388, 5489.298317521581, 5531.446855314477, 5535.889282214373, 4006.419069234974, 4019.789115986196, 4024.6176613221696, 4028.113814960704, 4034.850067730712, 5562.7774889004795, 5720.685362305072, 5748.223989761371, 5786.710664466802, 5797.826065218008, 4064.8170832312617, 4068.7965601719798, 4085.611866872642, 4095.9590404096175, 4103.199876024147, 4142.08874047709, 4142.937855932163, 4144.544100148981, 4158.958410415918, 4160.625543701081, 4583.885402864888, 4610.76946152691, 4714.81140754366, 4722.7874745635845, 4724.472407262098, 5465.207544906046, 5498.917516237259, 5510.972445137749, 5513.696746678891, 5563.610547261734, 1390.9652258693613, 1422.871941525247, 1424.230915305744, 1431.6206205355588, 1432.596055865258, 899.6491368366343, 913.488446469979, 916.7845556294266, 929.8140371925507, 936.5036530638772, 4698.788554515055, 4710.5760481556135, 4737.810487580458, 4760.547747963938, 4773.284007398918, 4942.8764280893265, 5000.64995450315, 5006.799728010911, 5018.874528136753, 5060.836007718245, 4708.599769019672, 4750.976245118822, 4814.325994360793, 4854.514548545118, 4992.201247800334, 2866.7959457028096, 2960.718731720483, 2961.8074825136296, 3028.530577760451, 3033.4388138194504, 5771.509421699118, 5803.738831752581, 5816.476517113396, 5821.243238378984, 5835.737391817378, 5580.469855363734, 5647.136444973149, 5737.627054241544, 5766.481016708516, 5778.971105144447, 5751.4823665869435, 5753.798617048467, 5771.249737534094, 5804.564657650609, 5816.76732930678, 5608.439156084522, 5623.409541998031, 5637.02704053578, 5694.259746232963, 5702.45826646468, 5400.459954004568, 5619.831405057855, 5637.605367624391, 5637.842808027518, 5642.319898048394, 5786.971065144648, 5859.0, 5860.8571328592225, 5861.6189947653265, 5882.470557655126, 3940.665043471337, 3957.92084158321, 3965.40518922164, 3966.504186976628, 3975.8409663613133, 5417.51242388187, 5649.870025994735, 5675.517581005495, 5681.715914204191, 5701.771929122789, 5414.3232095988005, 5518.172274158908, 5532.3637781655625, 5538.6399884007415, 5545.390007099297, 5326.866828329323, 5336.466353364633, 5410.188471729272, 5472.589555783412, 5473.397926228032, 5370.677759334452, 5408.513233808819, 5417.214503896834, 5440.619156658996, 5447.155690867922, 5396.64921780083, 5436.700981446058, 5515.25544051564, 5531.308586426697, 5548.4174161712435, 5240.213967904845, 5345.1714984177515, 5345.839624811262, 5358.7674834788995, 5360.839174824761], "value": 4157.509852568364, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [625.7590827531401, 643.4369926314475, 656.8850451171045, 661.5237029338874, 681.3935597318384, 13638.522651707191, 14629.0, 14640.633984150389, 15083.170425626586, 16044.679106417865, 15743.527694169165, 16356.263968121433, 16501.0924399158, 16537.090460024694, 16538.66922661546, 638.0206383201786, 772.7025095338307, 818.5129847740615, 819.9672013119483, 825.5872063968015, 819.1726356380069, 819.9918000819976, 822.3339095332769, 823.1768231768232, 823.505896462121, 849.3969281809923, 850.0606829453427, 850.3707256630111, 851.5188918261163, 851.5231470376578, 666.7932940788347, 795.7254747112266, 836.7029704454952, 839.7270886961762, 844.6621351459404, 614.0482252508639, 614.1402037147984, 614.8155553333982, 614.9852742974084, 614.9907751383732, 13601.183928964196, 13680.452781888713, 13685.0, 13730.970177236748, 13856.584302470941, 11801.173917825756, 12288.877111228863, 12912.0, 13035.15271507349, 13061.542846000439, 11026.44867756609, 11932.880671193263, 12009.93995030028, 12100.031997440183, 12102.152849300552, 4309.482862056542, 4355.73865568067, 4400.09797991411, 4416.514183439819, 4524.140413321458, 74496.0, 75303.0, 75396.62301688512, 76903.6154819228, 77327.6133619334, 9518.0, 9522.476263805418, 9594.328397012143, 9725.367851089657, 9943.950280248697, 16264.430744923871, 16283.511494655178, 16318.918405408134, 16364.018158910503, 16474.58813529671, 7559.357454616419, 7560.735374261874, 7584.81037974044, 7911.248431399008, 7970.84058318842, 4483.293669206198, 4538.931916021263, 4539.500654927955, 4601.562851529099, 4618.214903466419, 3301.323228738103, 3342.364950659367, 3425.3663072331697, 3427.6572342765526, 3430.091025878144, 580.135597959038, 584.5323741007177, 585.8652509922741, 594.5273507561499, 600.9969950150221, 607.259143844509, 611.5260672978477, 616.4236438929615, 622.5797586629097, 635.9141515895295, 8428.704995325133, 8446.873296900552, 8574.314054875595, 8600.440971336968, 8811.515366654896, 563.8026690658237, 594.381842883405, 601.9217501724835, 608.9756409743561, 635.9951276982449, 4135.0, 4403.911921761547, 4432.601065904019, 4433.933490997638, 4485.753283569435, 112116.0, 113283.0, 115345.4232728831, 116686.41656791832, 117361.0, 97763.0, 98540.50729746449, 100998.49500752595, 101768.66831140031, 101865.0, 54701.90596188133, 70202.29797701958, 83751.58124209462, 86271.0, 88750.55624721835, 8256.380771442286, 8292.380838227627, 8336.249737523653, 8408.495490270603, 8499.660013599387, 49024.2646360312, 50305.74847125741, 50460.0, 50885.74557127191, 51042.48957510526, 69549.65225173841, 69956.0, 76777.0, 78470.0, 79122.0, 11146.49840757184, 11235.438228088726, 11327.830082548933, 11556.653300401002, 11643.76712465729, 9657.420554766737, 12157.81763273534, 12458.875411246134, 12462.052742354836, 12597.496100156257, 11391.145664075062, 11497.770044598894, 11687.18189726745, 12356.25862448256, 12428.689282767642, 12485.0, 12496.375181241083, 12547.623571292876, 12569.162121963313, 12692.111552191258, 12039.879601203877, 12048.337341446304, 12049.156559041134, 12118.091143164122, 12532.0, 10873.891261087289, 11047.116230701364, 11261.0, 11378.829317560077, 11598.789760738775, 10269.332493387907, 10537.104346130665, 10553.155747540024, 10560.10239129652, 10585.682429527127], "value": 7059.532307643612, "unit": "score"}], "name": "dromaeo_css", "value": 7008.65887531118, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 110.0, 111.0, 112.0, 110.0, 111.0, 110.0, 110.0, 111.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 123.0, 135.0, 179.0, 131.0, 130.0, 146.0, 124.0, 153.0, 126.0], "value": 139.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 160.0, 160.0, 164.0, 161.0, 162.0, 161.0, 162.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 121.0, 75.0, 76.0, 73.0, 74.0, 101.0, 75.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 122.0, 84.0, 84.0, 85.0, 112.0, 85.0, 85.0, 133.0], "value": 96.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 119.0, 118.0, 118.0, 117.0, 117.0, 116.0, 116.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 148.0, 147.0, 146.0, 146.0, 146.0, 148.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 53.0, 53.0, 53.0, 55.0, 54.0, 52.0, 53.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 64.0, 63.0, 63.0, 63.0, 64.0, 63.0, 63.0, 63.0], "value": 63.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 80.0, 79.0, 80.0, 79.0, 79.0, 80.0, 81.0, 94.0, 78.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 124.0, 135.0, 126.0, 122.0, 121.0, 118.0, 124.0, 135.0, 132.0], "value": 126.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 156.0, 162.0, 165.0, 158.0, 160.0, 161.0, 158.0, 159.0, 159.0], "value": 159.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 65.0, 65.0, 66.0, 64.0, 66.0, 63.0, 68.0], "value": 65.1, "unit": "score"}], "name": "kraken", "value": 1496.8, "alertThreshold": 2.0}]} 05:37:46 INFO - Return code: 0 05:37:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:37:46 INFO - # TBPL SUCCESS # 05:37:46 INFO - Running post-action listener: _resource_record_post_action 05:37:46 INFO - ##### 05:37:46 INFO - ##### Finished run-tests step (success) 05:37:46 INFO - ##### 05:37:46 INFO - Running post-run listener: _resource_record_post_run 05:37:46 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 10240000; Write bytes: 476377088; Read time: 3612; Write time: 413240 05:37:46 INFO - TinderboxPrint: CPU usage
13.1% 05:37:46 INFO - TinderboxPrint: I/O read bytes / time
10,240,000 / 3,612 05:37:46 INFO - TinderboxPrint: I/O write bytes / time
476,377,088 / 413,240 05:37:46 INFO - TinderboxPrint: CPU idle
8,295.8 (86.8%) 05:37:46 INFO - TinderboxPrint: CPU user
1,205.1 (12.6%) 05:37:46 INFO - TinderboxPrint: Swap in / out
0 / 0 05:37:46 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 20660224; Read time: 0; Write time: 23668 05:37:46 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 8478720; Write bytes: 455716864; Read time: 3572; Write time: 389572 05:37:47 INFO - Running post-run listener: _upload_blobber_files 05:37:47 INFO - Blob upload gear active. 05:37:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:37:47 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:37:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:37:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:37:47 INFO - (blobuploader) - INFO - Open directory for files ... 05:37:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:37:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:37:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:48 INFO - (blobuploader) - INFO - Done attempting. 05:37:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:37:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:37:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:51 INFO - (blobuploader) - INFO - Done attempting. 05:37:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:37:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:37:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:52 INFO - (blobuploader) - INFO - Done attempting. 05:37:52 INFO - (blobuploader) - INFO - Iteration through files over. 05:37:52 INFO - Return code: 0 05:37:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:37:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:37:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/43b055347e18891bb10392588056c8f066575b428ce2ae54824e7bab653ee8bf888817087ff15adef1d007f1a3d0c2d2850d084d96c7f7b80cf70f9fa59394df", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/441645e2427dc03e289f35d4dd726220968900d1a98900bca18874be8a443b88e8944249e1b800b44ebcbb9d33c4b7c8793e252ded039ee6552153f41927c048", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/06bcbf0791e652187738a8c95cb28179a8d41b68c9d3eda9b2d39a4c54e4e539c1dc3ec1188a25a7cbee386b4426ed6ce5f55780eb80a454ae4ef7e16d2062f5"} 05:37:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:37:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:37:52 INFO - Contents: 05:37:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/43b055347e18891bb10392588056c8f066575b428ce2ae54824e7bab653ee8bf888817087ff15adef1d007f1a3d0c2d2850d084d96c7f7b80cf70f9fa59394df", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/441645e2427dc03e289f35d4dd726220968900d1a98900bca18874be8a443b88e8944249e1b800b44ebcbb9d33c4b7c8793e252ded039ee6552153f41927c048", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/06bcbf0791e652187738a8c95cb28179a8d41b68c9d3eda9b2d39a4c54e4e539c1dc3ec1188a25a7cbee386b4426ed6ce5f55780eb80a454ae4ef7e16d2062f5"} 05:37:52 INFO - Running post-run listener: copy_logs_to_upload_dir 05:37:52 INFO - Copying logs to upload dir... 05:37:52 INFO - mkdir: /builds/slave/test/build/upload/logs 05:37:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.523947 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-28 05:37:52.307862) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 05:37:52.311856) ========= 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=6dbc10da6d83fee962c624be000001a8-1467116051.559059-1093339788 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/43b055347e18891bb10392588056c8f066575b428ce2ae54824e7bab653ee8bf888817087ff15adef1d007f1a3d0c2d2850d084d96c7f7b80cf70f9fa59394df", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/441645e2427dc03e289f35d4dd726220968900d1a98900bca18874be8a443b88e8944249e1b800b44ebcbb9d33c4b7c8793e252ded039ee6552153f41927c048", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/06bcbf0791e652187738a8c95cb28179a8d41b68c9d3eda9b2d39a4c54e4e539c1dc3ec1188a25a7cbee386b4426ed6ce5f55780eb80a454ae4ef7e16d2062f5"} build_url:https://queue.taskcluster.net/v1/task/CNNwy5leRmWazIi41CW1Bg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011272 build_url: 'https://queue.taskcluster.net/v1/task/CNNwy5leRmWazIi41CW1Bg/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/43b055347e18891bb10392588056c8f066575b428ce2ae54824e7bab653ee8bf888817087ff15adef1d007f1a3d0c2d2850d084d96c7f7b80cf70f9fa59394df", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/441645e2427dc03e289f35d4dd726220968900d1a98900bca18874be8a443b88e8944249e1b800b44ebcbb9d33c4b7c8793e252ded039ee6552153f41927c048", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/06bcbf0791e652187738a8c95cb28179a8d41b68c9d3eda9b2d39a4c54e4e539c1dc3ec1188a25a7cbee386b4426ed6ce5f55780eb80a454ae4ef7e16d2062f5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 05:37:52.337724) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 05:37:52.338081) ========= 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=6dbc10da6d83fee962c624be000001a8-1467116051.559059-1093339788 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004327 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 05:37:52.423309) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 05:37:52.423655) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 05:37:52.423982) ========= ========= Total master_lag: 0.30 =========