builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-056 starttime: 1464981257.82 results: success (0) buildid: 20160603114627 builduid: 94c9c17b93fb44ffb7e05f8b0e835f1a revision: dc5692c66a028e98980527c9a637932b992874b2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 12:14:17.817637) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 12:14:17.818063) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 12:14:17.818347) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 12:14:17.882643) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 12:14:17.882914) ========= 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=52faae308a556c440401f8e5000001e8-1464981171.560497-1317786345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-03 12:14:18-- 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% 32.9M=0s 2016-06-03 12:14:18 (32.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103266 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 12:14:18.008409) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 12:14:18.008712) ========= 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=52faae308a556c440401f8e5000001e8-1464981171.560497-1317786345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019876 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 12:14:18.058337) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 12:14:18.058710) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev dc5692c66a028e98980527c9a637932b992874b2 --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 dc5692c66a028e98980527c9a637932b992874b2 --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=52faae308a556c440401f8e5000001e8-1464981171.560497-1317786345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-03 12:14:18,326 truncating revision to first 12 chars 2016-06-03 12:14:18,326 Setting DEBUG logging. 2016-06-03 12:14:18,326 attempt 1/10 2016-06-03 12:14:18,326 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/dc5692c66a02?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-03 12:14:18,643 unpacking tar archive at: fx-team-dc5692c66a02/testing/mozharness/ program finished with exit code 0 elapsedTime=0.685826 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 12:14:18.757711) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 12:14:18.758052) ========= script_repo_revision: dc5692c66a028e98980527c9a637932b992874b2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 12:14:18.758714) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 12:14:18.759195) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 12:14:18.771439) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-03 12:14:18.771923) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1464981171.560497-1317786345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:14:19 INFO - MultiFileLogger online at 20160603 12:14:19 in /builds/slave/test 12:14:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 12:14:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:14:19 INFO - {'append_to_log': False, 12:14:19 INFO - 'base_work_dir': '/builds/slave/test', 12:14:19 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:14:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:14:19 INFO - 'branch': 'Fx-Team-Non-PGO', 12:14:19 INFO - 'buildbot_json_path': 'buildprops.json', 12:14:19 INFO - 'config_files': ('talos/linux_config.py',), 12:14:19 INFO - 'default_actions': ('clobber', 12:14:19 INFO - 'read-buildbot-config', 12:14:19 INFO - 'download-and-extract', 12:14:19 INFO - 'populate-webroot', 12:14:19 INFO - 'create-virtualenv', 12:14:19 INFO - 'install', 12:14:19 INFO - 'run-tests'), 12:14:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:14:19 INFO - 'download_minidump_stackwalk': True, 12:14:19 INFO - 'download_symbols': 'ondemand', 12:14:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:14:19 INFO - 'tooltool.py': '/tools/tooltool.py', 12:14:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:14:19 INFO - '/tools/misc-python/virtualenv.py')}, 12:14:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:14:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:14:19 INFO - 'installer_path': 'installer.exe', 12:14:19 INFO - 'log_level': 'info', 12:14:19 INFO - 'log_name': 'talos', 12:14:19 INFO - 'log_to_console': True, 12:14:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:14:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:14:19 INFO - 'opt_config_files': (), 12:14:19 INFO - 'pip_index': False, 12:14:19 INFO - 'sps_profile': False, 12:14:19 INFO - 'sps_profile_interval': 0, 12:14:19 INFO - 'suite': 'dromaeojs', 12:14:19 INFO - 'system_bits': '32', 12:14:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:14:19 INFO - 'title': 'talos-linux64-ix-056', 12:14:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:14:19 INFO - 'use_talos_json': True, 12:14:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:14:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:14:19 INFO - 'work_dir': 'build'} 12:14:19 INFO - ##### 12:14:19 INFO - ##### Running clobber step. 12:14:19 INFO - ##### 12:14:19 INFO - Running pre-action listener: _resource_record_pre_action 12:14:19 INFO - Running main action method: clobber 12:14:19 INFO - rmtree: /builds/slave/test/build 12:14:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:14:19 INFO - Running post-action listener: _resource_record_post_action 12:14:19 INFO - ##### 12:14:19 INFO - ##### Finished clobber step (success) 12:14:19 INFO - ##### 12:14:19 INFO - ##### 12:14:19 INFO - ##### Running read-buildbot-config step. 12:14:19 INFO - ##### 12:14:19 INFO - Running pre-action listener: _resource_record_pre_action 12:14:19 INFO - Running main action method: read_buildbot_config 12:14:19 INFO - Using buildbot properties: 12:14:19 INFO - { 12:14:19 INFO - "project": "", 12:14:19 INFO - "product": "firefox", 12:14:19 INFO - "script_repo_revision": "production", 12:14:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:14:19 INFO - "repository": "", 12:14:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 12:14:19 INFO - "buildid": "20160603114627", 12:14:19 INFO - "pgo_build": "False", 12:14:19 INFO - "basedir": "/builds/slave/test", 12:14:19 INFO - "buildnumber": 1812, 12:14:19 INFO - "slavename": "talos-linux64-ix-056", 12:14:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:14:19 INFO - "platform": "ubuntu64_hw", 12:14:19 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:14:19 INFO - "branch": "fx-team", 12:14:19 INFO - "repo_path": "integration/fx-team", 12:14:19 INFO - "revision": "dc5692c66a028e98980527c9a637932b992874b2", 12:14:19 INFO - "stage_platform": "linux64", 12:14:19 INFO - "builduid": "94c9c17b93fb44ffb7e05f8b0e835f1a", 12:14:19 INFO - "slavebuilddir": "test" 12:14:19 INFO - } 12:14:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/KlZyiwCLST2E5HQDwmWoxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 12:14:19 INFO - Running post-action listener: _resource_record_post_action 12:14:19 INFO - ##### 12:14:19 INFO - ##### Finished read-buildbot-config step (success) 12:14:19 INFO - ##### 12:14:19 INFO - ##### 12:14:19 INFO - ##### Running download-and-extract step. 12:14:19 INFO - ##### 12:14:19 INFO - Running pre-action listener: _resource_record_pre_action 12:14:19 INFO - Running main action method: download_and_extract 12:14:19 INFO - mkdir: /builds/slave/test/build/tests 12:14: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')]} 12:14:19 INFO - https://queue.taskcluster.net/v1/task/KlZyiwCLST2E5HQDwmWoxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:14:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KlZyiwCLST2E5HQDwmWoxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 12:14:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KlZyiwCLST2E5HQDwmWoxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 12:14:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KlZyiwCLST2E5HQDwmWoxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 12:14:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KlZyiwCLST2E5HQDwmWoxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:14:20 INFO - Downloaded 1361 bytes. 12:14:20 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 12:14:20 INFO - Using the following test package requirements: 12:14:20 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 12:14:20 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:14:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:14:20 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:14:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:14:20 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:14:20 INFO - u'jsshell-linux-x86_64.zip'], 12:14:20 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:14:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:14:20 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 12:14:20 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:14:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:14:20 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:14:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:14:20 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:14:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:14:20 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:14:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:14:20 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:14:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:20 INFO - https://queue.taskcluster.net/v1/task/KlZyiwCLST2E5HQDwmWoxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:14:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KlZyiwCLST2E5HQDwmWoxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:14:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KlZyiwCLST2E5HQDwmWoxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:14:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KlZyiwCLST2E5HQDwmWoxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:14:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KlZyiwCLST2E5HQDwmWoxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:14:21 INFO - Downloaded 22868152 bytes. 12:14:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:14:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:14:23 INFO - Return code: 0 12:14:23 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:14:23 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')]} 12:14:23 INFO - https://queue.taskcluster.net/v1/task/KlZyiwCLST2E5HQDwmWoxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:14:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KlZyiwCLST2E5HQDwmWoxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:14:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KlZyiwCLST2E5HQDwmWoxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:14:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KlZyiwCLST2E5HQDwmWoxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:14:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KlZyiwCLST2E5HQDwmWoxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:14:24 INFO - Downloaded 22868152 bytes. 12:14:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:14:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:14:25 INFO - Return code: 0 12:14: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')]} 12:14:25 INFO - https://queue.taskcluster.net/v1/task/KlZyiwCLST2E5HQDwmWoxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:14:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KlZyiwCLST2E5HQDwmWoxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 12:14:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KlZyiwCLST2E5HQDwmWoxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 12:14:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KlZyiwCLST2E5HQDwmWoxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 12:14:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KlZyiwCLST2E5HQDwmWoxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:14:27 INFO - Downloaded 10833369 bytes. 12:14:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:14:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 12:14:27 INFO - Return code: 0 12:14:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:27 INFO - https://queue.taskcluster.net/v1/task/KlZyiwCLST2E5HQDwmWoxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:14:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KlZyiwCLST2E5HQDwmWoxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:14:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KlZyiwCLST2E5HQDwmWoxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:14:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KlZyiwCLST2E5HQDwmWoxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:14:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KlZyiwCLST2E5HQDwmWoxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:14:31 INFO - Downloaded 55185641 bytes. 12:14:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KlZyiwCLST2E5HQDwmWoxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:14:31 INFO - mkdir: /builds/slave/test/properties 12:14:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:14:31 INFO - Writing to file /builds/slave/test/properties/build_url 12:14:31 INFO - Contents: 12:14:31 INFO - build_url:https://queue.taskcluster.net/v1/task/KlZyiwCLST2E5HQDwmWoxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:14:32 INFO - Running post-action listener: _resource_record_post_action 12:14:32 INFO - Running post-action listener: set_extra_try_arguments 12:14:32 INFO - ##### 12:14:32 INFO - ##### Finished download-and-extract step (success) 12:14:32 INFO - ##### 12:14:32 INFO - ##### 12:14:32 INFO - ##### Running populate-webroot step. 12:14:32 INFO - ##### 12:14:32 INFO - Running pre-action listener: _resource_record_pre_action 12:14:32 INFO - Running main action method: populate_webroot 12:14:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:14:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:14:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:14:32 INFO - '--tppagecycles', 12:14:32 INFO - '7'], 12:14:32 INFO - 'tests': ['tsvgm']}}, 12:14:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:14:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:14:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:14:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:14:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:14:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:14:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:32 INFO - 'talos_options': ['--disable-e10s'], 12:14:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:14:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:14:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:32 INFO - 'talos_options': ['--disable-e10s'], 12:14:32 INFO - 'tests': ['damp', 'tps']}, 12:14:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:32 INFO - 'tests': ['damp', 'tps']}, 12:14:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:14:32 INFO - 'tests': ['dromaeo_dom']}, 12:14:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:14:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:14:32 INFO - 'tests': ['a11yr', 12:14:32 INFO - 'ts_paint', 12:14:32 INFO - 'tpaint', 12:14:32 INFO - 'sessionrestore', 12:14:32 INFO - 'sessionrestore_no_auto_restore', 12:14:32 INFO - 'tabpaint']}, 12:14:32 INFO - 'other-e10s': {'tests': ['a11yr', 12:14:32 INFO - 'ts_paint', 12:14:32 INFO - 'tpaint', 12:14:32 INFO - 'sessionrestore', 12:14:32 INFO - 'sessionrestore_no_auto_restore', 12:14:32 INFO - 'tabpaint']}, 12:14:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:14:32 INFO - 'ts_paint', 12:14:32 INFO - 'tpaint', 12:14:32 INFO - 'sessionrestore', 12:14:32 INFO - 'sessionrestore_no_auto_restore', 12:14:32 INFO - 'tabpaint']}, 12:14:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:14:32 INFO - 'ts_paint', 12:14:32 INFO - 'tpaint', 12:14:32 INFO - 'sessionrestore', 12:14:32 INFO - 'sessionrestore_no_auto_restore', 12:14:32 INFO - 'tabpaint']}, 12:14:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:14:32 INFO - 'tests': ['a11yr', 12:14:32 INFO - 'ts_paint', 12:14:32 INFO - 'tpaint', 12:14:32 INFO - 'sessionrestore', 12:14:32 INFO - 'sessionrestore_no_auto_restore', 12:14:32 INFO - 'tabpaint']}, 12:14:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:14:32 INFO - 'tests': ['a11yr', 12:14:32 INFO - 'ts_paint', 12:14:32 INFO - 'tpaint', 12:14:32 INFO - 'sessionrestore', 12:14:32 INFO - 'sessionrestore_no_auto_restore', 12:14:32 INFO - 'tabpaint']}, 12:14:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:14:32 INFO - 'tests': ['tsvgx', 12:14:32 INFO - 'tsvgr_opacity', 12:14:32 INFO - 'tart', 12:14:32 INFO - 'tscrollx', 12:14:32 INFO - 'cart']}, 12:14:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:14:32 INFO - 'tsvgr_opacity', 12:14:32 INFO - 'tart', 12:14:32 INFO - 'tscrollx', 12:14:32 INFO - 'cart']}, 12:14:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:32 INFO - 'talos_options': ['--disable-e10s'], 12:14:32 INFO - 'tests': ['tp5o']}, 12:14:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:32 INFO - 'tests': ['tp5o']}, 12:14:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:32 INFO - 'talos_options': ['--disable-e10s', 12:14:32 INFO - '--xperf_path', 12:14:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:14:32 INFO - 'tests': ['tp5n']}, 12:14:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:32 INFO - 'talos_options': ['--xperf_path', 12:14:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:14:32 INFO - 'tests': ['tp5n']}}, 12:14:32 INFO - 'talos.zip': {'path': '', 12:14:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:14:32 INFO - Running post-action listener: _resource_record_post_action 12:14:32 INFO - ##### 12:14:32 INFO - ##### Finished populate-webroot step (success) 12:14:32 INFO - ##### 12:14:32 INFO - ##### 12:14:32 INFO - ##### Running create-virtualenv step. 12:14:32 INFO - ##### 12:14:32 INFO - Running pre-action listener: _resource_record_pre_action 12:14:32 INFO - Running main action method: create_virtualenv 12:14:32 INFO - Creating virtualenv /builds/slave/test/build/venv 12:14:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:14:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:14:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:14:32 INFO - Using real prefix '/usr' 12:14:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:14:32 INFO - Installing distribute.............................................................................................................................................................................................done. 12:14:34 INFO - Installing pip.................done. 12:14:34 INFO - Return code: 0 12:14:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:14:34 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')]} 12:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:34 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')]} 12:14:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:34 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 0x7f2d4bc46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2894020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29262e0>, '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 0x2892140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28925d0>, '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': '52faae308a556c440401f8e5000001e8-1464981171.560497-1317786345', '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 12:14:34 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 12:14:34 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 12:14:34 INFO - Using env: {'DISPLAY': ':0', 12:14:34 INFO - 'HOME': '/home/cltbld', 12:14:34 INFO - 'LANG': 'en_US.UTF-8', 12:14:34 INFO - 'LANGUAGE': 'en_US:en', 12:14:34 INFO - 'LOGNAME': 'cltbld', 12:14:34 INFO - 'MAIL': '/var/mail/cltbld', 12:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:34 INFO - 'MOZ_NO_REMOTE': '1', 12:14:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:34 INFO - 'NO_EM_RESTART': '1', 12:14:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:34 INFO - 'PWD': '/builds/slave/test', 12:14:34 INFO - 'SHELL': '/bin/bash', 12:14:34 INFO - 'SHLVL': '1', 12:14:34 INFO - 'TERM': 'linux', 12:14:34 INFO - 'TMOUT': '86400', 12:14:34 INFO - 'USER': 'cltbld', 12:14:34 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464981171.560497-1317786345', 12:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:34 INFO - '_': '/tools/buildbot/bin/python'} 12:14:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:34 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 12:14:34 INFO - Cleaning up... 12:14:34 INFO - Return code: 0 12:14:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:14:34 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')]} 12:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:34 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')]} 12:14:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:34 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 0x7f2d4bc46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2894020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29262e0>, '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 0x2892140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28925d0>, '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': '52faae308a556c440401f8e5000001e8-1464981171.560497-1317786345', '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 12:14:34 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 12:14:34 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 12:14:34 INFO - Using env: {'DISPLAY': ':0', 12:14:34 INFO - 'HOME': '/home/cltbld', 12:14:34 INFO - 'LANG': 'en_US.UTF-8', 12:14:34 INFO - 'LANGUAGE': 'en_US:en', 12:14:34 INFO - 'LOGNAME': 'cltbld', 12:14:34 INFO - 'MAIL': '/var/mail/cltbld', 12:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:34 INFO - 'MOZ_NO_REMOTE': '1', 12:14:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:34 INFO - 'NO_EM_RESTART': '1', 12:14:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:34 INFO - 'PWD': '/builds/slave/test', 12:14:34 INFO - 'SHELL': '/bin/bash', 12:14:34 INFO - 'SHLVL': '1', 12:14:34 INFO - 'TERM': 'linux', 12:14:34 INFO - 'TMOUT': '86400', 12:14:34 INFO - 'USER': 'cltbld', 12:14:34 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464981171.560497-1317786345', 12:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:34 INFO - '_': '/tools/buildbot/bin/python'} 12:14:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:35 INFO - Downloading/unpacking psutil>=3.1.1 12:14: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 12:14: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 12:14: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 12:14: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 12:14: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 12:14: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 12:14:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:14:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:14:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:14:37 INFO - Installing collected packages: psutil 12:14:37 INFO - Running setup.py install for psutil 12:14:37 INFO - building 'psutil._psutil_linux' extension 12:14:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 12:14:37 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 12:14:37 INFO - building 'psutil._psutil_posix' extension 12:14:37 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 12:14:37 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 12:14:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:14:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:14:37 INFO - Successfully installed psutil 12:14:37 INFO - Cleaning up... 12:14:37 INFO - Return code: 0 12:14:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:14:37 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')]} 12:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:37 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')]} 12:14:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:37 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 0x7f2d4bc46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2894020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29262e0>, '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 0x2892140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28925d0>, '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': '52faae308a556c440401f8e5000001e8-1464981171.560497-1317786345', '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 12:14:37 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 12:14:37 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 12:14:37 INFO - Using env: {'DISPLAY': ':0', 12:14:37 INFO - 'HOME': '/home/cltbld', 12:14:37 INFO - 'LANG': 'en_US.UTF-8', 12:14:37 INFO - 'LANGUAGE': 'en_US:en', 12:14:37 INFO - 'LOGNAME': 'cltbld', 12:14:37 INFO - 'MAIL': '/var/mail/cltbld', 12:14:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:37 INFO - 'MOZ_NO_REMOTE': '1', 12:14:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:37 INFO - 'NO_EM_RESTART': '1', 12:14:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:37 INFO - 'PWD': '/builds/slave/test', 12:14:37 INFO - 'SHELL': '/bin/bash', 12:14:37 INFO - 'SHLVL': '1', 12:14:37 INFO - 'TERM': 'linux', 12:14:37 INFO - 'TMOUT': '86400', 12:14:37 INFO - 'USER': 'cltbld', 12:14:37 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464981171.560497-1317786345', 12:14:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:37 INFO - '_': '/tools/buildbot/bin/python'} 12:14:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:14: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 12:14: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 12:14: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 12:14: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 12:14: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 12:14: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 12:14:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:14:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:14:39 INFO - Installing collected packages: mozsystemmonitor 12:14:39 INFO - Running setup.py install for mozsystemmonitor 12:14:39 INFO - Successfully installed mozsystemmonitor 12:14:39 INFO - Cleaning up... 12:14:40 INFO - Return code: 0 12:14:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d4bc46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2894020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29262e0>, '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 0x2892140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28925d0>, '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': '52faae308a556c440401f8e5000001e8-1464981171.560497-1317786345', '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 12:14:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:14:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:14:40 INFO - Using env: {'DISPLAY': ':0', 12:14:40 INFO - 'HOME': '/home/cltbld', 12:14:40 INFO - 'LANG': 'en_US.UTF-8', 12:14:40 INFO - 'LANGUAGE': 'en_US:en', 12:14:40 INFO - 'LOGNAME': 'cltbld', 12:14:40 INFO - 'MAIL': '/var/mail/cltbld', 12:14:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:40 INFO - 'MOZ_NO_REMOTE': '1', 12:14:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:40 INFO - 'NO_EM_RESTART': '1', 12:14:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:40 INFO - 'PWD': '/builds/slave/test', 12:14:40 INFO - 'SHELL': '/bin/bash', 12:14:40 INFO - 'SHLVL': '1', 12:14:40 INFO - 'TERM': 'linux', 12:14:40 INFO - 'TMOUT': '86400', 12:14:40 INFO - 'USER': 'cltbld', 12:14:40 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464981171.560497-1317786345', 12:14:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:40 INFO - '_': '/tools/buildbot/bin/python'} 12:14:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:40 INFO - Downloading/unpacking jsonschema==2.5.1 12:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:14:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:42 INFO - Downloading functools32-3.2.3-2.tar.gz 12:14:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:14:42 INFO - warning: no files found matching '*.txt' 12:14:42 INFO - no previously-included directories found matching 'build' 12:14:42 INFO - no previously-included directories found matching 'dist' 12:14:42 INFO - no previously-included directories found matching '.git*' 12:14:42 INFO - Installing collected packages: jsonschema, functools32 12:14:42 INFO - Running setup.py install for functools32 12:14:42 INFO - warning: no files found matching '*.txt' 12:14:42 INFO - no previously-included directories found matching 'build' 12:14:42 INFO - no previously-included directories found matching 'dist' 12:14:42 INFO - no previously-included directories found matching '.git*' 12:14:42 INFO - Successfully installed jsonschema functools32 12:14:42 INFO - Cleaning up... 12:14:42 INFO - Return code: 0 12:14:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:14:42 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')]} 12:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:42 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')]} 12:14:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:42 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 0x7f2d4bc46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2894020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29262e0>, '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 0x2892140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28925d0>, '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': '52faae308a556c440401f8e5000001e8-1464981171.560497-1317786345', '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 12:14:42 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 12:14:42 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 12:14:42 INFO - Using env: {'DISPLAY': ':0', 12:14:42 INFO - 'HOME': '/home/cltbld', 12:14:42 INFO - 'LANG': 'en_US.UTF-8', 12:14:42 INFO - 'LANGUAGE': 'en_US:en', 12:14:42 INFO - 'LOGNAME': 'cltbld', 12:14:42 INFO - 'MAIL': '/var/mail/cltbld', 12:14:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:42 INFO - 'MOZ_NO_REMOTE': '1', 12:14:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:42 INFO - 'NO_EM_RESTART': '1', 12:14:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:42 INFO - 'PWD': '/builds/slave/test', 12:14:42 INFO - 'SHELL': '/bin/bash', 12:14:42 INFO - 'SHLVL': '1', 12:14:42 INFO - 'TERM': 'linux', 12:14:42 INFO - 'TMOUT': '86400', 12:14:42 INFO - 'USER': 'cltbld', 12:14:42 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464981171.560497-1317786345', 12:14:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:42 INFO - '_': '/tools/buildbot/bin/python'} 12:14:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:42 INFO - Downloading/unpacking blobuploader==1.2.4 12:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:44 INFO - Downloading blobuploader-1.2.4.tar.gz 12:14:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:14:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:14:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:45 INFO - Downloading docopt-0.6.1.tar.gz 12:14:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:14:45 INFO - Installing collected packages: blobuploader, requests, docopt 12:14:45 INFO - Running setup.py install for blobuploader 12:14:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:14:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:14:45 INFO - Running setup.py install for requests 12:14:45 INFO - Running setup.py install for docopt 12:14:46 INFO - Successfully installed blobuploader requests docopt 12:14:46 INFO - Cleaning up... 12:14:46 INFO - Return code: 0 12:14:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d4bc46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2894020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29262e0>, '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 0x2892140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28925d0>, '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': '52faae308a556c440401f8e5000001e8-1464981171.560497-1317786345', '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 12:14:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:14:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:14:46 INFO - Using env: {'DISPLAY': ':0', 12:14:46 INFO - 'HOME': '/home/cltbld', 12:14:46 INFO - 'LANG': 'en_US.UTF-8', 12:14:46 INFO - 'LANGUAGE': 'en_US:en', 12:14:46 INFO - 'LOGNAME': 'cltbld', 12:14:46 INFO - 'MAIL': '/var/mail/cltbld', 12:14:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:46 INFO - 'MOZ_NO_REMOTE': '1', 12:14:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:46 INFO - 'NO_EM_RESTART': '1', 12:14:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:46 INFO - 'PWD': '/builds/slave/test', 12:14:46 INFO - 'SHELL': '/bin/bash', 12:14:46 INFO - 'SHLVL': '1', 12:14:46 INFO - 'TERM': 'linux', 12:14:46 INFO - 'TMOUT': '86400', 12:14:46 INFO - 'USER': 'cltbld', 12:14:46 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464981171.560497-1317786345', 12:14:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:46 INFO - '_': '/tools/buildbot/bin/python'} 12:14:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:14:46 INFO - Running setup.py (path:/tmp/pip-5dJ42l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:14:46 INFO - Running setup.py (path:/tmp/pip-_E6Djb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:14:46 INFO - Running setup.py (path:/tmp/pip-ujmBKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:14:46 INFO - Running setup.py (path:/tmp/pip-iT5dLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:14:46 INFO - Running setup.py (path:/tmp/pip-lxg2Zq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:14:46 INFO - Running setup.py (path:/tmp/pip-_nPtBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:14:46 INFO - Running setup.py (path:/tmp/pip-ZSQ_JD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:14:46 INFO - Running setup.py (path:/tmp/pip-1XTQZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:14:46 INFO - Running setup.py (path:/tmp/pip-k4SEa8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:14:47 INFO - Running setup.py (path:/tmp/pip-jEbPLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:14:47 INFO - Running setup.py (path:/tmp/pip-ax_Sk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:14:47 INFO - Running setup.py (path:/tmp/pip-ZxxlrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:14:47 INFO - Running setup.py (path:/tmp/pip-clu6Gp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:14:47 INFO - Running setup.py (path:/tmp/pip-Tju3Lo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:14:47 INFO - Running setup.py (path:/tmp/pip-qwsrhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:14:47 INFO - Running setup.py (path:/tmp/pip-C6vIfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:14:47 INFO - Running setup.py (path:/tmp/pip-8h2IRu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:14:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:14:47 INFO - Running setup.py install for manifestparser 12:14:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:14:47 INFO - Running setup.py install for mozcrash 12:14:47 INFO - Running setup.py install for mozdebug 12:14:47 INFO - Running setup.py install for mozdevice 12:14:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:14:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:14:48 INFO - Running setup.py install for mozfile 12:14:48 INFO - Running setup.py install for mozhttpd 12:14:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:14:48 INFO - Running setup.py install for mozinfo 12:14:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:14:48 INFO - Running setup.py install for mozInstall 12:14:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:14:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:14:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:14:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:14:48 INFO - Running setup.py install for mozleak 12:14:48 INFO - Running setup.py install for mozlog 12:14:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:14:48 INFO - Running setup.py install for moznetwork 12:14:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:14:48 INFO - Running setup.py install for mozprocess 12:14:48 INFO - Running setup.py install for mozprofile 12:14:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:14:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:14:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:14:48 INFO - Running setup.py install for mozrunner 12:14:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:14:49 INFO - Running setup.py install for mozscreenshot 12:14:49 INFO - Running setup.py install for moztest 12:14:49 INFO - Running setup.py install for mozversion 12:14:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:14:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:14:49 INFO - Cleaning up... 12:14:49 INFO - Return code: 0 12:14:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:14:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:49 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 0x7f2d4bc46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2894020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29262e0>, '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 0x2892140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28925d0>, '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': '52faae308a556c440401f8e5000001e8-1464981171.560497-1317786345', '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 12:14:49 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 12:14:49 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 12:14:49 INFO - Using env: {'DISPLAY': ':0', 12:14:49 INFO - 'HOME': '/home/cltbld', 12:14:49 INFO - 'LANG': 'en_US.UTF-8', 12:14:49 INFO - 'LANGUAGE': 'en_US:en', 12:14:49 INFO - 'LOGNAME': 'cltbld', 12:14:49 INFO - 'MAIL': '/var/mail/cltbld', 12:14:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:49 INFO - 'MOZ_NO_REMOTE': '1', 12:14:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:49 INFO - 'NO_EM_RESTART': '1', 12:14:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:49 INFO - 'PWD': '/builds/slave/test', 12:14:49 INFO - 'SHELL': '/bin/bash', 12:14:49 INFO - 'SHLVL': '1', 12:14:49 INFO - 'TERM': 'linux', 12:14:49 INFO - 'TMOUT': '86400', 12:14:49 INFO - 'USER': 'cltbld', 12:14:49 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464981171.560497-1317786345', 12:14:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:49 INFO - '_': '/tools/buildbot/bin/python'} 12:14:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:14:49 INFO - Running setup.py (path:/tmp/pip-ysYkDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:14:49 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)) 12:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:14:49 INFO - Running setup.py (path:/tmp/pip-0LkL4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:14:49 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)) 12:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:14:49 INFO - Running setup.py (path:/tmp/pip-IjYI4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:14:49 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)) 12:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:14:49 INFO - Running setup.py (path:/tmp/pip-rF0Iow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:14:49 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)) 12:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:14:49 INFO - Running setup.py (path:/tmp/pip-FHfaju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:14:50 INFO - Running setup.py (path:/tmp/pip-MLwGdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:14:50 INFO - Running setup.py (path:/tmp/pip-pPfc6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:14:50 INFO - Running setup.py (path:/tmp/pip-9SNUvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:14:50 INFO - Running setup.py (path:/tmp/pip-slp9np-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:14:50 INFO - Running setup.py (path:/tmp/pip-tUrOPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:14:50 INFO - Running setup.py (path:/tmp/pip-eQeFGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:14:50 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)) 12:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:14:50 INFO - Running setup.py (path:/tmp/pip-1KFa8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:14:50 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)) 12:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:14:50 INFO - Running setup.py (path:/tmp/pip-r6jIoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:14:50 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)) 12:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:14:50 INFO - Running setup.py (path:/tmp/pip-1Q8atz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:14:50 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)) 12:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:14:50 INFO - Running setup.py (path:/tmp/pip-zHoKen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:14:50 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)) 12:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:14:50 INFO - Running setup.py (path:/tmp/pip-bnGQDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:14:50 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)) 12:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:14:50 INFO - Running setup.py (path:/tmp/pip-vZOEY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:14:50 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)) 12:14:50 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)) 12:14:50 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)) 12:14:50 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)) 12:14:50 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)) 12:14:50 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)) 12:14:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:14:50 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 12:14:50 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 12:14:50 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 12:14:50 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 12:14:50 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 12:14:50 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 12:14:52 INFO - Downloading blessings-1.6.tar.gz 12:14:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:14:52 INFO - Installing collected packages: blessings 12:14:52 INFO - Running setup.py install for blessings 12:14:53 INFO - Successfully installed blessings 12:14:53 INFO - Cleaning up... 12:14:53 INFO - Return code: 0 12:14:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:14:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:14:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:14:53 INFO - Reading from file tmpfile_stdout 12:14:53 INFO - Current package versions: 12:14:53 INFO - argparse == 1.2.1 12:14:53 INFO - blessings == 1.6 12:14:53 INFO - blobuploader == 1.2.4 12:14:53 INFO - docopt == 0.6.1 12:14:53 INFO - functools32 == 3.2.3-2 12:14:53 INFO - jsonschema == 2.5.1 12:14:53 INFO - manifestparser == 1.1 12:14:53 INFO - mozInstall == 1.12 12:14:53 INFO - mozcrash == 0.17 12:14:53 INFO - mozdebug == 0.1 12:14:53 INFO - mozdevice == 0.48 12:14:53 INFO - mozfile == 1.2 12:14:53 INFO - mozhttpd == 0.7 12:14:53 INFO - mozinfo == 0.9 12:14:53 INFO - mozleak == 0.1 12:14:53 INFO - mozlog == 3.2 12:14:53 INFO - moznetwork == 0.27 12:14:53 INFO - mozprocess == 0.22 12:14:53 INFO - mozprofile == 0.28 12:14:53 INFO - mozrunner == 6.11 12:14:53 INFO - mozscreenshot == 0.1 12:14:53 INFO - mozsystemmonitor == 0.3 12:14:53 INFO - moztest == 0.7 12:14:53 INFO - mozversion == 1.4 12:14:53 INFO - psutil == 3.1.1 12:14:53 INFO - requests == 1.2.3 12:14:53 INFO - wsgiref == 0.1.2 12:14:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:14:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d4bc46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2894020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29262e0>, '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 0x2892140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28925d0>, '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': '52faae308a556c440401f8e5000001e8-1464981171.560497-1317786345', '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 12:14:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:14:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:14:53 INFO - Using env: {'DISPLAY': ':0', 12:14:53 INFO - 'HOME': '/home/cltbld', 12:14:53 INFO - 'LANG': 'en_US.UTF-8', 12:14:53 INFO - 'LANGUAGE': 'en_US:en', 12:14:53 INFO - 'LOGNAME': 'cltbld', 12:14:53 INFO - 'MAIL': '/var/mail/cltbld', 12:14:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:53 INFO - 'MOZ_NO_REMOTE': '1', 12:14:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:53 INFO - 'NO_EM_RESTART': '1', 12:14:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:53 INFO - 'PWD': '/builds/slave/test', 12:14:53 INFO - 'SHELL': '/bin/bash', 12:14:53 INFO - 'SHLVL': '1', 12:14:53 INFO - 'TERM': 'linux', 12:14:53 INFO - 'TMOUT': '86400', 12:14:53 INFO - 'USER': 'cltbld', 12:14:53 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464981171.560497-1317786345', 12:14:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:53 INFO - '_': '/tools/buildbot/bin/python'} 12:14:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:53 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)) 12:14:53 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)) 12:14:53 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)) 12:14:53 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)) 12:14:53 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)) 12:14:53 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)) 12:14:53 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)) 12:14:53 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)) 12:14:53 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)) 12:14:53 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)) 12:14:53 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)) 12:14:53 INFO - Cleaning up... 12:14:53 INFO - Return code: 0 12:14:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:14:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d4bc46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2894020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29262e0>, '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 0x2892140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28925d0>, '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': '52faae308a556c440401f8e5000001e8-1464981171.560497-1317786345', '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 12:14:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:14:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:14:53 INFO - Using env: {'DISPLAY': ':0', 12:14:53 INFO - 'HOME': '/home/cltbld', 12:14:53 INFO - 'LANG': 'en_US.UTF-8', 12:14:53 INFO - 'LANGUAGE': 'en_US:en', 12:14:53 INFO - 'LOGNAME': 'cltbld', 12:14:53 INFO - 'MAIL': '/var/mail/cltbld', 12:14:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:53 INFO - 'MOZ_NO_REMOTE': '1', 12:14:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:53 INFO - 'NO_EM_RESTART': '1', 12:14:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:53 INFO - 'PWD': '/builds/slave/test', 12:14:53 INFO - 'SHELL': '/bin/bash', 12:14:53 INFO - 'SHLVL': '1', 12:14:53 INFO - 'TERM': 'linux', 12:14:53 INFO - 'TMOUT': '86400', 12:14:53 INFO - 'USER': 'cltbld', 12:14:53 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464981171.560497-1317786345', 12:14:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:53 INFO - '_': '/tools/buildbot/bin/python'} 12:14:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:14:53 INFO - Cleaning up... 12:14:53 INFO - Return code: 0 12:14:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:14:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d4bc46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2894020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29262e0>, '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 0x2892140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28925d0>, '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': '52faae308a556c440401f8e5000001e8-1464981171.560497-1317786345', '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 12:14:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 12:14:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 12:14:53 INFO - Using env: {'DISPLAY': ':0', 12:14:53 INFO - 'HOME': '/home/cltbld', 12:14:53 INFO - 'LANG': 'en_US.UTF-8', 12:14:53 INFO - 'LANGUAGE': 'en_US:en', 12:14:53 INFO - 'LOGNAME': 'cltbld', 12:14:53 INFO - 'MAIL': '/var/mail/cltbld', 12:14:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:53 INFO - 'MOZ_NO_REMOTE': '1', 12:14:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:53 INFO - 'NO_EM_RESTART': '1', 12:14:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:53 INFO - 'PWD': '/builds/slave/test', 12:14:53 INFO - 'SHELL': '/bin/bash', 12:14:53 INFO - 'SHLVL': '1', 12:14:53 INFO - 'TERM': 'linux', 12:14:53 INFO - 'TMOUT': '86400', 12:14:53 INFO - 'USER': 'cltbld', 12:14:53 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464981171.560497-1317786345', 12:14:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:53 INFO - '_': '/tools/buildbot/bin/python'} 12:14:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:53 INFO - Downloading/unpacking flake8 12:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:14:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:14:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:14:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:14:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:14:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:14:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:14:56 INFO - no previously-included directories found matching 'docs/_build' 12:14:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:14:56 INFO - Running setup.py install for pep8 12:14:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:14:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:14:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:14:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:14:56 INFO - no previously-included directories found matching 'docs/_build' 12:14:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:14:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:14:56 INFO - Cleaning up... 12:14:56 INFO - Return code: 0 12:14:56 INFO - Running post-action listener: _resource_record_post_action 12:14:56 INFO - Running post-action listener: _start_resource_monitoring 12:14:56 INFO - Starting resource monitoring. 12:14:56 INFO - ##### 12:14:56 INFO - ##### Finished create-virtualenv step (success) 12:14:56 INFO - ##### 12:14:56 INFO - ##### 12:14:56 INFO - ##### Running install step. 12:14:56 INFO - ##### 12:14:56 INFO - Running pre-action listener: _resource_record_pre_action 12:14:56 INFO - Running main action method: install 12:14:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:14:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:14:57 INFO - Reading from file tmpfile_stdout 12:14:57 INFO - Detecting whether we're running mozinstall >=1.0... 12:14:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:14:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:14:57 INFO - Reading from file tmpfile_stdout 12:14:57 INFO - Output received: 12:14:57 INFO - Usage: mozinstall [options] installer 12:14:57 INFO - Options: 12:14:57 INFO - -h, --help show this help message and exit 12:14:57 INFO - -d DEST, --destination=DEST 12:14:57 INFO - Directory to install application into. [default: 12:14:57 INFO - "/builds/slave/test"] 12:14:57 INFO - --app=APP Application being installed. [default: firefox] 12:14:57 INFO - mkdir: /builds/slave/test/build/application 12:14:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:14:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:15:13 INFO - Reading from file tmpfile_stdout 12:15:13 INFO - Output received: 12:15:13 INFO - /builds/slave/test/build/application/firefox/firefox 12:15:13 INFO - Running post-action listener: _resource_record_post_action 12:15:13 INFO - ##### 12:15:13 INFO - ##### Finished install step (success) 12:15:13 INFO - ##### 12:15:13 INFO - ##### 12:15:13 INFO - ##### Running run-tests step. 12:15:13 INFO - ##### 12:15:13 INFO - Running pre-action listener: _resource_record_pre_action 12:15:13 INFO - Running main action method: run_tests 12:15:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:15:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:15:13 INFO - Python 2.7.3 12:15:13 INFO - Return code: 0 12:15:13 INFO - grabbing minidump binary from tooltool 12:15: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')]} 12:15:13 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29262e0>, '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 0x2892140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28925d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:15:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:15:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:15:13 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 12:15:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:15:13 INFO - Return code: 0 12:15:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:15:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:15:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:15:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:15:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:15:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:15:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:15:14 INFO - Return code: 0 12:15:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KlZyiwCLST2E5HQDwmWoxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 12:15:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KlZyiwCLST2E5HQDwmWoxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --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 12:15:14 INFO - Using env: {'DISPLAY': ':0', 12:15:14 INFO - 'HOME': '/home/cltbld', 12:15:14 INFO - 'LANG': 'en_US.UTF-8', 12:15:14 INFO - 'LANGUAGE': 'en_US:en', 12:15:14 INFO - 'LOGNAME': 'cltbld', 12:15:14 INFO - 'MAIL': '/var/mail/cltbld', 12:15:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:15:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:15:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:14 INFO - 'MOZ_NO_REMOTE': '1', 12:15:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:15:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:14 INFO - 'NO_EM_RESTART': '1', 12:15:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:14 INFO - 'PWD': '/builds/slave/test', 12:15:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:15:14 INFO - 'SHELL': '/bin/bash', 12:15:14 INFO - 'SHLVL': '1', 12:15:14 INFO - 'TERM': 'linux', 12:15:14 INFO - 'TMOUT': '86400', 12:15:14 INFO - 'USER': 'cltbld', 12:15:14 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464981171.560497-1317786345', 12:15:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:14 INFO - '_': '/tools/buildbot/bin/python'} 12:15:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KlZyiwCLST2E5HQDwmWoxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 12:15:14 INFO - mozversion application_buildid: 20160603114627 12:15:14 INFO - mozversion application_changeset: dc5692c66a028e98980527c9a637932b992874b2 12:15:14 INFO - mozversion application_display_name: Nightly 12:15:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:15:14 INFO - mozversion application_name: Firefox 12:15:14 INFO - mozversion application_remotingname: firefox 12:15:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:15:14 INFO - mozversion application_vendor: Mozilla 12:15:14 INFO - mozversion application_version: 49.0a1 12:15:14 INFO - mozversion platform_buildid: 20160603114627 12:15:14 INFO - mozversion platform_changeset: dc5692c66a028e98980527c9a637932b992874b2 12:15:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:15:14 INFO - mozversion platform_version: 49.0a1 12:15:14 INFO - using testdate: 1464981314 12:15:14 INFO - actual date: 1464981314 12:15:14 INFO - starting webserver on 'localhost:37843' 12:15:14 INFO - SUITE-START | Running 2 tests 12:15:14 INFO - TEST-START | dromaeo_css 12:15:14 INFO - operating with platform_type : linux_ 12:15:14 INFO - Initialising browser for dromaeo_css test... 12:15:14 INFO - TEST-INFO | started process 12889 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplzU63A/profile http://localhost:37843/getInfo.html) 12:15:19 INFO - PROCESS | 12889 | __metrics Screen width/height:1600/1200 12:15:19 INFO - PROCESS | 12889 | colorDepth:24 12:15:19 INFO - PROCESS | 12889 | Browser inner width/height: 1024/697 12:15:19 INFO - PROCESS | 12889 | __metrics 12:15:20 ERROR - PROCESS | 12889 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:15:21 INFO - TEST-INFO | 12889: exit 0 12:15:21 INFO - Browser initialized. 12:15:21 INFO - Running cycle 1/1 for dromaeo_css test... 12:15:21 INFO - TEST-INFO | started process 12970 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplzU63A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:15:33 INFO - PROCESS | 12970 | RSS: Main: 158187520 12:15:33 INFO - PROCESS | 12970 | 12:16:24 INFO - PROCESS | 12970 | 1464981384870 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] 12:18:36 INFO - PROCESS | 12970 | Cycle 1(1): loaded http://localhost:37843/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37843/tests/dromaeo/cssquery-ext.html) 12:18:38 INFO - PROCESS | 12970 | RSS: Main: 269275136 12:18:38 INFO - PROCESS | 12970 | 12:21:40 INFO - PROCESS | 12970 | Cycle 1(1): loaded http://localhost:37843/tests/dromaeo/cssquery-ext.html (next: http://localhost:37843/tests/dromaeo/cssquery-jquery.html) 12:21:41 INFO - PROCESS | 12970 | RSS: Main: 239575040 12:21:41 INFO - PROCESS | 12970 | 12:24:43 INFO - PROCESS | 12970 | Cycle 1(1): loaded http://localhost:37843/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37843/tests/dromaeo/cssquery-mootools.html) 12:24:44 INFO - PROCESS | 12970 | RSS: Main: 244621312 12:24:44 INFO - PROCESS | 12970 | 12:27:46 INFO - PROCESS | 12970 | Cycle 1(1): loaded http://localhost:37843/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37843/tests/dromaeo/cssquery-prototype.html) 12:27:46 INFO - PROCESS | 12970 | RSS: Main: 239558656 12:27:46 INFO - PROCESS | 12970 | 12:30:49 INFO - PROCESS | 12970 | Cycle 1(1): loaded http://localhost:37843/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37843/tests/dromaeo/cssquery-yui.html) 12:30:50 INFO - PROCESS | 12970 | RSS: Main: 218038272 12:30:50 INFO - PROCESS | 12970 | 12:33:53 INFO - PROCESS | 12970 | Cycle 1(1): loaded http://localhost:37843/tests/dromaeo/cssquery-yui.html (next: http://localhost:37843/tests/dromaeo/cssquery-dojo.html) 12:33:53 INFO - PROCESS | 12970 | RSS: Main: 271749120 12:33:53 INFO - PROCESS | 12970 | 12:33:53 INFO - PROCESS | 12970 | __start_tp_report 12:33:53 INFO - PROCESS | 12970 | _x_x_mozilla_page_load 12:33:53 INFO - PROCESS | 12970 | _x_x_mozilla_page_load_details 12:33:53 INFO - PROCESS | 12970 | |i|pagename|runs| 12:33:53 INFO - PROCESS | 12970 | |0;dojo.html;2671.4790615829916;2689.5831146172327;2715.918522444327;2718.524258254805;2731.221601843475;4604.424446944132;4648.442186937568;4690.835820746274;4719.693219940706;4781.450133234679;4680.742559159254;4725.763711814404;4732.479427262998;4742.359781429506;4760.309755085511;4302.806373713175;4303.720258183208;4316.115196384733;4376.321670141133;4391.275439552486;4339.457567804025;4395.274779661352;4412.426384570002;4429.867103986886;4440.600345968862;4341.131773645252;4435;4437.068215674696;4441.46702395713;4473.619742321906;4236.195122926665;4248.490181178247;4268.765217913014;4275.038116423811;4282.486101667789;4263.616274535276;4298.333758267474;4309.159713855799;4347.130573885235;4358.411614432042;4634.8876269695365;4637.049404871993;4646.3495110684535;4650.86047418578;4665.720056796603;4854.2233242681;4941.950580494221;5015.623828212899;5023.974880125613;5092.770825312833;5043.773030213612;5082.034413461431;5096.872578185538;5102.540771330561;5120.411152717448;4598.26427771555;4754.286856971447;4771.093492236464;4772.809087636525;4776.617870570346;5118.59051275897;5193.402758682724;5195.6622819516615;5204.42751297357;5289.576833853283;5032.169692000852;5037.496250375007;5063.215201643751;5079.6952182869145;5090.77091530882;4887.486813884562;5055.292259083732;5060.721660308718;5094.923576146361;5128.410232823273;5038.546530812171;5040.546350828443;5066.341375621146;5094.439611642716;5130.897382052338;5046.39443266803;5058.595312375001;5069.721165335868;5073.365829271341;5123.743812809419;4166.520850102216;4191.874243772691;4193.832246710097;4296.720713153635;4340.2187606230555;3687.3178461984617;3726.5900750917376;3731.235096805203;3754.1740817020213;3759.191773768598;4313.654907607384;4320.4167437395545;4354.303311470149;4363.498197707241;4365.061511774984;4911.901761964741;5047.369078865142;5123.666961647481;5124.92312615311;5157.484251574812;4367.45406824147;4377.4965878923695;4379.080393117481;4410.051838854598;4418.182636212311;4566.292224705176;4574.199515084913;4574.268117101248;4577.496475387705;4622.745748983838;4642.234031384919;4711.19909615373;4745.786439610157;4802.327674125555;4805.831795887128;5055.797768089235;5067.594592432671;5075.670081444694;5085.593152547861;5127.41034781005;4742.952570474389;4747.881302967454;4749.833755818529;4768.737719425465;4809.879753006203;4876.122297986397;4972.676776009548;4986.850394488026;5002.399712034579;5031.798728050837;5091.694498329964;5106.514881086291;5125.4362020177;5129.846104616868;5181.81863634771;4961.603071754179;4962.379702537183;4965.1311020571975;4970.130227210151;4973.328600638867;4773.856784296477;4884.511548845087;4922.507749225048;4950.2079667253065;4973.52751488608;4839.612830973584;4864.975675121602;4911.214205727067;4919.877003074952;4926.605871530341;4830.106430310404;4974.676646017997;4988.575971042502;5037.19404895215;5037.496250374933;4684.5549672781035;4738.8341408050555;4745;4761.428628564595;4786.545278198566 12:33:53 INFO - PROCESS | 12970 | |1;ext.html;543.8759567272513;586.5718025841134;586.7711592478931;590.8936391449539;603.9516838652906;26937.326566835814;39107.41338879919;39701.4044789328;39746.20507589846;43622;40796.18407631846;41298.79350603243;41312.79343603278;41373.79313103438;41436.58563414365;7671.50135241209;7844.333231675315;7845.215478452166;7851.842963140763;7853.332466740334;7687.500312479699;7803.492772969767;7831.2560306770765;7834.764957051298;7840.333571646417;7840.176781437953;7884.32983196429;7895.684172633117;7908.920910790905;7911.248431399008;7813.843723125534;7878.763637090897;7888.092869320044;7905.328047115973;7909.999999999943;7727.343175830061;7808.180141085218;7813;7815.531068135873;7816.335611473031;37339.62660373389;37848.43227351592;37851.43222851659;37964.810175948944;38000.42999355012;2939.76481881449;3101.9379612407624;3160.8577614007427;3216.533602627606;3314.767966242364;28359;28834;28854;29317.120486385444;29320.560191597142;3409.7442691798215;3421.6920477157178;3436.856085995874;3451.3442445935193;3477.634848340913;247888;248326;248525;248870;250207;31176.53235201474;51529.22706159411;51591.226131608055;51727;51892.48107518952;32085.19787005297;34008.829955850066;34091.4886276706;34159.65840341565;34333;12255.019598432104;12374.071944604191;12380.81428778569;12384.690382740324;12410.875891240972;9952.950235248778;9966.2525310602;9973.50132493387;9985.950070249603;9989.400635961865;7834.569098699626;7894.802629934297;7922.881156782653;7991.400644951652;7999.520028798291;3075.308055687497;3086.5678804967324;3095.8947915417734;3101.550275210082;3155.2742869140225;873.9344549158839;912.3112050401904;1031.3811712972156;1052.026875140492;1057.613970900631;26419.867900660374;26877.731222687522;26975.190744277705;26992.325191869968;27091.32271693184;783.5847001089431;961.6201600367956;984.158544444504;984.2077127911956;1011.9392836429838;13019.739605208033;13981.22506923125;13986.930065349608;14156.929215354063;14165.645858853612;366126;369199;370601;371905;373040;46626.30060549094;47041;47186.29220561626;47224.291635625494;47267.763661181474;1120.439780109945;1197.4431889171576;1217.6347095871204;1232.0820988363726;1239.4422509870594;26450;28036;28290.2927426816;28439.857800710863;28534.714652853207;40459.59540404558;40542.59457405506;41144.79427602843;41163.38254926119;41219.1756164869;301757;303501;304196;304889;538860;23855.403614909766;24447.777611119018;24628.261152165465;25969.74030259749;25988.740112598633;39923.60076399199;39927.600723992386;40072.59927400688;40788;40790.1841963165;35193.120171995906;35203.82398087993;35288.29423411466;35912.281754365285;36217.81891090528;34952.825235874676;35168;35225;35302;35348.293034139686;33687.66312336845;34151.829240853636;34256.82871585626;34801.82599087089;34887.47668785021;30920.226994325323;31127.68872311248;31500.527492088095;32008.19979500438;32038.35923281568;22433.887830561394;23504.6474302889;23588;23625.64561531544;23721.64417533773 12:33:53 INFO - PROCESS | 12970 | |2;jquery.html;363.27889140056993;363.87810083621986;368.35905524387573;369.87794027970773;388.3475760721986;15569.532914012583;16844.410445634407;16865.241064152113;17232.56918577036;17352.13239338033;14902.850971490281;15062.322195501201;15279.01524616358;15373.846261537381;15395.69208615827;4937.160682683934;5165.76754046067;5177.30106435632;5177.663451875635;5179.741012949356;3658.3049220648127;3804.619538046201;4962.858542535219;5073.086844368012;5611.8316450506345;5859.882802343951;5939.554533410012;5968.612040217394;5969.641821490724;5971.253593300838;5810.854728631776;5831.504322132602;5932.466078052953;5944.4352786485215;5946.524278057766;3318.7510936679846;4727.976360118212;5007.4992500749995;5215.139501982168;5223.268742376071;19688;20403.08186131613;20404.693929591067;20411.89794051035;20437.489062773402;1822.189125838989;1917.4822797844643;1928.8495259607168;2204.900779464912;2463.519613675334;12808.743825123538;12844.422001009976;12913.160644558073;12931.5473958411;13396;1740.6344667619815;1770.7875054993353;1801.3245033112582;1818.1727314072066;1823.1613457809424;61884;64540.67729661322;64708.67645661742;65035.34964650388;65498.3450165497;9290.767730806783;9451.574679139456;9746.366486178518;10180.956547815234;10435.060844523878;13221.140625859289;13307.401166947511;13312.068155229235;13312.26782526951;13331.533396331082;6947.617881016593;6978.651067446607;7096.645167741593;7110.537815042006;7126.714931402789;6612.669366531654;6686.197656281277;6697.162854643169;6890.276520965226;7017.754378596826;5927.585069045125;6061.636301821904;6069.36271691466;6079.270487541523;6088.4824789893355;1582.4777823318277;1684.1915880377487;1708.5386945524638;1709.538424625344;1778.6353797471488;814.7963009247688;847.6778824046946;874.4141425245101;1008.9646862359782;1009.6466236817203;15824.604384890239;16118.919405402898;16312.75530867038;16655.583610409838;17017.149142542825;837.6858677995751;872.9345299102592;894.8836651235298;901.085398320705;940.9978373032835;8786.341024423065;9250;9263.212626926652;9296.907030929739;9366;357816;357962;358628;380631;380934;74476;74559;74638;75285.62357188179;75954.6202268985;949.9335046546813;956.086936975187;956.550421301987;968.2109081099022;973.59595767757;13689.315534223448;14513.419463221353;14855.851441485447;15413.383464661289;15717.528474145794;32735.253388259047;34196.62182765239;34598;34820.129496762784;35538.28923421465;45585.544144559455;45839.56053843162;46566.30150547812;47658;47736.85184166651;7448.255174482509;7689.615519224129;7712.344450721752;7727.150013498623;7748.496347737604;8529;10354.948225258826;11275.436228188722;11588.710282243012;11622.128340374336;6674.599524028574;6873.656317184021;7252.347288744038;9889.55497002651;10196.490175491048;9864.654737084167;9960.302778805413;10048.89951100509;10103.646372376932;10176.89823101789;9849.26130540198;10070.244731645302;10159.7460063499;10382.37705737628;10460;7251.492395532262;7271.745488908075;7326.04761381017;7361.1166659999;7538.133114691881;8858.247049000907;9990.500474976367;10056.798864022532;10102.09081182697;10206 12:33:53 INFO - PROCESS | 12970 | |3;mootools.html;1304.432571831254;1394.7489451898662;1456.905301155425;1549.2253873063469;1747.3622127923304;6623.37077977592;7460.440466964979;7705.075390953093;7709.537427754339;7835.098963619185;7595.734149304775;7745.109312429072;7772.378209743221;7779;7783.766487005385;1863.413024897153;2059.794020597943;2118.7881211878803;2128.467883029243;2152.6986221928864;2190.8247340212743;2210.9778902210933;2211.6682497625325;2214.4242496950746;2217.756046834847;2103.5582527669208;2116.2487317002474;2152.5587254612765;2152.773958734334;2156.6520924422234;1760.665473560026;2028.8275496582808;2068.617305798432;2097.643400621883;2108.20942146695;2154.8707077575395;2161.1247444784885;2176.249194028058;2178.357384571555;2183.7816218378193;7742.187070357644;7750.302472777421;7781.844363112763;7834.608269586555;7890.132085470594;4299.247631664446;4386;4449;4451.755153466558;4459.643228541709;2852.885884564615;2943.2641839540115;3002.24943764059;3022.2444388902773;3027.364253506766;848.3849209323191;855.5850412549909;888.5512816027929;895.8656201569752;902.9774255643596;10366.844497332546;10386.740331491697;10401.68794936153;10473.109785668228;10591.417472039111;4139.544650088488;4190.811413486339;4267;4280.871573852789;4302.397664326997;8920.375573709907;8934.86597701035;8970.82058358829;8982.056884027214;9000.59497322622;4443.089166720814;4501.729896206238;4502.099580083931;4512.638988880882;4514.661400394918;3622.4747411625167;3948.1314110895555;4053.007013281765;4053.9797301013896;4125.1131006833675;3488.2500262443696;3562.625924277965;3677.3380791457794;3682.3371793076967;3746.5129533160516;1171.2796630072444;1183.7336599265097;1195.503865895661;1199.7060720123625;1203.2479700187382;785.367778937949;838.7903024243939;886.5833058462513;898.766320756608;943.712167788831;5381.542568881689;5484.808031718871;5519.69641669712;5596.104623260258;5598.1322894951345;393.626055247516;400.3574263307408;410.97328673636116;416.91661667666585;419.80059471751287;3709.4806727058235;3744.344739670547;3753.211825516672;3780.9621903781162;3787.8484860605818;9185.908140918638;9347.672831450867;9519;9528.95235523818;9530.285228607881;9110.407823491452;9179.265658747418;9208.355415121012;9438.90561094394;9482.004389539137;7233.45749068822;7244.166920804069;7312.670929808065;7358.11702595692;7361.227071157451;5422.5119739223655;5465.098258787256;5587.497125258747;5663.1788390682295;5818.738156782871;8108.6756529740505;8144.429889907649;8391.958040210004;8412.158784121539;8423.789405264917;8271.875921861056;8402.453840500348;8413.579321034047;8430.325573954191;8479.279261262862;5828.76684932598;6228.28374736893;6340.682965851781;6437.485001199986;6480.513961452815;7511;7524;7559.28186822251;7606.543607383574;7618.504797188165;6626.867462650816;6756.560823546453;6756.729730810909;6858.725650974105;6956.79129626112;6611.305812889577;6666.966665166643;6706.798796036127;6774.830629234309;6775.728970841308;6229.283632382153;6271.3415091414745;6300.71646775887;6317.778877739257;6321.810345689637;4704.153252414599;4709.0817290628;4763.642726795435;4773.403324584427;4805.207140821725;4693.788779504999;4756.6908150970075;4774.474807771073;4870.488598697228;4887.608991280618 12:33:53 INFO - PROCESS | 12970 | |4;prototype.html;285.7999400419707;292.12799792619035;296.9109267219834;300.73234821009316;301.1267324758201;4703.248599569251;4800.255960326151;4821.228603423453;4830.589399901012;4845.515448455153;4254.0255453847985;4418.955810441895;4545.727196385009;4696.272077827934;4788.497207793183;3722.4416337549314;3737.364648009845;3740.719446041544;3752.967933818208;3756.9436458453147;3545;3749.5125633667585;3754.9624503754885;3762.473253744478;3779.1874746929407;3575.856965721381;3711.5917249102577;3738.6822120119823;3747.3067482515685;3747.6252374762444;3708.2768860072297;3713.1459764254373;3718.219173973469;3724.478572999782;3741.38267185914;3296.489044198153;3301.1747063234193;3305.6116431098994;3329;3334.3831391192707;4417.624501917341;4557.384753058328;4585.541445855421;4592.173408786417;4604.309353596954;4241.87274381769;4252.128313695685;4252.149570085964;4273.957260427387;4286.228478873802;4934;4958.925616115761;4959.528844759742;4963.652544321899;4969.503049695038;3525.1399717309505;3634.1096431374217;3640.8179591020607;3643.417053271464;3655.232401195752;5154.819581314636;5161.58707303411;5197.58419326453;5202.947970520284;5238.659487133362;3638.7089032877834;3664.780113193217;3670.119171398845;3671.6879065279218;3672.3389789838084;3676.1361080146144;3719.795411252407;3721.5162028936065;3722.1439069013736;3733.90901095382;3925.3523168676847;4172.4784401949755;4187.434696315959;4210.642040457354;4232.322828347511;4975.427825800007;4978.701277923336;4984.750762461862;4986.700797952134;4997.375328083989;1191.9940400297944;1215.7872372334982;1255.3409460033372;1259.0745801835644;1259.1815320042047;766.1993217088157;790.6679194738224;790.9881351779728;792.6235038356734;800.1518390505965;3940.8226629801156;3943.431194768739;3946.7039972002217;3977.9458443512494;3981.8145483612993;4555.658325625592;4560.224761790503;4568.33759104928;4583.381243532147;4595.954040459619;3948.249832531867;3956.248312820555;3965.5637879833193;4025.3961905714377;4053.6554392876346;2441.5971364724624;2442.496441147802;2557.8593177375424;2735.3024978630324;2767.9446411071667;4844.685095468783;4846.757662116951;4851.636127290397;4886.364772579542;4897.902041959141;5273.235380869829;5276.762545685453;5282.815101471507;5317.494837990384;5324.334458192726;4607.262837945913;4854.271859221074;4858.975705121452;4884.267359895973;4901.460839307744;5144.254083157846;5157.974210128926;5162.870928226675;5177.559907407913;5191.792328306977;5070.2141168119;5081.923771143362;5089.949100509096;5092.3125378074965;5094.490550945025;4714.316424118552;4857.247126695368;4861.586765125004;4866.245731911417;4874.171390863491;3733.693207377396;3737.3833317503395;3753.737238393286;3753.887383378503;3754.8685795998103;4857.149998750276;5074.923876141935;5088.949110508847;5134.15286477727;5136.922946155736;4875.853724388132;4992.450830408579;5011.2961593058535;5039.697618142924;5043.5712964398435;4995.525425084611;4999.200127979506;5023.773930173078;5027.572656324253;5068.163752980717;4800.5199480051715;4885.706857588556;4909.337239472626;4948.208286674115;4948.950510494993;4990.625703072212;5029.44676085623;5035.546800787946;5051.924221136613;5054.418741844588;4822.397200349957;4919.557239848431;4950.45544990058;4977.43210888569;4980.800767969386 12:33:53 INFO - PROCESS | 12970 | |5;yui.html;674.939255467008;689.6930865764737;690.8307464671154;693.947953903457;750.9361704255138;11165.665030049102;11709.297442153456;11710.238834475753;11767.058635309177;11792.646220613384;12021.978131858781;12048.337341446217;12073.275603463799;12076.033917286619;12080.879191208085;614.3856143856144;770.5723323555438;775.9495632783851;800.1918062756599;804.7786858613899;783.5416281475344;788.7594283743456;790.4664351562701;791.161368948916;791.3985371117963;833.9791505212357;838.0195171649154;838.9874151887726;839.0267289943666;839.3830534557096;648.7210499485243;810.8013536683521;824.5629816197425;834.1991687979486;838.3083955736541;608.939106089392;613.2916481463916;614.342653360904;615.301632646949;617.2931992868185;11523.48144333507;11577.363245021521;11684.47419866108;11690.941545292304;11697.064234861191;11596.826047609293;11986;12049.397530123546;12060.095492838072;12368.938155309255;11049.392283424408;11180.142687277083;11202;11400.486978086006;11440.771184576344;4083.4079058536645;4089.3865920111925;4101.425800387919;4114.19773144237;4164.7709375984305;54575.45424545743;54690.179647305325;54826;55050;55353.723231383585;9565.139137477661;9634.90365096354;9635;9651.276154288456;9672.419654820733;18260.086995650163;18263.17815698297;18295.908520457313;18314.26742930268;18431;6562.212534495891;6606.867862642816;6637.800865974028;6744.393004629607;6755.695993680296;3611.205534782344;3620.149264922741;3655.250673611903;3673.3571624965525;3704.4628528863163;2802.313433208877;2903.2016195546394;2905.244636394553;2911.3740545782334;2913.140623516068;454.3843092609533;456.1834316573363;496.8757810547363;503.4436947173394;508.5346907579597;578.2511647416521;601.3955974245943;612.4426771637789;620.432304441431;638.3712043637014;8246.958765206256;8625.0943650917;8636.740897773077;8819.162179592928;8889.288856891433;480.47628085387095;555.9520304226562;569.9800506982235;572.0047118014625;586.8914250863604;4048.838046478108;4166.979165104155;4194.706370554032;4202.348635961431;4304.78476076195;56203.156952645746;56475.71762141163;56663.15005274924;56687.14969275464;80115.7982630261;75799.62100189574;79462;80334;80749.59625201837;80762;68978.65510672414;69132.92601221972;69649.65175174092;69687;69984.30015699778;7727.11138219112;7983.72056978003;8056.355491560778;8136.83726325482;8387.706430274911;43253.783731081145;43594.34608480939;43753.34369984389;44055.33916991184;44278.335824963295;60568;61543;61917.69041154766;62763;62855.6857215711;10056.446895420822;10405.895941040493;10463.843042354218;10526.578936842441;10599.364038157735;10883.891161088604;11042.779144416905;11267.605633802777;11345.886541134812;11976.16166868311;10363.585456581954;10391.740206494898;10614.150867930393;10637.521311540844;10922.453877306261;9983.90177080506;10164.593416263267;10292.845607316047;10453.372797632166;10554.050135487843;10268.743281418025;10521.894781052091;10662.306950048222;10757.246992710436;10975.396353200651;8882.866756998521;8920.107989201028;9042.502662353634;9057.275417966679;9342.906570934476;8245.711400100967;8668.436551624125;8717.782055448664;8776.254018408506;8955.552222388986 12:33:53 INFO - PROCESS | 12970 | __end_tp_report 12:33:53 INFO - PROCESS | 12970 | __start_cc_report 12:33:53 INFO - PROCESS | 12970 | _x_x_mozilla_cycle_collect,1072 12:33:53 INFO - PROCESS | 12970 | __end_cc_report 12:33:53 INFO - PROCESS | 12970 | __startTimestamp1464982433582__endTimestamp 12:33:53 INFO - PROCESS | 12970 | 12:33:53 INFO - PROCESS | 12970 | ------- Summary: start ------- 12:33:53 INFO - PROCESS | 12970 | Number of tests: 6 12:33:53 INFO - PROCESS | 12970 | 12:33:53 INFO - PROCESS | 12970 | [#0] dojo.html Cycles:165 Average:4675.87 Median:4771.09 stddev:489.03 (10.2%) stddev-sans-first:464.57 12:33:53 INFO - PROCESS | 12970 | Values: 2671.5 2689.6 2715.9 2718.5 2731.2 4604.4 4648.4 4690.8 4719.7 4781.5 4680.7 4725.8 4732.5 4742.4 4760.3 4302.8 4303.7 4316.1 4376.3 4391.3 4339.5 4395.3 4412.4 4429.9 4440.6 4341.1 4435.0 4437.1 4441.5 4473.6 4236.2 4248.5 4268.8 4275.0 4282.5 4263.6 4298.3 4309.2 4347.1 4358.4 4634.9 4637.0 4646.3 4650.9 4665.7 4854.2 4942.0 5015.6 5024.0 5092.8 5043.8 5082.0 5096.9 5102.5 5120.4 4598.3 4754.3 4771.1 4772.8 4776.6 5118.6 5193.4 5195.7 5204.4 5289.6 5032.2 5037.5 5063.2 5079.7 5090.8 4887.5 5055.3 5060.7 5094.9 5128.4 5038.5 5040.5 5066.3 5094.4 5130.9 5046.4 5058.6 5069.7 5073.4 5123.7 4166.5 4191.9 4193.8 4296.7 4340.2 3687.3 3726.6 3731.2 3754.2 3759.2 4313.7 4320.4 4354.3 4363.5 4365.1 4911.9 5047.4 5123.7 5124.9 5157.5 4367.5 4377.5 4379.1 4410.1 4418.2 4566.3 4574.2 4574.3 4577.5 4622.7 4642.2 4711.2 4745.8 4802.3 4805.8 5055.8 5067.6 5075.7 5085.6 5127.4 4743.0 4747.9 4749.8 4768.7 4809.9 4876.1 4972.7 4986.9 5002.4 5031.8 5091.7 5106.5 5125.4 5129.8 5181.8 4961.6 4962.4 4965.1 4970.1 4973.3 4773.9 4884.5 4922.5 4950.2 4973.5 4839.6 4865.0 4911.2 4919.9 4926.6 4830.1 4974.7 4988.6 5037.2 5037.5 4684.6 4738.8 4745.0 4761.4 4786.5 12:33:53 INFO - PROCESS | 12970 | 12:33:53 INFO - PROCESS | 12970 | [#1] ext.html Cycles:180 Average:46152.62 Median:35295.15 stddev:87908.55 (249.1%) stddev-sans-first:88088.46 12:33:53 INFO - PROCESS | 12970 | Values: 543.9 586.6 586.8 590.9 604.0 26937.3 39107.4 39701.4 39746.2 43622.0 40796.2 41298.8 41312.8 41373.8 41436.6 7671.5 7844.3 7845.2 7851.8 7853.3 7687.5 7803.5 7831.3 7834.8 7840.3 7840.2 7884.3 7895.7 7908.9 7911.2 7813.8 7878.8 7888.1 7905.3 7910.0 7727.3 7808.2 7813.0 7815.5 7816.3 37339.6 37848.4 37851.4 37964.8 38000.4 2939.8 3101.9 3160.9 3216.5 3314.8 28359.0 28834.0 28854.0 29317.1 29320.6 3409.7 3421.7 3436.9 3451.3 3477.6 247888.0 248326.0 248525.0 248870.0 250207.0 31176.5 51529.2 51591.2 51727.0 51892.5 32085.2 34008.8 34091.5 34159.7 34333.0 12255.0 12374.1 12380.8 12384.7 12410.9 9953.0 9966.3 9973.5 9986.0 9989.4 7834.6 7894.8 7922.9 7991.4 7999.5 3075.3 3086.6 3095.9 3101.6 3155.3 873.9 912.3 1031.4 1052.0 1057.6 26419.9 26877.7 26975.2 26992.3 27091.3 783.6 961.6 984.2 984.2 1011.9 13019.7 13981.2 13986.9 14156.9 14165.6 366126.0 369199.0 370601.0 371905.0 373040.0 46626.3 47041.0 47186.3 47224.3 47267.8 1120.4 1197.4 1217.6 1232.1 1239.4 26450.0 28036.0 28290.3 28439.9 28534.7 40459.6 40542.6 41144.8 41163.4 41219.2 301757.0 303501.0 304196.0 304889.0 538860.0 23855.4 24447.8 24628.3 25969.7 25988.7 39923.6 39927.6 40072.6 40788.0 40790.2 35193.1 35203.8 35288.3 35912.3 36217.8 34952.8 35168.0 35225.0 35302.0 35348.3 33687.7 34151.8 34256.8 34801.8 34887.5 30920.2 31127.7 31500.5 32008.2 32038.4 22433.9 23504.6 23588.0 23625.6 23721.6 12:33:53 INFO - PROCESS | 12970 | 12:33:53 INFO - PROCESS | 12970 | [#2] jquery.html Cycles:180 Average:23196.97 Median:26192.99 stddev:60614.47 (231.4%) stddev-sans-first:60760.26 12:33:53 INFO - PROCESS | 12970 | Values: 363.3 363.9 368.4 369.9 388.3 15569.5 16844.4 16865.2 17232.6 17352.1 14902.9 15062.3 15279.0 15373.8 15395.7 4937.2 5165.8 5177.3 5177.7 5179.7 3658.3 3804.6 4962.9 5073.1 5611.8 5859.9 5939.6 5968.6 5969.6 5971.3 5810.9 5831.5 5932.5 5944.4 5946.5 3318.8 4728.0 5007.5 5215.1 5223.3 19688.0 20403.1 20404.7 20411.9 20437.5 1822.2 1917.5 1928.8 2204.9 2463.5 12808.7 12844.4 12913.2 12931.5 13396.0 1740.6 1770.8 1801.3 1818.2 1823.2 61884.0 64540.7 64708.7 65035.3 65498.3 9290.8 9451.6 9746.4 10181.0 10435.1 13221.1 13307.4 13312.1 13312.3 13331.5 6947.6 6978.7 7096.6 7110.5 7126.7 6612.7 6686.2 6697.2 6890.3 7017.8 5927.6 6061.6 6069.4 6079.3 6088.5 1582.5 1684.2 1708.5 1709.5 1778.6 814.8 847.7 874.4 1009.0 1009.6 15824.6 16118.9 16312.8 16655.6 17017.1 837.7 872.9 894.9 901.1 941.0 8786.3 9250.0 9263.2 9296.9 9366.0 357816.0 357962.0 358628.0 380631.0 380934.0 74476.0 74559.0 74638.0 75285.6 75954.6 949.9 956.1 956.6 968.2 973.6 13689.3 14513.4 14855.9 15413.4 15717.5 32735.3 34196.6 34598.0 34820.1 35538.3 45585.5 45839.6 46566.3 47658.0 47736.9 7448.3 7689.6 7712.3 7727.2 7748.5 8529.0 10354.9 11275.4 11588.7 11622.1 6674.6 6873.7 7252.3 9889.6 10196.5 9864.7 9960.3 10048.9 10103.6 10176.9 9849.3 10070.2 10159.7 10382.4 10460.0 7251.5 7271.7 7326.0 7361.1 7538.1 8858.2 9990.5 10056.8 10102.1 10206.0 12:33:53 INFO - PROCESS | 12970 | 12:33:53 INFO - PROCESS | 12970 | [#3] mootools.html Cycles:180 Average:5063.03 Median:5402.03 stddev:2810.01 (52.0%) stddev-sans-first:2803.70 12:33:53 INFO - PROCESS | 12970 | Values: 1304.4 1394.7 1456.9 1549.2 1747.4 6623.4 7460.4 7705.1 7709.5 7835.1 7595.7 7745.1 7772.4 7779.0 7783.8 1863.4 2059.8 2118.8 2128.5 2152.7 2190.8 2211.0 2211.7 2214.4 2217.8 2103.6 2116.2 2152.6 2152.8 2156.7 1760.7 2028.8 2068.6 2097.6 2108.2 2154.9 2161.1 2176.2 2178.4 2183.8 7742.2 7750.3 7781.8 7834.6 7890.1 4299.2 4386.0 4449.0 4451.8 4459.6 2852.9 2943.3 3002.2 3022.2 3027.4 848.4 855.6 888.6 895.9 903.0 10366.8 10386.7 10401.7 10473.1 10591.4 4139.5 4190.8 4267.0 4280.9 4302.4 8920.4 8934.9 8970.8 8982.1 9000.6 4443.1 4501.7 4502.1 4512.6 4514.7 3622.5 3948.1 4053.0 4054.0 4125.1 3488.3 3562.6 3677.3 3682.3 3746.5 1171.3 1183.7 1195.5 1199.7 1203.2 785.4 838.8 886.6 898.8 943.7 5381.5 5484.8 5519.7 5596.1 5598.1 393.6 400.4 411.0 416.9 419.8 3709.5 3744.3 3753.2 3781.0 3787.8 9185.9 9347.7 9519.0 9529.0 9530.3 9110.4 9179.3 9208.4 9438.9 9482.0 7233.5 7244.2 7312.7 7358.1 7361.2 5422.5 5465.1 5587.5 5663.2 5818.7 8108.7 8144.4 8392.0 8412.2 8423.8 8271.9 8402.5 8413.6 8430.3 8479.3 5828.8 6228.3 6340.7 6437.5 6480.5 7511.0 7524.0 7559.3 7606.5 7618.5 6626.9 6756.6 6756.7 6858.7 6956.8 6611.3 6667.0 6706.8 6774.8 6775.7 6229.3 6271.3 6300.7 6317.8 6321.8 4704.2 4709.1 4763.6 4773.4 4805.2 4693.8 4756.7 4774.5 4870.5 4887.6 12:33:53 INFO - PROCESS | 12970 | 12:33:53 INFO - PROCESS | 12970 | [#4] prototype.html Cycles:180 Average:4105.81 Median:4594.06 stddev:1202.59 (26.2%) stddev-sans-first:1171.29 12:33:53 INFO - PROCESS | 12970 | Values: 285.8 292.1 296.9 300.7 301.1 4703.2 4800.3 4821.2 4830.6 4845.5 4254.0 4419.0 4545.7 4696.3 4788.5 3722.4 3737.4 3740.7 3753.0 3756.9 3545.0 3749.5 3755.0 3762.5 3779.2 3575.9 3711.6 3738.7 3747.3 3747.6 3708.3 3713.1 3718.2 3724.5 3741.4 3296.5 3301.2 3305.6 3329.0 3334.4 4417.6 4557.4 4585.5 4592.2 4604.3 4241.9 4252.1 4252.1 4274.0 4286.2 4934.0 4958.9 4959.5 4963.7 4969.5 3525.1 3634.1 3640.8 3643.4 3655.2 5154.8 5161.6 5197.6 5202.9 5238.7 3638.7 3664.8 3670.1 3671.7 3672.3 3676.1 3719.8 3721.5 3722.1 3733.9 3925.4 4172.5 4187.4 4210.6 4232.3 4975.4 4978.7 4984.8 4986.7 4997.4 1192.0 1215.8 1255.3 1259.1 1259.2 766.2 790.7 791.0 792.6 800.2 3940.8 3943.4 3946.7 3977.9 3981.8 4555.7 4560.2 4568.3 4583.4 4596.0 3948.2 3956.2 3965.6 4025.4 4053.7 2441.6 2442.5 2557.9 2735.3 2767.9 4844.7 4846.8 4851.6 4886.4 4897.9 5273.2 5276.8 5282.8 5317.5 5324.3 4607.3 4854.3 4859.0 4884.3 4901.5 5144.3 5158.0 5162.9 5177.6 5191.8 5070.2 5081.9 5089.9 5092.3 5094.5 4714.3 4857.2 4861.6 4866.2 4874.2 3733.7 3737.4 3753.7 3753.9 3754.9 4857.1 5074.9 5088.9 5134.2 5136.9 4875.9 4992.5 5011.3 5039.7 5043.6 4995.5 4999.2 5023.8 5027.6 5068.2 4800.5 4885.7 4909.3 4948.2 4949.0 4990.6 5029.4 5035.5 5051.9 5054.4 4822.4 4919.6 4950.5 4977.4 4980.8 12:33:53 INFO - PROCESS | 12970 | 12:33:53 INFO - PROCESS | 12970 | [#5] yui.html Cycles:180 Average:15904.61 Median:28379.55 stddev:21613.33 (76.2%) stddev-sans-first:21643.70 12:33:53 INFO - PROCESS | 12970 | Values: 674.9 689.7 690.8 693.9 750.9 11165.7 11709.3 11710.2 11767.1 11792.6 12022.0 12048.3 12073.3 12076.0 12080.9 614.4 770.6 775.9 800.2 804.8 783.5 788.8 790.5 791.2 791.4 834.0 838.0 839.0 839.0 839.4 648.7 810.8 824.6 834.2 838.3 608.9 613.3 614.3 615.3 617.3 11523.5 11577.4 11684.5 11690.9 11697.1 11596.8 11986.0 12049.4 12060.1 12368.9 11049.4 11180.1 11202.0 11400.5 11440.8 4083.4 4089.4 4101.4 4114.2 4164.8 54575.5 54690.2 54826.0 55050.0 55353.7 9565.1 9634.9 9635.0 9651.3 9672.4 18260.1 18263.2 18295.9 18314.3 18431.0 6562.2 6606.9 6637.8 6744.4 6755.7 3611.2 3620.1 3655.3 3673.4 3704.5 2802.3 2903.2 2905.2 2911.4 2913.1 454.4 456.2 496.9 503.4 508.5 578.3 601.4 612.4 620.4 638.4 8247.0 8625.1 8636.7 8819.2 8889.3 480.5 556.0 570.0 572.0 586.9 4048.8 4167.0 4194.7 4202.3 4304.8 56203.2 56475.7 56663.2 56687.1 80115.8 75799.6 79462.0 80334.0 80749.6 80762.0 68978.7 69132.9 69649.7 69687.0 69984.3 7727.1 7983.7 8056.4 8136.8 8387.7 43253.8 43594.3 43753.3 44055.3 44278.3 60568.0 61543.0 61917.7 62763.0 62855.7 10056.4 10405.9 10463.8 10526.6 10599.4 10883.9 11042.8 11267.6 11345.9 11976.2 10363.6 10391.7 10614.2 10637.5 10922.5 9983.9 10164.6 10292.8 10453.4 10554.1 10268.7 10521.9 10662.3 10757.2 10975.4 8882.9 8920.1 9042.5 9057.3 9342.9 8245.7 8668.4 8717.8 8776.3 8955.6 12:33:53 INFO - PROCESS | 12970 | -------- Summary: end -------- 12:33:53 INFO - PROCESS | 12970 | 12:33:54 INFO - TEST-INFO | 12970: exit 0 12:33:54 INFO - TEST-OK | dromaeo_css | took 1120092ms 12:33:54 INFO - TEST-START | kraken 12:33:54 INFO - operating with platform_type : linux_ 12:33:54 INFO - Initialising browser for kraken test... 12:33:54 INFO - TEST-INFO | started process 13149 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTqoUsl/profile http://localhost:37843/getInfo.html) 12:33:58 INFO - PROCESS | 13149 | __metrics Screen width/height:1600/1200 12:33:58 INFO - PROCESS | 13149 | colorDepth:24 12:33:58 INFO - PROCESS | 13149 | Browser inner width/height: 1024/697 12:33:58 INFO - PROCESS | 13149 | __metrics 12:34:00 ERROR - PROCESS | 13149 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:34:01 INFO - TEST-INFO | 13149: exit 0 12:34:01 INFO - Browser initialized. 12:34:01 INFO - Running cycle 1/1 for kraken test... 12:34:01 INFO - TEST-INFO | started process 13232 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTqoUsl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:34:13 INFO - PROCESS | 13232 | RSS: Main: 157712384 12:34:13 INFO - PROCESS | 13232 | 12:34:15 INFO - PROCESS | 13232 | Cycle 1(1): loaded http://localhost:37843/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37843/tests/kraken/driver.html?testName=audio-beat-detection) 12:34:16 INFO - PROCESS | 13232 | RSS: Main: 215011328 12:34:16 INFO - PROCESS | 13232 | 12:34:19 INFO - PROCESS | 13232 | Cycle 1(1): loaded http://localhost:37843/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37843/tests/kraken/driver.html?testName=audio-dft) 12:34:20 INFO - PROCESS | 13232 | RSS: Main: 201900032 12:34:20 INFO - PROCESS | 13232 | 12:34:23 INFO - PROCESS | 13232 | Cycle 1(1): loaded http://localhost:37843/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37843/tests/kraken/driver.html?testName=audio-fft) 12:34:24 INFO - PROCESS | 13232 | RSS: Main: 269807616 12:34:24 INFO - PROCESS | 13232 | 12:34:26 INFO - PROCESS | 13232 | Cycle 1(1): loaded http://localhost:37843/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37843/tests/kraken/driver.html?testName=audio-oscillator) 12:34:26 INFO - PROCESS | 13232 | RSS: Main: 180408320 12:34:26 INFO - PROCESS | 13232 | 12:34:29 INFO - PROCESS | 13232 | Cycle 1(1): loaded http://localhost:37843/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37843/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:34:29 INFO - PROCESS | 13232 | RSS: Main: 183828480 12:34:29 INFO - PROCESS | 13232 | 12:34:33 INFO - PROCESS | 13232 | Cycle 1(1): loaded http://localhost:37843/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37843/tests/kraken/driver.html?testName=imaging-darkroom) 12:34:33 INFO - PROCESS | 13232 | RSS: Main: 220774400 12:34:33 INFO - PROCESS | 13232 | 12:34:37 INFO - PROCESS | 13232 | Cycle 1(1): loaded http://localhost:37843/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37843/tests/kraken/driver.html?testName=imaging-desaturate) 12:34:37 INFO - PROCESS | 13232 | RSS: Main: 216117248 12:34:37 INFO - PROCESS | 13232 | 12:34:40 INFO - PROCESS | 13232 | Cycle 1(1): loaded http://localhost:37843/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37843/tests/kraken/driver.html?testName=json-parse-financial) 12:34:41 INFO - PROCESS | 13232 | RSS: Main: 219602944 12:34:41 INFO - PROCESS | 13232 | 12:34:42 INFO - PROCESS | 13232 | Cycle 1(1): loaded http://localhost:37843/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37843/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:34:43 INFO - PROCESS | 13232 | RSS: Main: 207245312 12:34:43 INFO - PROCESS | 13232 | 12:34:45 INFO - PROCESS | 13232 | Cycle 1(1): loaded http://localhost:37843/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37843/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:34:46 INFO - PROCESS | 13232 | RSS: Main: 209432576 12:34:46 INFO - PROCESS | 13232 | 12:34:48 INFO - PROCESS | 13232 | Cycle 1(1): loaded http://localhost:37843/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37843/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:34:49 INFO - PROCESS | 13232 | RSS: Main: 216694784 12:34:49 INFO - PROCESS | 13232 | 12:34:51 INFO - PROCESS | 13232 | Cycle 1(1): loaded http://localhost:37843/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37843/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:34:52 INFO - PROCESS | 13232 | RSS: Main: 223260672 12:34:52 INFO - PROCESS | 13232 | 12:34:55 INFO - PROCESS | 13232 | Cycle 1(1): loaded http://localhost:37843/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37843/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:34:55 INFO - PROCESS | 13232 | RSS: Main: 223232000 12:34:55 INFO - PROCESS | 13232 | 12:34:57 INFO - PROCESS | 13232 | Cycle 1(1): loaded http://localhost:37843/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37843/tests/kraken/driver.html?testName=ai-astar) 12:34:57 INFO - PROCESS | 13232 | RSS: Main: 265605120 12:34:57 INFO - PROCESS | 13232 | 12:34:57 INFO - PROCESS | 13232 | __start_tp_report 12:34:57 INFO - PROCESS | 13232 | _x_x_mozilla_page_load 12:34:57 INFO - PROCESS | 13232 | _x_x_mozilla_page_load_details 12:34:57 INFO - PROCESS | 13232 | |i|pagename|runs| 12:34:57 INFO - PROCESS | 13232 | |0;ai-astar;114;108;111;112;113;113;113;113;112;113 12:34:57 INFO - PROCESS | 13232 | |1;audio-beat-detection;162;140;135;192;132;135;160;135;188;130 12:34:57 INFO - PROCESS | 13232 | |2;audio-dft;162;168;162;163;163;162;162;163;162;164 12:34:57 INFO - PROCESS | 13232 | |3;audio-fft;75;77;77;101;79;76;75;75;100;77 12:34:57 INFO - PROCESS | 13232 | |4;audio-oscillator;87;86;121;86;86;87;117;87;88;137 12:34:57 INFO - PROCESS | 13232 | |5;imaging-gaussian-blur;118;117;117;116;117;117;119;118;119;118 12:34:57 INFO - PROCESS | 13232 | |6;imaging-darkroom;147;147;147;146;146;147;146;146;146;147 12:34:57 INFO - PROCESS | 13232 | |7;imaging-desaturate;95;95;95;95;96;96;96;96;95;94 12:34:57 INFO - PROCESS | 13232 | |8;json-parse-financial;65;65;65;65;64;65;65;66;65;64 12:34:57 INFO - PROCESS | 13232 | |9;json-stringify-tinderbox;67;66;65;66;66;65;66;67;66;65 12:34:57 INFO - PROCESS | 13232 | |10;stanford-crypto-aes;83;83;84;83;87;84;81;87;112;89 12:34:57 INFO - PROCESS | 13232 | |11;stanford-crypto-ccm;140;133;132;134;130;135;134;133;158;136 12:34:57 INFO - PROCESS | 13232 | |12;stanford-crypto-pbkdf2;175;169;169;172;172;173;168;166;168;169 12:34:57 INFO - PROCESS | 13232 | |13;stanford-crypto-sha256-iterative;68;68;69;68;71;68;67;66;68;66 12:34:57 INFO - PROCESS | 13232 | __end_tp_report 12:34:57 INFO - PROCESS | 13232 | __start_cc_report 12:34:57 INFO - PROCESS | 13232 | _x_x_mozilla_cycle_collect,1898 12:34:57 INFO - PROCESS | 13232 | __end_cc_report 12:34:57 INFO - PROCESS | 13232 | __startTimestamp1464982497957__endTimestamp 12:34:57 INFO - PROCESS | 13232 | 12:34:57 INFO - PROCESS | 13232 | ------- Summary: start ------- 12:34:57 INFO - PROCESS | 13232 | Number of tests: 14 12:34:57 INFO - PROCESS | 13232 | 12:34:57 INFO - PROCESS | 13232 | [#0] ai-astar Cycles:10 Average:112.20 Median:113.00 stddev:1.69 (1.5%) stddev-sans-first:1.66 12:34:57 INFO - PROCESS | 13232 | Values: 114.0 108.0 111.0 112.0 113.0 113.0 113.0 113.0 112.0 113.0 12:34:57 INFO - PROCESS | 13232 | 12:34:57 INFO - PROCESS | 13232 | [#1] audio-beat-detection Cycles:10 Average:150.90 Median:150.00 stddev:23.44 (15.6%) stddev-sans-first:24.51 12:34:57 INFO - PROCESS | 13232 | Values: 162.0 140.0 135.0 192.0 132.0 135.0 160.0 135.0 188.0 130.0 12:34:57 INFO - PROCESS | 13232 | 12:34:57 INFO - PROCESS | 13232 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.00 stddev:1.85 (1.1%) stddev-sans-first:1.92 12:34:57 INFO - PROCESS | 13232 | Values: 162.0 168.0 162.0 163.0 163.0 162.0 162.0 163.0 162.0 164.0 12:34:57 INFO - PROCESS | 13232 | 12:34:57 INFO - PROCESS | 13232 | [#3] audio-fft Cycles:10 Average:81.20 Median:76.50 stddev:10.25 (13.4%) stddev-sans-first:10.62 12:34:57 INFO - PROCESS | 13232 | Values: 75.0 77.0 77.0 101.0 79.0 76.0 75.0 75.0 100.0 77.0 12:34:57 INFO - PROCESS | 13232 | 12:34:57 INFO - PROCESS | 13232 | [#4] audio-oscillator Cycles:10 Average:98.20 Median:86.50 stddev:19.16 (22.2%) stddev-sans-first:19.89 12:34:57 INFO - PROCESS | 13232 | Values: 87.0 86.0 121.0 86.0 86.0 87.0 117.0 87.0 88.0 137.0 12:34:57 INFO - PROCESS | 13232 | 12:34:57 INFO - PROCESS | 13232 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.97 (0.8%) stddev-sans-first:1.01 12:34:57 INFO - PROCESS | 13232 | Values: 118.0 117.0 117.0 116.0 117.0 117.0 119.0 118.0 119.0 118.0 12:34:57 INFO - PROCESS | 13232 | 12:34:57 INFO - PROCESS | 13232 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 12:34:57 INFO - PROCESS | 13232 | Values: 147.0 147.0 147.0 146.0 146.0 147.0 146.0 146.0 146.0 147.0 12:34:57 INFO - PROCESS | 13232 | 12:34:57 INFO - PROCESS | 13232 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 12:34:57 INFO - PROCESS | 13232 | Values: 95.0 95.0 95.0 95.0 96.0 96.0 96.0 96.0 95.0 94.0 12:34:57 INFO - PROCESS | 13232 | 12:34:57 INFO - PROCESS | 13232 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:65.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 12:34:57 INFO - PROCESS | 13232 | Values: 65.0 65.0 65.0 65.0 64.0 65.0 65.0 66.0 65.0 64.0 12:34:57 INFO - PROCESS | 13232 | 12:34:57 INFO - PROCESS | 13232 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.74 (1.1%) stddev-sans-first:0.67 12:34:57 INFO - PROCESS | 13232 | Values: 67.0 66.0 65.0 66.0 66.0 65.0 66.0 67.0 66.0 65.0 12:34:57 INFO - PROCESS | 13232 | 12:34:57 INFO - PROCESS | 13232 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:84.00 stddev:9.01 (10.7%) stddev-sans-first:9.42 12:34:57 INFO - PROCESS | 13232 | Values: 83.0 83.0 84.0 83.0 87.0 84.0 81.0 87.0 112.0 89.0 12:34:57 INFO - PROCESS | 13232 | 12:34:57 INFO - PROCESS | 13232 | [#11] stanford-crypto-ccm Cycles:10 Average:136.50 Median:134.50 stddev:8.00 (6.0%) stddev-sans-first:8.39 12:34:57 INFO - PROCESS | 13232 | Values: 140.0 133.0 132.0 134.0 130.0 135.0 134.0 133.0 158.0 136.0 12:34:57 INFO - PROCESS | 13232 | 12:34:57 INFO - PROCESS | 13232 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.10 Median:170.50 stddev:2.77 (1.6%) stddev-sans-first:2.30 12:34:57 INFO - PROCESS | 13232 | Values: 175.0 169.0 169.0 172.0 172.0 173.0 168.0 166.0 168.0 169.0 12:34:57 INFO - PROCESS | 13232 | 12:34:57 INFO - PROCESS | 13232 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:1.45 (2.1%) stddev-sans-first:1.54 12:34:57 INFO - PROCESS | 13232 | Values: 68.0 68.0 69.0 68.0 71.0 68.0 67.0 66.0 68.0 66.0 12:34:57 INFO - PROCESS | 13232 | -------- Summary: end -------- 12:34:57 INFO - PROCESS | 13232 | 12:34:59 INFO - TEST-INFO | 13232: exit 0 12:34:59 INFO - TEST-OK | kraken | took 64763ms 12:34:59 INFO - SUITE-END | took 1184s 12:34:59 INFO - Completed test suite (00:19:45) 12:34:59 INFO - javascript benchmark 12:34:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2671.4790615829916, 2689.5831146172327, 2715.918522444327, 2718.524258254805, 2731.221601843475, 4604.424446944132, 4648.442186937568, 4690.835820746274, 4719.693219940706, 4781.450133234679, 4680.742559159254, 4725.763711814404, 4732.479427262998, 4742.359781429506, 4760.309755085511, 4302.806373713175, 4303.720258183208, 4316.115196384733, 4376.321670141133, 4391.275439552486, 4339.457567804025, 4395.274779661352, 4412.426384570002, 4429.867103986886, 4440.600345968862, 4341.131773645252, 4435.0, 4437.068215674696, 4441.46702395713, 4473.619742321906, 4236.195122926665, 4248.490181178247, 4268.765217913014, 4275.038116423811, 4282.486101667789, 4263.616274535276, 4298.333758267474, 4309.159713855799, 4347.130573885235, 4358.411614432042, 4634.8876269695365, 4637.049404871993, 4646.3495110684535, 4650.86047418578, 4665.720056796603, 4854.2233242681, 4941.950580494221, 5015.623828212899, 5023.974880125613, 5092.770825312833, 5043.773030213612, 5082.034413461431, 5096.872578185538, 5102.540771330561, 5120.411152717448, 4598.26427771555, 4754.286856971447, 4771.093492236464, 4772.809087636525, 4776.617870570346, 5118.59051275897, 5193.402758682724, 5195.6622819516615, 5204.42751297357, 5289.576833853283, 5032.169692000852, 5037.496250375007, 5063.215201643751, 5079.6952182869145, 5090.77091530882, 4887.486813884562, 5055.292259083732, 5060.721660308718, 5094.923576146361, 5128.410232823273, 5038.546530812171, 5040.546350828443, 5066.341375621146, 5094.439611642716, 5130.897382052338, 5046.39443266803, 5058.595312375001, 5069.721165335868, 5073.365829271341, 5123.743812809419, 4166.520850102216, 4191.874243772691, 4193.832246710097, 4296.720713153635, 4340.2187606230555, 3687.3178461984617, 3726.5900750917376, 3731.235096805203, 3754.1740817020213, 3759.191773768598, 4313.654907607384, 4320.4167437395545, 4354.303311470149, 4363.498197707241, 4365.061511774984, 4911.901761964741, 5047.369078865142, 5123.666961647481, 5124.92312615311, 5157.484251574812, 4367.45406824147, 4377.4965878923695, 4379.080393117481, 4410.051838854598, 4418.182636212311, 4566.292224705176, 4574.199515084913, 4574.268117101248, 4577.496475387705, 4622.745748983838, 4642.234031384919, 4711.19909615373, 4745.786439610157, 4802.327674125555, 4805.831795887128, 5055.797768089235, 5067.594592432671, 5075.670081444694, 5085.593152547861, 5127.41034781005, 4742.952570474389, 4747.881302967454, 4749.833755818529, 4768.737719425465, 4809.879753006203, 4876.122297986397, 4972.676776009548, 4986.850394488026, 5002.399712034579, 5031.798728050837, 5091.694498329964, 5106.514881086291, 5125.4362020177, 5129.846104616868, 5181.81863634771, 4961.603071754179, 4962.379702537183, 4965.1311020571975, 4970.130227210151, 4973.328600638867, 4773.856784296477, 4884.511548845087, 4922.507749225048, 4950.2079667253065, 4973.52751488608, 4839.612830973584, 4864.975675121602, 4911.214205727067, 4919.877003074952, 4926.605871530341, 4830.106430310404, 4974.676646017997, 4988.575971042502, 5037.19404895215, 5037.496250374933, 4684.5549672781035, 4738.8341408050555, 4745.0, 4761.428628564595, 4786.545278198566], "value": 4645.2775472980165, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.8759567272513, 586.5718025841134, 586.7711592478931, 590.8936391449539, 603.9516838652906, 26937.326566835814, 39107.41338879919, 39701.4044789328, 39746.20507589846, 43622.0, 40796.18407631846, 41298.79350603243, 41312.79343603278, 41373.79313103438, 41436.58563414365, 7671.50135241209, 7844.333231675315, 7845.215478452166, 7851.842963140763, 7853.332466740334, 7687.500312479699, 7803.492772969767, 7831.2560306770765, 7834.764957051298, 7840.333571646417, 7840.176781437953, 7884.32983196429, 7895.684172633117, 7908.920910790905, 7911.248431399008, 7813.843723125534, 7878.763637090897, 7888.092869320044, 7905.328047115973, 7909.999999999943, 7727.343175830061, 7808.180141085218, 7813.0, 7815.531068135873, 7816.335611473031, 37339.62660373389, 37848.43227351592, 37851.43222851659, 37964.810175948944, 38000.42999355012, 2939.76481881449, 3101.9379612407624, 3160.8577614007427, 3216.533602627606, 3314.767966242364, 28359.0, 28834.0, 28854.0, 29317.120486385444, 29320.560191597142, 3409.7442691798215, 3421.6920477157178, 3436.856085995874, 3451.3442445935193, 3477.634848340913, 247888.0, 248326.0, 248525.0, 248870.0, 250207.0, 31176.53235201474, 51529.22706159411, 51591.226131608055, 51727.0, 51892.48107518952, 32085.19787005297, 34008.829955850066, 34091.4886276706, 34159.65840341565, 34333.0, 12255.019598432104, 12374.071944604191, 12380.81428778569, 12384.690382740324, 12410.875891240972, 9952.950235248778, 9966.2525310602, 9973.50132493387, 9985.950070249603, 9989.400635961865, 7834.569098699626, 7894.802629934297, 7922.881156782653, 7991.400644951652, 7999.520028798291, 3075.308055687497, 3086.5678804967324, 3095.8947915417734, 3101.550275210082, 3155.2742869140225, 873.9344549158839, 912.3112050401904, 1031.3811712972156, 1052.026875140492, 1057.613970900631, 26419.867900660374, 26877.731222687522, 26975.190744277705, 26992.325191869968, 27091.32271693184, 783.5847001089431, 961.6201600367956, 984.158544444504, 984.2077127911956, 1011.9392836429838, 13019.739605208033, 13981.22506923125, 13986.930065349608, 14156.929215354063, 14165.645858853612, 366126.0, 369199.0, 370601.0, 371905.0, 373040.0, 46626.30060549094, 47041.0, 47186.29220561626, 47224.291635625494, 47267.763661181474, 1120.439780109945, 1197.4431889171576, 1217.6347095871204, 1232.0820988363726, 1239.4422509870594, 26450.0, 28036.0, 28290.2927426816, 28439.857800710863, 28534.714652853207, 40459.59540404558, 40542.59457405506, 41144.79427602843, 41163.38254926119, 41219.1756164869, 301757.0, 303501.0, 304196.0, 304889.0, 538860.0, 23855.403614909766, 24447.777611119018, 24628.261152165465, 25969.74030259749, 25988.740112598633, 39923.60076399199, 39927.600723992386, 40072.59927400688, 40788.0, 40790.1841963165, 35193.120171995906, 35203.82398087993, 35288.29423411466, 35912.281754365285, 36217.81891090528, 34952.825235874676, 35168.0, 35225.0, 35302.0, 35348.293034139686, 33687.66312336845, 34151.829240853636, 34256.82871585626, 34801.82599087089, 34887.47668785021, 30920.226994325323, 31127.68872311248, 31500.527492088095, 32008.19979500438, 32038.35923281568, 22433.887830561394, 23504.6474302889, 23588.0, 23625.64561531544, 23721.64417533773], "value": 16212.94776328814, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.27889140056993, 363.87810083621986, 368.35905524387573, 369.87794027970773, 388.3475760721986, 15569.532914012583, 16844.410445634407, 16865.241064152113, 17232.56918577036, 17352.13239338033, 14902.850971490281, 15062.322195501201, 15279.01524616358, 15373.846261537381, 15395.69208615827, 4937.160682683934, 5165.76754046067, 5177.30106435632, 5177.663451875635, 5179.741012949356, 3658.3049220648127, 3804.619538046201, 4962.858542535219, 5073.086844368012, 5611.8316450506345, 5859.882802343951, 5939.554533410012, 5968.612040217394, 5969.641821490724, 5971.253593300838, 5810.854728631776, 5831.504322132602, 5932.466078052953, 5944.4352786485215, 5946.524278057766, 3318.7510936679846, 4727.976360118212, 5007.4992500749995, 5215.139501982168, 5223.268742376071, 19688.0, 20403.08186131613, 20404.693929591067, 20411.89794051035, 20437.489062773402, 1822.189125838989, 1917.4822797844643, 1928.8495259607168, 2204.900779464912, 2463.519613675334, 12808.743825123538, 12844.422001009976, 12913.160644558073, 12931.5473958411, 13396.0, 1740.6344667619815, 1770.7875054993353, 1801.3245033112582, 1818.1727314072066, 1823.1613457809424, 61884.0, 64540.67729661322, 64708.67645661742, 65035.34964650388, 65498.3450165497, 9290.767730806783, 9451.574679139456, 9746.366486178518, 10180.956547815234, 10435.060844523878, 13221.140625859289, 13307.401166947511, 13312.068155229235, 13312.26782526951, 13331.533396331082, 6947.617881016593, 6978.651067446607, 7096.645167741593, 7110.537815042006, 7126.714931402789, 6612.669366531654, 6686.197656281277, 6697.162854643169, 6890.276520965226, 7017.754378596826, 5927.585069045125, 6061.636301821904, 6069.36271691466, 6079.270487541523, 6088.4824789893355, 1582.4777823318277, 1684.1915880377487, 1708.5386945524638, 1709.538424625344, 1778.6353797471488, 814.7963009247688, 847.6778824046946, 874.4141425245101, 1008.9646862359782, 1009.6466236817203, 15824.604384890239, 16118.919405402898, 16312.75530867038, 16655.583610409838, 17017.149142542825, 837.6858677995751, 872.9345299102592, 894.8836651235298, 901.085398320705, 940.9978373032835, 8786.341024423065, 9250.0, 9263.212626926652, 9296.907030929739, 9366.0, 357816.0, 357962.0, 358628.0, 380631.0, 380934.0, 74476.0, 74559.0, 74638.0, 75285.62357188179, 75954.6202268985, 949.9335046546813, 956.086936975187, 956.550421301987, 968.2109081099022, 973.59595767757, 13689.315534223448, 14513.419463221353, 14855.851441485447, 15413.383464661289, 15717.528474145794, 32735.253388259047, 34196.62182765239, 34598.0, 34820.129496762784, 35538.28923421465, 45585.544144559455, 45839.56053843162, 46566.30150547812, 47658.0, 47736.85184166651, 7448.255174482509, 7689.615519224129, 7712.344450721752, 7727.150013498623, 7748.496347737604, 8529.0, 10354.948225258826, 11275.436228188722, 11588.710282243012, 11622.128340374336, 6674.599524028574, 6873.656317184021, 7252.347288744038, 9889.55497002651, 10196.490175491048, 9864.654737084167, 9960.302778805413, 10048.89951100509, 10103.646372376932, 10176.89823101789, 9849.26130540198, 10070.244731645302, 10159.7460063499, 10382.37705737628, 10460.0, 7251.492395532262, 7271.745488908075, 7326.04761381017, 7361.1166659999, 7538.133114691881, 8858.247049000907, 9990.500474976367, 10056.798864022532, 10102.09081182697, 10206.0], "value": 8124.000515368918, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1304.432571831254, 1394.7489451898662, 1456.905301155425, 1549.2253873063469, 1747.3622127923304, 6623.37077977592, 7460.440466964979, 7705.075390953093, 7709.537427754339, 7835.098963619185, 7595.734149304775, 7745.109312429072, 7772.378209743221, 7779.0, 7783.766487005385, 1863.413024897153, 2059.794020597943, 2118.7881211878803, 2128.467883029243, 2152.6986221928864, 2190.8247340212743, 2210.9778902210933, 2211.6682497625325, 2214.4242496950746, 2217.756046834847, 2103.5582527669208, 2116.2487317002474, 2152.5587254612765, 2152.773958734334, 2156.6520924422234, 1760.665473560026, 2028.8275496582808, 2068.617305798432, 2097.643400621883, 2108.20942146695, 2154.8707077575395, 2161.1247444784885, 2176.249194028058, 2178.357384571555, 2183.7816218378193, 7742.187070357644, 7750.302472777421, 7781.844363112763, 7834.608269586555, 7890.132085470594, 4299.247631664446, 4386.0, 4449.0, 4451.755153466558, 4459.643228541709, 2852.885884564615, 2943.2641839540115, 3002.24943764059, 3022.2444388902773, 3027.364253506766, 848.3849209323191, 855.5850412549909, 888.5512816027929, 895.8656201569752, 902.9774255643596, 10366.844497332546, 10386.740331491697, 10401.68794936153, 10473.109785668228, 10591.417472039111, 4139.544650088488, 4190.811413486339, 4267.0, 4280.871573852789, 4302.397664326997, 8920.375573709907, 8934.86597701035, 8970.82058358829, 8982.056884027214, 9000.59497322622, 4443.089166720814, 4501.729896206238, 4502.099580083931, 4512.638988880882, 4514.661400394918, 3622.4747411625167, 3948.1314110895555, 4053.007013281765, 4053.9797301013896, 4125.1131006833675, 3488.2500262443696, 3562.625924277965, 3677.3380791457794, 3682.3371793076967, 3746.5129533160516, 1171.2796630072444, 1183.7336599265097, 1195.503865895661, 1199.7060720123625, 1203.2479700187382, 785.367778937949, 838.7903024243939, 886.5833058462513, 898.766320756608, 943.712167788831, 5381.542568881689, 5484.808031718871, 5519.69641669712, 5596.104623260258, 5598.1322894951345, 393.626055247516, 400.3574263307408, 410.97328673636116, 416.91661667666585, 419.80059471751287, 3709.4806727058235, 3744.344739670547, 3753.211825516672, 3780.9621903781162, 3787.8484860605818, 9185.908140918638, 9347.672831450867, 9519.0, 9528.95235523818, 9530.285228607881, 9110.407823491452, 9179.265658747418, 9208.355415121012, 9438.90561094394, 9482.004389539137, 7233.45749068822, 7244.166920804069, 7312.670929808065, 7358.11702595692, 7361.227071157451, 5422.5119739223655, 5465.098258787256, 5587.497125258747, 5663.1788390682295, 5818.738156782871, 8108.6756529740505, 8144.429889907649, 8391.958040210004, 8412.158784121539, 8423.789405264917, 8271.875921861056, 8402.453840500348, 8413.579321034047, 8430.325573954191, 8479.279261262862, 5828.76684932598, 6228.28374736893, 6340.682965851781, 6437.485001199986, 6480.513961452815, 7511.0, 7524.0, 7559.28186822251, 7606.543607383574, 7618.504797188165, 6626.867462650816, 6756.560823546453, 6756.729730810909, 6858.725650974105, 6956.79129626112, 6611.305812889577, 6666.966665166643, 6706.798796036127, 6774.830629234309, 6775.728970841308, 6229.283632382153, 6271.3415091414745, 6300.71646775887, 6317.778877739257, 6321.810345689637, 4704.153252414599, 4709.0817290628, 4763.642726795435, 4773.403324584427, 4805.207140821725, 4693.788779504999, 4756.6908150970075, 4774.474807771073, 4870.488598697228, 4887.608991280618], "value": 4021.1548899127447, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.7999400419707, 292.12799792619035, 296.9109267219834, 300.73234821009316, 301.1267324758201, 4703.248599569251, 4800.255960326151, 4821.228603423453, 4830.589399901012, 4845.515448455153, 4254.0255453847985, 4418.955810441895, 4545.727196385009, 4696.272077827934, 4788.497207793183, 3722.4416337549314, 3737.364648009845, 3740.719446041544, 3752.967933818208, 3756.9436458453147, 3545.0, 3749.5125633667585, 3754.9624503754885, 3762.473253744478, 3779.1874746929407, 3575.856965721381, 3711.5917249102577, 3738.6822120119823, 3747.3067482515685, 3747.6252374762444, 3708.2768860072297, 3713.1459764254373, 3718.219173973469, 3724.478572999782, 3741.38267185914, 3296.489044198153, 3301.1747063234193, 3305.6116431098994, 3329.0, 3334.3831391192707, 4417.624501917341, 4557.384753058328, 4585.541445855421, 4592.173408786417, 4604.309353596954, 4241.87274381769, 4252.128313695685, 4252.149570085964, 4273.957260427387, 4286.228478873802, 4934.0, 4958.925616115761, 4959.528844759742, 4963.652544321899, 4969.503049695038, 3525.1399717309505, 3634.1096431374217, 3640.8179591020607, 3643.417053271464, 3655.232401195752, 5154.819581314636, 5161.58707303411, 5197.58419326453, 5202.947970520284, 5238.659487133362, 3638.7089032877834, 3664.780113193217, 3670.119171398845, 3671.6879065279218, 3672.3389789838084, 3676.1361080146144, 3719.795411252407, 3721.5162028936065, 3722.1439069013736, 3733.90901095382, 3925.3523168676847, 4172.4784401949755, 4187.434696315959, 4210.642040457354, 4232.322828347511, 4975.427825800007, 4978.701277923336, 4984.750762461862, 4986.700797952134, 4997.375328083989, 1191.9940400297944, 1215.7872372334982, 1255.3409460033372, 1259.0745801835644, 1259.1815320042047, 766.1993217088157, 790.6679194738224, 790.9881351779728, 792.6235038356734, 800.1518390505965, 3940.8226629801156, 3943.431194768739, 3946.7039972002217, 3977.9458443512494, 3981.8145483612993, 4555.658325625592, 4560.224761790503, 4568.33759104928, 4583.381243532147, 4595.954040459619, 3948.249832531867, 3956.248312820555, 3965.5637879833193, 4025.3961905714377, 4053.6554392876346, 2441.5971364724624, 2442.496441147802, 2557.8593177375424, 2735.3024978630324, 2767.9446411071667, 4844.685095468783, 4846.757662116951, 4851.636127290397, 4886.364772579542, 4897.902041959141, 5273.235380869829, 5276.762545685453, 5282.815101471507, 5317.494837990384, 5324.334458192726, 4607.262837945913, 4854.271859221074, 4858.975705121452, 4884.267359895973, 4901.460839307744, 5144.254083157846, 5157.974210128926, 5162.870928226675, 5177.559907407913, 5191.792328306977, 5070.2141168119, 5081.923771143362, 5089.949100509096, 5092.3125378074965, 5094.490550945025, 4714.316424118552, 4857.247126695368, 4861.586765125004, 4866.245731911417, 4874.171390863491, 3733.693207377396, 3737.3833317503395, 3753.737238393286, 3753.887383378503, 3754.8685795998103, 4857.149998750276, 5074.923876141935, 5088.949110508847, 5134.15286477727, 5136.922946155736, 4875.853724388132, 4992.450830408579, 5011.2961593058535, 5039.697618142924, 5043.5712964398435, 4995.525425084611, 4999.200127979506, 5023.773930173078, 5027.572656324253, 5068.163752980717, 4800.5199480051715, 4885.706857588556, 4909.337239472626, 4948.208286674115, 4948.950510494993, 4990.625703072212, 5029.44676085623, 5035.546800787946, 5051.924221136613, 5054.418741844588, 4822.397200349957, 4919.557239848431, 4950.45544990058, 4977.43210888569, 4980.800767969386], "value": 3719.9647426437637, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [674.939255467008, 689.6930865764737, 690.8307464671154, 693.947953903457, 750.9361704255138, 11165.665030049102, 11709.297442153456, 11710.238834475753, 11767.058635309177, 11792.646220613384, 12021.978131858781, 12048.337341446217, 12073.275603463799, 12076.033917286619, 12080.879191208085, 614.3856143856144, 770.5723323555438, 775.9495632783851, 800.1918062756599, 804.7786858613899, 783.5416281475344, 788.7594283743456, 790.4664351562701, 791.161368948916, 791.3985371117963, 833.9791505212357, 838.0195171649154, 838.9874151887726, 839.0267289943666, 839.3830534557096, 648.7210499485243, 810.8013536683521, 824.5629816197425, 834.1991687979486, 838.3083955736541, 608.939106089392, 613.2916481463916, 614.342653360904, 615.301632646949, 617.2931992868185, 11523.48144333507, 11577.363245021521, 11684.47419866108, 11690.941545292304, 11697.064234861191, 11596.826047609293, 11986.0, 12049.397530123546, 12060.095492838072, 12368.938155309255, 11049.392283424408, 11180.142687277083, 11202.0, 11400.486978086006, 11440.771184576344, 4083.4079058536645, 4089.3865920111925, 4101.425800387919, 4114.19773144237, 4164.7709375984305, 54575.45424545743, 54690.179647305325, 54826.0, 55050.0, 55353.723231383585, 9565.139137477661, 9634.90365096354, 9635.0, 9651.276154288456, 9672.419654820733, 18260.086995650163, 18263.17815698297, 18295.908520457313, 18314.26742930268, 18431.0, 6562.212534495891, 6606.867862642816, 6637.800865974028, 6744.393004629607, 6755.695993680296, 3611.205534782344, 3620.149264922741, 3655.250673611903, 3673.3571624965525, 3704.4628528863163, 2802.313433208877, 2903.2016195546394, 2905.244636394553, 2911.3740545782334, 2913.140623516068, 454.3843092609533, 456.1834316573363, 496.8757810547363, 503.4436947173394, 508.5346907579597, 578.2511647416521, 601.3955974245943, 612.4426771637789, 620.432304441431, 638.3712043637014, 8246.958765206256, 8625.0943650917, 8636.740897773077, 8819.162179592928, 8889.288856891433, 480.47628085387095, 555.9520304226562, 569.9800506982235, 572.0047118014625, 586.8914250863604, 4048.838046478108, 4166.979165104155, 4194.706370554032, 4202.348635961431, 4304.78476076195, 56203.156952645746, 56475.71762141163, 56663.15005274924, 56687.14969275464, 80115.7982630261, 75799.62100189574, 79462.0, 80334.0, 80749.59625201837, 80762.0, 68978.65510672414, 69132.92601221972, 69649.65175174092, 69687.0, 69984.30015699778, 7727.11138219112, 7983.72056978003, 8056.355491560778, 8136.83726325482, 8387.706430274911, 43253.783731081145, 43594.34608480939, 43753.34369984389, 44055.33916991184, 44278.335824963295, 60568.0, 61543.0, 61917.69041154766, 62763.0, 62855.6857215711, 10056.446895420822, 10405.895941040493, 10463.843042354218, 10526.578936842441, 10599.364038157735, 10883.891161088604, 11042.779144416905, 11267.605633802777, 11345.886541134812, 11976.16166868311, 10363.585456581954, 10391.740206494898, 10614.150867930393, 10637.521311540844, 10922.453877306261, 9983.90177080506, 10164.593416263267, 10292.845607316047, 10453.372797632166, 10554.050135487843, 10268.743281418025, 10521.894781052091, 10662.306950048222, 10757.246992710436, 10975.396353200651, 8882.866756998521, 8920.107989201028, 9042.502662353634, 9057.275417966679, 9342.906570934476, 8245.711400100967, 8668.436551624125, 8717.782055448664, 8776.254018408506, 8955.552222388986], "value": 6266.326600602013, "unit": "score"}], "name": "dromaeo_css", "value": 6210.106815805608, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 111.0, 112.0, 113.0, 113.0, 113.0, 113.0, 112.0, 113.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 140.0, 135.0, 192.0, 132.0, 135.0, 160.0, 135.0, 188.0, 130.0], "value": 150.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 168.0, 162.0, 163.0, 163.0, 162.0, 162.0, 163.0, 162.0, 164.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 77.0, 101.0, 79.0, 76.0, 75.0, 75.0, 100.0, 77.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 121.0, 86.0, 86.0, 87.0, 117.0, 87.0, 88.0, 137.0], "value": 98.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 116.0, 117.0, 117.0, 119.0, 118.0, 119.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 94.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 64.0, 65.0, 65.0, 66.0, 65.0, 64.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 65.0, 66.0, 66.0, 65.0, 66.0, 67.0, 66.0, 65.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 84.0, 83.0, 87.0, 84.0, 81.0, 87.0, 112.0, 89.0], "value": 87.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 133.0, 132.0, 134.0, 130.0, 135.0, 134.0, 133.0, 158.0, 136.0], "value": 136.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 169.0, 169.0, 172.0, 172.0, 173.0, 168.0, 166.0, 168.0, 169.0], "value": 170.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 69.0, 68.0, 71.0, 68.0, 67.0, 66.0, 68.0, 66.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1557.6000000000001, "alertThreshold": 2.0}]} 12:34:59 INFO - Return code: 0 12:34:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:34:59 ERROR - # TBPL SUCCESS # 12:34:59 INFO - Running post-action listener: _resource_record_post_action 12:34:59 INFO - ##### 12:34:59 INFO - ##### Finished run-tests step (success) 12:34:59 INFO - ##### 12:34:59 INFO - Running post-run listener: _resource_record_post_run 12:34:59 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 0; Write bytes: 539213824; Read time: 0; Write time: 783824 12:34:59 INFO - TinderboxPrint: CPU usage
13.2% 12:34:59 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 12:34:59 INFO - TinderboxPrint: I/O write bytes / time
539,213,824 / 783,824 12:34:59 INFO - TinderboxPrint: CPU idle
8,325.0 (86.8%) 12:34:59 INFO - TinderboxPrint: CPU user
1,218.2 (12.7%) 12:34:59 INFO - TinderboxPrint: Swap in / out
0 / 0 12:34:59 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 244490240; Read time: 0; Write time: 477048 12:34:59 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 294723584; Read time: 0; Write time: 306776 12:35:00 INFO - Running post-run listener: _upload_blobber_files 12:35:00 INFO - Blob upload gear active. 12:35:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:35:00 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 12:35:00 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:35:00 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:35:00 INFO - (blobuploader) - INFO - Open directory for files ... 12:35:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:35:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:35:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:35:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:35:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:35:05 INFO - (blobuploader) - INFO - Done attempting. 12:35:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:35:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:35:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:35:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:35:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:35:05 INFO - (blobuploader) - INFO - Done attempting. 12:35:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:35:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:35:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:35:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:35:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:35:06 INFO - (blobuploader) - INFO - Done attempting. 12:35:06 INFO - (blobuploader) - INFO - Iteration through files over. 12:35:06 INFO - Return code: 0 12:35:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:35:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:35:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e949cb3f4756e58806da23aa677d64208fb2ec46fa2e962289d3d932f58f43fb03751b6e7c05e6347d98ef7452711f51ce916115d1c1ec1ee694490e8fcf5169", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2095ad7717a31f7d4b316df34dd696b97d14d7971cbb6e4a48336df7a4af2588a93c8ef9b242321466b8096b771cb685595499b05c1c2abf1a5a20913d74978f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ea65e96a8100b4c3104a3cb82f102184f355f60b195665bf317887c3fc148cf2ea86a7115e700c93dfd2fecf7146799bda1be4263f25712497f8b0e627de4c09"} 12:35:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:35:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:35:06 INFO - Contents: 12:35:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e949cb3f4756e58806da23aa677d64208fb2ec46fa2e962289d3d932f58f43fb03751b6e7c05e6347d98ef7452711f51ce916115d1c1ec1ee694490e8fcf5169", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2095ad7717a31f7d4b316df34dd696b97d14d7971cbb6e4a48336df7a4af2588a93c8ef9b242321466b8096b771cb685595499b05c1c2abf1a5a20913d74978f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ea65e96a8100b4c3104a3cb82f102184f355f60b195665bf317887c3fc148cf2ea86a7115e700c93dfd2fecf7146799bda1be4263f25712497f8b0e627de4c09"} 12:35:06 INFO - Running post-run listener: copy_logs_to_upload_dir 12:35:06 INFO - Copying logs to upload dir... 12:35:06 INFO - mkdir: /builds/slave/test/build/upload/logs 12:35:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.734963 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-03 12:35:06.502926) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 12:35:06.506889) ========= 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=52faae308a556c440401f8e5000001e8-1464981171.560497-1317786345 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-Non-PGO/sha512/e949cb3f4756e58806da23aa677d64208fb2ec46fa2e962289d3d932f58f43fb03751b6e7c05e6347d98ef7452711f51ce916115d1c1ec1ee694490e8fcf5169", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2095ad7717a31f7d4b316df34dd696b97d14d7971cbb6e4a48336df7a4af2588a93c8ef9b242321466b8096b771cb685595499b05c1c2abf1a5a20913d74978f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ea65e96a8100b4c3104a3cb82f102184f355f60b195665bf317887c3fc148cf2ea86a7115e700c93dfd2fecf7146799bda1be4263f25712497f8b0e627de4c09"} build_url:https://queue.taskcluster.net/v1/task/KlZyiwCLST2E5HQDwmWoxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011366 build_url: 'https://queue.taskcluster.net/v1/task/KlZyiwCLST2E5HQDwmWoxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e949cb3f4756e58806da23aa677d64208fb2ec46fa2e962289d3d932f58f43fb03751b6e7c05e6347d98ef7452711f51ce916115d1c1ec1ee694490e8fcf5169", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2095ad7717a31f7d4b316df34dd696b97d14d7971cbb6e4a48336df7a4af2588a93c8ef9b242321466b8096b771cb685595499b05c1c2abf1a5a20913d74978f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ea65e96a8100b4c3104a3cb82f102184f355f60b195665bf317887c3fc148cf2ea86a7115e700c93dfd2fecf7146799bda1be4263f25712497f8b0e627de4c09"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 12:35:06.532134) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 12:35:06.532466) ========= 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=52faae308a556c440401f8e5000001e8-1464981171.560497-1317786345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004581 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 12:35:06.617352) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 12:35:06.617690) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 12:35:06.617978) ========= ========= Total master_lag: 0.16 =========