builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-013 starttime: 1464969857.68 results: success (0) buildid: 20160603083311 builduid: 8077051f393c4a05963bea2a0cdf66ad revision: 0e6dfa8fc2f4d513dba9f434fc3a92c32e6b9ad6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 09:04:17.682084) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 09:04:17.682671) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 09:04:17.683021) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 09:04:17.698405) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 09:04:17.698756) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1464969800.823209-552753711 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-03 09:04:17-- 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% 26.6M=0s 2016-06-03 09:04:17 (26.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101252 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 09:04:17.814690) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 09:04:17.815099) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1464969800.823209-552753711 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014688 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 09:04:17.866786) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-03 09:04:17.867265) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0e6dfa8fc2f4d513dba9f434fc3a92c32e6b9ad6 --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 0e6dfa8fc2f4d513dba9f434fc3a92c32e6b9ad6 --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=9c3a94c35cc88655b05d2c08000001b2-1464969800.823209-552753711 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-03 09:04:17,976 truncating revision to first 12 chars 2016-06-03 09:04:17,976 Setting DEBUG logging. 2016-06-03 09:04:17,976 attempt 1/10 2016-06-03 09:04:17,976 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0e6dfa8fc2f4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-03 09:04:19,339 unpacking tar archive at: fx-team-0e6dfa8fc2f4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.716535 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-03 09:04:19.601468) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 09:04:19.602258) ========= script_repo_revision: 0e6dfa8fc2f4d513dba9f434fc3a92c32e6b9ad6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 09:04:19.603276) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 09:04:19.603940) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 09:04:19.617172) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-03 09:04:19.617836) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=9c3a94c35cc88655b05d2c08000001b2-1464969800.823209-552753711 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:04:19 INFO - MultiFileLogger online at 20160603 09:04:19 in /builds/slave/test 09:04:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 09:04:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:04:19 INFO - {'append_to_log': False, 09:04:19 INFO - 'base_work_dir': '/builds/slave/test', 09:04:19 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:04:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:04:19 INFO - 'branch': 'Fx-Team-Non-PGO', 09:04:19 INFO - 'buildbot_json_path': 'buildprops.json', 09:04:19 INFO - 'config_files': ('talos/linux_config.py',), 09:04:19 INFO - 'default_actions': ('clobber', 09:04:19 INFO - 'read-buildbot-config', 09:04:19 INFO - 'download-and-extract', 09:04:19 INFO - 'populate-webroot', 09:04:19 INFO - 'create-virtualenv', 09:04:19 INFO - 'install', 09:04:19 INFO - 'run-tests'), 09:04:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:04:19 INFO - 'download_minidump_stackwalk': True, 09:04:19 INFO - 'download_symbols': 'ondemand', 09:04:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:04:19 INFO - 'tooltool.py': '/tools/tooltool.py', 09:04:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:04:19 INFO - '/tools/misc-python/virtualenv.py')}, 09:04:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:04:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:04:19 INFO - 'installer_path': 'installer.exe', 09:04:19 INFO - 'log_level': 'info', 09:04:19 INFO - 'log_name': 'talos', 09:04:19 INFO - 'log_to_console': True, 09:04:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:04:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:04:19 INFO - 'opt_config_files': (), 09:04:19 INFO - 'pip_index': False, 09:04:19 INFO - 'sps_profile': False, 09:04:19 INFO - 'sps_profile_interval': 0, 09:04:19 INFO - 'suite': 'dromaeojs-e10s', 09:04:19 INFO - 'system_bits': '32', 09:04:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:04:19 INFO - 'title': 'talos-linux64-ix-013', 09:04:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:04:19 INFO - 'use_talos_json': True, 09:04:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:04:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:04:19 INFO - 'work_dir': 'build'} 09:04:19 INFO - ##### 09:04:19 INFO - ##### Running clobber step. 09:04:19 INFO - ##### 09:04:19 INFO - Running pre-action listener: _resource_record_pre_action 09:04:19 INFO - Running main action method: clobber 09:04:19 INFO - rmtree: /builds/slave/test/build 09:04:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:04:20 INFO - Running post-action listener: _resource_record_post_action 09:04:20 INFO - ##### 09:04:20 INFO - ##### Finished clobber step (success) 09:04:20 INFO - ##### 09:04:20 INFO - ##### 09:04:20 INFO - ##### Running read-buildbot-config step. 09:04:20 INFO - ##### 09:04:20 INFO - Running pre-action listener: _resource_record_pre_action 09:04:20 INFO - Running main action method: read_buildbot_config 09:04:20 INFO - Using buildbot properties: 09:04:20 INFO - { 09:04:20 INFO - "project": "", 09:04:20 INFO - "product": "firefox", 09:04:20 INFO - "script_repo_revision": "production", 09:04:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 09:04:20 INFO - "repository": "", 09:04:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 09:04:20 INFO - "buildid": "20160603083311", 09:04:20 INFO - "pgo_build": "False", 09:04:20 INFO - "basedir": "/builds/slave/test", 09:04:20 INFO - "buildnumber": 1340, 09:04:20 INFO - "slavename": "talos-linux64-ix-013", 09:04:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:04:20 INFO - "platform": "ubuntu64_hw", 09:04:20 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:04:20 INFO - "branch": "fx-team", 09:04:20 INFO - "repo_path": "integration/fx-team", 09:04:20 INFO - "revision": "0e6dfa8fc2f4d513dba9f434fc3a92c32e6b9ad6", 09:04:20 INFO - "stage_platform": "linux64", 09:04:20 INFO - "builduid": "8077051f393c4a05963bea2a0cdf66ad", 09:04:20 INFO - "slavebuilddir": "test" 09:04:20 INFO - } 09:04:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/HM0H6EJBShuUoJjEQqCYEA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 09:04:20 INFO - Running post-action listener: _resource_record_post_action 09:04:20 INFO - ##### 09:04:20 INFO - ##### Finished read-buildbot-config step (success) 09:04:20 INFO - ##### 09:04:20 INFO - ##### 09:04:20 INFO - ##### Running download-and-extract step. 09:04:20 INFO - ##### 09:04:20 INFO - Running pre-action listener: _resource_record_pre_action 09:04:20 INFO - Running main action method: download_and_extract 09:04:20 INFO - mkdir: /builds/slave/test/build/tests 09:04:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:20 INFO - https://queue.taskcluster.net/v1/task/HM0H6EJBShuUoJjEQqCYEA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:04:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HM0H6EJBShuUoJjEQqCYEA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:04:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HM0H6EJBShuUoJjEQqCYEA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:04:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HM0H6EJBShuUoJjEQqCYEA/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 09:04:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HM0H6EJBShuUoJjEQqCYEA/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 09:04:21 INFO - Downloaded 1361 bytes. 09:04:21 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:04:21 INFO - Using the following test package requirements: 09:04:21 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 09:04:21 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:04:21 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:04:21 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:21 INFO - u'jsshell-linux-x86_64.zip'], 09:04:21 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:04:21 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 09:04:21 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:04:21 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:04:21 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:04:21 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:04:21 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:04:21 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')]} 09:04:21 INFO - https://queue.taskcluster.net/v1/task/HM0H6EJBShuUoJjEQqCYEA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:04:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HM0H6EJBShuUoJjEQqCYEA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:04:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HM0H6EJBShuUoJjEQqCYEA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:04:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HM0H6EJBShuUoJjEQqCYEA/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 09:04:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HM0H6EJBShuUoJjEQqCYEA/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 09:04:22 INFO - Downloaded 22868152 bytes. 09:04:22 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'] 09:04:22 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 09:04:23 INFO - Return code: 0 09:04:23 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:04:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:23 INFO - https://queue.taskcluster.net/v1/task/HM0H6EJBShuUoJjEQqCYEA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:04:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HM0H6EJBShuUoJjEQqCYEA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:04:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HM0H6EJBShuUoJjEQqCYEA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:04:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HM0H6EJBShuUoJjEQqCYEA/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 09:04:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HM0H6EJBShuUoJjEQqCYEA/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 09:04:25 INFO - Downloaded 22868152 bytes. 09:04:25 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'] 09:04:25 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 09:04:26 INFO - Return code: 0 09:04:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:26 INFO - https://queue.taskcluster.net/v1/task/HM0H6EJBShuUoJjEQqCYEA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:04:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HM0H6EJBShuUoJjEQqCYEA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 09:04:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HM0H6EJBShuUoJjEQqCYEA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 09:04:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HM0H6EJBShuUoJjEQqCYEA/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 09:04:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HM0H6EJBShuUoJjEQqCYEA/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 09:04:27 INFO - Downloaded 10833369 bytes. 09:04:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:04:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:04:28 INFO - Return code: 0 09:04:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:28 INFO - https://queue.taskcluster.net/v1/task/HM0H6EJBShuUoJjEQqCYEA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:04:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HM0H6EJBShuUoJjEQqCYEA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:04:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HM0H6EJBShuUoJjEQqCYEA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:04:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HM0H6EJBShuUoJjEQqCYEA/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 09:04:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HM0H6EJBShuUoJjEQqCYEA/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 09:04:29 INFO - Downloaded 55169581 bytes. 09:04:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HM0H6EJBShuUoJjEQqCYEA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:04:29 INFO - mkdir: /builds/slave/test/properties 09:04:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:04:29 INFO - Writing to file /builds/slave/test/properties/build_url 09:04:29 INFO - Contents: 09:04:29 INFO - build_url:https://queue.taskcluster.net/v1/task/HM0H6EJBShuUoJjEQqCYEA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:04:30 INFO - Running post-action listener: _resource_record_post_action 09:04:30 INFO - Running post-action listener: set_extra_try_arguments 09:04:30 INFO - ##### 09:04:30 INFO - ##### Finished download-and-extract step (success) 09:04:30 INFO - ##### 09:04:30 INFO - ##### 09:04:30 INFO - ##### Running populate-webroot step. 09:04:30 INFO - ##### 09:04:30 INFO - Running pre-action listener: _resource_record_pre_action 09:04:30 INFO - Running main action method: populate_webroot 09:04:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:04:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:04:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:04:30 INFO - '--tppagecycles', 09:04:30 INFO - '7'], 09:04:30 INFO - 'tests': ['tsvgm']}}, 09:04:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:04:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:04:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:04:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:04:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:04:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:04:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:30 INFO - 'talos_options': ['--disable-e10s'], 09:04:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:04:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:04:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:30 INFO - 'talos_options': ['--disable-e10s'], 09:04:30 INFO - 'tests': ['damp', 'tps']}, 09:04:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:30 INFO - 'tests': ['damp', 'tps']}, 09:04:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:04:30 INFO - 'tests': ['dromaeo_dom']}, 09:04:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:04:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:04:30 INFO - 'tests': ['a11yr', 09:04:30 INFO - 'ts_paint', 09:04:30 INFO - 'tpaint', 09:04:30 INFO - 'sessionrestore', 09:04:30 INFO - 'sessionrestore_no_auto_restore', 09:04:30 INFO - 'tabpaint']}, 09:04:30 INFO - 'other-e10s': {'tests': ['a11yr', 09:04:30 INFO - 'ts_paint', 09:04:30 INFO - 'tpaint', 09:04:30 INFO - 'sessionrestore', 09:04:30 INFO - 'sessionrestore_no_auto_restore', 09:04:30 INFO - 'tabpaint']}, 09:04:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:04:30 INFO - 'ts_paint', 09:04:30 INFO - 'tpaint', 09:04:30 INFO - 'sessionrestore', 09:04:30 INFO - 'sessionrestore_no_auto_restore', 09:04:30 INFO - 'tabpaint']}, 09:04:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:04:30 INFO - 'ts_paint', 09:04:30 INFO - 'tpaint', 09:04:30 INFO - 'sessionrestore', 09:04:30 INFO - 'sessionrestore_no_auto_restore', 09:04:30 INFO - 'tabpaint']}, 09:04:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:04:30 INFO - 'tests': ['a11yr', 09:04:30 INFO - 'ts_paint', 09:04:30 INFO - 'tpaint', 09:04:30 INFO - 'sessionrestore', 09:04:30 INFO - 'sessionrestore_no_auto_restore', 09:04:30 INFO - 'tabpaint']}, 09:04:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:04:30 INFO - 'tests': ['a11yr', 09:04:30 INFO - 'ts_paint', 09:04:30 INFO - 'tpaint', 09:04:30 INFO - 'sessionrestore', 09:04:30 INFO - 'sessionrestore_no_auto_restore', 09:04:30 INFO - 'tabpaint']}, 09:04:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:04:30 INFO - 'tests': ['tsvgx', 09:04:30 INFO - 'tsvgr_opacity', 09:04:30 INFO - 'tart', 09:04:30 INFO - 'tscrollx', 09:04:30 INFO - 'cart']}, 09:04:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:04:30 INFO - 'tsvgr_opacity', 09:04:30 INFO - 'tart', 09:04:30 INFO - 'tscrollx', 09:04:30 INFO - 'cart']}, 09:04:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:30 INFO - 'talos_options': ['--disable-e10s'], 09:04:30 INFO - 'tests': ['tp5o']}, 09:04:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:30 INFO - 'tests': ['tp5o']}, 09:04:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:30 INFO - 'talos_options': ['--disable-e10s', 09:04:30 INFO - '--xperf_path', 09:04:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:04:30 INFO - 'tests': ['tp5n']}, 09:04:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:30 INFO - 'talos_options': ['--xperf_path', 09:04:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:04:30 INFO - 'tests': ['tp5n']}}, 09:04:30 INFO - 'talos.zip': {'path': '', 09:04:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:04:30 INFO - Running post-action listener: _resource_record_post_action 09:04:30 INFO - ##### 09:04:30 INFO - ##### Finished populate-webroot step (success) 09:04:30 INFO - ##### 09:04:30 INFO - ##### 09:04:30 INFO - ##### Running create-virtualenv step. 09:04:30 INFO - ##### 09:04:30 INFO - Running pre-action listener: _resource_record_pre_action 09:04:30 INFO - Running main action method: create_virtualenv 09:04:30 INFO - Creating virtualenv /builds/slave/test/build/venv 09:04:30 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 09:04:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:04:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:04:30 INFO - Using real prefix '/usr' 09:04:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:04:30 INFO - Installing distribute.............................................................................................................................................................................................done. 09:04:32 INFO - Installing pip.................done. 09:04:32 INFO - Return code: 0 09:04:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:04:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb09a8c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd74350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe031c0>, '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 0xe040c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe04550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1464969800.823209-552753711', '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 09:04:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:04:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:04:32 INFO - Using env: {'DISPLAY': ':0', 09:04:32 INFO - 'HOME': '/home/cltbld', 09:04:32 INFO - 'LANG': 'en_US.UTF-8', 09:04:32 INFO - 'LANGUAGE': 'en_US:en', 09:04:32 INFO - 'LOGNAME': 'cltbld', 09:04:32 INFO - 'MAIL': '/var/mail/cltbld', 09:04:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:32 INFO - 'MOZ_NO_REMOTE': '1', 09:04:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:32 INFO - 'NO_EM_RESTART': '1', 09:04:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:32 INFO - 'PWD': '/builds/slave/test', 09:04:32 INFO - 'SHELL': '/bin/bash', 09:04:32 INFO - 'SHLVL': '1', 09:04:32 INFO - 'TERM': 'linux', 09:04:32 INFO - 'TMOUT': '86400', 09:04:32 INFO - 'USER': 'cltbld', 09:04:32 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1464969800.823209-552753711', 09:04:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:32 INFO - '_': '/tools/buildbot/bin/python'} 09:04:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:33 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 09:04:33 INFO - Cleaning up... 09:04:33 INFO - Return code: 0 09:04:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:04:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:33 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 0x7fb09a8c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd74350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe031c0>, '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 0xe040c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe04550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1464969800.823209-552753711', '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 09:04:33 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 09:04:33 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 09:04:33 INFO - Using env: {'DISPLAY': ':0', 09:04:33 INFO - 'HOME': '/home/cltbld', 09:04:33 INFO - 'LANG': 'en_US.UTF-8', 09:04:33 INFO - 'LANGUAGE': 'en_US:en', 09:04:33 INFO - 'LOGNAME': 'cltbld', 09:04:33 INFO - 'MAIL': '/var/mail/cltbld', 09:04:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:33 INFO - 'MOZ_NO_REMOTE': '1', 09:04:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:33 INFO - 'NO_EM_RESTART': '1', 09:04:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:33 INFO - 'PWD': '/builds/slave/test', 09:04:33 INFO - 'SHELL': '/bin/bash', 09:04:33 INFO - 'SHLVL': '1', 09:04:33 INFO - 'TERM': 'linux', 09:04:33 INFO - 'TMOUT': '86400', 09:04:33 INFO - 'USER': 'cltbld', 09:04:33 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1464969800.823209-552753711', 09:04:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:33 INFO - '_': '/tools/buildbot/bin/python'} 09:04:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:33 INFO - Downloading/unpacking psutil>=3.1.1 09:04:33 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 09:04:33 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 09:04:33 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 09:04:33 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 09:04:33 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 09:04:33 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 09:04:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:04:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:04:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:04:35 INFO - Installing collected packages: psutil 09:04:35 INFO - Running setup.py install for psutil 09:04:35 INFO - building 'psutil._psutil_linux' extension 09:04:35 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 09:04:35 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 09:04:35 INFO - building 'psutil._psutil_posix' extension 09:04:35 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 09:04:35 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 09:04:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:04:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:04:35 INFO - Successfully installed psutil 09:04:35 INFO - Cleaning up... 09:04:35 INFO - Return code: 0 09:04:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:04: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')]} 09:04:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04: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')]} 09:04:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb09a8c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd74350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe031c0>, '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 0xe040c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe04550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1464969800.823209-552753711', '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 09:04:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:04:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:04:35 INFO - Using env: {'DISPLAY': ':0', 09:04:35 INFO - 'HOME': '/home/cltbld', 09:04:35 INFO - 'LANG': 'en_US.UTF-8', 09:04:35 INFO - 'LANGUAGE': 'en_US:en', 09:04:35 INFO - 'LOGNAME': 'cltbld', 09:04:35 INFO - 'MAIL': '/var/mail/cltbld', 09:04:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:35 INFO - 'MOZ_NO_REMOTE': '1', 09:04:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:35 INFO - 'NO_EM_RESTART': '1', 09:04:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:35 INFO - 'PWD': '/builds/slave/test', 09:04:35 INFO - 'SHELL': '/bin/bash', 09:04:35 INFO - 'SHLVL': '1', 09:04:35 INFO - 'TERM': 'linux', 09:04:35 INFO - 'TMOUT': '86400', 09:04:35 INFO - 'USER': 'cltbld', 09:04:35 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1464969800.823209-552753711', 09:04:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:35 INFO - '_': '/tools/buildbot/bin/python'} 09:04:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:04:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:04:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:04:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:04:37 INFO - Installing collected packages: mozsystemmonitor 09:04:37 INFO - Running setup.py install for mozsystemmonitor 09:04:38 INFO - Successfully installed mozsystemmonitor 09:04:38 INFO - Cleaning up... 09:04:38 INFO - Return code: 0 09:04:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:04:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:38 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 0x7fb09a8c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd74350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe031c0>, '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 0xe040c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe04550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1464969800.823209-552753711', '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 09:04:38 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 09:04:38 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 09:04:38 INFO - Using env: {'DISPLAY': ':0', 09:04:38 INFO - 'HOME': '/home/cltbld', 09:04:38 INFO - 'LANG': 'en_US.UTF-8', 09:04:38 INFO - 'LANGUAGE': 'en_US:en', 09:04:38 INFO - 'LOGNAME': 'cltbld', 09:04:38 INFO - 'MAIL': '/var/mail/cltbld', 09:04:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:38 INFO - 'MOZ_NO_REMOTE': '1', 09:04:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:38 INFO - 'NO_EM_RESTART': '1', 09:04:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:38 INFO - 'PWD': '/builds/slave/test', 09:04:38 INFO - 'SHELL': '/bin/bash', 09:04:38 INFO - 'SHLVL': '1', 09:04:38 INFO - 'TERM': 'linux', 09:04:38 INFO - 'TMOUT': '86400', 09:04:38 INFO - 'USER': 'cltbld', 09:04:38 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1464969800.823209-552753711', 09:04:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:38 INFO - '_': '/tools/buildbot/bin/python'} 09:04:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:38 INFO - Downloading/unpacking jsonschema==2.5.1 09:04:38 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 09:04:38 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 09:04:38 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 09:04:38 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 09:04:38 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 09:04:38 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 09:04:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:04:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:40 INFO - Downloading functools32-3.2.3-2.tar.gz 09:04:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:04:40 INFO - warning: no files found matching '*.txt' 09:04:40 INFO - no previously-included directories found matching 'build' 09:04:40 INFO - no previously-included directories found matching 'dist' 09:04:40 INFO - no previously-included directories found matching '.git*' 09:04:40 INFO - Installing collected packages: jsonschema, functools32 09:04:40 INFO - Running setup.py install for functools32 09:04:40 INFO - warning: no files found matching '*.txt' 09:04:40 INFO - no previously-included directories found matching 'build' 09:04:40 INFO - no previously-included directories found matching 'dist' 09:04:40 INFO - no previously-included directories found matching '.git*' 09:04:40 INFO - Successfully installed jsonschema functools32 09:04:40 INFO - Cleaning up... 09:04:40 INFO - Return code: 0 09:04:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:04: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')]} 09:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04: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')]} 09:04:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb09a8c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd74350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe031c0>, '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 0xe040c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe04550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1464969800.823209-552753711', '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 09:04:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:04:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:04:40 INFO - Using env: {'DISPLAY': ':0', 09:04:40 INFO - 'HOME': '/home/cltbld', 09:04:40 INFO - 'LANG': 'en_US.UTF-8', 09:04:40 INFO - 'LANGUAGE': 'en_US:en', 09:04:40 INFO - 'LOGNAME': 'cltbld', 09:04:40 INFO - 'MAIL': '/var/mail/cltbld', 09:04:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:40 INFO - 'MOZ_NO_REMOTE': '1', 09:04:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:40 INFO - 'NO_EM_RESTART': '1', 09:04:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:40 INFO - 'PWD': '/builds/slave/test', 09:04:40 INFO - 'SHELL': '/bin/bash', 09:04:40 INFO - 'SHLVL': '1', 09:04:40 INFO - 'TERM': 'linux', 09:04:40 INFO - 'TMOUT': '86400', 09:04:40 INFO - 'USER': 'cltbld', 09:04:40 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1464969800.823209-552753711', 09:04:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:40 INFO - '_': '/tools/buildbot/bin/python'} 09:04:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:40 INFO - Downloading/unpacking blobuploader==1.2.4 09:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:42 INFO - Downloading blobuploader-1.2.4.tar.gz 09:04:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:04:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:04:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:04:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:04:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:43 INFO - Downloading docopt-0.6.1.tar.gz 09:04:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:04:43 INFO - Installing collected packages: blobuploader, requests, docopt 09:04:43 INFO - Running setup.py install for blobuploader 09:04:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:04:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:04:43 INFO - Running setup.py install for requests 09:04:43 INFO - Running setup.py install for docopt 09:04:43 INFO - Successfully installed blobuploader requests docopt 09:04:43 INFO - Cleaning up... 09:04:44 INFO - Return code: 0 09:04:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:04: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')]} 09:04:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04: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')]} 09:04:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:44 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 0x7fb09a8c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd74350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe031c0>, '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 0xe040c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe04550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1464969800.823209-552753711', '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 09:04:44 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 09:04:44 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 09:04:44 INFO - Using env: {'DISPLAY': ':0', 09:04:44 INFO - 'HOME': '/home/cltbld', 09:04:44 INFO - 'LANG': 'en_US.UTF-8', 09:04:44 INFO - 'LANGUAGE': 'en_US:en', 09:04:44 INFO - 'LOGNAME': 'cltbld', 09:04:44 INFO - 'MAIL': '/var/mail/cltbld', 09:04:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:44 INFO - 'MOZ_NO_REMOTE': '1', 09:04:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:44 INFO - 'NO_EM_RESTART': '1', 09:04:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:44 INFO - 'PWD': '/builds/slave/test', 09:04:44 INFO - 'SHELL': '/bin/bash', 09:04:44 INFO - 'SHLVL': '1', 09:04:44 INFO - 'TERM': 'linux', 09:04:44 INFO - 'TMOUT': '86400', 09:04:44 INFO - 'USER': 'cltbld', 09:04:44 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1464969800.823209-552753711', 09:04:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:44 INFO - '_': '/tools/buildbot/bin/python'} 09:04:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:04:44 INFO - Running setup.py (path:/tmp/pip-4g8Hz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:04:44 INFO - Running setup.py (path:/tmp/pip-qVRkym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:04:44 INFO - Running setup.py (path:/tmp/pip-X5bX0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:04:44 INFO - Running setup.py (path:/tmp/pip-nxQVjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:04:44 INFO - Running setup.py (path:/tmp/pip-ej4wY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:04:44 INFO - Running setup.py (path:/tmp/pip-11BxzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:04:44 INFO - Running setup.py (path:/tmp/pip-rfRBXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:04:44 INFO - Running setup.py (path:/tmp/pip-hdNNEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:04:44 INFO - Running setup.py (path:/tmp/pip-vzy9un-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:04:44 INFO - Running setup.py (path:/tmp/pip-7psonl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:04:44 INFO - Running setup.py (path:/tmp/pip-N6KOyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:04:45 INFO - Running setup.py (path:/tmp/pip-vnjRFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:04:45 INFO - Running setup.py (path:/tmp/pip-7YmfAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:04:45 INFO - Running setup.py (path:/tmp/pip-8fpiQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:04:45 INFO - Running setup.py (path:/tmp/pip-tbwcKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:04:45 INFO - Running setup.py (path:/tmp/pip-yynI46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:04:45 INFO - Running setup.py (path:/tmp/pip-XU9tjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:04:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:04:45 INFO - Running setup.py install for manifestparser 09:04:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:04:45 INFO - Running setup.py install for mozcrash 09:04:45 INFO - Running setup.py install for mozdebug 09:04:45 INFO - Running setup.py install for mozdevice 09:04:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:04:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:04:45 INFO - Running setup.py install for mozfile 09:04:46 INFO - Running setup.py install for mozhttpd 09:04:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:04:46 INFO - Running setup.py install for mozinfo 09:04:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:04:46 INFO - Running setup.py install for mozInstall 09:04:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:04:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:04:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:04:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:04:46 INFO - Running setup.py install for mozleak 09:04:46 INFO - Running setup.py install for mozlog 09:04:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:04:46 INFO - Running setup.py install for moznetwork 09:04:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:04:46 INFO - Running setup.py install for mozprocess 09:04:46 INFO - Running setup.py install for mozprofile 09:04:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:04:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:04:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:04:46 INFO - Running setup.py install for mozrunner 09:04:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:04:46 INFO - Running setup.py install for mozscreenshot 09:04:47 INFO - Running setup.py install for moztest 09:04:47 INFO - Running setup.py install for mozversion 09:04:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:04:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:04:47 INFO - Cleaning up... 09:04:47 INFO - Return code: 0 09:04:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:04:47 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')]} 09:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:47 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')]} 09:04:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:47 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 0x7fb09a8c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd74350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe031c0>, '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 0xe040c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe04550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1464969800.823209-552753711', '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 09:04:47 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 09:04:47 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 09:04:47 INFO - Using env: {'DISPLAY': ':0', 09:04:47 INFO - 'HOME': '/home/cltbld', 09:04:47 INFO - 'LANG': 'en_US.UTF-8', 09:04:47 INFO - 'LANGUAGE': 'en_US:en', 09:04:47 INFO - 'LOGNAME': 'cltbld', 09:04:47 INFO - 'MAIL': '/var/mail/cltbld', 09:04:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:47 INFO - 'MOZ_NO_REMOTE': '1', 09:04:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:47 INFO - 'NO_EM_RESTART': '1', 09:04:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:47 INFO - 'PWD': '/builds/slave/test', 09:04:47 INFO - 'SHELL': '/bin/bash', 09:04:47 INFO - 'SHLVL': '1', 09:04:47 INFO - 'TERM': 'linux', 09:04:47 INFO - 'TMOUT': '86400', 09:04:47 INFO - 'USER': 'cltbld', 09:04:47 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1464969800.823209-552753711', 09:04:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:47 INFO - '_': '/tools/buildbot/bin/python'} 09:04:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:04:47 INFO - Running setup.py (path:/tmp/pip-4ykDEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:04:47 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)) 09:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:04:47 INFO - Running setup.py (path:/tmp/pip-PNAkgB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:04:47 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)) 09:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:04:47 INFO - Running setup.py (path:/tmp/pip-Odo5iJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:04:47 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)) 09:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:04:47 INFO - Running setup.py (path:/tmp/pip-fsNrph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:04:47 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)) 09:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:04:47 INFO - Running setup.py (path:/tmp/pip-Q8Mhje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:04:47 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)) 09:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:04:47 INFO - Running setup.py (path:/tmp/pip-0UFtKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:04:47 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)) 09:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:04:47 INFO - Running setup.py (path:/tmp/pip-sELtbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:04:47 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)) 09:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:04:48 INFO - Running setup.py (path:/tmp/pip-u2OWE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:04:48 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)) 09:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:04:48 INFO - Running setup.py (path:/tmp/pip-l1ZAmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:04:48 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)) 09:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:04:48 INFO - Running setup.py (path:/tmp/pip-ktYvhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:04:48 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)) 09:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:04:48 INFO - Running setup.py (path:/tmp/pip-OgorHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:04:48 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)) 09:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:04:48 INFO - Running setup.py (path:/tmp/pip-txNstA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:04:48 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)) 09:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:04:48 INFO - Running setup.py (path:/tmp/pip-kVCmeY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:04:48 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)) 09:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:04:48 INFO - Running setup.py (path:/tmp/pip-dGLFuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:04:48 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)) 09:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:04:48 INFO - Running setup.py (path:/tmp/pip-V6t2p3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:04:48 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)) 09:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:04:48 INFO - Running setup.py (path:/tmp/pip-3D7ruh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:04:48 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)) 09:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:04:48 INFO - Running setup.py (path:/tmp/pip-pe8nsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:04:48 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)) 09:04:48 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)) 09:04:48 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)) 09:04:48 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)) 09:04:48 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)) 09:04:48 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)) 09:04:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:50 INFO - Downloading blessings-1.6.tar.gz 09:04:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:04:50 INFO - Installing collected packages: blessings 09:04:50 INFO - Running setup.py install for blessings 09:04:50 INFO - Successfully installed blessings 09:04:50 INFO - Cleaning up... 09:04:50 INFO - Return code: 0 09:04:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:04:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:04:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:04:51 INFO - Reading from file tmpfile_stdout 09:04:51 INFO - Current package versions: 09:04:51 INFO - argparse == 1.2.1 09:04:51 INFO - blessings == 1.6 09:04:51 INFO - blobuploader == 1.2.4 09:04:51 INFO - docopt == 0.6.1 09:04:51 INFO - functools32 == 3.2.3-2 09:04:51 INFO - jsonschema == 2.5.1 09:04:51 INFO - manifestparser == 1.1 09:04:51 INFO - mozInstall == 1.12 09:04:51 INFO - mozcrash == 0.17 09:04:51 INFO - mozdebug == 0.1 09:04:51 INFO - mozdevice == 0.48 09:04:51 INFO - mozfile == 1.2 09:04:51 INFO - mozhttpd == 0.7 09:04:51 INFO - mozinfo == 0.9 09:04:51 INFO - mozleak == 0.1 09:04:51 INFO - mozlog == 3.2 09:04:51 INFO - moznetwork == 0.27 09:04:51 INFO - mozprocess == 0.22 09:04:51 INFO - mozprofile == 0.28 09:04:51 INFO - mozrunner == 6.11 09:04:51 INFO - mozscreenshot == 0.1 09:04:51 INFO - mozsystemmonitor == 0.3 09:04:51 INFO - moztest == 0.7 09:04:51 INFO - mozversion == 1.4 09:04:51 INFO - psutil == 3.1.1 09:04:51 INFO - requests == 1.2.3 09:04:51 INFO - wsgiref == 0.1.2 09:04:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:51 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 0x7fb09a8c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd74350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe031c0>, '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 0xe040c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe04550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1464969800.823209-552753711', '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 09:04:51 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 09:04:51 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 09:04:51 INFO - Using env: {'DISPLAY': ':0', 09:04:51 INFO - 'HOME': '/home/cltbld', 09:04:51 INFO - 'LANG': 'en_US.UTF-8', 09:04:51 INFO - 'LANGUAGE': 'en_US:en', 09:04:51 INFO - 'LOGNAME': 'cltbld', 09:04:51 INFO - 'MAIL': '/var/mail/cltbld', 09:04:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:51 INFO - 'MOZ_NO_REMOTE': '1', 09:04:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:51 INFO - 'NO_EM_RESTART': '1', 09:04:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:51 INFO - 'PWD': '/builds/slave/test', 09:04:51 INFO - 'SHELL': '/bin/bash', 09:04:51 INFO - 'SHLVL': '1', 09:04:51 INFO - 'TERM': 'linux', 09:04:51 INFO - 'TMOUT': '86400', 09:04:51 INFO - 'USER': 'cltbld', 09:04:51 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1464969800.823209-552753711', 09:04:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:51 INFO - '_': '/tools/buildbot/bin/python'} 09:04:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:51 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)) 09:04:51 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)) 09:04:51 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)) 09:04:51 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)) 09:04:51 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)) 09:04:51 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)) 09:04:51 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)) 09:04:51 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)) 09:04:51 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)) 09:04:51 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)) 09:04:51 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)) 09:04:51 INFO - Cleaning up... 09:04:51 INFO - Return code: 0 09:04:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb09a8c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd74350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe031c0>, '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 0xe040c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe04550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1464969800.823209-552753711', '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 09:04:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:04:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:04:51 INFO - Using env: {'DISPLAY': ':0', 09:04:51 INFO - 'HOME': '/home/cltbld', 09:04:51 INFO - 'LANG': 'en_US.UTF-8', 09:04:51 INFO - 'LANGUAGE': 'en_US:en', 09:04:51 INFO - 'LOGNAME': 'cltbld', 09:04:51 INFO - 'MAIL': '/var/mail/cltbld', 09:04:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:51 INFO - 'MOZ_NO_REMOTE': '1', 09:04:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:51 INFO - 'NO_EM_RESTART': '1', 09:04:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:51 INFO - 'PWD': '/builds/slave/test', 09:04:51 INFO - 'SHELL': '/bin/bash', 09:04:51 INFO - 'SHLVL': '1', 09:04:51 INFO - 'TERM': 'linux', 09:04:51 INFO - 'TMOUT': '86400', 09:04:51 INFO - 'USER': 'cltbld', 09:04:51 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1464969800.823209-552753711', 09:04:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:51 INFO - '_': '/tools/buildbot/bin/python'} 09:04:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:04:51 INFO - Cleaning up... 09:04:51 INFO - Return code: 0 09:04:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb09a8c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd74350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe031c0>, '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 0xe040c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe04550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1464969800.823209-552753711', '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 09:04:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:04:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:04:51 INFO - Using env: {'DISPLAY': ':0', 09:04:51 INFO - 'HOME': '/home/cltbld', 09:04:51 INFO - 'LANG': 'en_US.UTF-8', 09:04:51 INFO - 'LANGUAGE': 'en_US:en', 09:04:51 INFO - 'LOGNAME': 'cltbld', 09:04:51 INFO - 'MAIL': '/var/mail/cltbld', 09:04:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:51 INFO - 'MOZ_NO_REMOTE': '1', 09:04:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:51 INFO - 'NO_EM_RESTART': '1', 09:04:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:51 INFO - 'PWD': '/builds/slave/test', 09:04:51 INFO - 'SHELL': '/bin/bash', 09:04:51 INFO - 'SHLVL': '1', 09:04:51 INFO - 'TERM': 'linux', 09:04:51 INFO - 'TMOUT': '86400', 09:04:51 INFO - 'USER': 'cltbld', 09:04:51 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1464969800.823209-552753711', 09:04:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:51 INFO - '_': '/tools/buildbot/bin/python'} 09:04:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:51 INFO - Downloading/unpacking flake8 09:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:04:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:04:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:04:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:04:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:04:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:04:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:04:54 INFO - no previously-included directories found matching 'docs/_build' 09:04:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:04:54 INFO - Running setup.py install for pep8 09:04:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:04:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:04:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:04:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:04:54 INFO - no previously-included directories found matching 'docs/_build' 09:04:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:04:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:04:54 INFO - Cleaning up... 09:04:54 INFO - Return code: 0 09:04:54 INFO - Running post-action listener: _resource_record_post_action 09:04:54 INFO - Running post-action listener: _start_resource_monitoring 09:04:54 INFO - Starting resource monitoring. 09:04:54 INFO - ##### 09:04:54 INFO - ##### Finished create-virtualenv step (success) 09:04:54 INFO - ##### 09:04:54 INFO - ##### 09:04:54 INFO - ##### Running install step. 09:04:54 INFO - ##### 09:04:54 INFO - Running pre-action listener: _resource_record_pre_action 09:04:54 INFO - Running main action method: install 09:04:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:04:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:04:54 INFO - Reading from file tmpfile_stdout 09:04:54 INFO - Detecting whether we're running mozinstall >=1.0... 09:04:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:04:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:04:54 INFO - Reading from file tmpfile_stdout 09:04:54 INFO - Output received: 09:04:54 INFO - Usage: mozinstall [options] installer 09:04:54 INFO - Options: 09:04:54 INFO - -h, --help show this help message and exit 09:04:54 INFO - -d DEST, --destination=DEST 09:04:54 INFO - Directory to install application into. [default: 09:04:54 INFO - "/builds/slave/test"] 09:04:54 INFO - --app=APP Application being installed. [default: firefox] 09:04:54 INFO - mkdir: /builds/slave/test/build/application 09:04:54 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'] 09:04:54 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 09:05:10 INFO - Reading from file tmpfile_stdout 09:05:10 INFO - Output received: 09:05:10 INFO - /builds/slave/test/build/application/firefox/firefox 09:05:10 INFO - Running post-action listener: _resource_record_post_action 09:05:10 INFO - ##### 09:05:10 INFO - ##### Finished install step (success) 09:05:10 INFO - ##### 09:05:10 INFO - ##### 09:05:10 INFO - ##### Running run-tests step. 09:05:10 INFO - ##### 09:05:10 INFO - Running pre-action listener: _resource_record_pre_action 09:05:10 INFO - Running main action method: run_tests 09:05:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:05:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:05:10 INFO - Python 2.7.3 09:05:10 INFO - Return code: 0 09:05:10 INFO - grabbing minidump binary from tooltool 09:05:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:10 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 0xe031c0>, '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 0xe040c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe04550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:05:10 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 09:05:10 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 09:05:10 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 09:05:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:05:10 INFO - Return code: 0 09:05:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:05:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:05:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:05:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:05:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:05:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:05:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:05:11 INFO - Return code: 0 09:05:11 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HM0H6EJBShuUoJjEQqCYEA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:05:11 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HM0H6EJBShuUoJjEQqCYEA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:05:11 INFO - Using env: {'DISPLAY': ':0', 09:05:11 INFO - 'HOME': '/home/cltbld', 09:05:11 INFO - 'LANG': 'en_US.UTF-8', 09:05:11 INFO - 'LANGUAGE': 'en_US:en', 09:05:11 INFO - 'LOGNAME': 'cltbld', 09:05:11 INFO - 'MAIL': '/var/mail/cltbld', 09:05:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:05:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:05:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:11 INFO - 'MOZ_NO_REMOTE': '1', 09:05:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:05:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:11 INFO - 'NO_EM_RESTART': '1', 09:05:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:11 INFO - 'PWD': '/builds/slave/test', 09:05:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:05:11 INFO - 'SHELL': '/bin/bash', 09:05:11 INFO - 'SHLVL': '1', 09:05:11 INFO - 'TERM': 'linux', 09:05:11 INFO - 'TMOUT': '86400', 09:05:11 INFO - 'USER': 'cltbld', 09:05:11 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1464969800.823209-552753711', 09:05:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:11 INFO - '_': '/tools/buildbot/bin/python'} 09:05:11 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HM0H6EJBShuUoJjEQqCYEA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:05:12 INFO - mozversion application_buildid: 20160603083311 09:05:12 INFO - mozversion application_changeset: 0e6dfa8fc2f4d513dba9f434fc3a92c32e6b9ad6 09:05:12 INFO - mozversion application_display_name: Nightly 09:05:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:05:12 INFO - mozversion application_name: Firefox 09:05:12 INFO - mozversion application_remotingname: firefox 09:05:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:05:12 INFO - mozversion application_vendor: Mozilla 09:05:12 INFO - mozversion application_version: 49.0a1 09:05:12 INFO - mozversion platform_buildid: 20160603083311 09:05:12 INFO - mozversion platform_changeset: 0e6dfa8fc2f4d513dba9f434fc3a92c32e6b9ad6 09:05:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:05:12 INFO - mozversion platform_version: 49.0a1 09:05:12 INFO - using testdate: 1464969912 09:05:12 INFO - actual date: 1464969912 09:05:12 INFO - starting webserver on 'localhost:60856' 09:05:12 INFO - SUITE-START | Running 2 tests 09:05:12 INFO - TEST-START | dromaeo_css 09:05:12 INFO - operating with platform_type : linux_ 09:05:12 INFO - Initialising browser for dromaeo_css test... 09:05:12 INFO - TEST-INFO | started process 2421 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfc4bhG/profile http://localhost:60856/getInfo.html) 09:05:16 INFO - PROCESS | 2421 | __metrics Screen width/height:1600/1200 09:05:16 INFO - PROCESS | 2421 | colorDepth:24 09:05:16 INFO - PROCESS | 2421 | Browser inner width/height: 1024/697 09:05:16 INFO - PROCESS | 2421 | __metrics 09:05:17 ERROR - PROCESS | 2421 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 09:05:18 INFO - TEST-INFO | 2421: exit 0 09:05:18 INFO - Browser initialized. 09:05:18 INFO - Running cycle 1/1 for dromaeo_css test... 09:05:18 INFO - TEST-INFO | started process 2559 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfc4bhG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:05:30 INFO - PROCESS | 2559 | RSS: Main: 168615936 09:05:30 INFO - PROCESS | 2559 | 09:06:20 INFO - PROCESS | 2559 | 1464969980034 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] 09:08:31 INFO - PROCESS | 2559 | Cycle 1(1): loaded http://localhost:60856/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60856/tests/dromaeo/cssquery-ext.html) 09:08:34 INFO - PROCESS | 2559 | RSS: Main: 170872832 09:08:34 INFO - PROCESS | 2559 | 09:11:36 INFO - PROCESS | 2559 | Cycle 1(1): loaded http://localhost:60856/tests/dromaeo/cssquery-ext.html (next: http://localhost:60856/tests/dromaeo/cssquery-jquery.html) 09:11:36 INFO - PROCESS | 2559 | RSS: Main: 170065920 09:11:36 INFO - PROCESS | 2559 | 09:14:38 INFO - PROCESS | 2559 | Cycle 1(1): loaded http://localhost:60856/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60856/tests/dromaeo/cssquery-mootools.html) 09:14:39 INFO - PROCESS | 2559 | RSS: Main: 171253760 09:14:39 INFO - PROCESS | 2559 | 09:17:41 INFO - PROCESS | 2559 | Cycle 1(1): loaded http://localhost:60856/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60856/tests/dromaeo/cssquery-prototype.html) 09:17:42 INFO - PROCESS | 2559 | RSS: Main: 168484864 09:17:42 INFO - PROCESS | 2559 | 09:20:44 INFO - PROCESS | 2559 | Cycle 1(1): loaded http://localhost:60856/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60856/tests/dromaeo/cssquery-yui.html) 09:20:45 INFO - PROCESS | 2559 | RSS: Main: 170594304 09:20:45 INFO - PROCESS | 2559 | 09:23:48 INFO - PROCESS | 2559 | Cycle 1(1): loaded http://localhost:60856/tests/dromaeo/cssquery-yui.html (next: http://localhost:60856/tests/dromaeo/cssquery-dojo.html) 09:23:48 INFO - PROCESS | 2559 | RSS: Main: 171814912 09:23:48 INFO - PROCESS | 2559 | 09:23:48 INFO - PROCESS | 2559 | __start_tp_report 09:23:48 INFO - PROCESS | 2559 | _x_x_mozilla_page_load 09:23:48 INFO - PROCESS | 2559 | _x_x_mozilla_page_load_details 09:23:48 INFO - PROCESS | 2559 | |i|pagename|runs| 09:23:48 INFO - PROCESS | 2559 | |0;dojo.html;2684.9731502684967;2691.636629055078;2694.178275625933;2698.419839734457;2725.918222453327;4776.331313616097;4787.976060119703;4790.592799612033;4811.821103829567;4824.252240902657;4671.416072990876;4764.666473346859;4770.904581908359;4783.258594917794;4796.760161991904;4347.5652434756585;4373.693841431085;4440.666949978749;4475.7985890635;4480.417545719052;4433.933490997621;4519.254323036695;4523.570260825217;4534.8866278342975;4549.090181963604;4300.311950088002;4318.2227199104145;4351.260285751398;4443.111377724468;4510.639148868083;4384.693071484998;4385.3641222022625;4404.163208990281;4452.577005184502;4461.330800379969;4402.823887044515;4403.119376124756;4424.247877860739;4445.266531022377;4465.754383508905;4658.301254811771;4692.319613656035;4703.2239680452685;4716.268978308368;4770.76146192689;5106.64253502255;5107.233914912756;5125.641205115643;5134.589232861362;5135.35808023997;5161.5870730341485;5168.121419358718;5170.741462926876;5174.353205849269;5182.559482443997;4849.442314133885;4882.5605695487575;4894.1679914414635;4897.7795999180125;4923.064617722621;5296.25852380667;5342.198670199424;5347.679139251657;5357.678539287655;5439;4937.382827146606;4939.975300123477;4967.279744437036;5097.515736005073;5144.6655967362;5057.620678449058;5058.772355244023;5061;5076.974615126975;5091.261767043758;4953;5050.166722490748;5053.0904437200925;5076.289319495274;5107.514786095315;4916.336294600254;5037;5064.063148317573;5079.1365467870555;5089.414717307557;4346.304591265382;4352.869413917588;4353.521112677603;4390.297552391602;4407.272799987966;3778.1876896467393;3819.6562309391734;3829.904252393657;3845.730798844054;3887.533495980444;4239.97880010598;4310.935335969963;4390.648748100144;4427.867163985085;4464.441944756905;5171;5171.172612382001;5184.351956005499;5197.558207552324;5253.369595648546;4448.911021779546;4452.5992660660695;4457.130859482435;4466.330050492452;4529.207388706963;4527.456705195332;4576.084783043405;4587.495375508692;4624.95375046252;4638.350630911675;4828.275758636162;4837.685550439211;4851;4859.2954021665955;4885.438174609965;5119.180931051014;5148.253503242084;5155.046316431472;5160.251763494197;5225.686458812484;4789;4825.831095911767;4855.295982082649;4868.805247790048;4891.779869905934;5037;5045.596352291735;5068.467810879804;5088.898222035465;5122.359705036871;5027.7737501813235;5198.6880787152895;5210.505002024802;5213.13983192769;5215.322008138917;4843.2735089736825;4873.658843881036;4901.436334821398;4994.1759609663995;5019.62352823547;4942.75286235694;4944.01119776039;4951.455339912534;4960.107180707508;4963.429205641253;4823.5658790709;4848.878778030577;4860.149473842134;4860.6111511079735;4866.659333846596;4921.409430868319;4978.775955082103;4999.925001124913;5007.724575148256;5061.544460998528;4930.704157750546;4931.2849636803185;4966.056449274771;4981.2030075187795;5020.949790502194 09:23:48 INFO - PROCESS | 2559 | |1;ext.html;524.0979468030984;592.3395414113263;597.8983572792624;606.7603296697805;621.9440250377465;34948.30103397934;40338.7983060085;40501.39247911284;40597.79701101494;40629;41551.37672934901;42121.57878421215;42131.368029479585;42188;42230.366544501856;7803.648835802388;8021.157778433268;8021.39839512036;8022.318102961255;8031.558264295461;7774.766756997299;7801;7844.646990885395;7858.803529911769;7867.960660196691;7779.105402878657;7850.214978502161;7866.646000929972;7867.960660196691;7885.723999660013;7779.922200777976;7811.726589569366;7838.804029899298;7854.646540905673;7861.528308301492;7693.115291741466;7706.7669172932065;7722.613869306512;7751.728689495897;7790.065192176975;38213.235735285416;38344.616553834385;38545.421818672745;38685;38688;3004.9098527044007;3083.1521331633758;3145.766505780898;3201.487761958099;3594.6944509716704;29820.70179298201;29847.70152298471;30098.54852177219;30109.247268818235;30455;2984.224101733543;2989.9551506727416;3008.3080891394884;3033.9544906826413;3065.3103051813387;255773;257107;258107;258290.9999999981;258400;28636.14091577256;29220.707792922225;54061.1890821638;54306.45693543093;54631.72684136633;34846;35065.649343506746;35092.473612895825;35307.4703879442;35333.46999795005;13427.597172084854;13476.258805765778;13571.52499662507;13648.65878353049;13656.385462654205;10775.084117849914;10860.022597966221;10880.12958963281;10884.455777211107;10890.564377424973;8019.518828870287;8044.517328960281;8067.959660201779;8086.312663423675;8151.959240203761;3101.9379612407624;3148.1185268124964;3172.5082612195147;3183.7771356004855;3188.12958075348;874.8950125984923;934.4813628436283;979.1921664626711;996.7956568903357;1001.1340190735108;26878.731212687624;27597.172084837486;27615.447691046065;27668.30829229245;27999.580006299922;1030.9381437113798;1049.4385503755454;1053.961847580133;1063.6702622187147;1107.4850194659523;14735.336909838868;14948;15325.708701851658;15348.386064557517;15446.459373922084;375125;375852;377712;378574;380543;50889.745551272004;51650.74174629103;51832.99999999924;51868.740656296475;51936.74031629818;1208.4682440846825;1208.4924331780674;1211.3216598704753;1234.2101055324779;1240.0389697983953;26591.60112598274;28274.71725282721;28473.43053138967;29026.854865725538;29056.7094329054;44563.331550027426;44626.3306050416;44711.55288447074;44757.32864007108;44967.32549011833;273592;277433;278171;278345;278852;25925.740742593087;26063.218103456926;26703.59944600794;26812.865935670197;26818.195454136407;44352.11295774131;44654.553454465036;44780;44800;44988.32517512306;38292.42561361526;38466.615333846305;38470.80764596159;38866.506043368696;40292.79853600713;37458.6254137466;37656.81171594124;37783.81108094442;37848;37874.62125378711;31876.36247275088;37550;38007.80996095002;39681.80159099186;40052.399214012396;33220.50169247512;33329.333413331115;34602.30795384028;34851.65148348585;34908.82545587256;24776.50446991014;25364.11225607095;25569.872150639127;25626.103086391886;25641.743582563937 09:23:48 INFO - PROCESS | 2559 | |2;jquery.html;365.2002115367347;369.2670049950848;369.6137536274593;375.96052414496495;384.6442041111971;15613.21933903306;16581.253843577037;17052.14739263035;17236.655266894653;17305.74041389377;14092.224927629002;15122.470713525028;15396.461123860667;15409.537713868602;15456.845431545682;4876.512348765131;5079.517445842639;5086.160783470741;5088;5105.872353191163;3721;5003.674761140533;5605.523530499912;5940.792072277472;5944.197533332988;5950.732217050221;5953.58324917256;5971.641701497902;5986.940130598704;6018.6689732064715;5700.600957932947;5840.153177789218;5875.941240587582;5893.823185304448;5922.378150294243;4571.337156112345;5175.404828444702;5184.170532714747;5198.92201616976;5207.583393328562;11545.480453379618;12203.45084471201;12298.385080745928;12305.569305074368;12312.938435307855;1728.8616910647117;1796.8113348098523;1814.4647329037966;1822.9088545572667;1835.2565063190023;8497.660093596249;8585.31317494599;8722.607482663296;8939.463632182025;9089.681861134828;1560.0327796766078;1668.5995361113366;1723.8448539631368;1757.1741281597629;1766.7703198584231;65763.67118164427;66489.66755166241;67456.3254367455;68831;70328;9634.566444510014;10151.94924025375;10167.847482287772;10326.896731032593;10900.236983411243;13956.162630242217;13992.720145597235;13998.580042598738;14012.859871401155;14063.156210627396;6974.651267436608;7060.505764596429;7084.893726594105;7129.251428600026;7139.500234983605;6509.739610415625;6589.110470086573;6594.07682924391;6654.068430419745;6668.499862510331;4257.74453532789;4298.570142985676;4362.716423432466;4378.299472084451;4426.15902978433;1692.6868529322114;1713.4773893962213;1759.8064212936567;1795.398541488616;1801.4235444657584;366.3917896292142;388.2254901471582;390.27993352265025;850.2093053460342;860.694453469022;10066.345687530287;10476.423796691102;15319.46381876629;16556.50330490087;16678.33286668544;867.9696210632598;890.3633901760143;930.1442672741094;937.7936853892132;983.7098056073476;8829.69096081634;9346.0653934606;9400.858987115198;9409.01205373426;9545.47499887499;375438;377386;378848;379782;379894;77777.61111194408;77879.22120778833;80350.19649803544;80455.19544804594;82098.17901821024;971.8056388722142;973.6446197137993;984.3700031979539;984.5225065843204;990.955407006672;14943.476978305707;14967.101973881601;15021.6995660084;15123.98551629417;15210.315535800693;34709;34874.82562587171;35132.64867351396;36345.45481817722;36475;46641;48788.75605622091;49550.256746148116;49964.75017625034;50447;7635.88546171819;7658.540487570764;7675.808104797425;7841.294283514511;7855.175206603453;11238.887611124112;11551.826722599335;11585.362805045803;11809.468573914366;11837.585684501;8662.870056949025;10108.595656173671;10244.795104098026;10284.948575257076;10307;9990.15083717892;10087.193024557871;10145;10295.742606434898;10439.94780026095;10296.433696146485;10298.70441458756;10325.277230594087;10342.638007669695;10558.947205263925;7734.071911370672;7825.804354891174;7834.843303133792;7889.526628402315;7958.0848202455145;10290.536925838505;10344.844827327746;10403.011713887168;10441.582336706446;10489 09:23:48 INFO - PROCESS | 2559 | |3;mootools.html;1333.7265860498599;1399.1946147973313;1449.9782503262447;1715.9742603860952;1725.8274172582735;6656.966715166417;7278.126624805024;7358.889616655754;7792.92207077929;7796.571188584626;7430.368418684418;7665.156832748393;7665.731699390522;7676.38588912887;7685.692572297102;2119.0993827623274;2149.3337065509663;2164.556265965481;2164.945876353088;2167.7940595643468;2089.749230092391;2096.1720120552372;2123.235635171337;2131.8720876747366;2145.9248926287582;2086.09254974086;2111.493241622007;2118.9576208475823;2123.214410668055;2165.317924853666;2091.9267825626107;2097.098247753473;2099.3177217404404;2099.7165382673297;2102.138123369411;2031.5022819409191;2100.317396846031;2100.9474763131043;2110.461832232771;2116.6824976253683;7648.847023059563;7657.961710191469;7670.194629563871;7673.50122242058;7682.731104411375;4542.523035081302;4617.5151609080895;4617.953820461786;4622.56085671864;4659.138059458977;2829.6604407471236;2909.6799352071257;2943.7644988400875;2965.688602696707;2971.6136902202793;905.3571963905634;908.7591788176138;922.1746536849549;954.4798085043668;958.8801399825022;10703.304285221435;10706.892931070668;10723.624673136403;10736.892631073668;10773.892261077446;4185.058361868555;4277.465316835395;4288.699791014599;4335.631471324909;4375.16871794358;9160.404573702688;9179.495127768037;9214.216791572657;9216.078392160864;9251.398659087272;4543.818247270072;4606.332081848113;4634.165850147006;4635.582797548237;4637.234856248681;3623.3840247158046;4007.719459637797;4137.048478849882;4205.642520385802;4209.24233637942;3597.712183025404;3635.1820840311248;3711.5917249102577;3744.3821769408287;3857.5370955485523;1143.1883362812496;1151.3207207747469;1152.9192956492966;1153.8788427215022;1154.8440960470398;861.9138086191456;876.785187629035;889.6263569300909;890.3811850763657;899.4378513429107;5436.510714035756;5462.317210348707;5609.523190528769;5734.885302293931;5741.024025915521;891.6968230801558;900.8603666431713;905.922996545301;909.0138048364345;959.9760005999766;3681.834317455721;3846.8653597124526;3895.2014836958356;3921.313770090223;3934.1738234970403;9621;9907;9962.55168517404;9967.252456065824;10003.44981026036;8964.8655270171;9300.953495232481;9824.803503929881;9934.304598678023;10021.39871607706;7352.926470735331;7463.888041679379;7525.247475252431;7541.622918854145;7547.73582924595;5382.623216374816;5574.92675696246;5623.803166889139;5721.5136713379825;5830.300363956352;8754;9020.503872287087;9023.4134781239;9261.53692315368;9286.860697089414;9245.72262832116;9259.583318750538;9375.671851485165;9391.765205869908;9507.572159252988;5972.671503067373;6251.593646412968;6301.8109456716375;6420.069089981833;6527.902081468686;7642.770716878503;7679.232076792276;7715.382769378324;7737.14891361961;7748;6605.207375114825;6806.489513286424;6849.2808255132495;6940.652967351713;6963.1644202696;6719.496037797283;6811.284815094344;6877.690503927435;6883.449324053963;6904.654767261717;6006.189164462917;6182.814515564541;6232.906506402317;6388.840278992877;6420.426995385974;4576.954230457653;4610;4640.350350950937;4691.554302341272;4702.600278976189;4573.565511276423;4583.564561366665;4627.07458508293;4695;4713.2223183175765 09:23:48 INFO - PROCESS | 2559 | |4;prototype.html;284.82198625858837;289.784110837426;292.8067475466192;293.15132690859974;296.2120758781641;4943.134951383511;4979.950200497999;5000.849974500762;5018.84943451697;5025.1708468102715;4932.975335123319;4941.258811178325;4952.554270115689;4957.801687932479;4970.757310672332;3658.5792633847113;3739.2708421857747;3838.9808050959705;3852.1717830666403;3861.3242682530445;3851.8844434667003;3863.613638636142;3870.845166193349;3877.418387241908;3879.4374815651713;3797.468354430382;3806.8667596634123;3812.2375524895133;3829.9234015319676;3844.1158533537305;3772;3810.4914281205038;3830.1765120499085;3840.829931088954;3858.6913046956315;3328.417526932801;3355.7248245666733;3376.206591451007;3385.8137802420856;3387.254803943153;4669.743164125972;4677.2750223715375;4696.506866778973;4705.435347758291;4724.527547245282;4416.514183439819;4416.668749843742;4420.8673739787855;4436.201483732927;4438.4451943507065;4956.801727930879;5121.871953201163;5136.64043516954;5145.6296126037505;5165.276861239429;3682.4660424238336;3706.2587482503336;3708.6291370862696;3708.796016219107;3717.6282371762877;5436.320459942507;5445.373782015079;5458.344998600153;5476.342838859362;5533.727242734194;3463.3246516928957;3685.9631403686158;3692.372296709566;3695.5750088740137;3844.2888065707375;3734.141147536028;3742.3825068863875;3743.8689645862264;3746.2882052409955;3749.1564398010773;4303.311470164758;4303.419038429772;4308.870733877989;4313.835264478574;4322.675799315001;5133.25567792668;5200.6619569727845;5212;5229.267902493654;5254.054270231395;1298.5909438526835;1300.0964329790704;1301.635542048228;1319.4524272426836;1323.0936808286356;775.6199462263563;796.7012370361115;805.7743831727125;808.9069756977905;809.7692157735017;4383.610932042045;4580.564846339659;4583.2666773316105;4588.770561471913;4604.332371806069;5419.485148910847;5426.158945363475;5426.538744206787;5430.9185362218805;5451.918221226685;4313.956860431355;4498.347739577743;4507.18870603288;4545.2954792007295;4597.954020459752;2860.4565132624734;2860.728230818069;2875.92810179743;2878.29481776966;2894.3921776426764;4964.851054468371;4979.502049794992;5003.4746351633285;5032.547070763576;5043.87390315245;5163.302954101224;5440.782368705287;5451.836444906659;5457.426970168154;5568.192612071227;5039.874003149877;5040.31955685985;5052.343195384577;5056.949430505648;5098.1588037973315;5425.945740542702;5454.236406903116;5455.481729235717;5460.31746031746;5464.743109085012;5203.271541984201;5303.886183901424;5320.122179840438;5335.893282134413;5338.626296159232;5018.824341148043;5032.974835125948;5061.190209566452;5079.222272204699;5094.2867998479505;3701.056230661164;3728.925421491609;3744.9139749472347;3749.231407561389;3760.473533705229;5318.308619879545;5351.919721204263;5380.650257733235;5390.649607775482;5472.905418916153;5216.843494695166;5255.947440525546;5266.42069372361;5266.73666316675;5272.525472707474;5279.920801187908;5290.6032047597355;5296.735163241746;5309.734513274244;5314.123169677115;4931.260310953386;5090.389153301628;5145.331106956071;5155.2782610433815;5163.896722065462;5013.470891378165;5083.38999320084;5263.157894736823;5285.920711189412;5286.7356632169;5136.768845401891;5139.820106296262;5142.202958541432;5145.224897410388;5154.072266991978 09:23:48 INFO - PROCESS | 2559 | |5;yui.html;618.1284389011495;660.5805313625846;671.8656268746251;703.4864548879318;721.46251042973;11684.883151168486;12147.149699521036;12370.07224458166;12418.875811241885;12672.68318292041;12591.999999999976;12613.4323955422;13038.674033149176;13067.803982940264;13596.18422894627;628.745358129958;782.5774081995716;809.7570728781342;812.8252425728452;817.0358976407837;809.4617079642031;813.0893399392688;814.9348052155814;815.8449894520022;816.1878930464196;852.4799872078028;858.935579831512;860.2086080805674;860.3074525007366;863.3481721300409;845.1337379186352;849.1254008371357;852.4459101583958;854;855.5978690015683;620.3362402229616;622.7695752571577;622.8536293970914;624.9375062493714;625.1248252446566;13795.517156899561;13842.100263482842;13854.861451385457;13856.307184640727;13896.444142234399;12925.289109098996;13249.13880597758;13284.667883302898;13427.86572134276;13433.865661343458;10283.177345812317;10438.373697578094;10480.94759526205;10553.41956192409;10616.469176541143;3230.194824538764;3272.280098378353;3279.7048265656204;3323.0529299149625;3342.6991570758505;65871.341286587;65930.3406965929;66197.66901165464;66214.33785662129;66691;10175.440350780778;10356.223283253636;10413.895861041445;10455.268131230741;10797.924975261614;19124;19256.133473993705;19269.710954335416;19305.51736206606;19414.902925485283;6481.384268494486;6591.143151390384;6651.301613330627;6719.731210751515;6756.628385438848;3726.8136593170234;3753.642859994387;3789.6399842014966;3820.9235815284096;3830.8467661293794;2912.6796052434215;3025.198322444554;3077.707617776308;3085.645150807641;3085.876564937377;519.97920083197;530.2894121876703;552.1276383314354;585.7861880413618;592.410551501259;594.432317137133;596.8716725903952;608.1394826320707;630.3255516597197;639.0063451333128;8628.870566941501;8665.35009874262;8725.650973961097;8771.956140219258;9027.954860225787;632.7216024949008;639.8080575827233;659.9538032337787;668.0480315550321;668.9230738465042;4250.808713607895;4280.957190428118;4291.356296555479;4314.633256173261;4343.4136391586735;85687;96557.51721241348;97486;98548.50725746325;100832;80968.59515702384;85209;85420;86108;86499;49845.75077124664;66705;79153.60423197963;80321.59839200767;80848;7928.326092282221;8169.2647661710735;8211.753647390588;8235.83528329442;8348.87476687838;45160.096798064515;45716;45931.54068459273;45979.77010114928;47047.764761175975;60512;61190;65721.67139164274;67257.32742672706;68332;10202.591896324064;10359;10377.792444151226;10396.636117735843;10569.682909512727;10893.56425742993;11027.283226590245;11122.165837562054;11282.210245282751;11700.941495292469;10956.397398143179;11086.556537738401;11205.60780372683;11336;11383.373914434786;10867.184961127788;11114.777704445703;11455.94272028668;11490.94254528722;12043.217190882564;10919.945400273265;11073.511269217532;11197.216194866607;11224.270422422516;11251.437428128396;8844.159804818531;9075.773105672411;9079.228265597498;9102.635894564144;9141.222996045144;9045.819083618422;9460.337776355589;9573;9671.516424178904;9784.461854597781 09:23:48 INFO - PROCESS | 2559 | __end_tp_report 09:23:48 INFO - PROCESS | 2559 | __start_cc_report 09:23:48 INFO - PROCESS | 2559 | _x_x_mozilla_cycle_collect,404 09:23:48 INFO - PROCESS | 2559 | __end_cc_report 09:23:48 INFO - PROCESS | 2559 | __startTimestamp1464971028417__endTimestamp 09:23:48 INFO - PROCESS | 2559 | 09:23:48 INFO - PROCESS | 2559 | ------- Summary: start ------- 09:23:48 INFO - PROCESS | 2559 | Number of tests: 6 09:23:48 INFO - PROCESS | 2559 | 09:23:48 INFO - PROCESS | 2559 | [#0] dojo.html Cycles:165 Average:4741.30 Median:4860.61 stddev:491.56 (10.1%) stddev-sans-first:465.85 09:23:48 INFO - PROCESS | 2559 | Values: 2685.0 2691.6 2694.2 2698.4 2725.9 4776.3 4788.0 4790.6 4811.8 4824.3 4671.4 4764.7 4770.9 4783.3 4796.8 4347.6 4373.7 4440.7 4475.8 4480.4 4433.9 4519.3 4523.6 4534.9 4549.1 4300.3 4318.2 4351.3 4443.1 4510.6 4384.7 4385.4 4404.2 4452.6 4461.3 4402.8 4403.1 4424.2 4445.3 4465.8 4658.3 4692.3 4703.2 4716.3 4770.8 5106.6 5107.2 5125.6 5134.6 5135.4 5161.6 5168.1 5170.7 5174.4 5182.6 4849.4 4882.6 4894.2 4897.8 4923.1 5296.3 5342.2 5347.7 5357.7 5439.0 4937.4 4940.0 4967.3 5097.5 5144.7 5057.6 5058.8 5061.0 5077.0 5091.3 4953.0 5050.2 5053.1 5076.3 5107.5 4916.3 5037.0 5064.1 5079.1 5089.4 4346.3 4352.9 4353.5 4390.3 4407.3 3778.2 3819.7 3829.9 3845.7 3887.5 4240.0 4310.9 4390.6 4427.9 4464.4 5171.0 5171.2 5184.4 5197.6 5253.4 4448.9 4452.6 4457.1 4466.3 4529.2 4527.5 4576.1 4587.5 4625.0 4638.4 4828.3 4837.7 4851.0 4859.3 4885.4 5119.2 5148.3 5155.0 5160.3 5225.7 4789.0 4825.8 4855.3 4868.8 4891.8 5037.0 5045.6 5068.5 5088.9 5122.4 5027.8 5198.7 5210.5 5213.1 5215.3 4843.3 4873.7 4901.4 4994.2 5019.6 4942.8 4944.0 4951.5 4960.1 4963.4 4823.6 4848.9 4860.1 4860.6 4866.7 4921.4 4978.8 4999.9 5007.7 5061.5 4930.7 4931.3 4966.1 4981.2 5020.9 09:23:48 INFO - PROCESS | 2559 | 09:23:48 INFO - PROCESS | 2559 | [#1] ext.html Cycles:180 Average:45520.98 Median:206291.81 stddev:81234.59 (39.4%) stddev-sans-first:81392.22 09:23:48 INFO - PROCESS | 2559 | Values: 524.1 592.3 597.9 606.8 621.9 34948.3 40338.8 40501.4 40597.8 40629.0 41551.4 42121.6 42131.4 42188.0 42230.4 7803.6 8021.2 8021.4 8022.3 8031.6 7774.8 7801.0 7844.6 7858.8 7868.0 7779.1 7850.2 7866.6 7868.0 7885.7 7779.9 7811.7 7838.8 7854.6 7861.5 7693.1 7706.8 7722.6 7751.7 7790.1 38213.2 38344.6 38545.4 38685.0 38688.0 3004.9 3083.2 3145.8 3201.5 3594.7 29820.7 29847.7 30098.5 30109.2 30455.0 2984.2 2990.0 3008.3 3034.0 3065.3 255773.0 257107.0 258107.0 258291.0 258400.0 28636.1 29220.7 54061.2 54306.5 54631.7 34846.0 35065.6 35092.5 35307.5 35333.5 13427.6 13476.3 13571.5 13648.7 13656.4 10775.1 10860.0 10880.1 10884.5 10890.6 8019.5 8044.5 8068.0 8086.3 8152.0 3101.9 3148.1 3172.5 3183.8 3188.1 874.9 934.5 979.2 996.8 1001.1 26878.7 27597.2 27615.4 27668.3 27999.6 1030.9 1049.4 1054.0 1063.7 1107.5 14735.3 14948.0 15325.7 15348.4 15446.5 375125.0 375852.0 377712.0 378574.0 380543.0 50889.7 51650.7 51833.0 51868.7 51936.7 1208.5 1208.5 1211.3 1234.2 1240.0 26591.6 28274.7 28473.4 29026.9 29056.7 44563.3 44626.3 44711.6 44757.3 44967.3 273592.0 277433.0 278171.0 278345.0 278852.0 25925.7 26063.2 26703.6 26812.9 26818.2 44352.1 44654.6 44780.0 44800.0 44988.3 38292.4 38466.6 38470.8 38866.5 40292.8 37458.6 37656.8 37783.8 37848.0 37874.6 31876.4 37550.0 38007.8 39681.8 40052.4 33220.5 33329.3 34602.3 34851.7 34908.8 24776.5 25364.1 25569.9 25626.1 25641.7 09:23:48 INFO - PROCESS | 2559 | 09:23:48 INFO - PROCESS | 2559 | [#2] jquery.html Cycles:180 Average:23524.26 Median:2324.01 stddev:62599.30 (2693.6%) stddev-sans-first:62750.75 09:23:48 INFO - PROCESS | 2559 | Values: 365.2 369.3 369.6 376.0 384.6 15613.2 16581.3 17052.1 17236.7 17305.7 14092.2 15122.5 15396.5 15409.5 15456.8 4876.5 5079.5 5086.2 5088.0 5105.9 3721.0 5003.7 5605.5 5940.8 5944.2 5950.7 5953.6 5971.6 5986.9 6018.7 5700.6 5840.2 5875.9 5893.8 5922.4 4571.3 5175.4 5184.2 5198.9 5207.6 11545.5 12203.5 12298.4 12305.6 12312.9 1728.9 1796.8 1814.5 1822.9 1835.3 8497.7 8585.3 8722.6 8939.5 9089.7 1560.0 1668.6 1723.8 1757.2 1766.8 65763.7 66489.7 67456.3 68831.0 70328.0 9634.6 10151.9 10167.8 10326.9 10900.2 13956.2 13992.7 13998.6 14012.9 14063.2 6974.7 7060.5 7084.9 7129.3 7139.5 6509.7 6589.1 6594.1 6654.1 6668.5 4257.7 4298.6 4362.7 4378.3 4426.2 1692.7 1713.5 1759.8 1795.4 1801.4 366.4 388.2 390.3 850.2 860.7 10066.3 10476.4 15319.5 16556.5 16678.3 868.0 890.4 930.1 937.8 983.7 8829.7 9346.1 9400.9 9409.0 9545.5 375438.0 377386.0 378848.0 379782.0 379894.0 77777.6 77879.2 80350.2 80455.2 82098.2 971.8 973.6 984.4 984.5 991.0 14943.5 14967.1 15021.7 15124.0 15210.3 34709.0 34874.8 35132.6 36345.5 36475.0 46641.0 48788.8 49550.3 49964.8 50447.0 7635.9 7658.5 7675.8 7841.3 7855.2 11238.9 11551.8 11585.4 11809.5 11837.6 8662.9 10108.6 10244.8 10284.9 10307.0 9990.2 10087.2 10145.0 10295.7 10439.9 10296.4 10298.7 10325.3 10342.6 10558.9 7734.1 7825.8 7834.8 7889.5 7958.1 10290.5 10344.8 10403.0 10441.6 10489.0 09:23:48 INFO - PROCESS | 2559 | 09:23:48 INFO - PROCESS | 2559 | [#3] mootools.html Cycles:180 Average:5179.58 Median:5592.22 stddev:2906.94 (52.0%) stddev-sans-first:2900.73 09:23:48 INFO - PROCESS | 2559 | Values: 1333.7 1399.2 1450.0 1716.0 1725.8 6657.0 7278.1 7358.9 7792.9 7796.6 7430.4 7665.2 7665.7 7676.4 7685.7 2119.1 2149.3 2164.6 2164.9 2167.8 2089.7 2096.2 2123.2 2131.9 2145.9 2086.1 2111.5 2119.0 2123.2 2165.3 2091.9 2097.1 2099.3 2099.7 2102.1 2031.5 2100.3 2100.9 2110.5 2116.7 7648.8 7658.0 7670.2 7673.5 7682.7 4542.5 4617.5 4618.0 4622.6 4659.1 2829.7 2909.7 2943.8 2965.7 2971.6 905.4 908.8 922.2 954.5 958.9 10703.3 10706.9 10723.6 10736.9 10773.9 4185.1 4277.5 4288.7 4335.6 4375.2 9160.4 9179.5 9214.2 9216.1 9251.4 4543.8 4606.3 4634.2 4635.6 4637.2 3623.4 4007.7 4137.0 4205.6 4209.2 3597.7 3635.2 3711.6 3744.4 3857.5 1143.2 1151.3 1152.9 1153.9 1154.8 861.9 876.8 889.6 890.4 899.4 5436.5 5462.3 5609.5 5734.9 5741.0 891.7 900.9 905.9 909.0 960.0 3681.8 3846.9 3895.2 3921.3 3934.2 9621.0 9907.0 9962.6 9967.3 10003.4 8964.9 9301.0 9824.8 9934.3 10021.4 7352.9 7463.9 7525.2 7541.6 7547.7 5382.6 5574.9 5623.8 5721.5 5830.3 8754.0 9020.5 9023.4 9261.5 9286.9 9245.7 9259.6 9375.7 9391.8 9507.6 5972.7 6251.6 6301.8 6420.1 6527.9 7642.8 7679.2 7715.4 7737.1 7748.0 6605.2 6806.5 6849.3 6940.7 6963.2 6719.5 6811.3 6877.7 6883.4 6904.7 6006.2 6182.8 6232.9 6388.8 6420.4 4577.0 4610.0 4640.4 4691.6 4702.6 4573.6 4583.6 4627.1 4695.0 4713.2 09:23:48 INFO - PROCESS | 2559 | 09:23:48 INFO - PROCESS | 2559 | [#4] prototype.html Cycles:180 Average:4307.81 Median:4957.30 stddev:1275.85 (25.7%) stddev-sans-first:1243.19 09:23:48 INFO - PROCESS | 2559 | Values: 284.8 289.8 292.8 293.2 296.2 4943.1 4980.0 5000.8 5018.8 5025.2 4933.0 4941.3 4952.6 4957.8 4970.8 3658.6 3739.3 3839.0 3852.2 3861.3 3851.9 3863.6 3870.8 3877.4 3879.4 3797.5 3806.9 3812.2 3829.9 3844.1 3772.0 3810.5 3830.2 3840.8 3858.7 3328.4 3355.7 3376.2 3385.8 3387.3 4669.7 4677.3 4696.5 4705.4 4724.5 4416.5 4416.7 4420.9 4436.2 4438.4 4956.8 5121.9 5136.6 5145.6 5165.3 3682.5 3706.3 3708.6 3708.8 3717.6 5436.3 5445.4 5458.3 5476.3 5533.7 3463.3 3686.0 3692.4 3695.6 3844.3 3734.1 3742.4 3743.9 3746.3 3749.2 4303.3 4303.4 4308.9 4313.8 4322.7 5133.3 5200.7 5212.0 5229.3 5254.1 1298.6 1300.1 1301.6 1319.5 1323.1 775.6 796.7 805.8 808.9 809.8 4383.6 4580.6 4583.3 4588.8 4604.3 5419.5 5426.2 5426.5 5430.9 5451.9 4314.0 4498.3 4507.2 4545.3 4598.0 2860.5 2860.7 2875.9 2878.3 2894.4 4964.9 4979.5 5003.5 5032.5 5043.9 5163.3 5440.8 5451.8 5457.4 5568.2 5039.9 5040.3 5052.3 5056.9 5098.2 5425.9 5454.2 5455.5 5460.3 5464.7 5203.3 5303.9 5320.1 5335.9 5338.6 5018.8 5033.0 5061.2 5079.2 5094.3 3701.1 3728.9 3744.9 3749.2 3760.5 5318.3 5351.9 5380.7 5390.6 5472.9 5216.8 5255.9 5266.4 5266.7 5272.5 5279.9 5290.6 5296.7 5309.7 5314.1 4931.3 5090.4 5145.3 5155.3 5163.9 5013.5 5083.4 5263.2 5285.9 5286.7 5136.8 5139.8 5142.2 5145.2 5154.1 09:23:48 INFO - PROCESS | 2559 | 09:23:48 INFO - PROCESS | 2559 | [#5] yui.html Cycles:180 Average:17766.68 Median:589.10 stddev:25495.03 (4327.8%) stddev-sans-first:25534.03 09:23:48 INFO - PROCESS | 2559 | Values: 618.1 660.6 671.9 703.5 721.5 11684.9 12147.1 12370.1 12418.9 12672.7 12592.0 12613.4 13038.7 13067.8 13596.2 628.7 782.6 809.8 812.8 817.0 809.5 813.1 814.9 815.8 816.2 852.5 858.9 860.2 860.3 863.3 845.1 849.1 852.4 854.0 855.6 620.3 622.8 622.9 624.9 625.1 13795.5 13842.1 13854.9 13856.3 13896.4 12925.3 13249.1 13284.7 13427.9 13433.9 10283.2 10438.4 10480.9 10553.4 10616.5 3230.2 3272.3 3279.7 3323.1 3342.7 65871.3 65930.3 66197.7 66214.3 66691.0 10175.4 10356.2 10413.9 10455.3 10797.9 19124.0 19256.1 19269.7 19305.5 19414.9 6481.4 6591.1 6651.3 6719.7 6756.6 3726.8 3753.6 3789.6 3820.9 3830.8 2912.7 3025.2 3077.7 3085.6 3085.9 520.0 530.3 552.1 585.8 592.4 594.4 596.9 608.1 630.3 639.0 8628.9 8665.4 8725.7 8772.0 9028.0 632.7 639.8 660.0 668.0 668.9 4250.8 4281.0 4291.4 4314.6 4343.4 85687.0 96557.5 97486.0 98548.5 100832.0 80968.6 85209.0 85420.0 86108.0 86499.0 49845.8 66705.0 79153.6 80321.6 80848.0 7928.3 8169.3 8211.8 8235.8 8348.9 45160.1 45716.0 45931.5 45979.8 47047.8 60512.0 61190.0 65721.7 67257.3 68332.0 10202.6 10359.0 10377.8 10396.6 10569.7 10893.6 11027.3 11122.2 11282.2 11700.9 10956.4 11086.6 11205.6 11336.0 11383.4 10867.2 11114.8 11455.9 11490.9 12043.2 10919.9 11073.5 11197.2 11224.3 11251.4 8844.2 9075.8 9079.2 9102.6 9141.2 9045.8 9460.3 9573.0 9671.5 9784.5 09:23:48 INFO - PROCESS | 2559 | -------- Summary: end -------- 09:23:48 INFO - PROCESS | 2559 | 09:23:49 INFO - TEST-INFO | 2559: exit 0 09:23:49 INFO - TEST-OK | dromaeo_css | took 1117096ms 09:23:49 INFO - TEST-START | kraken 09:23:49 INFO - operating with platform_type : linux_ 09:23:49 INFO - Initialising browser for kraken test... 09:23:49 INFO - TEST-INFO | started process 2899 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYqzQp0/profile http://localhost:60856/getInfo.html) 09:23:54 INFO - PROCESS | 2899 | __metrics Screen width/height:1600/1200 09:23:54 INFO - PROCESS | 2899 | colorDepth:24 09:23:54 INFO - PROCESS | 2899 | Browser inner width/height: 1024/697 09:23:54 INFO - PROCESS | 2899 | __metrics 09:23:54 ERROR - PROCESS | 2899 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 09:23:55 INFO - TEST-INFO | 2899: exit 0 09:23:55 INFO - Browser initialized. 09:23:55 INFO - Running cycle 1/1 for kraken test... 09:23:55 INFO - TEST-INFO | started process 3023 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYqzQp0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:24:07 INFO - PROCESS | 3023 | RSS: Main: 168079360 09:24:07 INFO - PROCESS | 3023 | 09:24:10 INFO - PROCESS | 3023 | Cycle 1(1): loaded http://localhost:60856/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60856/tests/kraken/driver.html?testName=audio-beat-detection) 09:24:11 INFO - PROCESS | 3023 | RSS: Main: 173342720 09:24:11 INFO - PROCESS | 3023 | 09:24:13 INFO - PROCESS | 3023 | Cycle 1(1): loaded http://localhost:60856/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60856/tests/kraken/driver.html?testName=audio-dft) 09:24:14 INFO - PROCESS | 3023 | RSS: Main: 172867584 09:24:14 INFO - PROCESS | 3023 | 09:24:17 INFO - PROCESS | 3023 | Cycle 1(1): loaded http://localhost:60856/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60856/tests/kraken/driver.html?testName=audio-fft) 09:24:18 INFO - PROCESS | 3023 | RSS: Main: 167698432 09:24:18 INFO - PROCESS | 3023 | 09:24:20 INFO - PROCESS | 3023 | Cycle 1(1): loaded http://localhost:60856/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60856/tests/kraken/driver.html?testName=audio-oscillator) 09:24:21 INFO - PROCESS | 3023 | RSS: Main: 168173568 09:24:21 INFO - PROCESS | 3023 | 09:24:23 INFO - PROCESS | 3023 | Cycle 1(1): loaded http://localhost:60856/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60856/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:24:23 INFO - PROCESS | 3023 | RSS: Main: 168124416 09:24:23 INFO - PROCESS | 3023 | 09:24:27 INFO - PROCESS | 3023 | Cycle 1(1): loaded http://localhost:60856/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60856/tests/kraken/driver.html?testName=imaging-darkroom) 09:24:27 INFO - PROCESS | 3023 | RSS: Main: 168456192 09:24:27 INFO - PROCESS | 3023 | 09:24:31 INFO - PROCESS | 3023 | Cycle 1(1): loaded http://localhost:60856/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60856/tests/kraken/driver.html?testName=imaging-desaturate) 09:24:31 INFO - PROCESS | 3023 | RSS: Main: 166277120 09:24:31 INFO - PROCESS | 3023 | 09:24:34 INFO - PROCESS | 3023 | Cycle 1(1): loaded http://localhost:60856/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60856/tests/kraken/driver.html?testName=json-parse-financial) 09:24:35 INFO - PROCESS | 3023 | RSS: Main: 168026112 09:24:35 INFO - PROCESS | 3023 | 09:24:37 INFO - PROCESS | 3023 | Cycle 1(1): loaded http://localhost:60856/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60856/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:24:37 INFO - PROCESS | 3023 | RSS: Main: 168316928 09:24:37 INFO - PROCESS | 3023 | 09:24:39 INFO - PROCESS | 3023 | Cycle 1(1): loaded http://localhost:60856/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60856/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:24:40 INFO - PROCESS | 3023 | RSS: Main: 168333312 09:24:40 INFO - PROCESS | 3023 | 09:24:42 INFO - PROCESS | 3023 | Cycle 1(1): loaded http://localhost:60856/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60856/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:24:43 INFO - PROCESS | 3023 | RSS: Main: 168796160 09:24:43 INFO - PROCESS | 3023 | 09:24:46 INFO - PROCESS | 3023 | Cycle 1(1): loaded http://localhost:60856/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60856/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:24:46 INFO - PROCESS | 3023 | RSS: Main: 168800256 09:24:46 INFO - PROCESS | 3023 | 09:24:49 INFO - PROCESS | 3023 | Cycle 1(1): loaded http://localhost:60856/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60856/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:24:50 INFO - PROCESS | 3023 | RSS: Main: 168091648 09:24:50 INFO - PROCESS | 3023 | 09:24:52 INFO - PROCESS | 3023 | Cycle 1(1): loaded http://localhost:60856/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60856/tests/kraken/driver.html?testName=ai-astar) 09:24:52 INFO - PROCESS | 3023 | RSS: Main: 169185280 09:24:52 INFO - PROCESS | 3023 | 09:24:52 INFO - PROCESS | 3023 | __start_tp_report 09:24:52 INFO - PROCESS | 3023 | _x_x_mozilla_page_load 09:24:52 INFO - PROCESS | 3023 | _x_x_mozilla_page_load_details 09:24:52 INFO - PROCESS | 3023 | |i|pagename|runs| 09:24:52 INFO - PROCESS | 3023 | |0;ai-astar;115;107;112;114;113;113;114;113;113;115 09:24:52 INFO - PROCESS | 3023 | |1;audio-beat-detection;156;131;162;176;133;162;159;137;205;138 09:24:52 INFO - PROCESS | 3023 | |2;audio-dft;161;163;165;178;163;164;163;162;161;164 09:24:52 INFO - PROCESS | 3023 | |3;audio-fft;76;79;76;180;77;76;75;76;161;78 09:24:52 INFO - PROCESS | 3023 | |4;audio-oscillator;90;87;144;86;86;86;131;86;86;142 09:24:52 INFO - PROCESS | 3023 | |5;imaging-gaussian-blur;118;122;117;117;117;118;118;118;118;117 09:24:52 INFO - PROCESS | 3023 | |6;imaging-darkroom;147;148;147;147;147;148;147;146;147;147 09:24:52 INFO - PROCESS | 3023 | |7;imaging-desaturate;96;95;95;95;97;97;96;97;96;96 09:24:52 INFO - PROCESS | 3023 | |8;json-parse-financial;64;64;65;65;74;65;65;64;65;66 09:24:52 INFO - PROCESS | 3023 | |9;json-stringify-tinderbox;65;65;69;65;65;66;66;66;66;66 09:24:52 INFO - PROCESS | 3023 | |10;stanford-crypto-aes;83;85;83;85;85;86;85;86;108;92 09:24:52 INFO - PROCESS | 3023 | |11;stanford-crypto-ccm;134;134;133;134;134;135;150;147;150;145 09:24:52 INFO - PROCESS | 3023 | |12;stanford-crypto-pbkdf2;172;171;170;166;171;178;171;178;170;167 09:24:52 INFO - PROCESS | 3023 | |13;stanford-crypto-sha256-iterative;69;69;71;71;69;67;67;67;66;66 09:24:52 INFO - PROCESS | 3023 | __end_tp_report 09:24:52 INFO - PROCESS | 3023 | __start_cc_report 09:24:52 INFO - PROCESS | 3023 | _x_x_mozilla_cycle_collect,990 09:24:52 INFO - PROCESS | 3023 | __end_cc_report 09:24:52 INFO - PROCESS | 3023 | __startTimestamp1464971092323__endTimestamp 09:24:52 INFO - PROCESS | 3023 | 09:24:52 INFO - PROCESS | 3023 | ------- Summary: start ------- 09:24:52 INFO - PROCESS | 3023 | Number of tests: 14 09:24:52 INFO - PROCESS | 3023 | 09:24:52 INFO - PROCESS | 3023 | [#0] ai-astar Cycles:10 Average:112.90 Median:113.50 stddev:2.28 (2.0%) stddev-sans-first:2.29 09:24:52 INFO - PROCESS | 3023 | Values: 115.0 107.0 112.0 114.0 113.0 113.0 114.0 113.0 113.0 115.0 09:24:52 INFO - PROCESS | 3023 | 09:24:52 INFO - PROCESS | 3023 | [#1] audio-beat-detection Cycles:10 Average:155.90 Median:160.50 stddev:22.90 (14.3%) stddev-sans-first:24.29 09:24:52 INFO - PROCESS | 3023 | Values: 156.0 131.0 162.0 176.0 133.0 162.0 159.0 137.0 205.0 138.0 09:24:52 INFO - PROCESS | 3023 | 09:24:52 INFO - PROCESS | 3023 | [#2] audio-dft Cycles:10 Average:164.40 Median:163.50 stddev:4.95 (3.0%) stddev-sans-first:5.09 09:24:52 INFO - PROCESS | 3023 | Values: 161.0 163.0 165.0 178.0 163.0 164.0 163.0 162.0 161.0 164.0 09:24:52 INFO - PROCESS | 3023 | 09:24:52 INFO - PROCESS | 3023 | [#3] audio-fft Cycles:10 Average:95.40 Median:76.00 stddev:39.85 (52.4%) stddev-sans-first:41.64 09:24:52 INFO - PROCESS | 3023 | Values: 76.0 79.0 76.0 180.0 77.0 76.0 75.0 76.0 161.0 78.0 09:24:52 INFO - PROCESS | 3023 | 09:24:52 INFO - PROCESS | 3023 | [#4] audio-oscillator Cycles:10 Average:102.40 Median:86.00 stddev:25.50 (29.7%) stddev-sans-first:26.65 09:24:52 INFO - PROCESS | 3023 | Values: 90.0 87.0 144.0 86.0 86.0 86.0 131.0 86.0 86.0 142.0 09:24:52 INFO - PROCESS | 3023 | 09:24:52 INFO - PROCESS | 3023 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:1.49 (1.3%) stddev-sans-first:1.58 09:24:52 INFO - PROCESS | 3023 | Values: 118.0 122.0 117.0 117.0 117.0 118.0 118.0 118.0 118.0 117.0 09:24:52 INFO - PROCESS | 3023 | 09:24:52 INFO - PROCESS | 3023 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 09:24:52 INFO - PROCESS | 3023 | Values: 147.0 148.0 147.0 147.0 147.0 148.0 147.0 146.0 147.0 147.0 09:24:52 INFO - PROCESS | 3023 | 09:24:52 INFO - PROCESS | 3023 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 09:24:52 INFO - PROCESS | 3023 | Values: 96.0 95.0 95.0 95.0 97.0 97.0 96.0 97.0 96.0 96.0 09:24:52 INFO - PROCESS | 3023 | 09:24:52 INFO - PROCESS | 3023 | [#8] json-parse-financial Cycles:10 Average:65.70 Median:65.00 stddev:2.98 (4.6%) stddev-sans-first:3.10 09:24:52 INFO - PROCESS | 3023 | Values: 64.0 64.0 65.0 65.0 74.0 65.0 65.0 64.0 65.0 66.0 09:24:52 INFO - PROCESS | 3023 | 09:24:52 INFO - PROCESS | 3023 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:1.20 (1.8%) stddev-sans-first:1.22 09:24:52 INFO - PROCESS | 3023 | Values: 65.0 65.0 69.0 65.0 65.0 66.0 66.0 66.0 66.0 66.0 09:24:52 INFO - PROCESS | 3023 | 09:24:52 INFO - PROCESS | 3023 | [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:85.00 stddev:7.52 (8.9%) stddev-sans-first:7.78 09:24:52 INFO - PROCESS | 3023 | Values: 83.0 85.0 83.0 85.0 85.0 86.0 85.0 86.0 108.0 92.0 09:24:52 INFO - PROCESS | 3023 | 09:24:52 INFO - PROCESS | 3023 | [#11] stanford-crypto-ccm Cycles:10 Average:139.60 Median:140.00 stddev:7.38 (5.3%) stddev-sans-first:7.55 09:24:52 INFO - PROCESS | 3023 | Values: 134.0 134.0 133.0 134.0 134.0 135.0 150.0 147.0 150.0 145.0 09:24:52 INFO - PROCESS | 3023 | 09:24:52 INFO - PROCESS | 3023 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.40 Median:171.00 stddev:3.95 (2.3%) stddev-sans-first:4.18 09:24:52 INFO - PROCESS | 3023 | Values: 172.0 171.0 170.0 166.0 171.0 178.0 171.0 178.0 170.0 167.0 09:24:52 INFO - PROCESS | 3023 | 09:24:52 INFO - PROCESS | 3023 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:69.00 stddev:1.87 (2.7%) stddev-sans-first:1.96 09:24:52 INFO - PROCESS | 3023 | Values: 69.0 69.0 71.0 71.0 69.0 67.0 67.0 67.0 66.0 66.0 09:24:52 INFO - PROCESS | 3023 | -------- Summary: end -------- 09:24:52 INFO - PROCESS | 3023 | 09:24:53 INFO - TEST-INFO | 3023: exit 0 09:24:53 INFO - TEST-OK | kraken | took 64220ms 09:24:53 INFO - SUITE-END | took 1181s 09:24:53 INFO - Completed test suite (00:19:41) 09:24:53 INFO - javascript benchmark 09:24:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6365.355250778195, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2684.9731502684967, 2691.636629055078, 2694.178275625933, 2698.419839734457, 2725.918222453327, 4776.331313616097, 4787.976060119703, 4790.592799612033, 4811.821103829567, 4824.252240902657, 4671.416072990876, 4764.666473346859, 4770.904581908359, 4783.258594917794, 4796.760161991904, 4347.5652434756585, 4373.693841431085, 4440.666949978749, 4475.7985890635, 4480.417545719052, 4433.933490997621, 4519.254323036695, 4523.570260825217, 4534.8866278342975, 4549.090181963604, 4300.311950088002, 4318.2227199104145, 4351.260285751398, 4443.111377724468, 4510.639148868083, 4384.693071484998, 4385.3641222022625, 4404.163208990281, 4452.577005184502, 4461.330800379969, 4402.823887044515, 4403.119376124756, 4424.247877860739, 4445.266531022377, 4465.754383508905, 4658.301254811771, 4692.319613656035, 4703.2239680452685, 4716.268978308368, 4770.76146192689, 5106.64253502255, 5107.233914912756, 5125.641205115643, 5134.589232861362, 5135.35808023997, 5161.5870730341485, 5168.121419358718, 5170.741462926876, 5174.353205849269, 5182.559482443997, 4849.442314133885, 4882.5605695487575, 4894.1679914414635, 4897.7795999180125, 4923.064617722621, 5296.25852380667, 5342.198670199424, 5347.679139251657, 5357.678539287655, 5439.0, 4937.382827146606, 4939.975300123477, 4967.279744437036, 5097.515736005073, 5144.6655967362, 5057.620678449058, 5058.772355244023, 5061.0, 5076.974615126975, 5091.261767043758, 4953.0, 5050.166722490748, 5053.0904437200925, 5076.289319495274, 5107.514786095315, 4916.336294600254, 5037.0, 5064.063148317573, 5079.1365467870555, 5089.414717307557, 4346.304591265382, 4352.869413917588, 4353.521112677603, 4390.297552391602, 4407.272799987966, 3778.1876896467393, 3819.6562309391734, 3829.904252393657, 3845.730798844054, 3887.533495980444, 4239.97880010598, 4310.935335969963, 4390.648748100144, 4427.867163985085, 4464.441944756905, 5171.0, 5171.172612382001, 5184.351956005499, 5197.558207552324, 5253.369595648546, 4448.911021779546, 4452.5992660660695, 4457.130859482435, 4466.330050492452, 4529.207388706963, 4527.456705195332, 4576.084783043405, 4587.495375508692, 4624.95375046252, 4638.350630911675, 4828.275758636162, 4837.685550439211, 4851.0, 4859.2954021665955, 4885.438174609965, 5119.180931051014, 5148.253503242084, 5155.046316431472, 5160.251763494197, 5225.686458812484, 4789.0, 4825.831095911767, 4855.295982082649, 4868.805247790048, 4891.779869905934, 5037.0, 5045.596352291735, 5068.467810879804, 5088.898222035465, 5122.359705036871, 5027.7737501813235, 5198.6880787152895, 5210.505002024802, 5213.13983192769, 5215.322008138917, 4843.2735089736825, 4873.658843881036, 4901.436334821398, 4994.1759609663995, 5019.62352823547, 4942.75286235694, 4944.01119776039, 4951.455339912534, 4960.107180707508, 4963.429205641253, 4823.5658790709, 4848.878778030577, 4860.149473842134, 4860.6111511079735, 4866.659333846596, 4921.409430868319, 4978.775955082103, 4999.925001124913, 5007.724575148256, 5061.544460998528, 4930.704157750546, 4931.2849636803185, 4966.056449274771, 4981.2030075187795, 5020.949790502194], "value": 4710.359423938885, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [524.0979468030984, 592.3395414113263, 597.8983572792624, 606.7603296697805, 621.9440250377465, 34948.30103397934, 40338.7983060085, 40501.39247911284, 40597.79701101494, 40629.0, 41551.37672934901, 42121.57878421215, 42131.368029479585, 42188.0, 42230.366544501856, 7803.648835802388, 8021.157778433268, 8021.39839512036, 8022.318102961255, 8031.558264295461, 7774.766756997299, 7801.0, 7844.646990885395, 7858.803529911769, 7867.960660196691, 7779.105402878657, 7850.214978502161, 7866.646000929972, 7867.960660196691, 7885.723999660013, 7779.922200777976, 7811.726589569366, 7838.804029899298, 7854.646540905673, 7861.528308301492, 7693.115291741466, 7706.7669172932065, 7722.613869306512, 7751.728689495897, 7790.065192176975, 38213.235735285416, 38344.616553834385, 38545.421818672745, 38685.0, 38688.0, 3004.9098527044007, 3083.1521331633758, 3145.766505780898, 3201.487761958099, 3594.6944509716704, 29820.70179298201, 29847.70152298471, 30098.54852177219, 30109.247268818235, 30455.0, 2984.224101733543, 2989.9551506727416, 3008.3080891394884, 3033.9544906826413, 3065.3103051813387, 255773.0, 257107.0, 258107.0, 258290.9999999981, 258400.0, 28636.14091577256, 29220.707792922225, 54061.1890821638, 54306.45693543093, 54631.72684136633, 34846.0, 35065.649343506746, 35092.473612895825, 35307.4703879442, 35333.46999795005, 13427.597172084854, 13476.258805765778, 13571.52499662507, 13648.65878353049, 13656.385462654205, 10775.084117849914, 10860.022597966221, 10880.12958963281, 10884.455777211107, 10890.564377424973, 8019.518828870287, 8044.517328960281, 8067.959660201779, 8086.312663423675, 8151.959240203761, 3101.9379612407624, 3148.1185268124964, 3172.5082612195147, 3183.7771356004855, 3188.12958075348, 874.8950125984923, 934.4813628436283, 979.1921664626711, 996.7956568903357, 1001.1340190735108, 26878.731212687624, 27597.172084837486, 27615.447691046065, 27668.30829229245, 27999.580006299922, 1030.9381437113798, 1049.4385503755454, 1053.961847580133, 1063.6702622187147, 1107.4850194659523, 14735.336909838868, 14948.0, 15325.708701851658, 15348.386064557517, 15446.459373922084, 375125.0, 375852.0, 377712.0, 378574.0, 380543.0, 50889.745551272004, 51650.74174629103, 51832.99999999924, 51868.740656296475, 51936.74031629818, 1208.4682440846825, 1208.4924331780674, 1211.3216598704753, 1234.2101055324779, 1240.0389697983953, 26591.60112598274, 28274.71725282721, 28473.43053138967, 29026.854865725538, 29056.7094329054, 44563.331550027426, 44626.3306050416, 44711.55288447074, 44757.32864007108, 44967.32549011833, 273592.0, 277433.0, 278171.0, 278345.0, 278852.0, 25925.740742593087, 26063.218103456926, 26703.59944600794, 26812.865935670197, 26818.195454136407, 44352.11295774131, 44654.553454465036, 44780.0, 44800.0, 44988.32517512306, 38292.42561361526, 38466.615333846305, 38470.80764596159, 38866.506043368696, 40292.79853600713, 37458.6254137466, 37656.81171594124, 37783.81108094442, 37848.0, 37874.62125378711, 31876.36247275088, 37550.0, 38007.80996095002, 39681.80159099186, 40052.399214012396, 33220.50169247512, 33329.333413331115, 34602.30795384028, 34851.65148348585, 34908.82545587256, 24776.50446991014, 25364.11225607095, 25569.872150639127, 25626.103086391886, 25641.743582563937], "value": 16669.636866311736, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.2002115367347, 369.2670049950848, 369.6137536274593, 375.96052414496495, 384.6442041111971, 15613.21933903306, 16581.253843577037, 17052.14739263035, 17236.655266894653, 17305.74041389377, 14092.224927629002, 15122.470713525028, 15396.461123860667, 15409.537713868602, 15456.845431545682, 4876.512348765131, 5079.517445842639, 5086.160783470741, 5088.0, 5105.872353191163, 3721.0, 5003.674761140533, 5605.523530499912, 5940.792072277472, 5944.197533332988, 5950.732217050221, 5953.58324917256, 5971.641701497902, 5986.940130598704, 6018.6689732064715, 5700.600957932947, 5840.153177789218, 5875.941240587582, 5893.823185304448, 5922.378150294243, 4571.337156112345, 5175.404828444702, 5184.170532714747, 5198.92201616976, 5207.583393328562, 11545.480453379618, 12203.45084471201, 12298.385080745928, 12305.569305074368, 12312.938435307855, 1728.8616910647117, 1796.8113348098523, 1814.4647329037966, 1822.9088545572667, 1835.2565063190023, 8497.660093596249, 8585.31317494599, 8722.607482663296, 8939.463632182025, 9089.681861134828, 1560.0327796766078, 1668.5995361113366, 1723.8448539631368, 1757.1741281597629, 1766.7703198584231, 65763.67118164427, 66489.66755166241, 67456.3254367455, 68831.0, 70328.0, 9634.566444510014, 10151.94924025375, 10167.847482287772, 10326.896731032593, 10900.236983411243, 13956.162630242217, 13992.720145597235, 13998.580042598738, 14012.859871401155, 14063.156210627396, 6974.651267436608, 7060.505764596429, 7084.893726594105, 7129.251428600026, 7139.500234983605, 6509.739610415625, 6589.110470086573, 6594.07682924391, 6654.068430419745, 6668.499862510331, 4257.74453532789, 4298.570142985676, 4362.716423432466, 4378.299472084451, 4426.15902978433, 1692.6868529322114, 1713.4773893962213, 1759.8064212936567, 1795.398541488616, 1801.4235444657584, 366.3917896292142, 388.2254901471582, 390.27993352265025, 850.2093053460342, 860.694453469022, 10066.345687530287, 10476.423796691102, 15319.46381876629, 16556.50330490087, 16678.33286668544, 867.9696210632598, 890.3633901760143, 930.1442672741094, 937.7936853892132, 983.7098056073476, 8829.69096081634, 9346.0653934606, 9400.858987115198, 9409.01205373426, 9545.47499887499, 375438.0, 377386.0, 378848.0, 379782.0, 379894.0, 77777.61111194408, 77879.22120778833, 80350.19649803544, 80455.19544804594, 82098.17901821024, 971.8056388722142, 973.6446197137993, 984.3700031979539, 984.5225065843204, 990.955407006672, 14943.476978305707, 14967.101973881601, 15021.6995660084, 15123.98551629417, 15210.315535800693, 34709.0, 34874.82562587171, 35132.64867351396, 36345.45481817722, 36475.0, 46641.0, 48788.75605622091, 49550.256746148116, 49964.75017625034, 50447.0, 7635.88546171819, 7658.540487570764, 7675.808104797425, 7841.294283514511, 7855.175206603453, 11238.887611124112, 11551.826722599335, 11585.362805045803, 11809.468573914366, 11837.585684501, 8662.870056949025, 10108.595656173671, 10244.795104098026, 10284.948575257076, 10307.0, 9990.15083717892, 10087.193024557871, 10145.0, 10295.742606434898, 10439.94780026095, 10296.433696146485, 10298.70441458756, 10325.277230594087, 10342.638007669695, 10558.947205263925, 7734.071911370672, 7825.804354891174, 7834.843303133792, 7889.526628402315, 7958.0848202455145, 10290.536925838505, 10344.844827327746, 10403.011713887168, 10441.582336706446, 10489.0], "value": 7894.614892723719, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1333.7265860498599, 1399.1946147973313, 1449.9782503262447, 1715.9742603860952, 1725.8274172582735, 6656.966715166417, 7278.126624805024, 7358.889616655754, 7792.92207077929, 7796.571188584626, 7430.368418684418, 7665.156832748393, 7665.731699390522, 7676.38588912887, 7685.692572297102, 2119.0993827623274, 2149.3337065509663, 2164.556265965481, 2164.945876353088, 2167.7940595643468, 2089.749230092391, 2096.1720120552372, 2123.235635171337, 2131.8720876747366, 2145.9248926287582, 2086.09254974086, 2111.493241622007, 2118.9576208475823, 2123.214410668055, 2165.317924853666, 2091.9267825626107, 2097.098247753473, 2099.3177217404404, 2099.7165382673297, 2102.138123369411, 2031.5022819409191, 2100.317396846031, 2100.9474763131043, 2110.461832232771, 2116.6824976253683, 7648.847023059563, 7657.961710191469, 7670.194629563871, 7673.50122242058, 7682.731104411375, 4542.523035081302, 4617.5151609080895, 4617.953820461786, 4622.56085671864, 4659.138059458977, 2829.6604407471236, 2909.6799352071257, 2943.7644988400875, 2965.688602696707, 2971.6136902202793, 905.3571963905634, 908.7591788176138, 922.1746536849549, 954.4798085043668, 958.8801399825022, 10703.304285221435, 10706.892931070668, 10723.624673136403, 10736.892631073668, 10773.892261077446, 4185.058361868555, 4277.465316835395, 4288.699791014599, 4335.631471324909, 4375.16871794358, 9160.404573702688, 9179.495127768037, 9214.216791572657, 9216.078392160864, 9251.398659087272, 4543.818247270072, 4606.332081848113, 4634.165850147006, 4635.582797548237, 4637.234856248681, 3623.3840247158046, 4007.719459637797, 4137.048478849882, 4205.642520385802, 4209.24233637942, 3597.712183025404, 3635.1820840311248, 3711.5917249102577, 3744.3821769408287, 3857.5370955485523, 1143.1883362812496, 1151.3207207747469, 1152.9192956492966, 1153.8788427215022, 1154.8440960470398, 861.9138086191456, 876.785187629035, 889.6263569300909, 890.3811850763657, 899.4378513429107, 5436.510714035756, 5462.317210348707, 5609.523190528769, 5734.885302293931, 5741.024025915521, 891.6968230801558, 900.8603666431713, 905.922996545301, 909.0138048364345, 959.9760005999766, 3681.834317455721, 3846.8653597124526, 3895.2014836958356, 3921.313770090223, 3934.1738234970403, 9621.0, 9907.0, 9962.55168517404, 9967.252456065824, 10003.44981026036, 8964.8655270171, 9300.953495232481, 9824.803503929881, 9934.304598678023, 10021.39871607706, 7352.926470735331, 7463.888041679379, 7525.247475252431, 7541.622918854145, 7547.73582924595, 5382.623216374816, 5574.92675696246, 5623.803166889139, 5721.5136713379825, 5830.300363956352, 8754.0, 9020.503872287087, 9023.4134781239, 9261.53692315368, 9286.860697089414, 9245.72262832116, 9259.583318750538, 9375.671851485165, 9391.765205869908, 9507.572159252988, 5972.671503067373, 6251.593646412968, 6301.8109456716375, 6420.069089981833, 6527.902081468686, 7642.770716878503, 7679.232076792276, 7715.382769378324, 7737.14891361961, 7748.0, 6605.207375114825, 6806.489513286424, 6849.2808255132495, 6940.652967351713, 6963.1644202696, 6719.496037797283, 6811.284815094344, 6877.690503927435, 6883.449324053963, 6904.654767261717, 6006.189164462917, 6182.814515564541, 6232.906506402317, 6388.840278992877, 6420.426995385974, 4576.954230457653, 4610.0, 4640.350350950937, 4691.554302341272, 4702.600278976189, 4573.565511276423, 4583.564561366665, 4627.07458508293, 4695.0, 4713.2223183175765], "value": 4171.198524557877, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.82198625858837, 289.784110837426, 292.8067475466192, 293.15132690859974, 296.2120758781641, 4943.134951383511, 4979.950200497999, 5000.849974500762, 5018.84943451697, 5025.1708468102715, 4932.975335123319, 4941.258811178325, 4952.554270115689, 4957.801687932479, 4970.757310672332, 3658.5792633847113, 3739.2708421857747, 3838.9808050959705, 3852.1717830666403, 3861.3242682530445, 3851.8844434667003, 3863.613638636142, 3870.845166193349, 3877.418387241908, 3879.4374815651713, 3797.468354430382, 3806.8667596634123, 3812.2375524895133, 3829.9234015319676, 3844.1158533537305, 3772.0, 3810.4914281205038, 3830.1765120499085, 3840.829931088954, 3858.6913046956315, 3328.417526932801, 3355.7248245666733, 3376.206591451007, 3385.8137802420856, 3387.254803943153, 4669.743164125972, 4677.2750223715375, 4696.506866778973, 4705.435347758291, 4724.527547245282, 4416.514183439819, 4416.668749843742, 4420.8673739787855, 4436.201483732927, 4438.4451943507065, 4956.801727930879, 5121.871953201163, 5136.64043516954, 5145.6296126037505, 5165.276861239429, 3682.4660424238336, 3706.2587482503336, 3708.6291370862696, 3708.796016219107, 3717.6282371762877, 5436.320459942507, 5445.373782015079, 5458.344998600153, 5476.342838859362, 5533.727242734194, 3463.3246516928957, 3685.9631403686158, 3692.372296709566, 3695.5750088740137, 3844.2888065707375, 3734.141147536028, 3742.3825068863875, 3743.8689645862264, 3746.2882052409955, 3749.1564398010773, 4303.311470164758, 4303.419038429772, 4308.870733877989, 4313.835264478574, 4322.675799315001, 5133.25567792668, 5200.6619569727845, 5212.0, 5229.267902493654, 5254.054270231395, 1298.5909438526835, 1300.0964329790704, 1301.635542048228, 1319.4524272426836, 1323.0936808286356, 775.6199462263563, 796.7012370361115, 805.7743831727125, 808.9069756977905, 809.7692157735017, 4383.610932042045, 4580.564846339659, 4583.2666773316105, 4588.770561471913, 4604.332371806069, 5419.485148910847, 5426.158945363475, 5426.538744206787, 5430.9185362218805, 5451.918221226685, 4313.956860431355, 4498.347739577743, 4507.18870603288, 4545.2954792007295, 4597.954020459752, 2860.4565132624734, 2860.728230818069, 2875.92810179743, 2878.29481776966, 2894.3921776426764, 4964.851054468371, 4979.502049794992, 5003.4746351633285, 5032.547070763576, 5043.87390315245, 5163.302954101224, 5440.782368705287, 5451.836444906659, 5457.426970168154, 5568.192612071227, 5039.874003149877, 5040.31955685985, 5052.343195384577, 5056.949430505648, 5098.1588037973315, 5425.945740542702, 5454.236406903116, 5455.481729235717, 5460.31746031746, 5464.743109085012, 5203.271541984201, 5303.886183901424, 5320.122179840438, 5335.893282134413, 5338.626296159232, 5018.824341148043, 5032.974835125948, 5061.190209566452, 5079.222272204699, 5094.2867998479505, 3701.056230661164, 3728.925421491609, 3744.9139749472347, 3749.231407561389, 3760.473533705229, 5318.308619879545, 5351.919721204263, 5380.650257733235, 5390.649607775482, 5472.905418916153, 5216.843494695166, 5255.947440525546, 5266.42069372361, 5266.73666316675, 5272.525472707474, 5279.920801187908, 5290.6032047597355, 5296.735163241746, 5309.734513274244, 5314.123169677115, 4931.260310953386, 5090.389153301628, 5145.331106956071, 5155.2782610433815, 5163.896722065462, 5013.470891378165, 5083.38999320084, 5263.157894736823, 5285.920711189412, 5286.7356632169, 5136.768845401891, 5139.820106296262, 5142.202958541432, 5145.224897410388, 5154.072266991978], "value": 3891.82072650591, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [618.1284389011495, 660.5805313625846, 671.8656268746251, 703.4864548879318, 721.46251042973, 11684.883151168486, 12147.149699521036, 12370.07224458166, 12418.875811241885, 12672.68318292041, 12591.999999999976, 12613.4323955422, 13038.674033149176, 13067.803982940264, 13596.18422894627, 628.745358129958, 782.5774081995716, 809.7570728781342, 812.8252425728452, 817.0358976407837, 809.4617079642031, 813.0893399392688, 814.9348052155814, 815.8449894520022, 816.1878930464196, 852.4799872078028, 858.935579831512, 860.2086080805674, 860.3074525007366, 863.3481721300409, 845.1337379186352, 849.1254008371357, 852.4459101583958, 854.0, 855.5978690015683, 620.3362402229616, 622.7695752571577, 622.8536293970914, 624.9375062493714, 625.1248252446566, 13795.517156899561, 13842.100263482842, 13854.861451385457, 13856.307184640727, 13896.444142234399, 12925.289109098996, 13249.13880597758, 13284.667883302898, 13427.86572134276, 13433.865661343458, 10283.177345812317, 10438.373697578094, 10480.94759526205, 10553.41956192409, 10616.469176541143, 3230.194824538764, 3272.280098378353, 3279.7048265656204, 3323.0529299149625, 3342.6991570758505, 65871.341286587, 65930.3406965929, 66197.66901165464, 66214.33785662129, 66691.0, 10175.440350780778, 10356.223283253636, 10413.895861041445, 10455.268131230741, 10797.924975261614, 19124.0, 19256.133473993705, 19269.710954335416, 19305.51736206606, 19414.902925485283, 6481.384268494486, 6591.143151390384, 6651.301613330627, 6719.731210751515, 6756.628385438848, 3726.8136593170234, 3753.642859994387, 3789.6399842014966, 3820.9235815284096, 3830.8467661293794, 2912.6796052434215, 3025.198322444554, 3077.707617776308, 3085.645150807641, 3085.876564937377, 519.97920083197, 530.2894121876703, 552.1276383314354, 585.7861880413618, 592.410551501259, 594.432317137133, 596.8716725903952, 608.1394826320707, 630.3255516597197, 639.0063451333128, 8628.870566941501, 8665.35009874262, 8725.650973961097, 8771.956140219258, 9027.954860225787, 632.7216024949008, 639.8080575827233, 659.9538032337787, 668.0480315550321, 668.9230738465042, 4250.808713607895, 4280.957190428118, 4291.356296555479, 4314.633256173261, 4343.4136391586735, 85687.0, 96557.51721241348, 97486.0, 98548.50725746325, 100832.0, 80968.59515702384, 85209.0, 85420.0, 86108.0, 86499.0, 49845.75077124664, 66705.0, 79153.60423197963, 80321.59839200767, 80848.0, 7928.326092282221, 8169.2647661710735, 8211.753647390588, 8235.83528329442, 8348.87476687838, 45160.096798064515, 45716.0, 45931.54068459273, 45979.77010114928, 47047.764761175975, 60512.0, 61190.0, 65721.67139164274, 67257.32742672706, 68332.0, 10202.591896324064, 10359.0, 10377.792444151226, 10396.636117735843, 10569.682909512727, 10893.56425742993, 11027.283226590245, 11122.165837562054, 11282.210245282751, 11700.941495292469, 10956.397398143179, 11086.556537738401, 11205.60780372683, 11336.0, 11383.373914434786, 10867.184961127788, 11114.777704445703, 11455.94272028668, 11490.94254528722, 12043.217190882564, 10919.945400273265, 11073.511269217532, 11197.216194866607, 11224.270422422516, 11251.437428128396, 8844.159804818531, 9075.773105672411, 9079.228265597498, 9102.635894564144, 9141.222996045144, 9045.819083618422, 9460.337776355589, 9573.0, 9671.516424178904, 9784.461854597781], "value": 6609.456619337459, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1590.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 107.0, 112.0, 114.0, 113.0, 113.0, 114.0, 113.0, 113.0, 115.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 131.0, 162.0, 176.0, 133.0, 162.0, 159.0, 137.0, 205.0, 138.0], "value": 155.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 165.0, 178.0, 163.0, 164.0, 163.0, 162.0, 161.0, 164.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 79.0, 76.0, 180.0, 77.0, 76.0, 75.0, 76.0, 161.0, 78.0], "value": 95.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 144.0, 86.0, 86.0, 86.0, 131.0, 86.0, 86.0, 142.0], "value": 102.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 122.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 117.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 147.0, 147.0, 148.0, 147.0, 146.0, 147.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 97.0, 97.0, 96.0, 97.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 65.0, 74.0, 65.0, 65.0, 64.0, 65.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 69.0, 65.0, 65.0, 66.0, 66.0, 66.0, 66.0, 66.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 83.0, 85.0, 85.0, 86.0, 85.0, 86.0, 108.0, 92.0], "value": 87.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 134.0, 133.0, 134.0, 134.0, 135.0, 150.0, 147.0, 150.0, 145.0], "value": 139.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 171.0, 170.0, 166.0, 171.0, 178.0, 171.0, 178.0, 170.0, 167.0], "value": 171.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 71.0, 71.0, 69.0, 67.0, 67.0, 67.0, 66.0, 66.0], "value": 68.2, "unit": "score"}]}]} 09:24:53 INFO - Return code: 0 09:24:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:24:53 ERROR - # TBPL SUCCESS # 09:24:53 INFO - Running post-action listener: _resource_record_post_action 09:24:53 INFO - ##### 09:24:53 INFO - ##### Finished run-tests step (success) 09:24:53 INFO - ##### 09:24:53 INFO - Running post-run listener: _resource_record_post_run 09:24:53 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 8192; Write bytes: 530628608; Read time: 200; Write time: 629208 09:24:53 INFO - TinderboxPrint: CPU usage
13.4% 09:24:53 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 200 09:24:53 INFO - TinderboxPrint: I/O write bytes / time
530,628,608 / 629,208 09:24:53 INFO - TinderboxPrint: CPU idle
8,274.8 (86.6%) 09:24:53 INFO - TinderboxPrint: CPU user
1,228.7 (12.9%) 09:24:53 INFO - TinderboxPrint: Swap in / out
0 / 0 09:24:53 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 249548800; Read time: 0; Write time: 387488 09:24:53 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 8192; Write bytes: 281079808; Read time: 200; Write time: 241720 09:24:54 INFO - Running post-run listener: _upload_blobber_files 09:24:54 INFO - Blob upload gear active. 09:24:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:24:54 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 09:24:54 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'] 09:24:54 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 09:24:54 INFO - (blobuploader) - INFO - Open directory for files ... 09:24:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:24:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:24:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:24:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:24:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:24:55 INFO - (blobuploader) - INFO - Done attempting. 09:24:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:24:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:24:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:24:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:24:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:24:56 INFO - (blobuploader) - INFO - Done attempting. 09:24:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:24:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:24:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:24:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:24:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:24:59 INFO - (blobuploader) - INFO - Done attempting. 09:24:59 INFO - (blobuploader) - INFO - Iteration through files over. 09:24:59 INFO - Return code: 0 09:24:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:24:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:24:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/50bfc9fcdd9016520bdd39517e8213deb5a9266d9c19ba24ff8e16489f920df8243ee30d131b1810f643bd6b5d9c3efaf7b1854cd586155720529aa2bfbe84ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c7c4f32f508153e51c4d325d19e48585a6d556e4215817c6da6e83ede9f3f4a03bcb51118c47e61768116520bb06b0cf60357bbf7dfa6dccdd4d8b4212d37364", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ef110eee31f92891ff4033fa9a03a217efe92e2494db11fd7e06a2359a77c694617159b2e0100f2c5e9d4e548fcb8d392f83a0c470241fa99f885ed559f1289d"} 09:24:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:24:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:24:59 INFO - Contents: 09:24:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/50bfc9fcdd9016520bdd39517e8213deb5a9266d9c19ba24ff8e16489f920df8243ee30d131b1810f643bd6b5d9c3efaf7b1854cd586155720529aa2bfbe84ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c7c4f32f508153e51c4d325d19e48585a6d556e4215817c6da6e83ede9f3f4a03bcb51118c47e61768116520bb06b0cf60357bbf7dfa6dccdd4d8b4212d37364", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ef110eee31f92891ff4033fa9a03a217efe92e2494db11fd7e06a2359a77c694617159b2e0100f2c5e9d4e548fcb8d392f83a0c470241fa99f885ed559f1289d"} 09:24:59 INFO - Running post-run listener: copy_logs_to_upload_dir 09:24:59 INFO - Copying logs to upload dir... 09:24:59 INFO - mkdir: /builds/slave/test/build/upload/logs 09:24:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.278126 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-03 09:24:59.920209) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 09:24:59.924044) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1464969800.823209-552753711 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/50bfc9fcdd9016520bdd39517e8213deb5a9266d9c19ba24ff8e16489f920df8243ee30d131b1810f643bd6b5d9c3efaf7b1854cd586155720529aa2bfbe84ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c7c4f32f508153e51c4d325d19e48585a6d556e4215817c6da6e83ede9f3f4a03bcb51118c47e61768116520bb06b0cf60357bbf7dfa6dccdd4d8b4212d37364", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ef110eee31f92891ff4033fa9a03a217efe92e2494db11fd7e06a2359a77c694617159b2e0100f2c5e9d4e548fcb8d392f83a0c470241fa99f885ed559f1289d"} build_url:https://queue.taskcluster.net/v1/task/HM0H6EJBShuUoJjEQqCYEA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.012414 build_url: 'https://queue.taskcluster.net/v1/task/HM0H6EJBShuUoJjEQqCYEA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/50bfc9fcdd9016520bdd39517e8213deb5a9266d9c19ba24ff8e16489f920df8243ee30d131b1810f643bd6b5d9c3efaf7b1854cd586155720529aa2bfbe84ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c7c4f32f508153e51c4d325d19e48585a6d556e4215817c6da6e83ede9f3f4a03bcb51118c47e61768116520bb06b0cf60357bbf7dfa6dccdd4d8b4212d37364", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ef110eee31f92891ff4033fa9a03a217efe92e2494db11fd7e06a2359a77c694617159b2e0100f2c5e9d4e548fcb8d392f83a0c470241fa99f885ed559f1289d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 09:24:59.952033) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 09:24:59.952426) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1464969800.823209-552753711 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 09:25:00.035871) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 09:25:00.036241) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 09:25:00.036643) ========= ========= Total master_lag: 0.19 =========