builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-045 starttime: 1465215099.05 results: success (0) buildid: 20160606030429 builduid: 84cb245a928c442e857bbc9b88c3ffa3 revision: 7fc6eedd33484ae8679bde3ae600563d2b457f4e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 05:11:39.051579) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 05:11:39.055158) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 05:11:39.056001) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 05:11:39.073123) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:11:39.073903) ========= 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=4300f881736b422476174874000001bc-1465215057.752461-163903584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-06 05:11:39-- 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% 46.4M=0s 2016-06-06 05:11:39 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110517 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:11:39.203498) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:11:39.204283) ========= 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=4300f881736b422476174874000001bc-1465215057.752461-163903584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015193 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:11:39.259499) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:11:39.260399) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7fc6eedd33484ae8679bde3ae600563d2b457f4e --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 7fc6eedd33484ae8679bde3ae600563d2b457f4e --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=4300f881736b422476174874000001bc-1465215057.752461-163903584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-06 05:11:39,308 truncating revision to first 12 chars 2016-06-06 05:11:39,308 Setting DEBUG logging. 2016-06-06 05:11:39,308 attempt 1/10 2016-06-06 05:11:39,308 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7fc6eedd3348?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 05:11:39,628 unpacking tar archive at: fx-team-7fc6eedd3348/testing/mozharness/ program finished with exit code 0 elapsedTime=0.647608 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:11:39.923371) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 05:11:39.923893) ========= script_repo_revision: 7fc6eedd33484ae8679bde3ae600563d2b457f4e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 05:11:39.924550) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 05:11:39.925046) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 05:11:39.937127) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-06 05:11:39.937508) ========= /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=4300f881736b422476174874000001bc-1465215057.752461-163903584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:11:40 INFO - MultiFileLogger online at 20160606 05:11:40 in /builds/slave/test 05:11:40 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 05:11:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:11:40 INFO - {'append_to_log': False, 05:11:40 INFO - 'base_work_dir': '/builds/slave/test', 05:11:40 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:11:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:11:40 INFO - 'branch': 'Fx-Team-Non-PGO', 05:11:40 INFO - 'buildbot_json_path': 'buildprops.json', 05:11:40 INFO - 'config_files': ('talos/linux_config.py',), 05:11:40 INFO - 'default_actions': ('clobber', 05:11:40 INFO - 'read-buildbot-config', 05:11:40 INFO - 'download-and-extract', 05:11:40 INFO - 'populate-webroot', 05:11:40 INFO - 'create-virtualenv', 05:11:40 INFO - 'install', 05:11:40 INFO - 'run-tests'), 05:11:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:11:40 INFO - 'download_minidump_stackwalk': True, 05:11:40 INFO - 'download_symbols': 'ondemand', 05:11:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:11:40 INFO - 'tooltool.py': '/tools/tooltool.py', 05:11:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:11:40 INFO - '/tools/misc-python/virtualenv.py')}, 05:11:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:11:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:11:40 INFO - 'installer_path': 'installer.exe', 05:11:40 INFO - 'log_level': 'info', 05:11:40 INFO - 'log_name': 'talos', 05:11:40 INFO - 'log_to_console': True, 05:11:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:11:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:11:40 INFO - 'opt_config_files': (), 05:11:40 INFO - 'pip_index': False, 05:11:40 INFO - 'sps_profile': False, 05:11:40 INFO - 'sps_profile_interval': 0, 05:11:40 INFO - 'suite': 'dromaeojs', 05:11:40 INFO - 'system_bits': '32', 05:11:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:11:40 INFO - 'title': 'talos-linux64-ix-045', 05:11:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:11:40 INFO - 'use_talos_json': True, 05:11:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:11:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:11:40 INFO - 'work_dir': 'build'} 05:11:40 INFO - ##### 05:11:40 INFO - ##### Running clobber step. 05:11:40 INFO - ##### 05:11:40 INFO - Running pre-action listener: _resource_record_pre_action 05:11:40 INFO - Running main action method: clobber 05:11:40 INFO - rmtree: /builds/slave/test/build 05:11:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:11:40 INFO - Running post-action listener: _resource_record_post_action 05:11:40 INFO - ##### 05:11:40 INFO - ##### Finished clobber step (success) 05:11:40 INFO - ##### 05:11:40 INFO - ##### 05:11:40 INFO - ##### Running read-buildbot-config step. 05:11:40 INFO - ##### 05:11:40 INFO - Running pre-action listener: _resource_record_pre_action 05:11:40 INFO - Running main action method: read_buildbot_config 05:11:40 INFO - Using buildbot properties: 05:11:40 INFO - { 05:11:40 INFO - "project": "", 05:11:40 INFO - "product": "firefox", 05:11:40 INFO - "script_repo_revision": "production", 05:11:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:11:40 INFO - "repository": "", 05:11:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:11:40 INFO - "buildid": "20160606030429", 05:11:40 INFO - "pgo_build": "False", 05:11:40 INFO - "basedir": "/builds/slave/test", 05:11:40 INFO - "buildnumber": 3044, 05:11:40 INFO - "slavename": "talos-linux64-ix-045", 05:11:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:11:40 INFO - "platform": "ubuntu64_hw", 05:11:40 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:11:40 INFO - "branch": "fx-team", 05:11:40 INFO - "repo_path": "integration/fx-team", 05:11:40 INFO - "revision": "7fc6eedd33484ae8679bde3ae600563d2b457f4e", 05:11:40 INFO - "stage_platform": "linux64", 05:11:40 INFO - "builduid": "84cb245a928c442e857bbc9b88c3ffa3", 05:11:40 INFO - "slavebuilddir": "test" 05:11:40 INFO - } 05:11:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:11:40 INFO - Running post-action listener: _resource_record_post_action 05:11:40 INFO - ##### 05:11:40 INFO - ##### Finished read-buildbot-config step (success) 05:11:40 INFO - ##### 05:11:40 INFO - ##### 05:11:40 INFO - ##### Running download-and-extract step. 05:11:40 INFO - ##### 05:11:40 INFO - Running pre-action listener: _resource_record_pre_action 05:11:40 INFO - Running main action method: download_and_extract 05:11:40 INFO - mkdir: /builds/slave/test/build/tests 05:11: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')]} 05:11:40 INFO - https://queue.taskcluster.net/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:11:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:11:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:11:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G5kplpIBRu2XJoJii0BdhA/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 05:11:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G5kplpIBRu2XJoJii0BdhA/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 05:11:41 INFO - Downloaded 1361 bytes. 05:11:41 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:11:41 INFO - Using the following test package requirements: 05:11:41 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:11:41 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:11:41 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:11:41 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:41 INFO - u'jsshell-linux-x86_64.zip'], 05:11:41 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:11:41 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:11:41 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:11:41 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:11:41 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:11:41 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:11:41 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:11:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:41 INFO - https://queue.taskcluster.net/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:11:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:11:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:11:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G5kplpIBRu2XJoJii0BdhA/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 05:11:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G5kplpIBRu2XJoJii0BdhA/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 05:11:43 INFO - Downloaded 22870980 bytes. 05:11:43 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'] 05:11:43 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 05:11:44 INFO - Return code: 0 05:11:44 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 05:11:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:44 INFO - https://queue.taskcluster.net/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:11:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:11:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:11:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G5kplpIBRu2XJoJii0BdhA/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 05:11:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G5kplpIBRu2XJoJii0BdhA/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 05:11:45 INFO - Downloaded 22870980 bytes. 05:11:45 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'] 05:11:45 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 05:11:46 INFO - Return code: 0 05:11:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:46 INFO - https://queue.taskcluster.net/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:11:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:11:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:11:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G5kplpIBRu2XJoJii0BdhA/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 05:11:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G5kplpIBRu2XJoJii0BdhA/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 05:11:49 INFO - Downloaded 10833369 bytes. 05:11:49 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'] 05:11:49 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 05:11:50 INFO - Return code: 0 05:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:50 INFO - https://queue.taskcluster.net/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:11:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:11:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:11:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G5kplpIBRu2XJoJii0BdhA/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 05:11:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G5kplpIBRu2XJoJii0BdhA/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 05:11:53 INFO - Downloaded 55203306 bytes. 05:11:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:11:53 INFO - mkdir: /builds/slave/test/properties 05:11:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:11:53 INFO - Writing to file /builds/slave/test/properties/build_url 05:11:53 INFO - Contents: 05:11:53 INFO - build_url:https://queue.taskcluster.net/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:11:54 INFO - Running post-action listener: _resource_record_post_action 05:11:54 INFO - Running post-action listener: set_extra_try_arguments 05:11:54 INFO - ##### 05:11:54 INFO - ##### Finished download-and-extract step (success) 05:11:54 INFO - ##### 05:11:54 INFO - ##### 05:11:54 INFO - ##### Running populate-webroot step. 05:11:54 INFO - ##### 05:11:54 INFO - Running pre-action listener: _resource_record_pre_action 05:11:54 INFO - Running main action method: populate_webroot 05:11:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:11:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:11:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:11:54 INFO - '--tppagecycles', 05:11:54 INFO - '7'], 05:11:54 INFO - 'tests': ['tsvgm']}}, 05:11:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:11:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:11:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:11:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:11:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:11:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:11:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:54 INFO - 'talos_options': ['--disable-e10s'], 05:11:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:11:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:11:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:54 INFO - 'talos_options': ['--disable-e10s'], 05:11:54 INFO - 'tests': ['damp', 'tps']}, 05:11:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:54 INFO - 'tests': ['damp', 'tps']}, 05:11:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:11:54 INFO - 'tests': ['dromaeo_dom']}, 05:11:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:11:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:11:54 INFO - 'tests': ['a11yr', 05:11:54 INFO - 'ts_paint', 05:11:54 INFO - 'tpaint', 05:11:54 INFO - 'sessionrestore', 05:11:54 INFO - 'sessionrestore_no_auto_restore', 05:11:54 INFO - 'tabpaint']}, 05:11:54 INFO - 'other-e10s': {'tests': ['a11yr', 05:11:54 INFO - 'ts_paint', 05:11:54 INFO - 'tpaint', 05:11:54 INFO - 'sessionrestore', 05:11:54 INFO - 'sessionrestore_no_auto_restore', 05:11:54 INFO - 'tabpaint']}, 05:11:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:11:54 INFO - 'ts_paint', 05:11:54 INFO - 'tpaint', 05:11:54 INFO - 'sessionrestore', 05:11:54 INFO - 'sessionrestore_no_auto_restore', 05:11:54 INFO - 'tabpaint']}, 05:11:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:11:54 INFO - 'ts_paint', 05:11:54 INFO - 'tpaint', 05:11:54 INFO - 'sessionrestore', 05:11:54 INFO - 'sessionrestore_no_auto_restore', 05:11:54 INFO - 'tabpaint']}, 05:11:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:11:54 INFO - 'tests': ['a11yr', 05:11:54 INFO - 'ts_paint', 05:11:54 INFO - 'tpaint', 05:11:54 INFO - 'sessionrestore', 05:11:54 INFO - 'sessionrestore_no_auto_restore', 05:11:54 INFO - 'tabpaint']}, 05:11:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:11:54 INFO - 'tests': ['a11yr', 05:11:54 INFO - 'ts_paint', 05:11:54 INFO - 'tpaint', 05:11:54 INFO - 'sessionrestore', 05:11:54 INFO - 'sessionrestore_no_auto_restore', 05:11:54 INFO - 'tabpaint']}, 05:11:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:11:54 INFO - 'tests': ['tsvgx', 05:11:54 INFO - 'tsvgr_opacity', 05:11:54 INFO - 'tart', 05:11:54 INFO - 'tscrollx', 05:11:54 INFO - 'cart']}, 05:11:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:11:54 INFO - 'tsvgr_opacity', 05:11:54 INFO - 'tart', 05:11:54 INFO - 'tscrollx', 05:11:54 INFO - 'cart']}, 05:11:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:54 INFO - 'talos_options': ['--disable-e10s'], 05:11:54 INFO - 'tests': ['tp5o']}, 05:11:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:54 INFO - 'tests': ['tp5o']}, 05:11:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:54 INFO - 'talos_options': ['--disable-e10s', 05:11:54 INFO - '--xperf_path', 05:11:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:11:54 INFO - 'tests': ['tp5n']}, 05:11:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:54 INFO - 'talos_options': ['--xperf_path', 05:11:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:11:54 INFO - 'tests': ['tp5n']}}, 05:11:54 INFO - 'talos.zip': {'path': '', 05:11:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:11:54 INFO - Running post-action listener: _resource_record_post_action 05:11:54 INFO - ##### 05:11:54 INFO - ##### Finished populate-webroot step (success) 05:11:54 INFO - ##### 05:11:54 INFO - ##### 05:11:54 INFO - ##### Running create-virtualenv step. 05:11:54 INFO - ##### 05:11:54 INFO - Running pre-action listener: _resource_record_pre_action 05:11:54 INFO - Running main action method: create_virtualenv 05:11:54 INFO - Creating virtualenv /builds/slave/test/build/venv 05:11:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:11:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:11:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:11:54 INFO - Using real prefix '/usr' 05:11:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:11:55 INFO - Installing distribute.............................................................................................................................................................................................done. 05:11:57 INFO - Installing pip.................done. 05:11:57 INFO - Return code: 0 05:11:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:57 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 0x7fc4eaad1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b27350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb61c0>, '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 0x2bb70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb7550>, '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': '4300f881736b422476174874000001bc-1465215057.752461-163903584', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:11:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:11:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:11:57 INFO - Using env: {'DISPLAY': ':0', 05:11:57 INFO - 'HOME': '/home/cltbld', 05:11:57 INFO - 'LANG': 'en_US.UTF-8', 05:11:57 INFO - 'LANGUAGE': 'en_US:en', 05:11:57 INFO - 'LOGNAME': 'cltbld', 05:11:57 INFO - 'MAIL': '/var/mail/cltbld', 05:11:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:57 INFO - 'MOZ_NO_REMOTE': '1', 05:11:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:57 INFO - 'NO_EM_RESTART': '1', 05:11:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:57 INFO - 'PWD': '/builds/slave/test', 05:11:57 INFO - 'SHELL': '/bin/bash', 05:11:57 INFO - 'SHLVL': '1', 05:11:57 INFO - 'TERM': 'linux', 05:11:57 INFO - 'TMOUT': '86400', 05:11:57 INFO - 'USER': 'cltbld', 05:11:57 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465215057.752461-163903584', 05:11:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:57 INFO - '_': '/tools/buildbot/bin/python'} 05:11:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:11:57 INFO - Cleaning up... 05:11:57 INFO - Return code: 0 05:11:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:57 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 0x7fc4eaad1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b27350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb61c0>, '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 0x2bb70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb7550>, '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': '4300f881736b422476174874000001bc-1465215057.752461-163903584', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:11:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:11:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:11:57 INFO - Using env: {'DISPLAY': ':0', 05:11:57 INFO - 'HOME': '/home/cltbld', 05:11:57 INFO - 'LANG': 'en_US.UTF-8', 05:11:57 INFO - 'LANGUAGE': 'en_US:en', 05:11:57 INFO - 'LOGNAME': 'cltbld', 05:11:57 INFO - 'MAIL': '/var/mail/cltbld', 05:11:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:57 INFO - 'MOZ_NO_REMOTE': '1', 05:11:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:57 INFO - 'NO_EM_RESTART': '1', 05:11:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:57 INFO - 'PWD': '/builds/slave/test', 05:11:57 INFO - 'SHELL': '/bin/bash', 05:11:57 INFO - 'SHLVL': '1', 05:11:57 INFO - 'TERM': 'linux', 05:11:57 INFO - 'TMOUT': '86400', 05:11:57 INFO - 'USER': 'cltbld', 05:11:57 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465215057.752461-163903584', 05:11:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:57 INFO - '_': '/tools/buildbot/bin/python'} 05:11:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:57 INFO - Downloading/unpacking psutil>=3.1.1 05:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:11:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:11:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:11:59 INFO - Installing collected packages: psutil 05:11:59 INFO - Running setup.py install for psutil 05:11:59 INFO - building 'psutil._psutil_linux' extension 05:11:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:11:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:11:59 INFO - building 'psutil._psutil_posix' extension 05:11:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:11:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:12:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:12:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:12:00 INFO - Successfully installed psutil 05:12:00 INFO - Cleaning up... 05:12:00 INFO - Return code: 0 05:12:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4eaad1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b27350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb61c0>, '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 0x2bb70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb7550>, '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': '4300f881736b422476174874000001bc-1465215057.752461-163903584', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:12:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:12:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:12:00 INFO - Using env: {'DISPLAY': ':0', 05:12:00 INFO - 'HOME': '/home/cltbld', 05:12:00 INFO - 'LANG': 'en_US.UTF-8', 05:12:00 INFO - 'LANGUAGE': 'en_US:en', 05:12:00 INFO - 'LOGNAME': 'cltbld', 05:12:00 INFO - 'MAIL': '/var/mail/cltbld', 05:12:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:00 INFO - 'MOZ_NO_REMOTE': '1', 05:12:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:00 INFO - 'NO_EM_RESTART': '1', 05:12:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:00 INFO - 'PWD': '/builds/slave/test', 05:12:00 INFO - 'SHELL': '/bin/bash', 05:12:00 INFO - 'SHLVL': '1', 05:12:00 INFO - 'TERM': 'linux', 05:12:00 INFO - 'TMOUT': '86400', 05:12:00 INFO - 'USER': 'cltbld', 05:12:00 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465215057.752461-163903584', 05:12:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:00 INFO - '_': '/tools/buildbot/bin/python'} 05:12:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:12:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:12:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:12:02 INFO - Installing collected packages: mozsystemmonitor 05:12:02 INFO - Running setup.py install for mozsystemmonitor 05:12:02 INFO - Successfully installed mozsystemmonitor 05:12:02 INFO - Cleaning up... 05:12:02 INFO - Return code: 0 05:12:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:12:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:02 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 0x7fc4eaad1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b27350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb61c0>, '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 0x2bb70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb7550>, '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': '4300f881736b422476174874000001bc-1465215057.752461-163903584', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:12:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:12:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:12:02 INFO - Using env: {'DISPLAY': ':0', 05:12:02 INFO - 'HOME': '/home/cltbld', 05:12:02 INFO - 'LANG': 'en_US.UTF-8', 05:12:02 INFO - 'LANGUAGE': 'en_US:en', 05:12:02 INFO - 'LOGNAME': 'cltbld', 05:12:02 INFO - 'MAIL': '/var/mail/cltbld', 05:12:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:02 INFO - 'MOZ_NO_REMOTE': '1', 05:12:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:02 INFO - 'NO_EM_RESTART': '1', 05:12:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:02 INFO - 'PWD': '/builds/slave/test', 05:12:02 INFO - 'SHELL': '/bin/bash', 05:12:02 INFO - 'SHLVL': '1', 05:12:02 INFO - 'TERM': 'linux', 05:12:02 INFO - 'TMOUT': '86400', 05:12:02 INFO - 'USER': 'cltbld', 05:12:02 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465215057.752461-163903584', 05:12:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:02 INFO - '_': '/tools/buildbot/bin/python'} 05:12:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:02 INFO - Downloading/unpacking jsonschema==2.5.1 05:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:12:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:04 INFO - Downloading functools32-3.2.3-2.tar.gz 05:12:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:12:04 INFO - warning: no files found matching '*.txt' 05:12:04 INFO - no previously-included directories found matching 'build' 05:12:04 INFO - no previously-included directories found matching 'dist' 05:12:04 INFO - no previously-included directories found matching '.git*' 05:12:04 INFO - Installing collected packages: jsonschema, functools32 05:12:04 INFO - Running setup.py install for functools32 05:12:04 INFO - warning: no files found matching '*.txt' 05:12:04 INFO - no previously-included directories found matching 'build' 05:12:04 INFO - no previously-included directories found matching 'dist' 05:12:04 INFO - no previously-included directories found matching '.git*' 05:12:04 INFO - Successfully installed jsonschema functools32 05:12:04 INFO - Cleaning up... 05:12:05 INFO - Return code: 0 05:12:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:12:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:05 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 0x7fc4eaad1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b27350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb61c0>, '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 0x2bb70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb7550>, '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': '4300f881736b422476174874000001bc-1465215057.752461-163903584', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:12:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:12:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:12:05 INFO - Using env: {'DISPLAY': ':0', 05:12:05 INFO - 'HOME': '/home/cltbld', 05:12:05 INFO - 'LANG': 'en_US.UTF-8', 05:12:05 INFO - 'LANGUAGE': 'en_US:en', 05:12:05 INFO - 'LOGNAME': 'cltbld', 05:12:05 INFO - 'MAIL': '/var/mail/cltbld', 05:12:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:05 INFO - 'MOZ_NO_REMOTE': '1', 05:12:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:05 INFO - 'NO_EM_RESTART': '1', 05:12:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:05 INFO - 'PWD': '/builds/slave/test', 05:12:05 INFO - 'SHELL': '/bin/bash', 05:12:05 INFO - 'SHLVL': '1', 05:12:05 INFO - 'TERM': 'linux', 05:12:05 INFO - 'TMOUT': '86400', 05:12:05 INFO - 'USER': 'cltbld', 05:12:05 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465215057.752461-163903584', 05:12:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:05 INFO - '_': '/tools/buildbot/bin/python'} 05:12:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:05 INFO - Downloading/unpacking blobuploader==1.2.4 05:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:07 INFO - Downloading blobuploader-1.2.4.tar.gz 05:12:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:12:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:12:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:07 INFO - Downloading docopt-0.6.1.tar.gz 05:12:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:12:08 INFO - Installing collected packages: blobuploader, requests, docopt 05:12:08 INFO - Running setup.py install for blobuploader 05:12:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:12:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:12:08 INFO - Running setup.py install for requests 05:12:08 INFO - Running setup.py install for docopt 05:12:08 INFO - Successfully installed blobuploader requests docopt 05:12:08 INFO - Cleaning up... 05:12:08 INFO - Return code: 0 05:12:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:12:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:08 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 0x7fc4eaad1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b27350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb61c0>, '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 0x2bb70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb7550>, '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': '4300f881736b422476174874000001bc-1465215057.752461-163903584', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:12:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:12:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:12:08 INFO - Using env: {'DISPLAY': ':0', 05:12:08 INFO - 'HOME': '/home/cltbld', 05:12:08 INFO - 'LANG': 'en_US.UTF-8', 05:12:08 INFO - 'LANGUAGE': 'en_US:en', 05:12:08 INFO - 'LOGNAME': 'cltbld', 05:12:08 INFO - 'MAIL': '/var/mail/cltbld', 05:12:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:08 INFO - 'MOZ_NO_REMOTE': '1', 05:12:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:08 INFO - 'NO_EM_RESTART': '1', 05:12:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:08 INFO - 'PWD': '/builds/slave/test', 05:12:08 INFO - 'SHELL': '/bin/bash', 05:12:08 INFO - 'SHLVL': '1', 05:12:08 INFO - 'TERM': 'linux', 05:12:08 INFO - 'TMOUT': '86400', 05:12:08 INFO - 'USER': 'cltbld', 05:12:08 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465215057.752461-163903584', 05:12:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:08 INFO - '_': '/tools/buildbot/bin/python'} 05:12:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:12:08 INFO - Running setup.py (path:/tmp/pip-uhR8gW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:12:08 INFO - Running setup.py (path:/tmp/pip-gofD6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:12:08 INFO - Running setup.py (path:/tmp/pip-yxKqIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:12:09 INFO - Running setup.py (path:/tmp/pip-VGo9cv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:12:09 INFO - Running setup.py (path:/tmp/pip-s8Axdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:12:09 INFO - Running setup.py (path:/tmp/pip-RB6tMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:12:09 INFO - Running setup.py (path:/tmp/pip-ryhe7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:12:09 INFO - Running setup.py (path:/tmp/pip-sBoVAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:12:09 INFO - Running setup.py (path:/tmp/pip-bnqcPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:12:09 INFO - Running setup.py (path:/tmp/pip-jGXrxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:12:09 INFO - Running setup.py (path:/tmp/pip-CfKZAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:12:09 INFO - Running setup.py (path:/tmp/pip-Vu94gn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:12:09 INFO - Running setup.py (path:/tmp/pip-DVluKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:12:09 INFO - Running setup.py (path:/tmp/pip-0lOQ3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:12:09 INFO - Running setup.py (path:/tmp/pip-JP2o78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:12:09 INFO - Running setup.py (path:/tmp/pip-jI1u3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:12:09 INFO - Running setup.py (path:/tmp/pip-NaJDU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:12:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:12:10 INFO - Running setup.py install for manifestparser 05:12:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:12:10 INFO - Running setup.py install for mozcrash 05:12:10 INFO - Running setup.py install for mozdebug 05:12:10 INFO - Running setup.py install for mozdevice 05:12:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:12:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:12:10 INFO - Running setup.py install for mozfile 05:12:10 INFO - Running setup.py install for mozhttpd 05:12:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:12:10 INFO - Running setup.py install for mozinfo 05:12:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:12:10 INFO - Running setup.py install for mozInstall 05:12:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:12:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:12:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:12:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:12:10 INFO - Running setup.py install for mozleak 05:12:10 INFO - Running setup.py install for mozlog 05:12:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:12:11 INFO - Running setup.py install for moznetwork 05:12:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:12:11 INFO - Running setup.py install for mozprocess 05:12:11 INFO - Running setup.py install for mozprofile 05:12:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:12:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:12:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:12:11 INFO - Running setup.py install for mozrunner 05:12:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:12:11 INFO - Running setup.py install for mozscreenshot 05:12:11 INFO - Running setup.py install for moztest 05:12:11 INFO - Running setup.py install for mozversion 05:12:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:12:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:12:11 INFO - Cleaning up... 05:12:11 INFO - Return code: 0 05:12:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:12:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:11 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 0x7fc4eaad1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b27350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb61c0>, '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 0x2bb70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb7550>, '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': '4300f881736b422476174874000001bc-1465215057.752461-163903584', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:12:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:12:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:12:11 INFO - Using env: {'DISPLAY': ':0', 05:12:11 INFO - 'HOME': '/home/cltbld', 05:12:11 INFO - 'LANG': 'en_US.UTF-8', 05:12:11 INFO - 'LANGUAGE': 'en_US:en', 05:12:11 INFO - 'LOGNAME': 'cltbld', 05:12:11 INFO - 'MAIL': '/var/mail/cltbld', 05:12:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:11 INFO - 'MOZ_NO_REMOTE': '1', 05:12:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:11 INFO - 'NO_EM_RESTART': '1', 05:12:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:11 INFO - 'PWD': '/builds/slave/test', 05:12:11 INFO - 'SHELL': '/bin/bash', 05:12:11 INFO - 'SHLVL': '1', 05:12:11 INFO - 'TERM': 'linux', 05:12:11 INFO - 'TMOUT': '86400', 05:12:11 INFO - 'USER': 'cltbld', 05:12:11 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465215057.752461-163903584', 05:12:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:11 INFO - '_': '/tools/buildbot/bin/python'} 05:12:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:12:12 INFO - Running setup.py (path:/tmp/pip-x0B59x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:12:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:12:12 INFO - Running setup.py (path:/tmp/pip-v4bvLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:12:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:12:12 INFO - Running setup.py (path:/tmp/pip-ENWsJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:12:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:12:12 INFO - Running setup.py (path:/tmp/pip-tZKCun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:12:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:12:12 INFO - Running setup.py (path:/tmp/pip-PkgtUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:12:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:12:12 INFO - Running setup.py (path:/tmp/pip-sD4lKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:12:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:12:12 INFO - Running setup.py (path:/tmp/pip-Tyb6gv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:12:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:12:12 INFO - Running setup.py (path:/tmp/pip-yjsgJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:12:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:12:12 INFO - Running setup.py (path:/tmp/pip-twkWbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:12:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:12:12 INFO - Running setup.py (path:/tmp/pip-SctspV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:12:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:12:12 INFO - Running setup.py (path:/tmp/pip-WdbWMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:12:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:12:12 INFO - Running setup.py (path:/tmp/pip-xA0dPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:12:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:12:12 INFO - Running setup.py (path:/tmp/pip-aotmkq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:12:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:12:13 INFO - Running setup.py (path:/tmp/pip-cIdf52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:12:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:12:13 INFO - Running setup.py (path:/tmp/pip-I2iOt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:12:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:12:13 INFO - Running setup.py (path:/tmp/pip-P2FcwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:12:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:12:13 INFO - Running setup.py (path:/tmp/pip-Z1rpNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:12:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:12:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:12:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:12:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:12:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:12:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:12:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:15 INFO - Downloading blessings-1.6.tar.gz 05:12:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:12:15 INFO - Installing collected packages: blessings 05:12:15 INFO - Running setup.py install for blessings 05:12:15 INFO - Successfully installed blessings 05:12:15 INFO - Cleaning up... 05:12:15 INFO - Return code: 0 05:12:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:12:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:12:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:12:15 INFO - Reading from file tmpfile_stdout 05:12:15 INFO - Current package versions: 05:12:15 INFO - argparse == 1.2.1 05:12:15 INFO - blessings == 1.6 05:12:15 INFO - blobuploader == 1.2.4 05:12:15 INFO - docopt == 0.6.1 05:12:15 INFO - functools32 == 3.2.3-2 05:12:15 INFO - jsonschema == 2.5.1 05:12:15 INFO - manifestparser == 1.1 05:12:15 INFO - mozInstall == 1.12 05:12:15 INFO - mozcrash == 0.17 05:12:15 INFO - mozdebug == 0.1 05:12:15 INFO - mozdevice == 0.48 05:12:15 INFO - mozfile == 1.2 05:12:15 INFO - mozhttpd == 0.7 05:12:15 INFO - mozinfo == 0.9 05:12:15 INFO - mozleak == 0.1 05:12:15 INFO - mozlog == 3.2 05:12:15 INFO - moznetwork == 0.27 05:12:15 INFO - mozprocess == 0.22 05:12:15 INFO - mozprofile == 0.28 05:12:15 INFO - mozrunner == 6.11 05:12:15 INFO - mozscreenshot == 0.1 05:12:15 INFO - mozsystemmonitor == 0.3 05:12:15 INFO - moztest == 0.7 05:12:15 INFO - mozversion == 1.4 05:12:15 INFO - psutil == 3.1.1 05:12:15 INFO - requests == 1.2.3 05:12:15 INFO - wsgiref == 0.1.2 05:12:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:12:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:15 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 0x7fc4eaad1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b27350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb61c0>, '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 0x2bb70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb7550>, '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': '4300f881736b422476174874000001bc-1465215057.752461-163903584', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:12:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:12:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:12:15 INFO - Using env: {'DISPLAY': ':0', 05:12:15 INFO - 'HOME': '/home/cltbld', 05:12:15 INFO - 'LANG': 'en_US.UTF-8', 05:12:15 INFO - 'LANGUAGE': 'en_US:en', 05:12:15 INFO - 'LOGNAME': 'cltbld', 05:12:15 INFO - 'MAIL': '/var/mail/cltbld', 05:12:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:15 INFO - 'MOZ_NO_REMOTE': '1', 05:12:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:15 INFO - 'NO_EM_RESTART': '1', 05:12:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:15 INFO - 'PWD': '/builds/slave/test', 05:12:15 INFO - 'SHELL': '/bin/bash', 05:12:15 INFO - 'SHLVL': '1', 05:12:15 INFO - 'TERM': 'linux', 05:12:15 INFO - 'TMOUT': '86400', 05:12:15 INFO - 'USER': 'cltbld', 05:12:15 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465215057.752461-163903584', 05:12:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:15 INFO - '_': '/tools/buildbot/bin/python'} 05:12:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:12:15 INFO - Cleaning up... 05:12:15 INFO - Return code: 0 05:12:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:12:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:15 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 0x7fc4eaad1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b27350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb61c0>, '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 0x2bb70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb7550>, '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': '4300f881736b422476174874000001bc-1465215057.752461-163903584', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:12:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:12:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:12:15 INFO - Using env: {'DISPLAY': ':0', 05:12:15 INFO - 'HOME': '/home/cltbld', 05:12:15 INFO - 'LANG': 'en_US.UTF-8', 05:12:15 INFO - 'LANGUAGE': 'en_US:en', 05:12:15 INFO - 'LOGNAME': 'cltbld', 05:12:15 INFO - 'MAIL': '/var/mail/cltbld', 05:12:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:15 INFO - 'MOZ_NO_REMOTE': '1', 05:12:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:15 INFO - 'NO_EM_RESTART': '1', 05:12:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:15 INFO - 'PWD': '/builds/slave/test', 05:12:15 INFO - 'SHELL': '/bin/bash', 05:12:15 INFO - 'SHLVL': '1', 05:12:15 INFO - 'TERM': 'linux', 05:12:15 INFO - 'TMOUT': '86400', 05:12:15 INFO - 'USER': 'cltbld', 05:12:15 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465215057.752461-163903584', 05:12:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:15 INFO - '_': '/tools/buildbot/bin/python'} 05:12:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:12:16 INFO - Cleaning up... 05:12:16 INFO - Return code: 0 05:12:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:12:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:16 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 0x7fc4eaad1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b27350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb61c0>, '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 0x2bb70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb7550>, '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': '4300f881736b422476174874000001bc-1465215057.752461-163903584', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:12:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:12:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:12:16 INFO - Using env: {'DISPLAY': ':0', 05:12:16 INFO - 'HOME': '/home/cltbld', 05:12:16 INFO - 'LANG': 'en_US.UTF-8', 05:12:16 INFO - 'LANGUAGE': 'en_US:en', 05:12:16 INFO - 'LOGNAME': 'cltbld', 05:12:16 INFO - 'MAIL': '/var/mail/cltbld', 05:12:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:16 INFO - 'MOZ_NO_REMOTE': '1', 05:12:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:16 INFO - 'NO_EM_RESTART': '1', 05:12:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:16 INFO - 'PWD': '/builds/slave/test', 05:12:16 INFO - 'SHELL': '/bin/bash', 05:12:16 INFO - 'SHLVL': '1', 05:12:16 INFO - 'TERM': 'linux', 05:12:16 INFO - 'TMOUT': '86400', 05:12:16 INFO - 'USER': 'cltbld', 05:12:16 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465215057.752461-163903584', 05:12:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:16 INFO - '_': '/tools/buildbot/bin/python'} 05:12:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:16 INFO - Downloading/unpacking flake8 05:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:12:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:12:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:12:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:12:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:12:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:12:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:12:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:12:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:12:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:12:19 INFO - no previously-included directories found matching 'docs/_build' 05:12:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:12:19 INFO - Running setup.py install for pep8 05:12:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:12:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:12:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:12:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:12:19 INFO - no previously-included directories found matching 'docs/_build' 05:12:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:12:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:12:19 INFO - Cleaning up... 05:12:19 INFO - Return code: 0 05:12:19 INFO - Running post-action listener: _resource_record_post_action 05:12:19 INFO - Running post-action listener: _start_resource_monitoring 05:12:19 INFO - Starting resource monitoring. 05:12:19 INFO - ##### 05:12:19 INFO - ##### Finished create-virtualenv step (success) 05:12:19 INFO - ##### 05:12:19 INFO - ##### 05:12:19 INFO - ##### Running install step. 05:12:19 INFO - ##### 05:12:19 INFO - Running pre-action listener: _resource_record_pre_action 05:12:19 INFO - Running main action method: install 05:12:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:12:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:12:19 INFO - Reading from file tmpfile_stdout 05:12:19 INFO - Detecting whether we're running mozinstall >=1.0... 05:12:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:12:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:12:19 INFO - Reading from file tmpfile_stdout 05:12:19 INFO - Output received: 05:12:19 INFO - Usage: mozinstall [options] installer 05:12:19 INFO - Options: 05:12:19 INFO - -h, --help show this help message and exit 05:12:19 INFO - -d DEST, --destination=DEST 05:12:19 INFO - Directory to install application into. [default: 05:12:19 INFO - "/builds/slave/test"] 05:12:19 INFO - --app=APP Application being installed. [default: firefox] 05:12:19 INFO - mkdir: /builds/slave/test/build/application 05:12:19 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'] 05:12:19 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 05:12:35 INFO - Reading from file tmpfile_stdout 05:12:35 INFO - Output received: 05:12:35 INFO - /builds/slave/test/build/application/firefox/firefox 05:12:35 INFO - Running post-action listener: _resource_record_post_action 05:12:35 INFO - ##### 05:12:35 INFO - ##### Finished install step (success) 05:12:35 INFO - ##### 05:12:35 INFO - ##### 05:12:35 INFO - ##### Running run-tests step. 05:12:35 INFO - ##### 05:12:35 INFO - Running pre-action listener: _resource_record_pre_action 05:12:35 INFO - Running main action method: run_tests 05:12:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:12:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:12:35 INFO - Python 2.7.3 05:12:35 INFO - Return code: 0 05:12:35 INFO - grabbing minidump binary from tooltool 05:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:35 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 0x2bb61c0>, '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 0x2bb70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb7550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:12:35 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:12:35 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:12:35 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:12:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:12:35 INFO - Return code: 0 05:12:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:12:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:12:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:12:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:12:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:12:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:12:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:12:36 INFO - Return code: 0 05:12:36 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/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:12:36 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/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:12:36 INFO - Using env: {'DISPLAY': ':0', 05:12:36 INFO - 'HOME': '/home/cltbld', 05:12:36 INFO - 'LANG': 'en_US.UTF-8', 05:12:36 INFO - 'LANGUAGE': 'en_US:en', 05:12:36 INFO - 'LOGNAME': 'cltbld', 05:12:36 INFO - 'MAIL': '/var/mail/cltbld', 05:12:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:12:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:12:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:36 INFO - 'MOZ_NO_REMOTE': '1', 05:12:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:12:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:36 INFO - 'NO_EM_RESTART': '1', 05:12:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:36 INFO - 'PWD': '/builds/slave/test', 05:12:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:12:36 INFO - 'SHELL': '/bin/bash', 05:12:36 INFO - 'SHLVL': '1', 05:12:36 INFO - 'TERM': 'linux', 05:12:36 INFO - 'TMOUT': '86400', 05:12:36 INFO - 'USER': 'cltbld', 05:12:36 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465215057.752461-163903584', 05:12:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:36 INFO - '_': '/tools/buildbot/bin/python'} 05:12:36 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/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:12:36 INFO - mozversion application_buildid: 20160606030429 05:12:36 INFO - mozversion application_changeset: 7fc6eedd33484ae8679bde3ae600563d2b457f4e 05:12:36 INFO - mozversion application_display_name: Nightly 05:12:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:12:36 INFO - mozversion application_name: Firefox 05:12:36 INFO - mozversion application_remotingname: firefox 05:12:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:12:36 INFO - mozversion application_vendor: Mozilla 05:12:36 INFO - mozversion application_version: 49.0a1 05:12:36 INFO - mozversion platform_buildid: 20160606030429 05:12:36 INFO - mozversion platform_changeset: 7fc6eedd33484ae8679bde3ae600563d2b457f4e 05:12:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:12:36 INFO - mozversion platform_version: 49.0a1 05:12:36 INFO - using testdate: 1465215156 05:12:36 INFO - actual date: 1465215156 05:12:36 INFO - starting webserver on 'localhost:59104' 05:12:36 INFO - SUITE-START | Running 2 tests 05:12:36 INFO - TEST-START | dromaeo_css 05:12:36 INFO - operating with platform_type : linux_ 05:12:36 INFO - Initialising browser for dromaeo_css test... 05:12:36 INFO - TEST-INFO | started process 16677 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoxpiPd/profile http://localhost:59104/getInfo.html) 05:12:41 INFO - PROCESS | 16677 | __metrics Screen width/height:1600/1200 05:12:41 INFO - PROCESS | 16677 | colorDepth:24 05:12:41 INFO - PROCESS | 16677 | Browser inner width/height: 1024/697 05:12:41 INFO - PROCESS | 16677 | __metrics 05:12:42 ERROR - PROCESS | 16677 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:12:42 INFO - PROCESS | 16677 | console.error: PushService: 05:12:42 INFO - PROCESS | 16677 | stateChangeProcessEnqueue: Error transitioning state 05:12:42 INFO - PROCESS | 16677 | UnknownError 05:12:43 INFO - TEST-INFO | 16677: exit 0 05:12:43 INFO - Browser initialized. 05:12:43 INFO - Running cycle 1/1 for dromaeo_css test... 05:12:43 INFO - TEST-INFO | started process 16757 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoxpiPd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:12:55 INFO - PROCESS | 16757 | RSS: Main: 158126080 05:12:55 INFO - PROCESS | 16757 | 05:13:46 INFO - PROCESS | 16757 | 1465215226701 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:15:58 INFO - PROCESS | 16757 | Cycle 1(1): loaded http://localhost:59104/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59104/tests/dromaeo/cssquery-ext.html) 05:15:59 INFO - PROCESS | 16757 | RSS: Main: 268062720 05:15:59 INFO - PROCESS | 16757 | 05:19:01 INFO - PROCESS | 16757 | Cycle 1(1): loaded http://localhost:59104/tests/dromaeo/cssquery-ext.html (next: http://localhost:59104/tests/dromaeo/cssquery-jquery.html) 05:19:02 INFO - PROCESS | 16757 | RSS: Main: 240680960 05:19:02 INFO - PROCESS | 16757 | 05:22:04 INFO - PROCESS | 16757 | Cycle 1(1): loaded http://localhost:59104/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59104/tests/dromaeo/cssquery-mootools.html) 05:22:05 INFO - PROCESS | 16757 | RSS: Main: 235683840 05:22:05 INFO - PROCESS | 16757 | 05:25:07 INFO - PROCESS | 16757 | Cycle 1(1): loaded http://localhost:59104/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59104/tests/dromaeo/cssquery-prototype.html) 05:25:08 INFO - PROCESS | 16757 | RSS: Main: 237367296 05:25:08 INFO - PROCESS | 16757 | 05:28:11 INFO - PROCESS | 16757 | Cycle 1(1): loaded http://localhost:59104/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59104/tests/dromaeo/cssquery-yui.html) 05:28:11 INFO - PROCESS | 16757 | RSS: Main: 208379904 05:28:11 INFO - PROCESS | 16757 | 05:31:14 INFO - PROCESS | 16757 | Cycle 1(1): loaded http://localhost:59104/tests/dromaeo/cssquery-yui.html (next: http://localhost:59104/tests/dromaeo/cssquery-dojo.html) 05:31:15 INFO - PROCESS | 16757 | RSS: Main: 316469248 05:31:15 INFO - PROCESS | 16757 | 05:31:15 INFO - PROCESS | 16757 | __start_tp_report 05:31:15 INFO - PROCESS | 16757 | _x_x_mozilla_page_load 05:31:15 INFO - PROCESS | 16757 | _x_x_mozilla_page_load_details 05:31:15 INFO - PROCESS | 16757 | |i|pagename|runs| 05:31:15 INFO - PROCESS | 16757 | |0;dojo.html;2698.514267431862;2710.2953232159643;2710.8780104895277;2737.4798788230223;2764.060219525361;4604.700694454858;4668.929966050512;4687.718736875786;4764.880877978052;4778.139934811733;4686.062787442516;4725.952740472594;4739.976300118503;4742.217534106877;4746.572808447239;4283.528811830696;4303.591158839905;4395.208862404766;4412.448443944507;4532.9320060199125;4453.9777301113445;4471.686981911267;4479.216137175998;4506.819727210924;4533.184026875161;4243;4290.056187638715;4293.957060429419;4321.65426765858;4370.8251669933325;4314.395984562164;4325.9134817303475;4337.089211265638;4371.650267978554;4378.824847006116;4348.4999225089205;4358.237308471036;4369.169857727022;4396.296592545209;4403.669724770623;4473.463184417858;4626.352310676508;4694.624430045588;4701.576858082789;4707.529247075299;5127.743612819344;5144.9742751286;5155.304033955405;5158.74206289684;5159.74201289934;5169.922451163236;5176.094183517869;5182.0931337016245;5182.170852663556;5182.404023537304;4668.906621867543;4719.905601887977;4753.833615823499;4768.165571025057;4832.057748739033;5247.816326428557;5273.578113750891;5276.81531146408;5279.340082489689;5284.233786101071;4893.804247830047;5023.0456213320085;5067.214581739836;5067.721275329893;5078.568321692697;5028.170351891897;5059.519345662156;5060.367454068241;5062.4684408137355;5074.4671809460215;5036.445990940993;5039.370078740158;5041.218611115283;5073.9746301269;5093.592512598983;4773.71357718538;4940.258961155855;5047.596192304607;5054.848354549369;5061.493850614983;4236.4704411948505;4236.6187043166265;4242.066745316026;4260.637845783143;4282.122164956177;3729.9627003730157;3759.9060023499633;3765.755225910307;3805.9429108563395;3812.1041555234497;4215.620594146541;4229.661627069827;4240.279152544075;4424.867253982386;4431.601155895984;5083.822066227664;5148.613853960968;5158.432572417031;5166.405863325691;5168.689878607295;4420.359047938031;4442.933355999663;4447.155040542351;4450.710703804242;4500.729956202638;4407.096545208225;4480.036792089716;4604.58558729716;4611.930821037688;4650.86047418578;4745.6440766942615;4768.642351823558;4796.712197268175;4813.4945830687275;4825.372701548777;5074.898502029865;5086.54221120101;5088.313077734459;5088.847334579968;5146.25379320004;4691.1555919934735;4725.692829966041;4757.191277482905;4776.617870570277;4820.855374338776;4968.180250258667;5003;5016.648834581691;5017.096922553829;5019.297298378157;5080.26336181259;5081.822136225214;5081.923771143362;5082.720450375265;5137.717425541481;4831.323614694016;4940.75296235194;4953.504649535018;4955.50444955516;4994.9750251248515;4860.3195552623365;4927.852164435073;4939.802407903788;4949.381327334083;4959.752012399438;4869.537393947569;4883.511648835088;4930.630202734737;4932.4327702314695;4934.777934993006;4825.879353016203;4870.464248932685;5018.598512118949;5031.723255220998;5036.370453693288;4817.638677099301;4827.903441931212;4862.440819305825;4865.367502224688;4905.607551395951 05:31:15 INFO - PROCESS | 16757 | |1;ext.html;544.3875639905107;599.5653151465189;599.5743022454058;601.7202001069503;616.0728104203175;27374.452510949795;27748.583771243422;39699.80150099253;40537.797311013404;40632.796836015776;37209.62790372095;41127;41155.58844411555;41176.38235426471;41274.58725412745;7652.617369131535;7823.530588164728;7825.25660062296;7825.726099586515;7830.80422989427;7566.470347075707;7730.420218483609;7731.188225236354;7733.922660773376;7736.458447908649;7718.729844455417;7751.8449631007625;7751.961240193791;7775.261350171753;7779.105402878685;7711.4216433767415;7734.071911370615;7734.99445072137;7741.264579864932;7741.535507869546;7646.885296720554;7725.111612164616;7725.729599464048;7726.884096738553;7731.690732370698;37184.62815371866;37186.814065929495;37554;37560.43659345112;37634.81182594097;2961.5853780470534;3081.938361232785;3104.2549788050933;3159.8420078996187;3221.8872339468007;29578.26054348637;29638;29650.851745741347;29846;30156.396872062436;3270.0680306112645;3298.4887342461957;3464.22055037617;3528.1179705073732;3537.540119784437;244911;246058;246957;247377;247503;28046.71953280482;28628.284292892844;56335.154972675446;56931.43068569261;57003.714981424826;33851.661483385345;34175.31649366999;34208.315833683686;34224.65775342215;34226;12426.130170887951;12549;12562.497500100077;12565;12591.496340146292;10105.747356316004;10113.949430252802;10128.696139115838;10129.797404051878;10133.442660653587;8026.117127116013;8026.638801253957;8051.959740201261;8095.433319667684;8125.06561745395;3103.3017571046335;3133.6396314424132;3149.622045354572;3163.9525407118913;3165.683431656862;883.7967267528504;911.2072496927583;911.5533388639519;933.659214386744;999.1357475783541;26777.33056673599;28058.43883122367;28248.15255542337;28356.43287134246;28674.569881451796;893.821235752852;961.3895176562793;979.4710856137748;1080.065743132185;1082.0802318029612;15614.609634759221;15955.601109972344;16295.266712997944;16816.831831681528;16967.660646786993;395663;397524;399067;401101;402026;49463.505364946606;49744.25383619249;49783;49918.25122623164;50035.49964500381;1074.9462526873624;1184.8010371995647;1230.6923269182705;1244.458660482693;1251.117961836921;27967.160985170478;29029.7097029027;29425;29528.261793455335;29937.251568710086;42334;42679;42962.78518607387;43022.569774303105;43177.56822431861;295424;299870;299958;302232;383637;25042.62436063424;25707;25739;26613.866930665223;26835.865820670773;41903;42887;43828.34257486076;43998;48395.5160448391;35370.29259414746;37067.25865482621;37158.44262336121;37720;38086.619133809414;35642.48709835207;36872.26255474822;36998;37092.25815483729;37538.24923501569;36010.63989360178;36217.81891090528;36505.81747091247;36677.63322366849;37152.44271335878;32333.35333293368;33249.546501691795;33415.66584334125;33451.156651684876;33873;25481.745182547937;25623.74376256288;25796.613050803877;25846.22461326163;25865.652171755934 05:31:15 INFO - PROCESS | 16757 | |2;jquery.html;353.87083714444225;355.50229678450177;372.65529385318575;373.5554689918996;375.66190428614226;15613.453529126482;16568.917155414205;16642;16950.576235594086;17109.486715398525;15837.762433563506;16559.172041397913;16596.751048734248;16689.582760430963;16704.331826726946;4841.709497430156;5042.218456139304;5085.66943148696;5087.414947281073;5088.669236499616;3686.318031164243;3877.7091718121114;3884.4950156479617;3889.2610404023285;5013.298138260647;3752.7935963521995;5624.409437009116;5684.5452363811;5765.7981970631035;5772.393898640646;5674.148877668342;5732.2261494698305;5768.826935191951;5776.306843178803;5812.331581868097;3319.9170020749675;5152.149895267276;5154.639175257734;5156.819511317086;5167.457416971201;18527.72208416875;19376.128074236552;19405.708914366296;19439.708404373945;20197.798022019884;1907.8664493485462;1971.3297478857114;2021.413790000898;2050.0979568989596;2059.742532183477;12341.321227332493;12706.936465317614;12884.742305153844;13335.199888006751;13354.465821367134;1677.2117104960648;1712.9314827406888;1739.5738044179132;1793.6323053773945;1810.3482746211353;63354.36645633531;64756.35243647597;65452;66052.669736651;67352.32647673509;9196.540172991323;9258.398204116711;9384.5307734613;9554.952225238829;9671.758206044764;13068.477260909458;13157.342132893316;13162.14446061003;13189.604311870658;13212.405441755143;7101.89347159793;7143.642817859086;7196.676149573282;7210.927890721131;7290.198078211392;6887.414569761526;6921.096698407878;6945.791626251221;7072.752453664097;7079;5902.0818234074095;5959.821205363846;5976.372480889444;6037.154798328237;6037.818865434044;1524.885633577486;1678.0770576183052;1691.4249155287016;1712.905790181527;1805.8735888487943;838.174398217755;902.8239493298744;953.0659953245857;974.5760594141572;1011.3931641015479;16039.759403608956;16510;16801.579960501087;17078.658426831393;17236.569085772957;912.6258234123977;927.7958849053198;942.2085448223526;951.9904800951902;1001.234055947201;9626.759331016781;9885.25860560461;9950.950245248727;9952.303338766216;9981.650642227487;378398;383519;388211;389319;396086;65378.67310663416;66651;68485.65757171182;69332.653336733;69452.652736736;914.9203939351629;937.9343445958717;942.34036174678;952.4333021852126;961.2982522758425;14899.702005960036;14904.18027008525;15083.854718452352;15094.924525377302;15119.244037798286;27988.30029249285;31547.684523155393;31622.841885791346;32949.50575741318;32972.34055318928;44379.77810110929;45158.77420612876;45276.0944781096;45296.547034529234;45303;7476.663550140365;7489;7499.212582678741;7506;7623.199564045695;6102.847428814315;9571.904280957102;10928.94535527349;11944.940275298568;12033.157678962389;4760.666753327372;5519.951209270226;9239.260859131387;10486.737831554272;10668.359898406121;6779.322067793379;10268.229882758673;10528.473576321307;10622.20333474977;10680.465976701289;7544.698212071675;10406;10520.105791007543;10540.631077912236;10617;11154.16343774204;11284.605038823602;11397.544098236309;11587;11673.12451566153;10495.317804342692;10554.208434367607;10714.303570267908;11192.272502287326;11241.325520468798 05:31:15 INFO - PROCESS | 16757 | |3;mootools.html;1251.1117106854133;1421.417218940234;1457.832349279833;1573.5043461309688;1743.145858529321;6549.639769812658;7416.629168541572;7609.162992070867;7609.54342739436;7758.534487930728;7552.509086909347;7705.422093342993;7719.961400193005;7727.1500134985245;7728.613569321526;1904.0860387014172;2094.9266775662854;2162.610730068583;2180.5529866377356;2194.47332640166;2230.6765518999737;2251.2233279518623;2256.537409830989;2256.7066281383395;2258.6499092640665;2161.3083813179787;2187.1798075721604;2188.1684959715285;2188.4091295350245;2197.8681279123302;1845.5478407790176;2075.7716651168357;2110.0715685098507;2155.708979287792;2160.1899287767087;2177.2379667116543;2217.789310015546;2220.578090162864;2222.5665995130958;2225.5326381459913;7492.737754178632;7551.093868735732;7562.054743157106;7562.773116806505;7570;4462.174497717932;4597.563231493003;4599;4603.10239503297;4604.079184163181;2744.108164846433;2824.477471667748;2926.800011995093;2927.7511411530045;2932.8533573321247;890.7644152056993;899.9865002024975;906.7642412972608;914.8764916736222;926.939748916325;10183.59265629374;10387.636432724817;10405.375677459377;10414.114800241912;10433.530491127918;4125.133721918371;4196.181744559843;4251.723637963522;4339.674524410681;4343.066240758252;9020.05289444599;9050.637974480947;9057.275417966546;9068.591913363782;9074.047225041408;4666.65000124992;4671.089137618132;4671.135839869635;4672.789724462407;4674.462436819741;3711.536057992751;3983.960160398417;4131.338985762263;4252.298370768788;4297.39836422901;3611.476335931275;3643.508126402902;3694.722895782827;3719.2189640175325;3764;1181.2144923625865;1215.1493954232074;1216.0514798457218;1227.545808051009;1231.4520038582923;848.2620120495209;860.049645142109;885.8582626779685;917.6512925088424;922.3313098003894;5209.140491818807;5310;5357.7589008494715;5579.2746942897165;5584.91622625661;397.7752569798055;400.2235662814131;402.0712154922139;403.76985118482185;405.4141765149331;3753.774773513543;3818.5608655004476;3887.2614203301846;3935.3506671399473;3997.2804895118575;9042.276617870555;9299.116583924517;9400.670976515788;9423.34036617444;9426.057394260657;8647.567621618893;9167.587458564381;9242.72271831846;9248.075192480832;9258.444493330422;6965.651717414109;7283.8543229136185;7317.963410182915;7324.816879577947;7336.706531738778;5477.945220547903;5647.915281270866;5782.855428614318;5849.181114644039;5857.765689372377;8607.698730544651;8617.48295102296;8819.955900220459;8823.69117080899;8853.822923541622;8310.418270721233;8655;8667.4366166199;8914.910850891667;8916.33127515426;6067.726952287069;6389.137466441971;6562.80311590653;6699.76550820719;6891.620960847202;7328.377087947584;7352.816179595553;7365.742199023222;7378.631068446449;7413.5551866886;6378.234611846423;6480.351964803671;6526.151600291932;6548.3124271952665;6760.08738820253;6198.101275315144;6285.96857015712;6292.182016337847;6661.300563440769;6700.93299067003;5898.144769008555;6095.268567771718;6105.297890742621;6116.113163591343;6122.112293717297;4457.242268814374;4724.929126063181;4750.976245118891;4782.808687652594;4785.306130610972;4652.13935421948;4724.527547245248;4733.83431579893;4768.284757286435;4790.904181916412 05:31:15 INFO - PROCESS | 16757 | |4;prototype.html;287.1929877045502;290.96653884803254;292.9882804687813;294.2349890285258;296.64699008180276;4677.766111694415;4697.2954056891485;4708.717476951381;4725.14947309485;4755.144074066667;4633.953660463394;4636.605888499473;4642.605378542819;4643.280291554806;4666.78999445025;3486.6164721880573;3601.6398360164035;3607.4047782115917;3610.007248006806;3614.222942067455;3564.536610240665;3624.6737793598572;3694.1688120173017;3695.224002959382;3706.7405281630295;3636.2000359920776;3660.432632941898;3665.6700896919406;3668.156324045471;3679.8592436344684;3530.894073177809;3656.0988286091083;3674.926501469956;3677.687396571295;3686.410174372101;3226.56441380413;3239.7408207343356;3240.659730728263;3249.545063691085;3250.528673342376;4468.011734778025;4479.7088189267915;4481.305397663367;4499.707519011254;4503.954960450419;4172.70791044627;4174.582541745832;4174.979125104385;4176.227397931392;4179.561146079679;4609.1933911565675;4839.588634966032;4843.878903027417;4870.220764677634;4874.780634871404;3388.220709236865;3400.4389275769468;3408.9659103409144;3409.0965894037854;3412.812295323756;5048.3941926969;5100.566451851597;5112.974435127838;5115.565176959963;5117.667351622133;3432.845521951518;3527.95925202066;3532.346515894568;3536.8585256589963;3537.8054207018863;3504;3549.6982756465472;3553.34263161316;3554.573451185874;3566.4472006838982;4066.959330406717;4084.509858816961;4091.5270502619032;4109.383592461155;4115.156392939441;4865.416150062015;4880.292357608198;4895.559399653977;4902.779374928136;4905.435874874435;1195.1156144453041;1212.6119641714567;1219.7743417467798;1226.6013545597539;1235.8640549539543;771.3366504805863;785.9174786647434;787.5471603827822;795.1213908630995;798.2974982015905;4173.5409104998425;4265.573442655709;4300.247456695129;4303.568483806639;4304.16068866568;5055.772490237948;5066.746662666926;5067.4932506749765;5073.720945348041;5074.543291103819;4389.648828093745;4393.758343291086;4398.824047038147;4415.161119387306;4430.379746835446;2513.554706044032;2656;2691.7039125696156;2716.850573218492;2717.91846244613;4810.855674329776;4817.13291607514;4830.661853670209;4834.347363106006;4848.200046992278;5202.765875535534;5206.219067139884;5217.6086793489885;5218.269442278084;5220.243064755665;4605.424321959755;4806.182948898696;4820.39745031871;4842.854714358505;4847.587955023862;5038.244263360525;5051.898962020812;5056.949430505795;5069;5095.337606111182;4972.5027497249985;4986.501349864984;4998.225275082368;5010.899782004412;5014.84955451337;4546.499655113871;4815.820124069625;4831.347768051268;4832.9459979507865;4836.443808962014;3548.2903419315726;3552.0340515669704;3560.8219589019927;3564.7861128331347;3566.518519999767;5025.698458092526;5043.899122017466;5049;5069.923951140662;5089.160288552347;4557.384753058427;4904.362432883845;4928.088303663833;4929.827456039022;4942.135126352802;4851.296561998561;4890.462049174659;4913.263010548446;4922.138625740553;4944.208926571731;4838.274258861199;4843.733594652328;4843.782029808596;4843.903121937612;4853.131544355378;4693.577578017995;4755.334253204624;4841.990573911788;4893.339399181065;4953.529414705597;4830.734309613005;4848.903021939471;4853.417589889236;4869.634777391639;4878.024395120919 05:31:15 INFO - PROCESS | 16757 | |5;yui.html;716.7527203114927;718.6227230703884;730.357285588682;763.0461922596754;774.3921021997733;12255.938720306398;12843;13371.465141394332;13546.864531354684;13614.727705445885;13003.219806811574;13135.540256091039;13146.802797958015;13148.93425532871;13165.144265622728;780.3562061299436;789.7591234673422;796.8924195233627;797.6251161953901;798.4450806689354;634.6794868591378;759.7986533568609;772.9922700772977;793.131520984524;794.2256300107377;827.2554700769296;829.983400331993;830.6967956695823;831.418007394823;835.4026870787386;656.7996760987896;828.7555171224473;828.9046759622661;829.3323874281201;829.672279449617;588.8763359694469;589.4282545930483;592.3424998251937;606.0152252589542;609.4849851875202;12868.356582170854;12885;12906.225626462443;12927.224366538037;12942.158759680591;12258.754824903452;12358.876411235862;12646;12663.556775512905;12825.87174128256;11693.883061169365;11700.595423701194;11726.35505047222;11731.648050558497;11855.585054523137;4157.376393540962;4196.181744559812;4240.215560121356;4263.062126332233;4296.484421869364;57731.71134144344;57779.422205777824;57861.421385786445;57937.710311448594;57955;9709.6601618943;9754.268429867789;9898.505074746234;10191.54138063789;10566.41884696349;18926.148323325484;18954.52613684669;18958.90520547416;19019;19031.61936761257;7005.929940700527;7036.612986285803;7048.400885924754;7106.147262328554;7170.282971702788;3713.3687273163628;3760.9811950940616;3786.772793632391;3792.810359482015;3822.8853134406013;2873.2242294580765;2975.9851200743856;2981.7763667724575;2984.0600210933485;2990.1627544287635;522.6341560907304;525.2279149650009;534.8047962493739;539.4928766959046;539.6761942834268;479.62104992509177;486.55237181792836;518.0778214777702;518.4323166133079;579.826052184343;7556.58438785872;7916.722914697958;7938.5236885787035;8138.552379619177;8168.060673022678;516.9767360468788;547.6796074296501;551.9503244707995;561.4441702714283;567.2823877794593;3682.2451397463456;3731.8320675569666;3781.1681430085337;3861.613838616172;3862.787546684903;61240.693796531625;88436.55781721178;89991.55004224936;90942.54528727314;91107;74074.25925740782;75133.62433187799;76020.61989690016;76499.23500765032;77883.22116778872;67401;68609.3139068613;68783.31216687869;68898.65550672215;70524;7390.96304518474;7411.5553066816165;7428.33145016951;7453.867197214623;7456.32893039629;41608;42165.57834421616;42519.7874010628;42632.5736742641;42835;54480.45519544754;58949;59011.70494147674;59022;60482.697586511786;9042.954785226031;9264;9287.442753434816;9378.531073446164;9586.233101352014;10315.535800889129;10680.305780124267;11630.476628551905;12762.361881905681;12975.286359250333;9047.728568142966;10083.647072352433;10462.21533384984;10554.419506927192;11268.943655281671;11163.386013769321;11467.713307167387;11735.47190376418;11846.348450835287;12150.939245303716;11979.101567382308;12298.692532686397;12309.322987235788;12703.618891433272;12846.550370736979;9826.263030272616;9956.253281003808;9959.850602240827;9963.750906227113;10422.009909058628;9304.767380815263;9348.766280843034;9380.390274632127;9386.765330866783;9386.906130938876 05:31:15 INFO - PROCESS | 16757 | __end_tp_report 05:31:15 INFO - PROCESS | 16757 | __start_cc_report 05:31:15 INFO - PROCESS | 16757 | _x_x_mozilla_cycle_collect,1063 05:31:15 INFO - PROCESS | 16757 | __end_cc_report 05:31:15 INFO - PROCESS | 16757 | __startTimestamp1465216275031__endTimestamp 05:31:15 INFO - PROCESS | 16757 | 05:31:15 INFO - PROCESS | 16757 | ------- Summary: start ------- 05:31:15 INFO - PROCESS | 16757 | Number of tests: 6 05:31:15 INFO - PROCESS | 16757 | 05:31:15 INFO - PROCESS | 16757 | [#0] dojo.html Cycles:165 Average:4695.91 Median:4813.49 stddev:489.87 (10.2%) stddev-sans-first:465.64 05:31:15 INFO - PROCESS | 16757 | Values: 2698.5 2710.3 2710.9 2737.5 2764.1 4604.7 4668.9 4687.7 4764.9 4778.1 4686.1 4726.0 4740.0 4742.2 4746.6 4283.5 4303.6 4395.2 4412.4 4532.9 4454.0 4471.7 4479.2 4506.8 4533.2 4243.0 4290.1 4294.0 4321.7 4370.8 4314.4 4325.9 4337.1 4371.7 4378.8 4348.5 4358.2 4369.2 4396.3 4403.7 4473.5 4626.4 4694.6 4701.6 4707.5 5127.7 5145.0 5155.3 5158.7 5159.7 5169.9 5176.1 5182.1 5182.2 5182.4 4668.9 4719.9 4753.8 4768.2 4832.1 5247.8 5273.6 5276.8 5279.3 5284.2 4893.8 5023.0 5067.2 5067.7 5078.6 5028.2 5059.5 5060.4 5062.5 5074.5 5036.4 5039.4 5041.2 5074.0 5093.6 4773.7 4940.3 5047.6 5054.8 5061.5 4236.5 4236.6 4242.1 4260.6 4282.1 3730.0 3759.9 3765.8 3805.9 3812.1 4215.6 4229.7 4240.3 4424.9 4431.6 5083.8 5148.6 5158.4 5166.4 5168.7 4420.4 4442.9 4447.2 4450.7 4500.7 4407.1 4480.0 4604.6 4611.9 4650.9 4745.6 4768.6 4796.7 4813.5 4825.4 5074.9 5086.5 5088.3 5088.8 5146.3 4691.2 4725.7 4757.2 4776.6 4820.9 4968.2 5003.0 5016.6 5017.1 5019.3 5080.3 5081.8 5081.9 5082.7 5137.7 4831.3 4940.8 4953.5 4955.5 4995.0 4860.3 4927.9 4939.8 4949.4 4959.8 4869.5 4883.5 4930.6 4932.4 4934.8 4825.9 4870.5 5018.6 5031.7 5036.4 4817.6 4827.9 4862.4 4865.4 4905.6 05:31:15 INFO - PROCESS | 16757 | 05:31:15 INFO - PROCESS | 16757 | [#1] ext.html Cycles:180 Average:46464.71 Median:36774.95 stddev:86431.60 (235.0%) stddev-sans-first:86605.30 05:31:15 INFO - PROCESS | 16757 | Values: 544.4 599.6 599.6 601.7 616.1 27374.5 27748.6 39699.8 40537.8 40632.8 37209.6 41127.0 41155.6 41176.4 41274.6 7652.6 7823.5 7825.3 7825.7 7830.8 7566.5 7730.4 7731.2 7733.9 7736.5 7718.7 7751.8 7752.0 7775.3 7779.1 7711.4 7734.1 7735.0 7741.3 7741.5 7646.9 7725.1 7725.7 7726.9 7731.7 37184.6 37186.8 37554.0 37560.4 37634.8 2961.6 3081.9 3104.3 3159.8 3221.9 29578.3 29638.0 29650.9 29846.0 30156.4 3270.1 3298.5 3464.2 3528.1 3537.5 244911.0 246058.0 246957.0 247377.0 247503.0 28046.7 28628.3 56335.2 56931.4 57003.7 33851.7 34175.3 34208.3 34224.7 34226.0 12426.1 12549.0 12562.5 12565.0 12591.5 10105.7 10113.9 10128.7 10129.8 10133.4 8026.1 8026.6 8052.0 8095.4 8125.1 3103.3 3133.6 3149.6 3164.0 3165.7 883.8 911.2 911.6 933.7 999.1 26777.3 28058.4 28248.2 28356.4 28674.6 893.8 961.4 979.5 1080.1 1082.1 15614.6 15955.6 16295.3 16816.8 16967.7 395663.0 397524.0 399067.0 401101.0 402026.0 49463.5 49744.3 49783.0 49918.3 50035.5 1074.9 1184.8 1230.7 1244.5 1251.1 27967.2 29029.7 29425.0 29528.3 29937.3 42334.0 42679.0 42962.8 43022.6 43177.6 295424.0 299870.0 299958.0 302232.0 383637.0 25042.6 25707.0 25739.0 26613.9 26835.9 41903.0 42887.0 43828.3 43998.0 48395.5 35370.3 37067.3 37158.4 37720.0 38086.6 35642.5 36872.3 36998.0 37092.3 37538.2 36010.6 36217.8 36505.8 36677.6 37152.4 32333.4 33249.5 33415.7 33451.2 33873.0 25481.7 25623.7 25796.6 25846.2 25865.7 05:31:15 INFO - PROCESS | 16757 | 05:31:15 INFO - PROCESS | 16757 | [#2] jquery.html Cycles:180 Average:23552.77 Median:196044.35 stddev:63584.39 (32.4%) stddev-sans-first:63738.90 05:31:15 INFO - PROCESS | 16757 | Values: 353.9 355.5 372.7 373.6 375.7 15613.5 16568.9 16642.0 16950.6 17109.5 15837.8 16559.2 16596.8 16689.6 16704.3 4841.7 5042.2 5085.7 5087.4 5088.7 3686.3 3877.7 3884.5 3889.3 5013.3 3752.8 5624.4 5684.5 5765.8 5772.4 5674.1 5732.2 5768.8 5776.3 5812.3 3319.9 5152.1 5154.6 5156.8 5167.5 18527.7 19376.1 19405.7 19439.7 20197.8 1907.9 1971.3 2021.4 2050.1 2059.7 12341.3 12706.9 12884.7 13335.2 13354.5 1677.2 1712.9 1739.6 1793.6 1810.3 63354.4 64756.4 65452.0 66052.7 67352.3 9196.5 9258.4 9384.5 9555.0 9671.8 13068.5 13157.3 13162.1 13189.6 13212.4 7101.9 7143.6 7196.7 7210.9 7290.2 6887.4 6921.1 6945.8 7072.8 7079.0 5902.1 5959.8 5976.4 6037.2 6037.8 1524.9 1678.1 1691.4 1712.9 1805.9 838.2 902.8 953.1 974.6 1011.4 16039.8 16510.0 16801.6 17078.7 17236.6 912.6 927.8 942.2 952.0 1001.2 9626.8 9885.3 9951.0 9952.3 9981.7 378398.0 383519.0 388211.0 389319.0 396086.0 65378.7 66651.0 68485.7 69332.7 69452.7 914.9 937.9 942.3 952.4 961.3 14899.7 14904.2 15083.9 15094.9 15119.2 27988.3 31547.7 31622.8 32949.5 32972.3 44379.8 45158.8 45276.1 45296.5 45303.0 7476.7 7489.0 7499.2 7506.0 7623.2 6102.8 9571.9 10928.9 11944.9 12033.2 4760.7 5520.0 9239.3 10486.7 10668.4 6779.3 10268.2 10528.5 10622.2 10680.5 7544.7 10406.0 10520.1 10540.6 10617.0 11154.2 11284.6 11397.5 11587.0 11673.1 10495.3 10554.2 10714.3 11192.3 11241.3 05:31:15 INFO - PROCESS | 16757 | 05:31:15 INFO - PROCESS | 16757 | [#3] mootools.html Cycles:180 Average:5066.05 Median:5259.57 stddev:2789.87 (53.0%) stddev-sans-first:2782.96 05:31:15 INFO - PROCESS | 16757 | Values: 1251.1 1421.4 1457.8 1573.5 1743.1 6549.6 7416.6 7609.2 7609.5 7758.5 7552.5 7705.4 7720.0 7727.2 7728.6 1904.1 2094.9 2162.6 2180.6 2194.5 2230.7 2251.2 2256.5 2256.7 2258.6 2161.3 2187.2 2188.2 2188.4 2197.9 1845.5 2075.8 2110.1 2155.7 2160.2 2177.2 2217.8 2220.6 2222.6 2225.5 7492.7 7551.1 7562.1 7562.8 7570.0 4462.2 4597.6 4599.0 4603.1 4604.1 2744.1 2824.5 2926.8 2927.8 2932.9 890.8 900.0 906.8 914.9 926.9 10183.6 10387.6 10405.4 10414.1 10433.5 4125.1 4196.2 4251.7 4339.7 4343.1 9020.1 9050.6 9057.3 9068.6 9074.0 4666.7 4671.1 4671.1 4672.8 4674.5 3711.5 3984.0 4131.3 4252.3 4297.4 3611.5 3643.5 3694.7 3719.2 3764.0 1181.2 1215.1 1216.1 1227.5 1231.5 848.3 860.0 885.9 917.7 922.3 5209.1 5310.0 5357.8 5579.3 5584.9 397.8 400.2 402.1 403.8 405.4 3753.8 3818.6 3887.3 3935.4 3997.3 9042.3 9299.1 9400.7 9423.3 9426.1 8647.6 9167.6 9242.7 9248.1 9258.4 6965.7 7283.9 7318.0 7324.8 7336.7 5477.9 5647.9 5782.9 5849.2 5857.8 8607.7 8617.5 8820.0 8823.7 8853.8 8310.4 8655.0 8667.4 8914.9 8916.3 6067.7 6389.1 6562.8 6699.8 6891.6 7328.4 7352.8 7365.7 7378.6 7413.6 6378.2 6480.4 6526.2 6548.3 6760.1 6198.1 6286.0 6292.2 6661.3 6700.9 5898.1 6095.3 6105.3 6116.1 6122.1 4457.2 4724.9 4751.0 4782.8 4785.3 4652.1 4724.5 4733.8 4768.3 4790.9 05:31:15 INFO - PROCESS | 16757 | 05:31:15 INFO - PROCESS | 16757 | [#4] prototype.html Cycles:180 Average:4067.18 Median:4639.61 stddev:1195.15 (25.8%) stddev-sans-first:1164.34 05:31:15 INFO - PROCESS | 16757 | Values: 287.2 291.0 293.0 294.2 296.6 4677.8 4697.3 4708.7 4725.1 4755.1 4634.0 4636.6 4642.6 4643.3 4666.8 3486.6 3601.6 3607.4 3610.0 3614.2 3564.5 3624.7 3694.2 3695.2 3706.7 3636.2 3660.4 3665.7 3668.2 3679.9 3530.9 3656.1 3674.9 3677.7 3686.4 3226.6 3239.7 3240.7 3249.5 3250.5 4468.0 4479.7 4481.3 4499.7 4504.0 4172.7 4174.6 4175.0 4176.2 4179.6 4609.2 4839.6 4843.9 4870.2 4874.8 3388.2 3400.4 3409.0 3409.1 3412.8 5048.4 5100.6 5113.0 5115.6 5117.7 3432.8 3528.0 3532.3 3536.9 3537.8 3504.0 3549.7 3553.3 3554.6 3566.4 4067.0 4084.5 4091.5 4109.4 4115.2 4865.4 4880.3 4895.6 4902.8 4905.4 1195.1 1212.6 1219.8 1226.6 1235.9 771.3 785.9 787.5 795.1 798.3 4173.5 4265.6 4300.2 4303.6 4304.2 5055.8 5066.7 5067.5 5073.7 5074.5 4389.6 4393.8 4398.8 4415.2 4430.4 2513.6 2656.0 2691.7 2716.9 2717.9 4810.9 4817.1 4830.7 4834.3 4848.2 5202.8 5206.2 5217.6 5218.3 5220.2 4605.4 4806.2 4820.4 4842.9 4847.6 5038.2 5051.9 5056.9 5069.0 5095.3 4972.5 4986.5 4998.2 5010.9 5014.8 4546.5 4815.8 4831.3 4832.9 4836.4 3548.3 3552.0 3560.8 3564.8 3566.5 5025.7 5043.9 5049.0 5069.9 5089.2 4557.4 4904.4 4928.1 4929.8 4942.1 4851.3 4890.5 4913.3 4922.1 4944.2 4838.3 4843.7 4843.8 4843.9 4853.1 4693.6 4755.3 4842.0 4893.3 4953.5 4830.7 4848.9 4853.4 4869.6 4878.0 05:31:15 INFO - PROCESS | 16757 | 05:31:15 INFO - PROCESS | 16757 | [#5] yui.html Cycles:180 Average:16616.86 Median:564.36 stddev:22838.56 (4046.8%) stddev-sans-first:22871.42 05:31:15 INFO - PROCESS | 16757 | Values: 716.8 718.6 730.4 763.0 774.4 12255.9 12843.0 13371.5 13546.9 13614.7 13003.2 13135.5 13146.8 13148.9 13165.1 780.4 789.8 796.9 797.6 798.4 634.7 759.8 773.0 793.1 794.2 827.3 830.0 830.7 831.4 835.4 656.8 828.8 828.9 829.3 829.7 588.9 589.4 592.3 606.0 609.5 12868.4 12885.0 12906.2 12927.2 12942.2 12258.8 12358.9 12646.0 12663.6 12825.9 11693.9 11700.6 11726.4 11731.6 11855.6 4157.4 4196.2 4240.2 4263.1 4296.5 57731.7 57779.4 57861.4 57937.7 57955.0 9709.7 9754.3 9898.5 10191.5 10566.4 18926.1 18954.5 18958.9 19019.0 19031.6 7005.9 7036.6 7048.4 7106.1 7170.3 3713.4 3761.0 3786.8 3792.8 3822.9 2873.2 2976.0 2981.8 2984.1 2990.2 522.6 525.2 534.8 539.5 539.7 479.6 486.6 518.1 518.4 579.8 7556.6 7916.7 7938.5 8138.6 8168.1 517.0 547.7 552.0 561.4 567.3 3682.2 3731.8 3781.2 3861.6 3862.8 61240.7 88436.6 89991.6 90942.5 91107.0 74074.3 75133.6 76020.6 76499.2 77883.2 67401.0 68609.3 68783.3 68898.7 70524.0 7391.0 7411.6 7428.3 7453.9 7456.3 41608.0 42165.6 42519.8 42632.6 42835.0 54480.5 58949.0 59011.7 59022.0 60482.7 9043.0 9264.0 9287.4 9378.5 9586.2 10315.5 10680.3 11630.5 12762.4 12975.3 9047.7 10083.6 10462.2 10554.4 11268.9 11163.4 11467.7 11735.5 11846.3 12150.9 11979.1 12298.7 12309.3 12703.6 12846.6 9826.3 9956.3 9959.9 9963.8 10422.0 9304.8 9348.8 9380.4 9386.8 9386.9 05:31:15 INFO - PROCESS | 16757 | -------- Summary: end -------- 05:31:15 INFO - PROCESS | 16757 | 05:31:15 INFO - TEST-INFO | 16757: exit 0 05:31:15 INFO - TEST-OK | dromaeo_css | took 1119131ms 05:31:15 INFO - TEST-START | kraken 05:31:15 INFO - operating with platform_type : linux_ 05:31:15 INFO - Initialising browser for kraken test... 05:31:15 INFO - TEST-INFO | started process 16941 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1EOirF/profile http://localhost:59104/getInfo.html) 05:31:20 INFO - PROCESS | 16941 | __metrics Screen width/height:1600/1200 05:31:20 INFO - PROCESS | 16941 | colorDepth:24 05:31:20 INFO - PROCESS | 16941 | Browser inner width/height: 1024/697 05:31:20 INFO - PROCESS | 16941 | __metrics 05:31:21 ERROR - PROCESS | 16941 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:31:21 INFO - PROCESS | 16941 | console.error: PushService: 05:31:21 INFO - PROCESS | 16941 | stateChangeProcessEnqueue: Error transitioning state 05:31:21 INFO - PROCESS | 16941 | UnknownError 05:31:22 INFO - TEST-INFO | 16941: exit 0 05:31:22 INFO - Browser initialized. 05:31:22 INFO - Running cycle 1/1 for kraken test... 05:31:22 INFO - TEST-INFO | started process 17021 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1EOirF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:31:34 INFO - PROCESS | 17021 | RSS: Main: 157782016 05:31:34 INFO - PROCESS | 17021 | 05:31:36 INFO - PROCESS | 17021 | Cycle 1(1): loaded http://localhost:59104/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59104/tests/kraken/driver.html?testName=audio-beat-detection) 05:31:37 INFO - PROCESS | 17021 | RSS: Main: 216051712 05:31:37 INFO - PROCESS | 17021 | 05:31:40 INFO - PROCESS | 17021 | Cycle 1(1): loaded http://localhost:59104/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59104/tests/kraken/driver.html?testName=audio-dft) 05:31:41 INFO - PROCESS | 17021 | RSS: Main: 202821632 05:31:41 INFO - PROCESS | 17021 | 05:31:44 INFO - PROCESS | 17021 | Cycle 1(1): loaded http://localhost:59104/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59104/tests/kraken/driver.html?testName=audio-fft) 05:31:45 INFO - PROCESS | 17021 | RSS: Main: 270098432 05:31:45 INFO - PROCESS | 17021 | 05:31:47 INFO - PROCESS | 17021 | Cycle 1(1): loaded http://localhost:59104/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59104/tests/kraken/driver.html?testName=audio-oscillator) 05:31:47 INFO - PROCESS | 17021 | RSS: Main: 180277248 05:31:47 INFO - PROCESS | 17021 | 05:31:50 INFO - PROCESS | 17021 | Cycle 1(1): loaded http://localhost:59104/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59104/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:31:50 INFO - PROCESS | 17021 | RSS: Main: 184930304 05:31:50 INFO - PROCESS | 17021 | 05:31:53 INFO - PROCESS | 17021 | Cycle 1(1): loaded http://localhost:59104/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59104/tests/kraken/driver.html?testName=imaging-darkroom) 05:31:54 INFO - PROCESS | 17021 | RSS: Main: 220921856 05:31:54 INFO - PROCESS | 17021 | 05:31:57 INFO - PROCESS | 17021 | Cycle 1(1): loaded http://localhost:59104/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59104/tests/kraken/driver.html?testName=imaging-desaturate) 05:31:58 INFO - PROCESS | 17021 | RSS: Main: 221282304 05:31:58 INFO - PROCESS | 17021 | 05:32:01 INFO - PROCESS | 17021 | Cycle 1(1): loaded http://localhost:59104/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59104/tests/kraken/driver.html?testName=json-parse-financial) 05:32:01 INFO - PROCESS | 17021 | RSS: Main: 220852224 05:32:01 INFO - PROCESS | 17021 | 05:32:03 INFO - PROCESS | 17021 | Cycle 1(1): loaded http://localhost:59104/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59104/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:32:04 INFO - PROCESS | 17021 | RSS: Main: 204038144 05:32:04 INFO - PROCESS | 17021 | 05:32:06 INFO - PROCESS | 17021 | Cycle 1(1): loaded http://localhost:59104/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59104/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:32:06 INFO - PROCESS | 17021 | RSS: Main: 210579456 05:32:06 INFO - PROCESS | 17021 | 05:32:08 INFO - PROCESS | 17021 | Cycle 1(1): loaded http://localhost:59104/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59104/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:32:09 INFO - PROCESS | 17021 | RSS: Main: 219275264 05:32:09 INFO - PROCESS | 17021 | 05:32:12 INFO - PROCESS | 17021 | Cycle 1(1): loaded http://localhost:59104/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59104/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:32:13 INFO - PROCESS | 17021 | RSS: Main: 225402880 05:32:13 INFO - PROCESS | 17021 | 05:32:15 INFO - PROCESS | 17021 | Cycle 1(1): loaded http://localhost:59104/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59104/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:32:16 INFO - PROCESS | 17021 | RSS: Main: 224092160 05:32:16 INFO - PROCESS | 17021 | 05:32:18 INFO - PROCESS | 17021 | Cycle 1(1): loaded http://localhost:59104/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59104/tests/kraken/driver.html?testName=ai-astar) 05:32:18 INFO - PROCESS | 17021 | RSS: Main: 266387456 05:32:18 INFO - PROCESS | 17021 | 05:32:18 INFO - PROCESS | 17021 | __start_tp_report 05:32:18 INFO - PROCESS | 17021 | _x_x_mozilla_page_load 05:32:18 INFO - PROCESS | 17021 | _x_x_mozilla_page_load_details 05:32:18 INFO - PROCESS | 17021 | |i|pagename|runs| 05:32:18 INFO - PROCESS | 17021 | |0;ai-astar;114;109;113;115;112;115;112;113;114;114 05:32:18 INFO - PROCESS | 17021 | |1;audio-beat-detection;152;134;132;183;136;156;152;129;203;142 05:32:18 INFO - PROCESS | 17021 | |2;audio-dft;160;161;160;162;161;163;162;161;161;163 05:32:18 INFO - PROCESS | 17021 | |3;audio-fft;77;75;75;113;76;78;74;75;98;75 05:32:18 INFO - PROCESS | 17021 | |4;audio-oscillator;86;86;118;87;86;86;115;86;87;120 05:32:18 INFO - PROCESS | 17021 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;118 05:32:18 INFO - PROCESS | 17021 | |6;imaging-darkroom;145;147;147;146;146;146;146;146;146;145 05:32:18 INFO - PROCESS | 17021 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;94 05:32:18 INFO - PROCESS | 17021 | |8;json-parse-financial;64;64;64;65;68;65;64;64;65;65 05:32:18 INFO - PROCESS | 17021 | |9;json-stringify-tinderbox;65;64;65;65;66;66;66;71;66;66 05:32:18 INFO - PROCESS | 17021 | |10;stanford-crypto-aes;90;84;83;83;88;84;84;84;113;83 05:32:18 INFO - PROCESS | 17021 | |11;stanford-crypto-ccm;134;131;131;131;131;132;130;134;134;131 05:32:18 INFO - PROCESS | 17021 | |12;stanford-crypto-pbkdf2;171;168;167;166;170;170;172;173;172;170 05:32:18 INFO - PROCESS | 17021 | |13;stanford-crypto-sha256-iterative;67;67;66;65;67;66;67;66;68;65 05:32:18 INFO - PROCESS | 17021 | __end_tp_report 05:32:18 INFO - PROCESS | 17021 | __start_cc_report 05:32:18 INFO - PROCESS | 17021 | _x_x_mozilla_cycle_collect,1871 05:32:18 INFO - PROCESS | 17021 | __end_cc_report 05:32:18 INFO - PROCESS | 17021 | __startTimestamp1465216338559__endTimestamp 05:32:18 INFO - PROCESS | 17021 | 05:32:18 INFO - PROCESS | 17021 | ------- Summary: start ------- 05:32:18 INFO - PROCESS | 17021 | Number of tests: 14 05:32:18 INFO - PROCESS | 17021 | 05:32:18 INFO - PROCESS | 17021 | [#0] ai-astar Cycles:10 Average:113.10 Median:114.00 stddev:1.79 (1.6%) stddev-sans-first:1.87 05:32:18 INFO - PROCESS | 17021 | Values: 114.0 109.0 113.0 115.0 112.0 115.0 112.0 113.0 114.0 114.0 05:32:18 INFO - PROCESS | 17021 | 05:32:18 INFO - PROCESS | 17021 | [#1] audio-beat-detection Cycles:10 Average:151.90 Median:152.00 stddev:24.01 (15.8%) stddev-sans-first:25.46 05:32:18 INFO - PROCESS | 17021 | Values: 152.0 134.0 132.0 183.0 136.0 156.0 152.0 129.0 203.0 142.0 05:32:18 INFO - PROCESS | 17021 | 05:32:18 INFO - PROCESS | 17021 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.07 (0.7%) stddev-sans-first:1.01 05:32:18 INFO - PROCESS | 17021 | Values: 160.0 161.0 160.0 162.0 161.0 163.0 162.0 161.0 161.0 163.0 05:32:18 INFO - PROCESS | 17021 | 05:32:18 INFO - PROCESS | 17021 | [#3] audio-fft Cycles:10 Average:81.60 Median:75.50 stddev:13.13 (17.4%) stddev-sans-first:13.82 05:32:18 INFO - PROCESS | 17021 | Values: 77.0 75.0 75.0 113.0 76.0 78.0 74.0 75.0 98.0 75.0 05:32:18 INFO - PROCESS | 17021 | 05:32:18 INFO - PROCESS | 17021 | [#4] audio-oscillator Cycles:10 Average:95.70 Median:86.00 stddev:15.21 (17.7%) stddev-sans-first:15.72 05:32:18 INFO - PROCESS | 17021 | Values: 86.0 86.0 118.0 87.0 86.0 86.0 115.0 86.0 87.0 120.0 05:32:18 INFO - PROCESS | 17021 | 05:32:18 INFO - PROCESS | 17021 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 05:32:18 INFO - PROCESS | 17021 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 05:32:18 INFO - PROCESS | 17021 | 05:32:18 INFO - PROCESS | 17021 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 05:32:18 INFO - PROCESS | 17021 | Values: 145.0 147.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 05:32:18 INFO - PROCESS | 17021 | 05:32:18 INFO - PROCESS | 17021 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 05:32:18 INFO - PROCESS | 17021 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 05:32:18 INFO - PROCESS | 17021 | 05:32:18 INFO - PROCESS | 17021 | [#8] json-parse-financial Cycles:10 Average:64.80 Median:65.00 stddev:1.23 (1.9%) stddev-sans-first:1.27 05:32:18 INFO - PROCESS | 17021 | Values: 64.0 64.0 64.0 65.0 68.0 65.0 64.0 64.0 65.0 65.0 05:32:18 INFO - PROCESS | 17021 | 05:32:18 INFO - PROCESS | 17021 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:1.89 (2.9%) stddev-sans-first:1.96 05:32:18 INFO - PROCESS | 17021 | Values: 65.0 64.0 65.0 65.0 66.0 66.0 66.0 71.0 66.0 66.0 05:32:18 INFO - PROCESS | 17021 | 05:32:18 INFO - PROCESS | 17021 | [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:84.00 stddev:9.23 (11.0%) stddev-sans-first:9.75 05:32:18 INFO - PROCESS | 17021 | Values: 90.0 84.0 83.0 83.0 88.0 84.0 84.0 84.0 113.0 83.0 05:32:18 INFO - PROCESS | 17021 | 05:32:18 INFO - PROCESS | 17021 | [#11] stanford-crypto-ccm Cycles:10 Average:131.90 Median:131.50 stddev:1.52 (1.2%) stddev-sans-first:1.41 05:32:18 INFO - PROCESS | 17021 | Values: 134.0 131.0 131.0 131.0 131.0 132.0 130.0 134.0 134.0 131.0 05:32:18 INFO - PROCESS | 17021 | 05:32:18 INFO - PROCESS | 17021 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.90 Median:170.50 stddev:2.28 (1.3%) stddev-sans-first:2.39 05:32:18 INFO - PROCESS | 17021 | Values: 171.0 168.0 167.0 166.0 170.0 170.0 172.0 173.0 172.0 170.0 05:32:18 INFO - PROCESS | 17021 | 05:32:18 INFO - PROCESS | 17021 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:67.00 stddev:0.97 (1.4%) stddev-sans-first:1.00 05:32:18 INFO - PROCESS | 17021 | Values: 67.0 67.0 66.0 65.0 67.0 66.0 67.0 66.0 68.0 65.0 05:32:18 INFO - PROCESS | 17021 | -------- Summary: end -------- 05:32:18 INFO - PROCESS | 17021 | 05:32:19 INFO - TEST-INFO | 17021: exit 0 05:32:19 INFO - TEST-OK | kraken | took 63791ms 05:32:19 INFO - SUITE-END | took 1182s 05:32:19 INFO - Completed test suite (00:19:43) 05:32:19 INFO - javascript benchmark 05:32:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2698.514267431862, 2710.2953232159643, 2710.8780104895277, 2737.4798788230223, 2764.060219525361, 4604.700694454858, 4668.929966050512, 4687.718736875786, 4764.880877978052, 4778.139934811733, 4686.062787442516, 4725.952740472594, 4739.976300118503, 4742.217534106877, 4746.572808447239, 4283.528811830696, 4303.591158839905, 4395.208862404766, 4412.448443944507, 4532.9320060199125, 4453.9777301113445, 4471.686981911267, 4479.216137175998, 4506.819727210924, 4533.184026875161, 4243.0, 4290.056187638715, 4293.957060429419, 4321.65426765858, 4370.8251669933325, 4314.395984562164, 4325.9134817303475, 4337.089211265638, 4371.650267978554, 4378.824847006116, 4348.4999225089205, 4358.237308471036, 4369.169857727022, 4396.296592545209, 4403.669724770623, 4473.463184417858, 4626.352310676508, 4694.624430045588, 4701.576858082789, 4707.529247075299, 5127.743612819344, 5144.9742751286, 5155.304033955405, 5158.74206289684, 5159.74201289934, 5169.922451163236, 5176.094183517869, 5182.0931337016245, 5182.170852663556, 5182.404023537304, 4668.906621867543, 4719.905601887977, 4753.833615823499, 4768.165571025057, 4832.057748739033, 5247.816326428557, 5273.578113750891, 5276.81531146408, 5279.340082489689, 5284.233786101071, 4893.804247830047, 5023.0456213320085, 5067.214581739836, 5067.721275329893, 5078.568321692697, 5028.170351891897, 5059.519345662156, 5060.367454068241, 5062.4684408137355, 5074.4671809460215, 5036.445990940993, 5039.370078740158, 5041.218611115283, 5073.9746301269, 5093.592512598983, 4773.71357718538, 4940.258961155855, 5047.596192304607, 5054.848354549369, 5061.493850614983, 4236.4704411948505, 4236.6187043166265, 4242.066745316026, 4260.637845783143, 4282.122164956177, 3729.9627003730157, 3759.9060023499633, 3765.755225910307, 3805.9429108563395, 3812.1041555234497, 4215.620594146541, 4229.661627069827, 4240.279152544075, 4424.867253982386, 4431.601155895984, 5083.822066227664, 5148.613853960968, 5158.432572417031, 5166.405863325691, 5168.689878607295, 4420.359047938031, 4442.933355999663, 4447.155040542351, 4450.710703804242, 4500.729956202638, 4407.096545208225, 4480.036792089716, 4604.58558729716, 4611.930821037688, 4650.86047418578, 4745.6440766942615, 4768.642351823558, 4796.712197268175, 4813.4945830687275, 4825.372701548777, 5074.898502029865, 5086.54221120101, 5088.313077734459, 5088.847334579968, 5146.25379320004, 4691.1555919934735, 4725.692829966041, 4757.191277482905, 4776.617870570277, 4820.855374338776, 4968.180250258667, 5003.0, 5016.648834581691, 5017.096922553829, 5019.297298378157, 5080.26336181259, 5081.822136225214, 5081.923771143362, 5082.720450375265, 5137.717425541481, 4831.323614694016, 4940.75296235194, 4953.504649535018, 4955.50444955516, 4994.9750251248515, 4860.3195552623365, 4927.852164435073, 4939.802407903788, 4949.381327334083, 4959.752012399438, 4869.537393947569, 4883.511648835088, 4930.630202734737, 4932.4327702314695, 4934.777934993006, 4825.879353016203, 4870.464248932685, 5018.598512118949, 5031.723255220998, 5036.370453693288, 4817.638677099301, 4827.903441931212, 4862.440819305825, 4865.367502224688, 4905.607551395951], "value": 4665.478781778473, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.3875639905107, 599.5653151465189, 599.5743022454058, 601.7202001069503, 616.0728104203175, 27374.452510949795, 27748.583771243422, 39699.80150099253, 40537.797311013404, 40632.796836015776, 37209.62790372095, 41127.0, 41155.58844411555, 41176.38235426471, 41274.58725412745, 7652.617369131535, 7823.530588164728, 7825.25660062296, 7825.726099586515, 7830.80422989427, 7566.470347075707, 7730.420218483609, 7731.188225236354, 7733.922660773376, 7736.458447908649, 7718.729844455417, 7751.8449631007625, 7751.961240193791, 7775.261350171753, 7779.105402878685, 7711.4216433767415, 7734.071911370615, 7734.99445072137, 7741.264579864932, 7741.535507869546, 7646.885296720554, 7725.111612164616, 7725.729599464048, 7726.884096738553, 7731.690732370698, 37184.62815371866, 37186.814065929495, 37554.0, 37560.43659345112, 37634.81182594097, 2961.5853780470534, 3081.938361232785, 3104.2549788050933, 3159.8420078996187, 3221.8872339468007, 29578.26054348637, 29638.0, 29650.851745741347, 29846.0, 30156.396872062436, 3270.0680306112645, 3298.4887342461957, 3464.22055037617, 3528.1179705073732, 3537.540119784437, 244911.0, 246058.0, 246957.0, 247377.0, 247503.0, 28046.71953280482, 28628.284292892844, 56335.154972675446, 56931.43068569261, 57003.714981424826, 33851.661483385345, 34175.31649366999, 34208.315833683686, 34224.65775342215, 34226.0, 12426.130170887951, 12549.0, 12562.497500100077, 12565.0, 12591.496340146292, 10105.747356316004, 10113.949430252802, 10128.696139115838, 10129.797404051878, 10133.442660653587, 8026.117127116013, 8026.638801253957, 8051.959740201261, 8095.433319667684, 8125.06561745395, 3103.3017571046335, 3133.6396314424132, 3149.622045354572, 3163.9525407118913, 3165.683431656862, 883.7967267528504, 911.2072496927583, 911.5533388639519, 933.659214386744, 999.1357475783541, 26777.33056673599, 28058.43883122367, 28248.15255542337, 28356.43287134246, 28674.569881451796, 893.821235752852, 961.3895176562793, 979.4710856137748, 1080.065743132185, 1082.0802318029612, 15614.609634759221, 15955.601109972344, 16295.266712997944, 16816.831831681528, 16967.660646786993, 395663.0, 397524.0, 399067.0, 401101.0, 402026.0, 49463.505364946606, 49744.25383619249, 49783.0, 49918.25122623164, 50035.49964500381, 1074.9462526873624, 1184.8010371995647, 1230.6923269182705, 1244.458660482693, 1251.117961836921, 27967.160985170478, 29029.7097029027, 29425.0, 29528.261793455335, 29937.251568710086, 42334.0, 42679.0, 42962.78518607387, 43022.569774303105, 43177.56822431861, 295424.0, 299870.0, 299958.0, 302232.0, 383637.0, 25042.62436063424, 25707.0, 25739.0, 26613.866930665223, 26835.865820670773, 41903.0, 42887.0, 43828.34257486076, 43998.0, 48395.5160448391, 35370.29259414746, 37067.25865482621, 37158.44262336121, 37720.0, 38086.619133809414, 35642.48709835207, 36872.26255474822, 36998.0, 37092.25815483729, 37538.24923501569, 36010.63989360178, 36217.81891090528, 36505.81747091247, 36677.63322366849, 37152.44271335878, 32333.35333293368, 33249.546501691795, 33415.66584334125, 33451.156651684876, 33873.0, 25481.745182547937, 25623.74376256288, 25796.613050803877, 25846.22461326163, 25865.652171755934], "value": 16494.86600506044, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.87083714444225, 355.50229678450177, 372.65529385318575, 373.5554689918996, 375.66190428614226, 15613.453529126482, 16568.917155414205, 16642.0, 16950.576235594086, 17109.486715398525, 15837.762433563506, 16559.172041397913, 16596.751048734248, 16689.582760430963, 16704.331826726946, 4841.709497430156, 5042.218456139304, 5085.66943148696, 5087.414947281073, 5088.669236499616, 3686.318031164243, 3877.7091718121114, 3884.4950156479617, 3889.2610404023285, 5013.298138260647, 3752.7935963521995, 5624.409437009116, 5684.5452363811, 5765.7981970631035, 5772.393898640646, 5674.148877668342, 5732.2261494698305, 5768.826935191951, 5776.306843178803, 5812.331581868097, 3319.9170020749675, 5152.149895267276, 5154.639175257734, 5156.819511317086, 5167.457416971201, 18527.72208416875, 19376.128074236552, 19405.708914366296, 19439.708404373945, 20197.798022019884, 1907.8664493485462, 1971.3297478857114, 2021.413790000898, 2050.0979568989596, 2059.742532183477, 12341.321227332493, 12706.936465317614, 12884.742305153844, 13335.199888006751, 13354.465821367134, 1677.2117104960648, 1712.9314827406888, 1739.5738044179132, 1793.6323053773945, 1810.3482746211353, 63354.36645633531, 64756.35243647597, 65452.0, 66052.669736651, 67352.32647673509, 9196.540172991323, 9258.398204116711, 9384.5307734613, 9554.952225238829, 9671.758206044764, 13068.477260909458, 13157.342132893316, 13162.14446061003, 13189.604311870658, 13212.405441755143, 7101.89347159793, 7143.642817859086, 7196.676149573282, 7210.927890721131, 7290.198078211392, 6887.414569761526, 6921.096698407878, 6945.791626251221, 7072.752453664097, 7079.0, 5902.0818234074095, 5959.821205363846, 5976.372480889444, 6037.154798328237, 6037.818865434044, 1524.885633577486, 1678.0770576183052, 1691.4249155287016, 1712.905790181527, 1805.8735888487943, 838.174398217755, 902.8239493298744, 953.0659953245857, 974.5760594141572, 1011.3931641015479, 16039.759403608956, 16510.0, 16801.579960501087, 17078.658426831393, 17236.569085772957, 912.6258234123977, 927.7958849053198, 942.2085448223526, 951.9904800951902, 1001.234055947201, 9626.759331016781, 9885.25860560461, 9950.950245248727, 9952.303338766216, 9981.650642227487, 378398.0, 383519.0, 388211.0, 389319.0, 396086.0, 65378.67310663416, 66651.0, 68485.65757171182, 69332.653336733, 69452.652736736, 914.9203939351629, 937.9343445958717, 942.34036174678, 952.4333021852126, 961.2982522758425, 14899.702005960036, 14904.18027008525, 15083.854718452352, 15094.924525377302, 15119.244037798286, 27988.30029249285, 31547.684523155393, 31622.841885791346, 32949.50575741318, 32972.34055318928, 44379.77810110929, 45158.77420612876, 45276.0944781096, 45296.547034529234, 45303.0, 7476.663550140365, 7489.0, 7499.212582678741, 7506.0, 7623.199564045695, 6102.847428814315, 9571.904280957102, 10928.94535527349, 11944.940275298568, 12033.157678962389, 4760.666753327372, 5519.951209270226, 9239.260859131387, 10486.737831554272, 10668.359898406121, 6779.322067793379, 10268.229882758673, 10528.473576321307, 10622.20333474977, 10680.465976701289, 7544.698212071675, 10406.0, 10520.105791007543, 10540.631077912236, 10617.0, 11154.16343774204, 11284.605038823602, 11397.544098236309, 11587.0, 11673.12451566153, 10495.317804342692, 10554.208434367607, 10714.303570267908, 11192.272502287326, 11241.325520468798], "value": 8145.501645722973, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1251.1117106854133, 1421.417218940234, 1457.832349279833, 1573.5043461309688, 1743.145858529321, 6549.639769812658, 7416.629168541572, 7609.162992070867, 7609.54342739436, 7758.534487930728, 7552.509086909347, 7705.422093342993, 7719.961400193005, 7727.1500134985245, 7728.613569321526, 1904.0860387014172, 2094.9266775662854, 2162.610730068583, 2180.5529866377356, 2194.47332640166, 2230.6765518999737, 2251.2233279518623, 2256.537409830989, 2256.7066281383395, 2258.6499092640665, 2161.3083813179787, 2187.1798075721604, 2188.1684959715285, 2188.4091295350245, 2197.8681279123302, 1845.5478407790176, 2075.7716651168357, 2110.0715685098507, 2155.708979287792, 2160.1899287767087, 2177.2379667116543, 2217.789310015546, 2220.578090162864, 2222.5665995130958, 2225.5326381459913, 7492.737754178632, 7551.093868735732, 7562.054743157106, 7562.773116806505, 7570.0, 4462.174497717932, 4597.563231493003, 4599.0, 4603.10239503297, 4604.079184163181, 2744.108164846433, 2824.477471667748, 2926.800011995093, 2927.7511411530045, 2932.8533573321247, 890.7644152056993, 899.9865002024975, 906.7642412972608, 914.8764916736222, 926.939748916325, 10183.59265629374, 10387.636432724817, 10405.375677459377, 10414.114800241912, 10433.530491127918, 4125.133721918371, 4196.181744559843, 4251.723637963522, 4339.674524410681, 4343.066240758252, 9020.05289444599, 9050.637974480947, 9057.275417966546, 9068.591913363782, 9074.047225041408, 4666.65000124992, 4671.089137618132, 4671.135839869635, 4672.789724462407, 4674.462436819741, 3711.536057992751, 3983.960160398417, 4131.338985762263, 4252.298370768788, 4297.39836422901, 3611.476335931275, 3643.508126402902, 3694.722895782827, 3719.2189640175325, 3764.0, 1181.2144923625865, 1215.1493954232074, 1216.0514798457218, 1227.545808051009, 1231.4520038582923, 848.2620120495209, 860.049645142109, 885.8582626779685, 917.6512925088424, 922.3313098003894, 5209.140491818807, 5310.0, 5357.7589008494715, 5579.2746942897165, 5584.91622625661, 397.7752569798055, 400.2235662814131, 402.0712154922139, 403.76985118482185, 405.4141765149331, 3753.774773513543, 3818.5608655004476, 3887.2614203301846, 3935.3506671399473, 3997.2804895118575, 9042.276617870555, 9299.116583924517, 9400.670976515788, 9423.34036617444, 9426.057394260657, 8647.567621618893, 9167.587458564381, 9242.72271831846, 9248.075192480832, 9258.444493330422, 6965.651717414109, 7283.8543229136185, 7317.963410182915, 7324.816879577947, 7336.706531738778, 5477.945220547903, 5647.915281270866, 5782.855428614318, 5849.181114644039, 5857.765689372377, 8607.698730544651, 8617.48295102296, 8819.955900220459, 8823.69117080899, 8853.822923541622, 8310.418270721233, 8655.0, 8667.4366166199, 8914.910850891667, 8916.33127515426, 6067.726952287069, 6389.137466441971, 6562.80311590653, 6699.76550820719, 6891.620960847202, 7328.377087947584, 7352.816179595553, 7365.742199023222, 7378.631068446449, 7413.5551866886, 6378.234611846423, 6480.351964803671, 6526.151600291932, 6548.3124271952665, 6760.08738820253, 6198.101275315144, 6285.96857015712, 6292.182016337847, 6661.300563440769, 6700.93299067003, 5898.144769008555, 6095.268567771718, 6105.297890742621, 6116.113163591343, 6122.112293717297, 4457.242268814374, 4724.929126063181, 4750.976245118891, 4782.808687652594, 4785.306130610972, 4652.13935421948, 4724.527547245248, 4733.83431579893, 4768.284757286435, 4790.904181916412], "value": 4039.4898598638597, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.1929877045502, 290.96653884803254, 292.9882804687813, 294.2349890285258, 296.64699008180276, 4677.766111694415, 4697.2954056891485, 4708.717476951381, 4725.14947309485, 4755.144074066667, 4633.953660463394, 4636.605888499473, 4642.605378542819, 4643.280291554806, 4666.78999445025, 3486.6164721880573, 3601.6398360164035, 3607.4047782115917, 3610.007248006806, 3614.222942067455, 3564.536610240665, 3624.6737793598572, 3694.1688120173017, 3695.224002959382, 3706.7405281630295, 3636.2000359920776, 3660.432632941898, 3665.6700896919406, 3668.156324045471, 3679.8592436344684, 3530.894073177809, 3656.0988286091083, 3674.926501469956, 3677.687396571295, 3686.410174372101, 3226.56441380413, 3239.7408207343356, 3240.659730728263, 3249.545063691085, 3250.528673342376, 4468.011734778025, 4479.7088189267915, 4481.305397663367, 4499.707519011254, 4503.954960450419, 4172.70791044627, 4174.582541745832, 4174.979125104385, 4176.227397931392, 4179.561146079679, 4609.1933911565675, 4839.588634966032, 4843.878903027417, 4870.220764677634, 4874.780634871404, 3388.220709236865, 3400.4389275769468, 3408.9659103409144, 3409.0965894037854, 3412.812295323756, 5048.3941926969, 5100.566451851597, 5112.974435127838, 5115.565176959963, 5117.667351622133, 3432.845521951518, 3527.95925202066, 3532.346515894568, 3536.8585256589963, 3537.8054207018863, 3504.0, 3549.6982756465472, 3553.34263161316, 3554.573451185874, 3566.4472006838982, 4066.959330406717, 4084.509858816961, 4091.5270502619032, 4109.383592461155, 4115.156392939441, 4865.416150062015, 4880.292357608198, 4895.559399653977, 4902.779374928136, 4905.435874874435, 1195.1156144453041, 1212.6119641714567, 1219.7743417467798, 1226.6013545597539, 1235.8640549539543, 771.3366504805863, 785.9174786647434, 787.5471603827822, 795.1213908630995, 798.2974982015905, 4173.5409104998425, 4265.573442655709, 4300.247456695129, 4303.568483806639, 4304.16068866568, 5055.772490237948, 5066.746662666926, 5067.4932506749765, 5073.720945348041, 5074.543291103819, 4389.648828093745, 4393.758343291086, 4398.824047038147, 4415.161119387306, 4430.379746835446, 2513.554706044032, 2656.0, 2691.7039125696156, 2716.850573218492, 2717.91846244613, 4810.855674329776, 4817.13291607514, 4830.661853670209, 4834.347363106006, 4848.200046992278, 5202.765875535534, 5206.219067139884, 5217.6086793489885, 5218.269442278084, 5220.243064755665, 4605.424321959755, 4806.182948898696, 4820.39745031871, 4842.854714358505, 4847.587955023862, 5038.244263360525, 5051.898962020812, 5056.949430505795, 5069.0, 5095.337606111182, 4972.5027497249985, 4986.501349864984, 4998.225275082368, 5010.899782004412, 5014.84955451337, 4546.499655113871, 4815.820124069625, 4831.347768051268, 4832.9459979507865, 4836.443808962014, 3548.2903419315726, 3552.0340515669704, 3560.8219589019927, 3564.7861128331347, 3566.518519999767, 5025.698458092526, 5043.899122017466, 5049.0, 5069.923951140662, 5089.160288552347, 4557.384753058427, 4904.362432883845, 4928.088303663833, 4929.827456039022, 4942.135126352802, 4851.296561998561, 4890.462049174659, 4913.263010548446, 4922.138625740553, 4944.208926571731, 4838.274258861199, 4843.733594652328, 4843.782029808596, 4843.903121937612, 4853.131544355378, 4693.577578017995, 4755.334253204624, 4841.990573911788, 4893.339399181065, 4953.529414705597, 4830.734309613005, 4848.903021939471, 4853.417589889236, 4869.634777391639, 4878.024395120919], "value": 3683.9988269631676, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.7527203114927, 718.6227230703884, 730.357285588682, 763.0461922596754, 774.3921021997733, 12255.938720306398, 12843.0, 13371.465141394332, 13546.864531354684, 13614.727705445885, 13003.219806811574, 13135.540256091039, 13146.802797958015, 13148.93425532871, 13165.144265622728, 780.3562061299436, 789.7591234673422, 796.8924195233627, 797.6251161953901, 798.4450806689354, 634.6794868591378, 759.7986533568609, 772.9922700772977, 793.131520984524, 794.2256300107377, 827.2554700769296, 829.983400331993, 830.6967956695823, 831.418007394823, 835.4026870787386, 656.7996760987896, 828.7555171224473, 828.9046759622661, 829.3323874281201, 829.672279449617, 588.8763359694469, 589.4282545930483, 592.3424998251937, 606.0152252589542, 609.4849851875202, 12868.356582170854, 12885.0, 12906.225626462443, 12927.224366538037, 12942.158759680591, 12258.754824903452, 12358.876411235862, 12646.0, 12663.556775512905, 12825.87174128256, 11693.883061169365, 11700.595423701194, 11726.35505047222, 11731.648050558497, 11855.585054523137, 4157.376393540962, 4196.181744559812, 4240.215560121356, 4263.062126332233, 4296.484421869364, 57731.71134144344, 57779.422205777824, 57861.421385786445, 57937.710311448594, 57955.0, 9709.6601618943, 9754.268429867789, 9898.505074746234, 10191.54138063789, 10566.41884696349, 18926.148323325484, 18954.52613684669, 18958.90520547416, 19019.0, 19031.61936761257, 7005.929940700527, 7036.612986285803, 7048.400885924754, 7106.147262328554, 7170.282971702788, 3713.3687273163628, 3760.9811950940616, 3786.772793632391, 3792.810359482015, 3822.8853134406013, 2873.2242294580765, 2975.9851200743856, 2981.7763667724575, 2984.0600210933485, 2990.1627544287635, 522.6341560907304, 525.2279149650009, 534.8047962493739, 539.4928766959046, 539.6761942834268, 479.62104992509177, 486.55237181792836, 518.0778214777702, 518.4323166133079, 579.826052184343, 7556.58438785872, 7916.722914697958, 7938.5236885787035, 8138.552379619177, 8168.060673022678, 516.9767360468788, 547.6796074296501, 551.9503244707995, 561.4441702714283, 567.2823877794593, 3682.2451397463456, 3731.8320675569666, 3781.1681430085337, 3861.613838616172, 3862.787546684903, 61240.693796531625, 88436.55781721178, 89991.55004224936, 90942.54528727314, 91107.0, 74074.25925740782, 75133.62433187799, 76020.61989690016, 76499.23500765032, 77883.22116778872, 67401.0, 68609.3139068613, 68783.31216687869, 68898.65550672215, 70524.0, 7390.96304518474, 7411.5553066816165, 7428.33145016951, 7453.867197214623, 7456.32893039629, 41608.0, 42165.57834421616, 42519.7874010628, 42632.5736742641, 42835.0, 54480.45519544754, 58949.0, 59011.70494147674, 59022.0, 60482.697586511786, 9042.954785226031, 9264.0, 9287.442753434816, 9378.531073446164, 9586.233101352014, 10315.535800889129, 10680.305780124267, 11630.476628551905, 12762.361881905681, 12975.286359250333, 9047.728568142966, 10083.647072352433, 10462.21533384984, 10554.419506927192, 11268.943655281671, 11163.386013769321, 11467.713307167387, 11735.47190376418, 11846.348450835287, 12150.939245303716, 11979.101567382308, 12298.692532686397, 12309.322987235788, 12703.618891433272, 12846.550370736979, 9826.263030272616, 9956.253281003808, 9959.850602240827, 9963.750906227113, 10422.009909058628, 9304.767380815263, 9348.766280843034, 9380.390274632127, 9386.765330866783, 9386.906130938876], "value": 6421.07189533272, "unit": "score"}], "name": "dromaeo_css", "value": 6255.244080849484, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 109.0, 113.0, 115.0, 112.0, 115.0, 112.0, 113.0, 114.0, 114.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 134.0, 132.0, 183.0, 136.0, 156.0, 152.0, 129.0, 203.0, 142.0], "value": 151.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 162.0, 161.0, 163.0, 162.0, 161.0, 161.0, 163.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 113.0, 76.0, 78.0, 74.0, 75.0, 98.0, 75.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 118.0, 87.0, 86.0, 86.0, 115.0, 86.0, 87.0, 120.0], "value": 95.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 65.0, 68.0, 65.0, 64.0, 64.0, 65.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 65.0, 66.0, 66.0, 66.0, 71.0, 66.0, 66.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 84.0, 83.0, 83.0, 88.0, 84.0, 84.0, 84.0, 113.0, 83.0], "value": 87.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 131.0, 131.0, 131.0, 131.0, 132.0, 130.0, 134.0, 134.0, 131.0], "value": 131.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 168.0, 167.0, 166.0, 170.0, 170.0, 172.0, 173.0, 172.0, 170.0], "value": 169.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 65.0, 67.0, 66.0, 67.0, 66.0, 68.0, 65.0], "value": 66.4, "unit": "score"}], "name": "kraken", "value": 1548.3000000000002, "alertThreshold": 2.0}]} 05:32:19 INFO - Return code: 0 05:32:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:32:19 ERROR - # TBPL SUCCESS # 05:32:19 INFO - Running post-action listener: _resource_record_post_action 05:32:19 INFO - ##### 05:32:19 INFO - ##### Finished run-tests step (success) 05:32:19 INFO - ##### 05:32:19 INFO - Running post-run listener: _resource_record_post_run 05:32:19 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 40960; Write bytes: 525160448; Read time: 68; Write time: 400208 05:32:19 INFO - TinderboxPrint: CPU usage
13.1% 05:32:19 INFO - TinderboxPrint: I/O read bytes / time
40,960 / 68 05:32:19 INFO - TinderboxPrint: I/O write bytes / time
525,160,448 / 400,208 05:32:19 INFO - TinderboxPrint: CPU idle
8,322.9 (86.9%) 05:32:19 INFO - TinderboxPrint: CPU user
1,208.8 (12.6%) 05:32:19 INFO - TinderboxPrint: Swap in / out
0 / 0 05:32:19 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 130895872; Read time: 0; Write time: 129076 05:32:19 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 40960; Write bytes: 280580096; Read time: 68; Write time: 208616 05:32:20 INFO - Running post-run listener: _upload_blobber_files 05:32:20 INFO - Blob upload gear active. 05:32:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:32:20 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:32:20 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'] 05:32:20 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 05:32:20 INFO - (blobuploader) - INFO - Open directory for files ... 05:32:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:32:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:32:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:32:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:32:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:32:21 INFO - (blobuploader) - INFO - Done attempting. 05:32:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:32:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:32:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:32:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:32:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:32:25 INFO - (blobuploader) - INFO - Done attempting. 05:32:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:32:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:32:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:32:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:32:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:32:26 INFO - (blobuploader) - INFO - Done attempting. 05:32:26 INFO - (blobuploader) - INFO - Iteration through files over. 05:32:26 INFO - Return code: 0 05:32:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:32:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:32:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ff8f65d0dcbae8e1cda16e22166443c7eaee692fc08b31adf4650ccbc08ad710b4c0c1d02d478fae2799668cacafce16f810574c964c9c51095fe6928bd12491", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/af3507ced6a81fba6e8cf3b553984b1f991af40804d48766ecf0081b172f032be94b49e7317838a51fd2c66b4f685d089a7dd60b90f2c6978a013413187af29a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3764c0451d88926f374631d1e5b7c66e417e626d61c825c4d35b21ab6b360fa722477c469560e131dcb50bac42a79d597857c884156bd38ac77a227ee3b068a4"} 05:32:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:32:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:32:26 INFO - Contents: 05:32:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ff8f65d0dcbae8e1cda16e22166443c7eaee692fc08b31adf4650ccbc08ad710b4c0c1d02d478fae2799668cacafce16f810574c964c9c51095fe6928bd12491", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/af3507ced6a81fba6e8cf3b553984b1f991af40804d48766ecf0081b172f032be94b49e7317838a51fd2c66b4f685d089a7dd60b90f2c6978a013413187af29a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3764c0451d88926f374631d1e5b7c66e417e626d61c825c4d35b21ab6b360fa722477c469560e131dcb50bac42a79d597857c884156bd38ac77a227ee3b068a4"} 05:32:26 INFO - Running post-run listener: copy_logs_to_upload_dir 05:32:26 INFO - Copying logs to upload dir... 05:32:26 INFO - mkdir: /builds/slave/test/build/upload/logs 05:32:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.187699 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-06 05:32:26.149566) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 05:32:26.153212) ========= 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=4300f881736b422476174874000001bc-1465215057.752461-163903584 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/ff8f65d0dcbae8e1cda16e22166443c7eaee692fc08b31adf4650ccbc08ad710b4c0c1d02d478fae2799668cacafce16f810574c964c9c51095fe6928bd12491", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/af3507ced6a81fba6e8cf3b553984b1f991af40804d48766ecf0081b172f032be94b49e7317838a51fd2c66b4f685d089a7dd60b90f2c6978a013413187af29a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3764c0451d88926f374631d1e5b7c66e417e626d61c825c4d35b21ab6b360fa722477c469560e131dcb50bac42a79d597857c884156bd38ac77a227ee3b068a4"} build_url:https://queue.taskcluster.net/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011396 build_url: 'https://queue.taskcluster.net/v1/task/G5kplpIBRu2XJoJii0BdhA/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/ff8f65d0dcbae8e1cda16e22166443c7eaee692fc08b31adf4650ccbc08ad710b4c0c1d02d478fae2799668cacafce16f810574c964c9c51095fe6928bd12491", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/af3507ced6a81fba6e8cf3b553984b1f991af40804d48766ecf0081b172f032be94b49e7317838a51fd2c66b4f685d089a7dd60b90f2c6978a013413187af29a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3764c0451d88926f374631d1e5b7c66e417e626d61c825c4d35b21ab6b360fa722477c469560e131dcb50bac42a79d597857c884156bd38ac77a227ee3b068a4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 05:32:26.183768) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:32:26.184203) ========= 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=4300f881736b422476174874000001bc-1465215057.752461-163903584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004534 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:32:26.266567) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 05:32:26.267363) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 05:32:26.268110) ========= ========= Total master_lag: 0.20 =========