builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-038 starttime: 1465953524.11 results: success (0) buildid: 20160614170925 builduid: 694114dbed4d4e6889572070acf6230b revision: 53f5b5c289fba6ad82c675578cf1c548ae37f0c1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-14 18:18:44.106232) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-14 18:18:44.106713) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-14 18:18:44.106993) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-14 18:18:44.122093) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 18:18:44.122471) ========= 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=8783db0840cc980e80bb0bd400000236-1465953523.624962-904656020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-14 18:18:44-- 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% 5.81M=0.002s 2016-06-14 18:18:44 (5.81 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114579 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 18:18:44.251004) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 18:18:44.251318) ========= 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=8783db0840cc980e80bb0bd400000236-1465953523.624962-904656020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014792 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 18:18:44.301466) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-14 18:18:44.301824) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 53f5b5c289fba6ad82c675578cf1c548ae37f0c1 --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 53f5b5c289fba6ad82c675578cf1c548ae37f0c1 --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=8783db0840cc980e80bb0bd400000236-1465953523.624962-904656020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-14 18:18:44,496 truncating revision to first 12 chars 2016-06-14 18:18:44,496 Setting DEBUG logging. 2016-06-14 18:18:44,496 attempt 1/10 2016-06-14 18:18:44,496 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/53f5b5c289fb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-14 18:18:45,624 unpacking tar archive at: fx-team-53f5b5c289fb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.482630 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-14 18:18:45.798293) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-14 18:18:45.798643) ========= script_repo_revision: 53f5b5c289fba6ad82c675578cf1c548ae37f0c1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-14 18:18:45.799043) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-14 18:18:45.799316) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-14 18:18:45.809528) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-14 18:18:45.809798) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1465953523.624962-904656020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:18:46 INFO - MultiFileLogger online at 20160614 18:18:46 in /builds/slave/test 18:18:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 18:18:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:18:46 INFO - {'append_to_log': False, 18:18:46 INFO - 'base_work_dir': '/builds/slave/test', 18:18:46 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 18:18:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:18:46 INFO - 'branch': 'Fx-Team-Non-PGO', 18:18:46 INFO - 'buildbot_json_path': 'buildprops.json', 18:18:46 INFO - 'config_files': ('talos/linux_config.py',), 18:18:46 INFO - 'default_actions': ('clobber', 18:18:46 INFO - 'read-buildbot-config', 18:18:46 INFO - 'download-and-extract', 18:18:46 INFO - 'populate-webroot', 18:18:46 INFO - 'create-virtualenv', 18:18:46 INFO - 'install', 18:18:46 INFO - 'run-tests'), 18:18:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:18:46 INFO - 'download_minidump_stackwalk': True, 18:18:46 INFO - 'download_symbols': 'ondemand', 18:18:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:18:46 INFO - 'tooltool.py': '/tools/tooltool.py', 18:18:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:18:46 INFO - '/tools/misc-python/virtualenv.py')}, 18:18:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:18:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:18:46 INFO - 'installer_path': 'installer.exe', 18:18:46 INFO - 'log_level': 'info', 18:18:46 INFO - 'log_name': 'talos', 18:18:46 INFO - 'log_to_console': True, 18:18:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:18:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:18:46 INFO - 'opt_config_files': (), 18:18:46 INFO - 'pip_index': False, 18:18:46 INFO - 'sps_profile': False, 18:18:46 INFO - 'sps_profile_interval': 0, 18:18:46 INFO - 'suite': 'dromaeojs', 18:18:46 INFO - 'system_bits': '32', 18:18:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:18:46 INFO - 'title': 'talos-linux64-ix-038', 18:18:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:18:46 INFO - 'use_talos_json': True, 18:18:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:18:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:18:46 INFO - 'work_dir': 'build'} 18:18:46 INFO - ##### 18:18:46 INFO - ##### Running clobber step. 18:18:46 INFO - ##### 18:18:46 INFO - Running pre-action listener: _resource_record_pre_action 18:18:46 INFO - Running main action method: clobber 18:18:46 INFO - rmtree: /builds/slave/test/build 18:18:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:18:47 INFO - Running post-action listener: _resource_record_post_action 18:18:47 INFO - ##### 18:18:47 INFO - ##### Finished clobber step (success) 18:18:47 INFO - ##### 18:18:47 INFO - ##### 18:18:47 INFO - ##### Running read-buildbot-config step. 18:18:47 INFO - ##### 18:18:47 INFO - Running pre-action listener: _resource_record_pre_action 18:18:47 INFO - Running main action method: read_buildbot_config 18:18:47 INFO - Using buildbot properties: 18:18:47 INFO - { 18:18:47 INFO - "project": "", 18:18:47 INFO - "product": "firefox", 18:18:47 INFO - "script_repo_revision": "production", 18:18:47 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 18:18:47 INFO - "repository": "", 18:18:47 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 18:18:47 INFO - "buildid": "20160614170925", 18:18:47 INFO - "pgo_build": "False", 18:18:47 INFO - "basedir": "/builds/slave/test", 18:18:47 INFO - "buildnumber": 1860, 18:18:47 INFO - "slavename": "talos-linux64-ix-038", 18:18:47 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:18:47 INFO - "platform": "ubuntu64_hw", 18:18:47 INFO - "scheduler": "tests-fx-team-linux64-talos", 18:18:47 INFO - "branch": "fx-team", 18:18:47 INFO - "repo_path": "integration/fx-team", 18:18:47 INFO - "revision": "53f5b5c289fba6ad82c675578cf1c548ae37f0c1", 18:18:47 INFO - "stage_platform": "linux64", 18:18:47 INFO - "builduid": "694114dbed4d4e6889572070acf6230b", 18:18:47 INFO - "slavebuilddir": "test" 18:18:47 INFO - } 18:18:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/G0T1sskeQNiGGZrSFu2b8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 18:18:47 INFO - Running post-action listener: _resource_record_post_action 18:18:47 INFO - ##### 18:18:47 INFO - ##### Finished read-buildbot-config step (success) 18:18:47 INFO - ##### 18:18:47 INFO - ##### 18:18:47 INFO - ##### Running download-and-extract step. 18:18:47 INFO - ##### 18:18:47 INFO - Running pre-action listener: _resource_record_pre_action 18:18:47 INFO - Running main action method: download_and_extract 18:18:47 INFO - mkdir: /builds/slave/test/build/tests 18:18: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')]} 18:18:47 INFO - https://queue.taskcluster.net/v1/task/G0T1sskeQNiGGZrSFu2b8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:18:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0T1sskeQNiGGZrSFu2b8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:18:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0T1sskeQNiGGZrSFu2b8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:18:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0T1sskeQNiGGZrSFu2b8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:18:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0T1sskeQNiGGZrSFu2b8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:18:47 INFO - Downloaded 1361 bytes. 18:18:47 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:18:47 INFO - Using the following test package requirements: 18:18:47 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:18:47 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:18:47 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:18:47 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:47 INFO - u'jsshell-linux-x86_64.zip'], 18:18:47 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:18:47 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:18:47 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:18:47 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:18:47 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:18:47 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:18:47 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:18: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')]} 18:18:47 INFO - https://queue.taskcluster.net/v1/task/G0T1sskeQNiGGZrSFu2b8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:18:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0T1sskeQNiGGZrSFu2b8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:18:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0T1sskeQNiGGZrSFu2b8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:18:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0T1sskeQNiGGZrSFu2b8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:18:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0T1sskeQNiGGZrSFu2b8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:18:50 INFO - Downloaded 22653673 bytes. 18:18:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:18:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:18:52 INFO - Return code: 0 18:18:52 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:18:52 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')]} 18:18:52 INFO - https://queue.taskcluster.net/v1/task/G0T1sskeQNiGGZrSFu2b8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:18:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0T1sskeQNiGGZrSFu2b8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:18:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0T1sskeQNiGGZrSFu2b8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:18:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0T1sskeQNiGGZrSFu2b8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:18:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0T1sskeQNiGGZrSFu2b8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:18:53 INFO - Downloaded 22653673 bytes. 18:18:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:18:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:18:54 INFO - Return code: 0 18:18:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:54 INFO - https://queue.taskcluster.net/v1/task/G0T1sskeQNiGGZrSFu2b8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:18:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0T1sskeQNiGGZrSFu2b8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:18:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0T1sskeQNiGGZrSFu2b8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:18:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0T1sskeQNiGGZrSFu2b8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:18:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0T1sskeQNiGGZrSFu2b8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:18:55 INFO - Downloaded 14405384 bytes. 18:18:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:18:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 18:18:56 INFO - Return code: 0 18:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:56 INFO - https://queue.taskcluster.net/v1/task/G0T1sskeQNiGGZrSFu2b8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:18:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0T1sskeQNiGGZrSFu2b8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:18:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0T1sskeQNiGGZrSFu2b8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:18:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0T1sskeQNiGGZrSFu2b8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:18:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G0T1sskeQNiGGZrSFu2b8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:18:57 INFO - Downloaded 55396806 bytes. 18:18:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/G0T1sskeQNiGGZrSFu2b8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:18:57 INFO - mkdir: /builds/slave/test/properties 18:18:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:18:57 INFO - Writing to file /builds/slave/test/properties/build_url 18:18:57 INFO - Contents: 18:18:57 INFO - build_url:https://queue.taskcluster.net/v1/task/G0T1sskeQNiGGZrSFu2b8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:18:58 INFO - Running post-action listener: _resource_record_post_action 18:18:58 INFO - Running post-action listener: set_extra_try_arguments 18:18:58 INFO - ##### 18:18:58 INFO - ##### Finished download-and-extract step (success) 18:18:58 INFO - ##### 18:18:58 INFO - ##### 18:18:58 INFO - ##### Running populate-webroot step. 18:18:58 INFO - ##### 18:18:58 INFO - Running pre-action listener: _resource_record_pre_action 18:18:58 INFO - Running main action method: populate_webroot 18:18:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:18:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:18:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:18:58 INFO - '--tppagecycles', 18:18:58 INFO - '7'], 18:18:58 INFO - 'tests': ['tsvgm']}}, 18:18:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:18:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:18:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:18:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:18:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:18:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:18:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:58 INFO - 'talos_options': ['--disable-e10s'], 18:18:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:18:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:18:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:58 INFO - 'talos_options': ['--disable-e10s'], 18:18:58 INFO - 'tests': ['damp', 'tps']}, 18:18:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:58 INFO - 'tests': ['damp', 'tps']}, 18:18:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:18:58 INFO - 'tests': ['dromaeo_dom']}, 18:18:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:18:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:18:58 INFO - 'tests': ['basic_compositor_video']}, 18:18:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:18:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:18:58 INFO - 'tests': ['a11yr', 18:18:58 INFO - 'ts_paint', 18:18:58 INFO - 'tpaint', 18:18:58 INFO - 'sessionrestore', 18:18:58 INFO - 'sessionrestore_no_auto_restore', 18:18:58 INFO - 'tabpaint']}, 18:18:58 INFO - 'other-e10s': {'tests': ['a11yr', 18:18:58 INFO - 'ts_paint', 18:18:58 INFO - 'tpaint', 18:18:58 INFO - 'sessionrestore', 18:18:58 INFO - 'sessionrestore_no_auto_restore', 18:18:58 INFO - 'tabpaint']}, 18:18:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:18:58 INFO - 'ts_paint', 18:18:58 INFO - 'tpaint', 18:18:58 INFO - 'sessionrestore', 18:18:58 INFO - 'sessionrestore_no_auto_restore', 18:18:58 INFO - 'tabpaint']}, 18:18:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:18:58 INFO - 'ts_paint', 18:18:58 INFO - 'tpaint', 18:18:58 INFO - 'sessionrestore', 18:18:58 INFO - 'sessionrestore_no_auto_restore', 18:18:58 INFO - 'tabpaint']}, 18:18:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:18:58 INFO - 'tests': ['a11yr', 18:18:58 INFO - 'ts_paint', 18:18:58 INFO - 'tpaint', 18:18:58 INFO - 'sessionrestore', 18:18:58 INFO - 'sessionrestore_no_auto_restore', 18:18:58 INFO - 'tabpaint']}, 18:18:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:18:58 INFO - 'tests': ['a11yr', 18:18:58 INFO - 'ts_paint', 18:18:58 INFO - 'tpaint', 18:18:58 INFO - 'sessionrestore', 18:18:58 INFO - 'sessionrestore_no_auto_restore', 18:18:58 INFO - 'tabpaint']}, 18:18:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:18:58 INFO - 'tests': ['tsvgx', 18:18:58 INFO - 'tsvgr_opacity', 18:18:58 INFO - 'tart', 18:18:58 INFO - 'tscrollx', 18:18:58 INFO - 'cart']}, 18:18:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:18:58 INFO - 'tsvgr_opacity', 18:18:58 INFO - 'tart', 18:18:58 INFO - 'tscrollx', 18:18:58 INFO - 'cart']}, 18:18:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:58 INFO - 'talos_options': ['--disable-e10s'], 18:18:58 INFO - 'tests': ['tp5o']}, 18:18:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:58 INFO - 'tests': ['tp5o']}, 18:18:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:58 INFO - 'talos_options': ['--disable-e10s', 18:18:58 INFO - '--xperf_path', 18:18:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:18:58 INFO - 'tests': ['tp5n']}, 18:18:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:58 INFO - 'talos_options': ['--xperf_path', 18:18:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:18:58 INFO - 'tests': ['tp5n']}}, 18:18:58 INFO - 'talos.zip': {'path': '', 18:18:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:18:58 INFO - Running post-action listener: _resource_record_post_action 18:18:58 INFO - ##### 18:18:58 INFO - ##### Finished populate-webroot step (success) 18:18:58 INFO - ##### 18:18:58 INFO - ##### 18:18:58 INFO - ##### Running create-virtualenv step. 18:18:58 INFO - ##### 18:18:58 INFO - Running pre-action listener: _resource_record_pre_action 18:18:58 INFO - Running main action method: create_virtualenv 18:18:58 INFO - Creating virtualenv /builds/slave/test/build/venv 18:18:58 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 18:18:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:18:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:18:58 INFO - Using real prefix '/usr' 18:18:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:18:58 INFO - Installing distribute.............................................................................................................................................................................................done. 18:19:00 INFO - Installing pip.................done. 18:19:00 INFO - Return code: 0 18:19:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa47635ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15561c0>, '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 0x15570c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1557550>, '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': '8783db0840cc980e80bb0bd400000236-1465953523.624962-904656020', '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 18:19:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:19:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:19:00 INFO - Using env: {'DISPLAY': ':0', 18:19:00 INFO - 'HOME': '/home/cltbld', 18:19:00 INFO - 'LANG': 'en_US.UTF-8', 18:19:00 INFO - 'LANGUAGE': 'en_US:en', 18:19:00 INFO - 'LOGNAME': 'cltbld', 18:19:00 INFO - 'MAIL': '/var/mail/cltbld', 18:19:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:00 INFO - 'MOZ_NO_REMOTE': '1', 18:19:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:00 INFO - 'NO_EM_RESTART': '1', 18:19:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:00 INFO - 'PWD': '/builds/slave/test', 18:19:00 INFO - 'SHELL': '/bin/bash', 18:19:00 INFO - 'SHLVL': '1', 18:19:00 INFO - 'TERM': 'linux', 18:19:00 INFO - 'TMOUT': '86400', 18:19:00 INFO - 'USER': 'cltbld', 18:19:00 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465953523.624962-904656020', 18:19:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:00 INFO - '_': '/tools/buildbot/bin/python'} 18:19:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:01 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 18:19:01 INFO - Cleaning up... 18:19:01 INFO - Return code: 0 18:19:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:19:01 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')]} 18:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:01 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')]} 18:19:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:01 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 0x7fa47635ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15561c0>, '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 0x15570c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1557550>, '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': '8783db0840cc980e80bb0bd400000236-1465953523.624962-904656020', '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 18:19:01 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 18:19:01 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 18:19:01 INFO - Using env: {'DISPLAY': ':0', 18:19:01 INFO - 'HOME': '/home/cltbld', 18:19:01 INFO - 'LANG': 'en_US.UTF-8', 18:19:01 INFO - 'LANGUAGE': 'en_US:en', 18:19:01 INFO - 'LOGNAME': 'cltbld', 18:19:01 INFO - 'MAIL': '/var/mail/cltbld', 18:19:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:01 INFO - 'MOZ_NO_REMOTE': '1', 18:19:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:01 INFO - 'NO_EM_RESTART': '1', 18:19:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:01 INFO - 'PWD': '/builds/slave/test', 18:19:01 INFO - 'SHELL': '/bin/bash', 18:19:01 INFO - 'SHLVL': '1', 18:19:01 INFO - 'TERM': 'linux', 18:19:01 INFO - 'TMOUT': '86400', 18:19:01 INFO - 'USER': 'cltbld', 18:19:01 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465953523.624962-904656020', 18:19:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:01 INFO - '_': '/tools/buildbot/bin/python'} 18:19:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:01 INFO - Downloading/unpacking psutil>=3.1.1 18:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:19:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:19:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:19:03 INFO - Installing collected packages: psutil 18:19:03 INFO - Running setup.py install for psutil 18:19:03 INFO - building 'psutil._psutil_linux' extension 18:19:03 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 18:19:03 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 18:19:03 INFO - building 'psutil._psutil_posix' extension 18:19:03 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 18:19:03 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 18:19:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:19:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:19:03 INFO - Successfully installed psutil 18:19:03 INFO - Cleaning up... 18:19:03 INFO - Return code: 0 18:19:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:19:03 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')]} 18:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:03 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')]} 18:19:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:03 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 0x7fa47635ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15561c0>, '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 0x15570c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1557550>, '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': '8783db0840cc980e80bb0bd400000236-1465953523.624962-904656020', '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 18:19:03 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 18:19:03 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 18:19:03 INFO - Using env: {'DISPLAY': ':0', 18:19:03 INFO - 'HOME': '/home/cltbld', 18:19:03 INFO - 'LANG': 'en_US.UTF-8', 18:19:03 INFO - 'LANGUAGE': 'en_US:en', 18:19:03 INFO - 'LOGNAME': 'cltbld', 18:19:03 INFO - 'MAIL': '/var/mail/cltbld', 18:19:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:03 INFO - 'MOZ_NO_REMOTE': '1', 18:19:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:03 INFO - 'NO_EM_RESTART': '1', 18:19:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:03 INFO - 'PWD': '/builds/slave/test', 18:19:03 INFO - 'SHELL': '/bin/bash', 18:19:03 INFO - 'SHLVL': '1', 18:19:03 INFO - 'TERM': 'linux', 18:19:03 INFO - 'TMOUT': '86400', 18:19:03 INFO - 'USER': 'cltbld', 18:19:03 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465953523.624962-904656020', 18:19:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:03 INFO - '_': '/tools/buildbot/bin/python'} 18:19:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:19:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:19:06 INFO - Installing collected packages: mozsystemmonitor 18:19:06 INFO - Running setup.py install for mozsystemmonitor 18:19:06 INFO - Successfully installed mozsystemmonitor 18:19:06 INFO - Cleaning up... 18:19:06 INFO - Return code: 0 18:19:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:19:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:06 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 0x7fa47635ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15561c0>, '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 0x15570c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1557550>, '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': '8783db0840cc980e80bb0bd400000236-1465953523.624962-904656020', '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 18:19:06 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 18:19:06 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 18:19:06 INFO - Using env: {'DISPLAY': ':0', 18:19:06 INFO - 'HOME': '/home/cltbld', 18:19:06 INFO - 'LANG': 'en_US.UTF-8', 18:19:06 INFO - 'LANGUAGE': 'en_US:en', 18:19:06 INFO - 'LOGNAME': 'cltbld', 18:19:06 INFO - 'MAIL': '/var/mail/cltbld', 18:19:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:06 INFO - 'MOZ_NO_REMOTE': '1', 18:19:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:06 INFO - 'NO_EM_RESTART': '1', 18:19:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:06 INFO - 'PWD': '/builds/slave/test', 18:19:06 INFO - 'SHELL': '/bin/bash', 18:19:06 INFO - 'SHLVL': '1', 18:19:06 INFO - 'TERM': 'linux', 18:19:06 INFO - 'TMOUT': '86400', 18:19:06 INFO - 'USER': 'cltbld', 18:19:06 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465953523.624962-904656020', 18:19:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:06 INFO - '_': '/tools/buildbot/bin/python'} 18:19:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:06 INFO - Downloading/unpacking jsonschema==2.5.1 18:19:06 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 18:19:06 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 18:19:06 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 18:19:06 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 18:19:06 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 18:19:06 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 18:19:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:19:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:19:08 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 18:19:08 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 18:19:08 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 18:19:08 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 18:19:08 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 18:19:08 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 18:19:08 INFO - Downloading functools32-3.2.3-2.tar.gz 18:19:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:19:08 INFO - warning: no files found matching '*.txt' 18:19:08 INFO - no previously-included directories found matching 'build' 18:19:08 INFO - no previously-included directories found matching 'dist' 18:19:08 INFO - no previously-included directories found matching '.git*' 18:19:08 INFO - Installing collected packages: jsonschema, functools32 18:19:08 INFO - Running setup.py install for functools32 18:19:08 INFO - warning: no files found matching '*.txt' 18:19:08 INFO - no previously-included directories found matching 'build' 18:19:08 INFO - no previously-included directories found matching 'dist' 18:19:08 INFO - no previously-included directories found matching '.git*' 18:19:08 INFO - Successfully installed jsonschema functools32 18:19:08 INFO - Cleaning up... 18:19:08 INFO - Return code: 0 18:19:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:19:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:08 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 0x7fa47635ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15561c0>, '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 0x15570c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1557550>, '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': '8783db0840cc980e80bb0bd400000236-1465953523.624962-904656020', '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 18:19:08 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 18:19:08 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 18:19:08 INFO - Using env: {'DISPLAY': ':0', 18:19:08 INFO - 'HOME': '/home/cltbld', 18:19:08 INFO - 'LANG': 'en_US.UTF-8', 18:19:08 INFO - 'LANGUAGE': 'en_US:en', 18:19:08 INFO - 'LOGNAME': 'cltbld', 18:19:08 INFO - 'MAIL': '/var/mail/cltbld', 18:19:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:08 INFO - 'MOZ_NO_REMOTE': '1', 18:19:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:08 INFO - 'NO_EM_RESTART': '1', 18:19:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:08 INFO - 'PWD': '/builds/slave/test', 18:19:08 INFO - 'SHELL': '/bin/bash', 18:19:08 INFO - 'SHLVL': '1', 18:19:08 INFO - 'TERM': 'linux', 18:19:08 INFO - 'TMOUT': '86400', 18:19:08 INFO - 'USER': 'cltbld', 18:19:08 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465953523.624962-904656020', 18:19:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:08 INFO - '_': '/tools/buildbot/bin/python'} 18:19:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:08 INFO - Downloading/unpacking blobuploader==1.2.4 18:19:08 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 18:19:08 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 18:19:08 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 18:19:08 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 18:19:08 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 18:19:08 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 18:19:10 INFO - Downloading blobuploader-1.2.4.tar.gz 18:19:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:19:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:19:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:19:11 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 18:19:11 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 18:19:11 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 18:19:11 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 18:19:11 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 18:19:11 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 18:19:11 INFO - Downloading docopt-0.6.1.tar.gz 18:19:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:19:11 INFO - Installing collected packages: blobuploader, requests, docopt 18:19:11 INFO - Running setup.py install for blobuploader 18:19:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:19:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:19:11 INFO - Running setup.py install for requests 18:19:12 INFO - Running setup.py install for docopt 18:19:12 INFO - Successfully installed blobuploader requests docopt 18:19:12 INFO - Cleaning up... 18:19:12 INFO - Return code: 0 18:19:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:19:12 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')]} 18:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:12 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')]} 18:19:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:12 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 0x7fa47635ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15561c0>, '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 0x15570c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1557550>, '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': '8783db0840cc980e80bb0bd400000236-1465953523.624962-904656020', '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 18:19:12 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 18:19:12 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 18:19:12 INFO - Using env: {'DISPLAY': ':0', 18:19:12 INFO - 'HOME': '/home/cltbld', 18:19:12 INFO - 'LANG': 'en_US.UTF-8', 18:19:12 INFO - 'LANGUAGE': 'en_US:en', 18:19:12 INFO - 'LOGNAME': 'cltbld', 18:19:12 INFO - 'MAIL': '/var/mail/cltbld', 18:19:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:12 INFO - 'MOZ_NO_REMOTE': '1', 18:19:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:12 INFO - 'NO_EM_RESTART': '1', 18:19:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:12 INFO - 'PWD': '/builds/slave/test', 18:19:12 INFO - 'SHELL': '/bin/bash', 18:19:12 INFO - 'SHLVL': '1', 18:19:12 INFO - 'TERM': 'linux', 18:19:12 INFO - 'TMOUT': '86400', 18:19:12 INFO - 'USER': 'cltbld', 18:19:12 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465953523.624962-904656020', 18:19:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:12 INFO - '_': '/tools/buildbot/bin/python'} 18:19:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:19:12 INFO - Running setup.py (path:/tmp/pip-TwmtwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:19:12 INFO - Running setup.py (path:/tmp/pip-iWTVXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:19:12 INFO - Running setup.py (path:/tmp/pip-a7gy97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:19:12 INFO - Running setup.py (path:/tmp/pip-7niDvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:19:12 INFO - Running setup.py (path:/tmp/pip-dem3nt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:19:12 INFO - Running setup.py (path:/tmp/pip-NyM2XR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:19:12 INFO - Running setup.py (path:/tmp/pip-aUeutp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:19:12 INFO - Running setup.py (path:/tmp/pip-quw93i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:19:12 INFO - Running setup.py (path:/tmp/pip-GnBkO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:19:13 INFO - Running setup.py (path:/tmp/pip-wLr4kN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:19:13 INFO - Running setup.py (path:/tmp/pip-GMn6_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:19:13 INFO - Running setup.py (path:/tmp/pip-nRzJ6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:19:13 INFO - Running setup.py (path:/tmp/pip-di2udM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:19:13 INFO - Running setup.py (path:/tmp/pip-Eo0N0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:19:13 INFO - Running setup.py (path:/tmp/pip-Qj7Q6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:19:13 INFO - Running setup.py (path:/tmp/pip-ZybCgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:19:13 INFO - Running setup.py (path:/tmp/pip-aAXNJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:19:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:19:13 INFO - Running setup.py install for manifestparser 18:19:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:19:13 INFO - Running setup.py install for mozcrash 18:19:13 INFO - Running setup.py install for mozdebug 18:19:13 INFO - Running setup.py install for mozdevice 18:19:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:19:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:19:14 INFO - Running setup.py install for mozfile 18:19:14 INFO - Running setup.py install for mozhttpd 18:19:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:19:14 INFO - Running setup.py install for mozinfo 18:19:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:19:14 INFO - Running setup.py install for mozInstall 18:19:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:19:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:19:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:19:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:19:14 INFO - Running setup.py install for mozleak 18:19:14 INFO - Running setup.py install for mozlog 18:19:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:19:14 INFO - Running setup.py install for moznetwork 18:19:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:19:14 INFO - Running setup.py install for mozprocess 18:19:14 INFO - Running setup.py install for mozprofile 18:19:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:19:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:19:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:19:14 INFO - Running setup.py install for mozrunner 18:19:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:19:15 INFO - Running setup.py install for mozscreenshot 18:19:15 INFO - Running setup.py install for moztest 18:19:15 INFO - Running setup.py install for mozversion 18:19:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:19:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:19:15 INFO - Cleaning up... 18:19:15 INFO - Return code: 0 18:19:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:19:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:15 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 0x7fa47635ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15561c0>, '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 0x15570c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1557550>, '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': '8783db0840cc980e80bb0bd400000236-1465953523.624962-904656020', '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 18:19:15 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 18:19:15 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 18:19:15 INFO - Using env: {'DISPLAY': ':0', 18:19:15 INFO - 'HOME': '/home/cltbld', 18:19:15 INFO - 'LANG': 'en_US.UTF-8', 18:19:15 INFO - 'LANGUAGE': 'en_US:en', 18:19:15 INFO - 'LOGNAME': 'cltbld', 18:19:15 INFO - 'MAIL': '/var/mail/cltbld', 18:19:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:15 INFO - 'MOZ_NO_REMOTE': '1', 18:19:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:15 INFO - 'NO_EM_RESTART': '1', 18:19:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:15 INFO - 'PWD': '/builds/slave/test', 18:19:15 INFO - 'SHELL': '/bin/bash', 18:19:15 INFO - 'SHLVL': '1', 18:19:15 INFO - 'TERM': 'linux', 18:19:15 INFO - 'TMOUT': '86400', 18:19:15 INFO - 'USER': 'cltbld', 18:19:15 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465953523.624962-904656020', 18:19:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:15 INFO - '_': '/tools/buildbot/bin/python'} 18:19:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:19:15 INFO - Running setup.py (path:/tmp/pip-3CPtVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:19:15 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)) 18:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:19:15 INFO - Running setup.py (path:/tmp/pip-4ZKOGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:19:15 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)) 18:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:19:15 INFO - Running setup.py (path:/tmp/pip-EkvTqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:19:15 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)) 18:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:19:15 INFO - Running setup.py (path:/tmp/pip-orQ4iA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:19:15 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)) 18:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:19:15 INFO - Running setup.py (path:/tmp/pip-mgLYda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:19:16 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)) 18:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:19:16 INFO - Running setup.py (path:/tmp/pip-zQmze1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:19:16 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)) 18:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:19:16 INFO - Running setup.py (path:/tmp/pip-FOsfkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:19:16 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)) 18:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:19:16 INFO - Running setup.py (path:/tmp/pip-rTuV4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:19:16 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)) 18:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:19:16 INFO - Running setup.py (path:/tmp/pip-qW4lww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:19:16 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)) 18:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:19:16 INFO - Running setup.py (path:/tmp/pip-MfmqU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:19:16 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)) 18:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:19:16 INFO - Running setup.py (path:/tmp/pip-5I1Tpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:19:16 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)) 18:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:19:16 INFO - Running setup.py (path:/tmp/pip-eWEmjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:19:16 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)) 18:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:19:16 INFO - Running setup.py (path:/tmp/pip-IuwQnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:19:16 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)) 18:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:19:16 INFO - Running setup.py (path:/tmp/pip-tbkGYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:19:16 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)) 18:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:19:16 INFO - Running setup.py (path:/tmp/pip-KBhy3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:19:16 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)) 18:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:19:16 INFO - Running setup.py (path:/tmp/pip-6TwHy6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:19:16 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)) 18:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:19:16 INFO - Running setup.py (path:/tmp/pip-8pccIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:19:16 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)) 18:19:16 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)) 18:19:16 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)) 18:19:16 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)) 18:19:16 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)) 18:19:16 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)) 18:19:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:18 INFO - Downloading blessings-1.6.tar.gz 18:19:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:19:18 INFO - Installing collected packages: blessings 18:19:18 INFO - Running setup.py install for blessings 18:19:18 INFO - Successfully installed blessings 18:19:18 INFO - Cleaning up... 18:19:19 INFO - Return code: 0 18:19:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:19:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:19:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:19:19 INFO - Reading from file tmpfile_stdout 18:19:19 INFO - Current package versions: 18:19:19 INFO - argparse == 1.2.1 18:19:19 INFO - blessings == 1.6 18:19:19 INFO - blobuploader == 1.2.4 18:19:19 INFO - docopt == 0.6.1 18:19:19 INFO - functools32 == 3.2.3-2 18:19:19 INFO - jsonschema == 2.5.1 18:19:19 INFO - manifestparser == 1.1 18:19:19 INFO - mozInstall == 1.12 18:19:19 INFO - mozcrash == 0.17 18:19:19 INFO - mozdebug == 0.1 18:19:19 INFO - mozdevice == 0.48 18:19:19 INFO - mozfile == 1.2 18:19:19 INFO - mozhttpd == 0.7 18:19:19 INFO - mozinfo == 0.9 18:19:19 INFO - mozleak == 0.1 18:19:19 INFO - mozlog == 3.2 18:19:19 INFO - moznetwork == 0.27 18:19:19 INFO - mozprocess == 0.22 18:19:19 INFO - mozprofile == 0.28 18:19:19 INFO - mozrunner == 6.11 18:19:19 INFO - mozscreenshot == 0.1 18:19:19 INFO - mozsystemmonitor == 0.3 18:19:19 INFO - moztest == 0.7 18:19:19 INFO - mozversion == 1.4 18:19:19 INFO - psutil == 3.1.1 18:19:19 INFO - requests == 1.2.3 18:19:19 INFO - wsgiref == 0.1.2 18:19:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:19:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:19 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 0x7fa47635ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15561c0>, '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 0x15570c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1557550>, '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': '8783db0840cc980e80bb0bd400000236-1465953523.624962-904656020', '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 18:19:19 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 18:19:19 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 18:19:19 INFO - Using env: {'DISPLAY': ':0', 18:19:19 INFO - 'HOME': '/home/cltbld', 18:19:19 INFO - 'LANG': 'en_US.UTF-8', 18:19:19 INFO - 'LANGUAGE': 'en_US:en', 18:19:19 INFO - 'LOGNAME': 'cltbld', 18:19:19 INFO - 'MAIL': '/var/mail/cltbld', 18:19:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:19 INFO - 'MOZ_NO_REMOTE': '1', 18:19:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:19 INFO - 'NO_EM_RESTART': '1', 18:19:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:19 INFO - 'PWD': '/builds/slave/test', 18:19:19 INFO - 'SHELL': '/bin/bash', 18:19:19 INFO - 'SHLVL': '1', 18:19:19 INFO - 'TERM': 'linux', 18:19:19 INFO - 'TMOUT': '86400', 18:19:19 INFO - 'USER': 'cltbld', 18:19:19 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465953523.624962-904656020', 18:19:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:19 INFO - '_': '/tools/buildbot/bin/python'} 18:19:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:19 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)) 18:19:19 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)) 18:19:19 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)) 18:19:19 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)) 18:19:19 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)) 18:19:19 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)) 18:19:19 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)) 18:19:19 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)) 18:19:19 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)) 18:19:19 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)) 18:19:19 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)) 18:19:19 INFO - Cleaning up... 18:19:19 INFO - Return code: 0 18:19:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:19:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:19 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 0x7fa47635ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15561c0>, '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 0x15570c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1557550>, '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': '8783db0840cc980e80bb0bd400000236-1465953523.624962-904656020', '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 18:19:19 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 18:19:19 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 18:19:19 INFO - Using env: {'DISPLAY': ':0', 18:19:19 INFO - 'HOME': '/home/cltbld', 18:19:19 INFO - 'LANG': 'en_US.UTF-8', 18:19:19 INFO - 'LANGUAGE': 'en_US:en', 18:19:19 INFO - 'LOGNAME': 'cltbld', 18:19:19 INFO - 'MAIL': '/var/mail/cltbld', 18:19:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:19 INFO - 'MOZ_NO_REMOTE': '1', 18:19:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:19 INFO - 'NO_EM_RESTART': '1', 18:19:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:19 INFO - 'PWD': '/builds/slave/test', 18:19:19 INFO - 'SHELL': '/bin/bash', 18:19:19 INFO - 'SHLVL': '1', 18:19:19 INFO - 'TERM': 'linux', 18:19:19 INFO - 'TMOUT': '86400', 18:19:19 INFO - 'USER': 'cltbld', 18:19:19 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465953523.624962-904656020', 18:19:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:19 INFO - '_': '/tools/buildbot/bin/python'} 18:19:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:19:19 INFO - Cleaning up... 18:19:19 INFO - Return code: 0 18:19:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:19:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:19 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 0x7fa47635ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15561c0>, '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 0x15570c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1557550>, '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': '8783db0840cc980e80bb0bd400000236-1465953523.624962-904656020', '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 18:19:19 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 18:19:19 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 18:19:19 INFO - Using env: {'DISPLAY': ':0', 18:19:19 INFO - 'HOME': '/home/cltbld', 18:19:19 INFO - 'LANG': 'en_US.UTF-8', 18:19:19 INFO - 'LANGUAGE': 'en_US:en', 18:19:19 INFO - 'LOGNAME': 'cltbld', 18:19:19 INFO - 'MAIL': '/var/mail/cltbld', 18:19:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:19 INFO - 'MOZ_NO_REMOTE': '1', 18:19:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:19 INFO - 'NO_EM_RESTART': '1', 18:19:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:19 INFO - 'PWD': '/builds/slave/test', 18:19:19 INFO - 'SHELL': '/bin/bash', 18:19:19 INFO - 'SHLVL': '1', 18:19:19 INFO - 'TERM': 'linux', 18:19:19 INFO - 'TMOUT': '86400', 18:19:19 INFO - 'USER': 'cltbld', 18:19:19 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465953523.624962-904656020', 18:19:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:19 INFO - '_': '/tools/buildbot/bin/python'} 18:19:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:19 INFO - Downloading/unpacking flake8 18:19:19 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 18:19:19 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 18:19:19 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 18:19:19 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 18:19:19 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 18:19:19 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 18:19:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:19:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:19:21 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 18:19:21 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 18:19:21 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 18:19:21 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 18:19:21 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 18:19:21 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 18:19:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:19:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:19:21 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 18:19:21 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 18:19:21 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 18:19:21 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 18:19:21 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 18:19:21 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 18:19:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:19:22 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 18:19:22 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 18:19:22 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 18:19:22 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 18:19:22 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 18:19:22 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 18:19:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:19:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:19:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:19:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:19:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:19:22 INFO - no previously-included directories found matching 'docs/_build' 18:19:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:19:22 INFO - Running setup.py install for pep8 18:19:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:19:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:19:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:19:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:19:22 INFO - no previously-included directories found matching 'docs/_build' 18:19:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:19:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:19:22 INFO - Cleaning up... 18:19:22 INFO - Return code: 0 18:19:22 INFO - Running post-action listener: _resource_record_post_action 18:19:22 INFO - Running post-action listener: _start_resource_monitoring 18:19:22 INFO - Starting resource monitoring. 18:19:22 INFO - ##### 18:19:22 INFO - ##### Finished create-virtualenv step (success) 18:19:22 INFO - ##### 18:19:22 INFO - ##### 18:19:22 INFO - ##### Running install step. 18:19:22 INFO - ##### 18:19:22 INFO - Running pre-action listener: _resource_record_pre_action 18:19:22 INFO - Running main action method: install 18:19:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:19:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:19:22 INFO - Reading from file tmpfile_stdout 18:19:22 INFO - Detecting whether we're running mozinstall >=1.0... 18:19:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:19:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:19:23 INFO - Reading from file tmpfile_stdout 18:19:23 INFO - Output received: 18:19:23 INFO - Usage: mozinstall [options] installer 18:19:23 INFO - Options: 18:19:23 INFO - -h, --help show this help message and exit 18:19:23 INFO - -d DEST, --destination=DEST 18:19:23 INFO - Directory to install application into. [default: 18:19:23 INFO - "/builds/slave/test"] 18:19:23 INFO - --app=APP Application being installed. [default: firefox] 18:19:23 INFO - mkdir: /builds/slave/test/build/application 18:19:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:19:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:19:39 INFO - Reading from file tmpfile_stdout 18:19:39 INFO - Output received: 18:19:39 INFO - /builds/slave/test/build/application/firefox/firefox 18:19:39 INFO - Running post-action listener: _resource_record_post_action 18:19:39 INFO - ##### 18:19:39 INFO - ##### Finished install step (success) 18:19:39 INFO - ##### 18:19:39 INFO - ##### 18:19:39 INFO - ##### Running run-tests step. 18:19:39 INFO - ##### 18:19:39 INFO - Running pre-action listener: _resource_record_pre_action 18:19:39 INFO - Running main action method: run_tests 18:19:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:19:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:19:39 INFO - Python 2.7.3 18:19:39 INFO - Return code: 0 18:19:39 INFO - grabbing minidump binary from tooltool 18:19:39 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')]} 18:19:39 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 0x15561c0>, '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 0x15570c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1557550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:19:39 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 18:19:39 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 18:19:39 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 18:19:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:19:39 INFO - Return code: 0 18:19:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:19:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:19:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:19:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:19:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:19:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:19:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:19:40 INFO - Return code: 0 18:19:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G0T1sskeQNiGGZrSFu2b8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 18:19:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/G0T1sskeQNiGGZrSFu2b8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 18:19:40 INFO - Using env: {'DISPLAY': ':0', 18:19:40 INFO - 'HOME': '/home/cltbld', 18:19:40 INFO - 'LANG': 'en_US.UTF-8', 18:19:40 INFO - 'LANGUAGE': 'en_US:en', 18:19:40 INFO - 'LOGNAME': 'cltbld', 18:19:40 INFO - 'MAIL': '/var/mail/cltbld', 18:19:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:19:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:19:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:40 INFO - 'MOZ_NO_REMOTE': '1', 18:19:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:19:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:40 INFO - 'NO_EM_RESTART': '1', 18:19:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:40 INFO - 'PWD': '/builds/slave/test', 18:19:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:19:40 INFO - 'SHELL': '/bin/bash', 18:19:40 INFO - 'SHLVL': '1', 18:19:40 INFO - 'TERM': 'linux', 18:19:40 INFO - 'TMOUT': '86400', 18:19:40 INFO - 'USER': 'cltbld', 18:19:40 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465953523.624962-904656020', 18:19:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:40 INFO - '_': '/tools/buildbot/bin/python'} 18:19:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G0T1sskeQNiGGZrSFu2b8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 18:19:40 INFO - mozversion application_buildid: 20160614170925 18:19:40 INFO - mozversion application_changeset: 53f5b5c289fba6ad82c675578cf1c548ae37f0c1 18:19:40 INFO - mozversion application_display_name: Nightly 18:19:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:19:40 INFO - mozversion application_name: Firefox 18:19:40 INFO - mozversion application_remotingname: firefox 18:19:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:19:40 INFO - mozversion application_vendor: Mozilla 18:19:40 INFO - mozversion application_version: 50.0a1 18:19:40 INFO - mozversion platform_buildid: 20160614170925 18:19:40 INFO - mozversion platform_changeset: 53f5b5c289fba6ad82c675578cf1c548ae37f0c1 18:19:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:19:40 INFO - mozversion platform_version: 50.0a1 18:19:40 INFO - using testdate: 1465953580 18:19:40 INFO - actual date: 1465953580 18:19:40 INFO - starting webserver on 'localhost:40224' 18:19:40 INFO - SUITE-START | Running 2 tests 18:19:40 INFO - TEST-START | dromaeo_css 18:19:40 INFO - operating with platform_type : linux_ 18:19:40 INFO - Initialising browser for dromaeo_css test... 18:19:40 INFO - TEST-INFO | started process 24822 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeAlXpY/profile http://localhost:40224/getInfo.html) 18:19:45 INFO - PROCESS | 24822 | __metrics Screen width/height:1600/1200 18:19:45 INFO - PROCESS | 24822 | colorDepth:24 18:19:45 INFO - PROCESS | 24822 | Browser inner width/height: 1024/697 18:19:45 INFO - PROCESS | 24822 | __metrics 18:19:47 INFO - PROCESS | 24822 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:19:47 INFO - PROCESS | 24822 | console.error: PushService: 18:19:47 INFO - PROCESS | 24822 | stateChangeProcessEnqueue: Error transitioning state 18:19:47 INFO - PROCESS | 24822 | UnknownError 18:19:48 INFO - TEST-INFO | 24822: exit 0 18:19:48 INFO - Browser initialized. 18:19:48 INFO - Running cycle 1/1 for dromaeo_css test... 18:19:48 INFO - TEST-INFO | started process 24903 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeAlXpY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:20:00 INFO - PROCESS | 24903 | RSS: Main: 178671616 18:20:00 INFO - PROCESS | 24903 | 18:20:51 INFO - PROCESS | 24903 | 1465953651077 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] 18:23:04 INFO - PROCESS | 24903 | Cycle 1(1): loaded http://localhost:40224/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40224/tests/dromaeo/cssquery-ext.html) 18:23:05 INFO - PROCESS | 24903 | RSS: Main: 288219136 18:23:05 INFO - PROCESS | 24903 | 18:26:08 INFO - PROCESS | 24903 | Cycle 1(1): loaded http://localhost:40224/tests/dromaeo/cssquery-ext.html (next: http://localhost:40224/tests/dromaeo/cssquery-jquery.html) 18:26:08 INFO - PROCESS | 24903 | RSS: Main: 257888256 18:26:08 INFO - PROCESS | 24903 | 18:29:10 INFO - PROCESS | 24903 | Cycle 1(1): loaded http://localhost:40224/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40224/tests/dromaeo/cssquery-mootools.html) 18:29:11 INFO - PROCESS | 24903 | RSS: Main: 257736704 18:29:11 INFO - PROCESS | 24903 | 18:32:13 INFO - PROCESS | 24903 | Cycle 1(1): loaded http://localhost:40224/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40224/tests/dromaeo/cssquery-prototype.html) 18:32:14 INFO - PROCESS | 24903 | RSS: Main: 256385024 18:32:14 INFO - PROCESS | 24903 | 18:35:17 INFO - PROCESS | 24903 | Cycle 1(1): loaded http://localhost:40224/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40224/tests/dromaeo/cssquery-yui.html) 18:35:17 INFO - PROCESS | 24903 | RSS: Main: 244543488 18:35:17 INFO - PROCESS | 24903 | 18:38:20 INFO - PROCESS | 24903 | Cycle 1(1): loaded http://localhost:40224/tests/dromaeo/cssquery-yui.html (next: http://localhost:40224/tests/dromaeo/cssquery-dojo.html) 18:38:21 INFO - PROCESS | 24903 | RSS: Main: 295673856 18:38:21 INFO - PROCESS | 24903 | 18:38:21 INFO - PROCESS | 24903 | __start_tp_report 18:38:21 INFO - PROCESS | 24903 | _x_x_mozilla_page_load 18:38:21 INFO - PROCESS | 24903 | _x_x_mozilla_page_load_details 18:38:21 INFO - PROCESS | 24903 | |i|pagename|runs| 18:38:21 INFO - PROCESS | 24903 | |0;dojo.html;2592.4944635796023;2605.088219123306;2615.581506958888;2619.4891996060765;2622.7508386703257;4534.546545345472;4596.563326483987;4634.930476042858;4692.202325604647;4734.100520901026;4680.648951328655;4691.2024955757515;4691.272852707827;4749.4063242094735;4749.786259618317;4101.548829628753;4244.405783190348;4334.414853994702;4362.8036738346855;4490.5509449055;4392.407025051609;4404.2512772828695;4432;4432.556744325574;4475.507694153641;4239.215745087169;4295.012147206129;4299.978500107511;4315.029118448356;4354.455693038371;4307;4316.633086187647;4325.156594464081;4372.628326592244;4406.471223453174;4295.892602684958;4306.117245964601;4307.763073030982;4344.131173765228;4352.804123814436;4635.490096089427;4637.6289896808175;4680.95319046812;4727.739974301412;4728;4999.750012499397;5007.84976450707;5062.215356619729;5076.771545280471;5077.64456488046;5068.645194836363;5095.515925987025;5101.923471147936;5113.795448182068;5114.820981265638;4588.082383523309;4682.41469816273;4740.762961851928;4743;4774.809007639725;5204.531592156724;5223.503767142115;5261.552768014762;5275.419703832576;5277.736113194325;4995.125852975715;4996.525330093636;5033.899322013539;5049.545540901337;5051.924221136685;4891.095147397743;5000.299958005882;5086.465921078234;5092.745362731848;5140.203268493389;5013.799448022039;5023.2214006829;5033.798648054037;5037.647364684511;5099.490050994871;5002.299678045077;5006.274090256965;5008.749562521859;5009.348784657971;5010.64925455222;4193.895152621209;4229.365595160751;4235.576442355801;4235.703500754979;4273.829046838092;3718.3678774608384;3727.8508859645854;3750.624937506282;3781.1303400218103;3818.9236215275537;4274.316109422478;4289.935650965238;4290.849820256276;4296.183725092223;4336.934945975813;4948.356713627278;5004;5018.89962200754;5039.44566097729;5093.541581257705;4291.699581029298;4315.352697095398;4318.978405107954;4360.236958532308;4361.996740749645;4545.568171023748;4550.97724511382;4552.066826300666;4554.203014472454;4601.700889442175;4598.724076555417;4777.928331075037;4781.497942715965;4782.832600858953;4830.7101573905675;5078.949210507848;5099.209622508517;5099.439061703284;5101.234814777813;5145.485451454824;4795.232762757942;4797.520247975174;4797.952020479751;4800.975995120002;4834.806607735652;4879.756012199447;4920.630952678635;4942.357493525818;4960.751962401938;5055.090083784954;4990.076835785391;5013.147764879906;5013.39839219296;5015.072211640858;5061.797528098835;4826.155422800925;4848.054629347384;4856.320115183948;4857.708537487762;4906.3376444181;4664.93002604968;4833.10587541306;4860.513948605111;4890.388701412324;4894.094592500399;4752.809887604457;4757.167495688172;4815.3258543803195;4836;4853.587445067067;4828.517148285144;4930.408350997904;4936.432310284364;4978.975105124451;4988.102141614544;4846.418429788448;4875.634327425528;4885.609151267961;4892.951070489249;4905.264210368473 18:38:21 INFO - PROCESS | 24903 | |1;ext.html;537.1236136848937;578.2309528327324;585.5374254339073;585.6544638663188;596.2338395162216;27031.729682703168;40372.39441408378;41146.58853411465;41200.79399603005;41255.793721031354;41053.17893642125;41752.79123604386;41773.58226417735;41811.58188418115;41831.163376732446;7685.654145563463;7878.724244651438;7889.644965976545;8000.799980000503;8157.836843263131;7794.922050779504;10119.848202276935;10389.48052597371;10390.584376624925;10718.732031699192;10525.947370263139;10573.418461984587;10606.628767993121;10606.681799546026;10614.522346494388;7707.383409327296;10188.898111018869;10433.42616156111;10491.94754026225;10503.894961050368;10093.798124037552;10447.52986115619;10452.216083793746;10452.634157804516;10452.895471045344;39225.41161882574;39506.40740388897;39519;39549.60450395488;39621.801890990646;3093.133922501703;3185.9362812743616;3262.7389808815237;3380.171857894807;3521.3485505181625;30130.096097117123;30163.547546786816;30357.544636830466;30449.695503044906;30749.692503074908;3459.4810778383194;3533.575970883485;3535.8585656573705;3585.1395665040463;3600.47793070006;251025;253838;254973.72513137502;255363;255651;31029.224269393446;54694.085707000064;55464.16803747947;55474.44525554773;55493.16760248599;32043.839780800947;33646.831765841016;33686.831565842505;33742.32515349728;33774.155646109044;13256.337183140997;13362.131461454974;13362.599122026355;13367.59897203066;13368.064235503616;9999.150072243796;10823.458827058615;10900.236983411085;10979.231453798158;11205.551777928791;7896.763097107096;7937.722179723682;7946.364290856717;8009.759707208793;8018.79953001168;3124.8437578121;3132.7963682360573;3163.209197700575;3166.794158379698;3191.3138675184946;873.8231254603007;878.0736323179108;910.5993362920426;937.6765016069445;967.5452537307455;28271.717282826907;28317;28424.573631395546;28824.855875720907;28901.421971560452;933.4725879877848;950.9286803489766;955.6655170690203;964.5177411294353;983.311681822727;14838.40646374133;14926.477573284883;15130.167840768863;15432.768508472382;15435.536933892;693623;715754;716573;716678;717593;50128;51149;51172.74413627908;51196.488035119175;51204.74397627988;1121.3608243301403;1165.1436194396942;1182.379250893288;1196.802527582939;1234.8703386144325;27687;28905.710942891143;29136.7086329134;29251.561226582045;29659.703402966556;42724.35913461363;43029.78485107554;43451.565484346014;43457;43459.56540434682;330982;334471;334890;335001;335099;22868.88565557228;23391.649125263473;24980.875095624404;25654.871725641253;25826.741732582435;40507.59492405038;40540.189196215324;41081.1783764329;41294;41431.37852932269;35830.82084589561;36031;36452.08869778277;36626.633733662326;37088.07279818026;35916.64083359238;35969.64030359663;36199.45700814542;36652.45021324629;36829.26341473102;35283.47074793932;35591.28817423689;35816.46275305925;35897.64102358943;36089;32403.08372246509;32479.512807308383;32816.835915820266;33207.33585328232;33294.16764580905;24905.501889962463;25276.74723252744;25506.48987020212;25506.86918255205;25751.227463176136 18:38:21 INFO - PROCESS | 24903 | |2;jquery.html;370.8664880642969;370.8998570385994;373.18086799475157;383.37509858929974;393.56314490915076;16870.746938795914;17062.232199551036;17972.55068623282;18230.635387292263;18240.726389104173;16971.236294366754;17104.743428848546;17669.91165044176;17728.64542709145;17740;4941.654084214107;5088.465711100337;5151.6908985460805;5180.404253510838;5184.326037615105;3638.945415818765;3705.8147092645395;4939.382577177853;5798.478136967672;5905.43898329658;5820.156077368779;5846.444587764156;5854.853628659275;5866.354700982888;5903.645781253117;5636.408177141403;5834.3873893241025;5850.502707269887;5869.559783016248;5915.556333274979;5151.922721159186;5151.9484805152215;5187;5191.922121168148;5214.504622060898;12302.261864288083;17426.518745906615;18590.90704546482;19690.113944872515;19698.70451943222;1925.075963537496;2007.8694884832585;2260.8530445520987;2299.9190380521295;2310.607196776552;8758.912410875873;9388.389754665925;9410.811783764355;9522.0954009369;9593.808123837554;1730.2473424060574;1742.8605711543173;1750.2823842224627;1837.7702787151607;1841.4567702527786;51167.744161278955;53719.73140134313;64257.67871160661;64820.027699584076;71865.64067179683;9760.511974401252;10079.875238676033;10116;10130.848037279447;10163.745906352253;13952.720945581032;13977;13977.510787122403;13990.650233744238;14002.439902403994;7369.189389167187;7479.177290498041;7493.325600695964;7581.12817026038;7586.772396828104;7193.136823581099;7215.783526494213;7271.272872712792;7345.70617175307;7376.299251571092;4320.4383430153875;4356.738595684269;4404.55954404557;4434.357018232403;4490.371348011281;1765.4615342320458;1817.191349849331;1849.7687789026372;1850.7501487299312;1877.7371168036486;803.4536515169741;845.0830848529414;857.8455877941906;860.2257967828879;913.3013244867682;16969.745453818203;17058.48824535266;17240.137993100296;17428.041457719948;17484;840.5881118252013;850.0776657326869;912.9087091290951;925.6713866577403;939.7838497145694;9087.863682044775;9507.809843803085;9661;9718.173955213744;9837.262205334628;432624;433758;441817;443645;445438;74336.62831685915;77128;77499.22500775033;77547.22452775513;77969.88120475231;873.9388242823069;895.3980703824483;901.1034021148998;905.800723840754;907.1654078248027;15523.84476155224;15573.299201536185;15607.375704972128;15704.685906281582;15791.447299344467;26286.4742705141;34325.79859704898;34548.30903381868;37941.241175176896;38232.42651360288;48876.2668559979;50027.499725002286;50437.24344134767;50463.24305135352;51166.23250651317;7462.552246865205;7546.320831125225;7600.619969001638;7630.961845190738;7736.92263077362;8281.751547453587;10363.274570779973;10884;11510.079193664655;11763.941180294043;9852.802943941224;10105.696829095139;10155;10209.336393134423;10308.072273495422;9902.504874756378;9914.553845077133;9974.850377244493;9982.900170998197;10008.899911000797;9699.70900872975;9770.951145244228;10006.44964526958;10151.478072388041;10288.228382871164;6466.805995820133;6785.1518560179975;7017;7093.609851458219;7820.84358312842;4982.900341993212;4986.675866068694;7791.961040194763;9505.809883802147;10325.845112323172 18:38:21 INFO - PROCESS | 24903 | |3;mootools.html;1212.0424864357158;1371.2595198592758;1395.9651008724784;1459.1536908593016;1692.644544645625;6684.632345221011;7574.204708505604;7815.0231221097365;7831.490953088052;7980.201979802031;7682.692692292301;7853.057633084024;7854.410919181056;7860.685572577105;7866.056073271201;1870.6258748250336;1940.4372731907729;1940.922363105481;2193.166596693254;2230.2194232018824;1948.0649288341604;2149.795769401912;2249.730032396115;2250.5948929192737;2260.9434764130865;2124.097258665061;2184.8798316092607;2191.9890400548056;2192.7697591752876;2194.1113848891223;1790.239148361941;2128.7658357580654;2135.95728085439;2138.027197625077;2139.0908863733007;2122.5118222808687;2212.4911270407733;2215.9113635454564;2225.9109635614554;2228.0196713446194;7975.282224599814;8032.3172530335;8037.276645101969;8052.838943221162;8059.919400805976;4534.13851368239;4704.64715146362;4705.647076469244;4709.788059537329;4709.882252943669;2856.957145642817;3012.0361484325026;3053.40458610571;3094.675059118805;3112.9221769455717;933.8365785987424;946.3675160348413;964.2575217082878;978.1343510992751;1760.542259012666;10335.483225838752;10706.678799636024;10732.248742588023;10736.516856741466;10741;4114.177164567099;4243.27864263076;4294.441722576045;4307.07397909451;4311.073119279307;8382.07797142314;8386.077531471534;8448;8448.239658430648;8449.493030418073;4626.606738427204;4627.213373726475;4632.953670463319;4633.930491042637;4634;3217.404780115686;3620.9197672053583;4245;4305.440292761984;4311.8706438806885;3345.8661653533586;3440.4667276572172;3464.72282217422;3468.5144079828337;3480.7041401481156;1064.6646306413609;1069.059227879461;1080.287010573018;1088.0479580367178;1091.7161538000178;686.2417029182781;695.6904177640902;734.8126227811874;769.6228847864618;807.7738233294687;4997.200447928314;5193.662411943212;5236.24074509194;5301.920471192935;5351.491608297206;417.39477757252104;421.05473212637213;425.71902544321216;430.7329455737463;432.78793391238696;3636.29092326999;3696.8890933272046;3730.720195985312;3836.4245363195187;3842.1547259602844;9286.62853485853;9814.214862810957;9823.656172033945;9836.311458198;9840.015998400246;9629.903700963041;9729.70810875675;9734.41593504392;9735.367201131903;9743.317967742332;7394.667239974214;7439.702411903571;7448.590327532038;7459.8508029839095;7467.066616672916;5208.140656791587;5250.133727934848;5260.473952604709;5332.813351532678;5440.537554307928;8900.332475064266;9017.188453039258;9031.232345250728;9298.95350523243;9304.906950930404;9173.862392064259;9358.298127640319;9359.953200233955;9366.391184572982;9425.952870235606;5560.221568980265;5811.535077193899;5813.09896965971;5924.377940316377;5930.377310382348;7314.232005639544;7663.31030207284;7670.156282808998;7671.424643151898;7826.7651970440975;6787.185537735306;6933.7226510939;6966;6978.302169782981;7203.639818008974;7046.506744527834;7094.53885497441;7149.785506434815;7179.210286868336;7194.352508274281;5979.940200597938;6171.907421388593;6174.320824709368;6270.655113968775;6273.247210334789;4696.765161741968;4715.740634265011;4773.594244489257;4814.7833347498745;4860.465348811698;4711.78796954131;4739.336492891067;4757.928631070467;4777.4267087949665;4785.712857228577 18:38:21 INFO - PROCESS | 24903 | |4;prototype.html;285.50607449113033;286.8952832216241;288.5080937002411;295.030823744001;295.61274730103565;4811.8797030074265;4825.420949486067;4879.194932836078;4888.462269150395;4895.926561101586;4730.290456431529;4768.734850945808;4793.1132740443045;4809.927851082237;4826;3585.3187894300063;3703.907402314937;3708.2768860072297;3720.9255814883686;3731.0112820102695;3616.1682812952904;3701.592824789271;3810.161764411825;3812.8856134315874;3813.084859633682;3721.9069523262;3751.756135851175;3763.3978563429855;3770.7360484766077;3775.3581891078447;3520.260745243502;3671.889843304705;3766.359718847789;3769.9444155636465;3772.1135533149686;3258.2506023614465;3260.3316320154313;3267.428200064979;3280.1471617379416;3283.1792051987004;4674.789634466423;4709.893175103848;4726.243800991859;4737.976310118462;4777.952220477786;4248.620772367453;4294.3343781713575;4302.462192225972;4308.375285583573;4312.698111132222;4930.654854160211;5055.797768089272;5059.696418214919;5060.569851562622;5069.822556210515;3566.5185199997927;3582.6059133495296;3604.441311596707;3609.4405367168133;3610.3501369753435;5274.5780337572905;5278.366596008504;5287.312649355559;5292.417834038252;5294.258803767476;3514.525539052246;3666.1934374437583;3689.3912504436466;3691.2315763177617;3696.242270334575;3716.6283371663158;3730.8247901910813;3752.3058234226755;3777.20678657485;3783.3920583751797;4268.935965960513;4271.530131685512;4275.893102672458;4301.462317210348;4311.461067366579;4848.733319667382;5031.77357018935;5037.546620804145;5041.6722913010535;5052.191649336089;1286.7233544787916;1287.1183239480986;1290.296788250387;1292;1298.1367390685277;818.43119032272;825.5418242875262;839.6809212499334;847.8261956298944;855.5764896376334;4341.565843415633;4460.665450091256;4472.105578884236;4501.122281155209;4503.774811259424;5159.819406320761;5171.9482805171465;5189.7405129743365;5211.400688920747;5216.347956505437;4396.538363471854;4406.405135306757;4416.712913660602;4439.578240067189;4466.6873318867365;2599.8440093594445;2754.187514683173;2761.5305398082373;2793.2877116335203;2799.3561480859516;4896.698551680704;4915.5330243626795;4921.458639549646;4925.581325587365;5003.224500202475;5168.9999999999245;5291.470852914677;5370.140777475585;5373.489518495737;5445.455454454523;4854.931914978699;4859.489753575824;4876.5854902332985;4910.238912968495;4929.186684197139;5196.428392876856;5201.843944681666;5220.243064755513;5263.394664627325;5300.522952934254;4795.616350692006;5085.364329458817;5108.386993560796;5125.410577783603;5133.435322114639;4873.634477414279;4895.485973972682;4905.484924083063;4916.582090522345;4927.408710954708;3580.266045460726;3589.366838088611;3595.676389124991;3608.80151591665;3624.873129440457;5147.2536482209125;5225.817096401608;5235.769594145297;5265.868353291198;5277.076511610376;5051.217061355495;5101.693898365961;5105.7191854448365;5107.719075450886;5109.74451277442;5091.530607655211;5107.438181799925;5108.28484012246;5142.254373115802;5148.58811295088;4690.507496712796;4914.967856750122;4970.27930950003;4984.258657738302;4993.300937868628;4854.95145048545;4977.0294792515115;4978.950210497848;4986.351774269322;5113.156329205788;4843.370361852936;4869.805207791649;4869.926951095807;4977.312251384212;5013.649044566845 18:38:21 INFO - PROCESS | 24903 | |5;yui.html;654.5788431824575;700.4326495538614;719.564663378656;747.6598147842732;748.0873334531871;12718.936405317972;12893.09748317617;13172.802407963889;13177.934110329446;13196.076274660754;12599.748005039917;12860.549880754175;12871.742565148692;13020.93489532551;13045.80431293529;631.3339426904614;785.7485604606528;790.549386849496;797.7407342613644;798.732424637747;777.3159619534802;800.0559339978822;804.0672819529348;804.8148925747082;806.9031716194065;841.3521588376946;843.6245870587591;846.6359465429863;847.1697736218509;847.5126802088793;654.9443297319733;814.8573999550114;840.2353857989231;840.5587066789923;840.8990921089478;612.8437248501648;613.7913109542777;616.5191150902303;617.2901163661825;618.1068356225256;13412.329383530785;13425.127366721132;13438.798418023738;13466;13477.123986940818;12990.350482475838;13580.728385432236;13592.252426116658;13654.385552650154;13690.794638080437;11920.821187682192;12018.939905300418;12158.635240942785;12337.50649974;12880.42038108278;4129.566395528456;4129.587041295877;4226.281532139544;4261.6590672746415;4336.6530677545725;64764.67617661929;65932.67033664849;66848;67033.3296667032;68175.31824681739;9263.53682315895;9293.256539476826;9365.531723413802;9522.571484283224;9601.615935362646;18365.7245141323;18431.447056588324;18467.261309547735;18469.168887399832;18635.254589816257;6589.670516474157;6681.899771503431;6682.732690692415;6809.182898052166;6815.897761533581;3440.6559344065895;3479.4780782882262;3554.235839294564;3567.696745776638;3585.390483617739;2768.5708715149185;2866.5986761853355;2869.655641323013;2872.784541159421;2875.525538286159;468.12227074235807;488.11650911849665;497.2615665736379;500.65955150498013;502.1513641945101;449;473.6826326361277;523.17338605004;525.4561528817655;547.6932917566176;7470.327670509571;7589.533401644488;7675.616219189018;7697.23027697237;7830.021247344082;392.548569145485;472.85568923205926;506.344284152024;515.7730598536632;536.8443151486103;3352.983235083809;3602.6397360263763;3627.183883626163;3642.2897534980425;3700.870469533553;104052.47973760082;105436;106713;107678;107813;52756.73621631944;53945.730271348395;78924.60537697274;89469.55265223763;90237.09762902287;49651;51505.48494515007;79633.28996116306;80837;81882.59058704668;6653;6851.725930962705;6890.655467226518;6991.545549539263;7045.612491313027;46057.30914036225;47234.52765472301;48048.51951480441;48147;48571.75714121407;67344.66327668526;69038.65480672565;69667.30332696608;69710;73185.6340718293;9919.355241909252;10132;10473;10528.36829790215;10849.728756781144;10653.680389588324;10851.240413171003;10931.289466184673;11221.495032723384;11254.493547790533;9826.65606703762;9832.950835245778;10291.176705863663;10343.534540945526;10531.526081326512;8831.249343805848;9904.158146557624;10172.13536849376;10367.170626349724;10392.896071039193;9202.865765438715;9447.24422046221;9968;10132.392056476636;10173.593056277667;8003.279704826594;8076.394270429624;8134.959325203336;8197.262246397853;8247.876281855897;7783.571903545359;7908.920910791048;8026.157253488534;8033.758987230392;8230.21812927771 18:38:21 INFO - PROCESS | 24903 | __end_tp_report 18:38:21 INFO - PROCESS | 24903 | __start_cc_report 18:38:21 INFO - PROCESS | 24903 | _x_x_mozilla_cycle_collect,1052 18:38:21 INFO - PROCESS | 24903 | __end_cc_report 18:38:21 INFO - PROCESS | 24903 | __startTimestamp1465954701069__endTimestamp 18:38:21 INFO - PROCESS | 24903 | 18:38:21 INFO - PROCESS | 24903 | ------- Summary: start ------- 18:38:21 INFO - PROCESS | 24903 | Number of tests: 6 18:38:21 INFO - PROCESS | 24903 | 18:38:21 INFO - PROCESS | 24903 | [#0] dojo.html Cycles:165 Average:4657.63 Median:4795.23 stddev:495.70 (10.3%) stddev-sans-first:470.00 18:38:21 INFO - PROCESS | 24903 | Values: 2592.5 2605.1 2615.6 2619.5 2622.8 4534.5 4596.6 4634.9 4692.2 4734.1 4680.6 4691.2 4691.3 4749.4 4749.8 4101.5 4244.4 4334.4 4362.8 4490.6 4392.4 4404.3 4432.0 4432.6 4475.5 4239.2 4295.0 4300.0 4315.0 4354.5 4307.0 4316.6 4325.2 4372.6 4406.5 4295.9 4306.1 4307.8 4344.1 4352.8 4635.5 4637.6 4681.0 4727.7 4728.0 4999.8 5007.8 5062.2 5076.8 5077.6 5068.6 5095.5 5101.9 5113.8 5114.8 4588.1 4682.4 4740.8 4743.0 4774.8 5204.5 5223.5 5261.6 5275.4 5277.7 4995.1 4996.5 5033.9 5049.5 5051.9 4891.1 5000.3 5086.5 5092.7 5140.2 5013.8 5023.2 5033.8 5037.6 5099.5 5002.3 5006.3 5008.7 5009.3 5010.6 4193.9 4229.4 4235.6 4235.7 4273.8 3718.4 3727.9 3750.6 3781.1 3818.9 4274.3 4289.9 4290.8 4296.2 4336.9 4948.4 5004.0 5018.9 5039.4 5093.5 4291.7 4315.4 4319.0 4360.2 4362.0 4545.6 4551.0 4552.1 4554.2 4601.7 4598.7 4777.9 4781.5 4782.8 4830.7 5078.9 5099.2 5099.4 5101.2 5145.5 4795.2 4797.5 4798.0 4801.0 4834.8 4879.8 4920.6 4942.4 4960.8 5055.1 4990.1 5013.1 5013.4 5015.1 5061.8 4826.2 4848.1 4856.3 4857.7 4906.3 4664.9 4833.1 4860.5 4890.4 4894.1 4752.8 4757.2 4815.3 4836.0 4853.6 4828.5 4930.4 4936.4 4979.0 4988.1 4846.4 4875.6 4885.6 4893.0 4905.3 18:38:21 INFO - PROCESS | 24903 | 18:38:21 INFO - PROCESS | 24903 | [#1] ext.html Cycles:180 Average:56310.39 Median:33758.24 stddev:128786.04 (381.5%) stddev-sans-first:129079.24 18:38:21 INFO - PROCESS | 24903 | Values: 537.1 578.2 585.5 585.7 596.2 27031.7 40372.4 41146.6 41200.8 41255.8 41053.2 41752.8 41773.6 41811.6 41831.2 7685.7 7878.7 7889.6 8000.8 8157.8 7794.9 10119.8 10389.5 10390.6 10718.7 10525.9 10573.4 10606.6 10606.7 10614.5 7707.4 10188.9 10433.4 10491.9 10503.9 10093.8 10447.5 10452.2 10452.6 10452.9 39225.4 39506.4 39519.0 39549.6 39621.8 3093.1 3185.9 3262.7 3380.2 3521.3 30130.1 30163.5 30357.5 30449.7 30749.7 3459.5 3533.6 3535.9 3585.1 3600.5 251025.0 253838.0 254973.7 255363.0 255651.0 31029.2 54694.1 55464.2 55474.4 55493.2 32043.8 33646.8 33686.8 33742.3 33774.2 13256.3 13362.1 13362.6 13367.6 13368.1 9999.2 10823.5 10900.2 10979.2 11205.6 7896.8 7937.7 7946.4 8009.8 8018.8 3124.8 3132.8 3163.2 3166.8 3191.3 873.8 878.1 910.6 937.7 967.5 28271.7 28317.0 28424.6 28824.9 28901.4 933.5 950.9 955.7 964.5 983.3 14838.4 14926.5 15130.2 15432.8 15435.5 693623.0 715754.0 716573.0 716678.0 717593.0 50128.0 51149.0 51172.7 51196.5 51204.7 1121.4 1165.1 1182.4 1196.8 1234.9 27687.0 28905.7 29136.7 29251.6 29659.7 42724.4 43029.8 43451.6 43457.0 43459.6 330982.0 334471.0 334890.0 335001.0 335099.0 22868.9 23391.6 24980.9 25654.9 25826.7 40507.6 40540.2 41081.2 41294.0 41431.4 35830.8 36031.0 36452.1 36626.6 37088.1 35916.6 35969.6 36199.5 36652.5 36829.3 35283.5 35591.3 35816.5 35897.6 36089.0 32403.1 32479.5 32816.8 33207.3 33294.2 24905.5 25276.7 25506.5 25506.9 25751.2 18:38:21 INFO - PROCESS | 24903 | 18:38:21 INFO - PROCESS | 24903 | [#2] jquery.html Cycles:180 Average:25221.36 Median:50450.24 stddev:72176.26 (143.1%) stddev-sans-first:72354.62 18:38:21 INFO - PROCESS | 24903 | Values: 370.9 370.9 373.2 383.4 393.6 16870.7 17062.2 17972.6 18230.6 18240.7 16971.2 17104.7 17669.9 17728.6 17740.0 4941.7 5088.5 5151.7 5180.4 5184.3 3638.9 3705.8 4939.4 5798.5 5905.4 5820.2 5846.4 5854.9 5866.4 5903.6 5636.4 5834.4 5850.5 5869.6 5915.6 5151.9 5151.9 5187.0 5191.9 5214.5 12302.3 17426.5 18590.9 19690.1 19698.7 1925.1 2007.9 2260.9 2299.9 2310.6 8758.9 9388.4 9410.8 9522.1 9593.8 1730.2 1742.9 1750.3 1837.8 1841.5 51167.7 53719.7 64257.7 64820.0 71865.6 9760.5 10079.9 10116.0 10130.8 10163.7 13952.7 13977.0 13977.5 13990.7 14002.4 7369.2 7479.2 7493.3 7581.1 7586.8 7193.1 7215.8 7271.3 7345.7 7376.3 4320.4 4356.7 4404.6 4434.4 4490.4 1765.5 1817.2 1849.8 1850.8 1877.7 803.5 845.1 857.8 860.2 913.3 16969.7 17058.5 17240.1 17428.0 17484.0 840.6 850.1 912.9 925.7 939.8 9087.9 9507.8 9661.0 9718.2 9837.3 432624.0 433758.0 441817.0 443645.0 445438.0 74336.6 77128.0 77499.2 77547.2 77969.9 873.9 895.4 901.1 905.8 907.2 15523.8 15573.3 15607.4 15704.7 15791.4 26286.5 34325.8 34548.3 37941.2 38232.4 48876.3 50027.5 50437.2 50463.2 51166.2 7462.6 7546.3 7600.6 7631.0 7736.9 8281.8 10363.3 10884.0 11510.1 11763.9 9852.8 10105.7 10155.0 10209.3 10308.1 9902.5 9914.6 9974.9 9982.9 10008.9 9699.7 9771.0 10006.4 10151.5 10288.2 6466.8 6785.2 7017.0 7093.6 7820.8 4982.9 4986.7 7792.0 9505.8 10325.8 18:38:21 INFO - PROCESS | 24903 | 18:38:21 INFO - PROCESS | 24903 | [#3] mootools.html Cycles:180 Average:5131.63 Median:4928.83 stddev:2917.92 (59.2%) stddev-sans-first:2911.23 18:38:21 INFO - PROCESS | 24903 | Values: 1212.0 1371.3 1396.0 1459.2 1692.6 6684.6 7574.2 7815.0 7831.5 7980.2 7682.7 7853.1 7854.4 7860.7 7866.1 1870.6 1940.4 1940.9 2193.2 2230.2 1948.1 2149.8 2249.7 2250.6 2260.9 2124.1 2184.9 2192.0 2192.8 2194.1 1790.2 2128.8 2136.0 2138.0 2139.1 2122.5 2212.5 2215.9 2225.9 2228.0 7975.3 8032.3 8037.3 8052.8 8059.9 4534.1 4704.6 4705.6 4709.8 4709.9 2857.0 3012.0 3053.4 3094.7 3112.9 933.8 946.4 964.3 978.1 1760.5 10335.5 10706.7 10732.2 10736.5 10741.0 4114.2 4243.3 4294.4 4307.1 4311.1 8382.1 8386.1 8448.0 8448.2 8449.5 4626.6 4627.2 4633.0 4633.9 4634.0 3217.4 3620.9 4245.0 4305.4 4311.9 3345.9 3440.5 3464.7 3468.5 3480.7 1064.7 1069.1 1080.3 1088.0 1091.7 686.2 695.7 734.8 769.6 807.8 4997.2 5193.7 5236.2 5301.9 5351.5 417.4 421.1 425.7 430.7 432.8 3636.3 3696.9 3730.7 3836.4 3842.2 9286.6 9814.2 9823.7 9836.3 9840.0 9629.9 9729.7 9734.4 9735.4 9743.3 7394.7 7439.7 7448.6 7459.9 7467.1 5208.1 5250.1 5260.5 5332.8 5440.5 8900.3 9017.2 9031.2 9299.0 9304.9 9173.9 9358.3 9360.0 9366.4 9426.0 5560.2 5811.5 5813.1 5924.4 5930.4 7314.2 7663.3 7670.2 7671.4 7826.8 6787.2 6933.7 6966.0 6978.3 7203.6 7046.5 7094.5 7149.8 7179.2 7194.4 5979.9 6171.9 6174.3 6270.7 6273.2 4696.8 4715.7 4773.6 4814.8 4860.5 4711.8 4739.3 4757.9 4777.4 4785.7 18:38:21 INFO - PROCESS | 24903 | 18:38:21 INFO - PROCESS | 24903 | [#4] prototype.html Cycles:180 Average:4190.58 Median:4810.90 stddev:1226.85 (25.5%) stddev-sans-first:1194.76 18:38:21 INFO - PROCESS | 24903 | Values: 285.5 286.9 288.5 295.0 295.6 4811.9 4825.4 4879.2 4888.5 4895.9 4730.3 4768.7 4793.1 4809.9 4826.0 3585.3 3703.9 3708.3 3720.9 3731.0 3616.2 3701.6 3810.2 3812.9 3813.1 3721.9 3751.8 3763.4 3770.7 3775.4 3520.3 3671.9 3766.4 3769.9 3772.1 3258.3 3260.3 3267.4 3280.1 3283.2 4674.8 4709.9 4726.2 4738.0 4778.0 4248.6 4294.3 4302.5 4308.4 4312.7 4930.7 5055.8 5059.7 5060.6 5069.8 3566.5 3582.6 3604.4 3609.4 3610.4 5274.6 5278.4 5287.3 5292.4 5294.3 3514.5 3666.2 3689.4 3691.2 3696.2 3716.6 3730.8 3752.3 3777.2 3783.4 4268.9 4271.5 4275.9 4301.5 4311.5 4848.7 5031.8 5037.5 5041.7 5052.2 1286.7 1287.1 1290.3 1292.0 1298.1 818.4 825.5 839.7 847.8 855.6 4341.6 4460.7 4472.1 4501.1 4503.8 5159.8 5171.9 5189.7 5211.4 5216.3 4396.5 4406.4 4416.7 4439.6 4466.7 2599.8 2754.2 2761.5 2793.3 2799.4 4896.7 4915.5 4921.5 4925.6 5003.2 5169.0 5291.5 5370.1 5373.5 5445.5 4854.9 4859.5 4876.6 4910.2 4929.2 5196.4 5201.8 5220.2 5263.4 5300.5 4795.6 5085.4 5108.4 5125.4 5133.4 4873.6 4895.5 4905.5 4916.6 4927.4 3580.3 3589.4 3595.7 3608.8 3624.9 5147.3 5225.8 5235.8 5265.9 5277.1 5051.2 5101.7 5105.7 5107.7 5109.7 5091.5 5107.4 5108.3 5142.3 5148.6 4690.5 4915.0 4970.3 4984.3 4993.3 4855.0 4977.0 4979.0 4986.4 5113.2 4843.4 4869.8 4869.9 4977.3 5013.6 18:38:21 INFO - PROCESS | 24903 | 18:38:21 INFO - PROCESS | 24903 | [#5] yui.html Cycles:180 Average:17607.86 Median:524.31 stddev:26116.00 (4981.0%) stddev-sans-first:26158.24 18:38:21 INFO - PROCESS | 24903 | Values: 654.6 700.4 719.6 747.7 748.1 12718.9 12893.1 13172.8 13177.9 13196.1 12599.7 12860.5 12871.7 13020.9 13045.8 631.3 785.7 790.5 797.7 798.7 777.3 800.1 804.1 804.8 806.9 841.4 843.6 846.6 847.2 847.5 654.9 814.9 840.2 840.6 840.9 612.8 613.8 616.5 617.3 618.1 13412.3 13425.1 13438.8 13466.0 13477.1 12990.4 13580.7 13592.3 13654.4 13690.8 11920.8 12018.9 12158.6 12337.5 12880.4 4129.6 4129.6 4226.3 4261.7 4336.7 64764.7 65932.7 66848.0 67033.3 68175.3 9263.5 9293.3 9365.5 9522.6 9601.6 18365.7 18431.4 18467.3 18469.2 18635.3 6589.7 6681.9 6682.7 6809.2 6815.9 3440.7 3479.5 3554.2 3567.7 3585.4 2768.6 2866.6 2869.7 2872.8 2875.5 468.1 488.1 497.3 500.7 502.2 449.0 473.7 523.2 525.5 547.7 7470.3 7589.5 7675.6 7697.2 7830.0 392.5 472.9 506.3 515.8 536.8 3353.0 3602.6 3627.2 3642.3 3700.9 104052.5 105436.0 106713.0 107678.0 107813.0 52756.7 53945.7 78924.6 89469.6 90237.1 49651.0 51505.5 79633.3 80837.0 81882.6 6653.0 6851.7 6890.7 6991.5 7045.6 46057.3 47234.5 48048.5 48147.0 48571.8 67344.7 69038.7 69667.3 69710.0 73185.6 9919.4 10132.0 10473.0 10528.4 10849.7 10653.7 10851.2 10931.3 11221.5 11254.5 9826.7 9833.0 10291.2 10343.5 10531.5 8831.2 9904.2 10172.1 10367.2 10392.9 9202.9 9447.2 9968.0 10132.4 10173.6 8003.3 8076.4 8135.0 8197.3 8247.9 7783.6 7908.9 8026.2 8033.8 8230.2 18:38:21 INFO - PROCESS | 24903 | -------- Summary: end -------- 18:38:21 INFO - PROCESS | 24903 | 18:38:21 INFO - TEST-INFO | 24903: exit 0 18:38:21 INFO - TEST-OK | dromaeo_css | took 1121704ms 18:38:21 INFO - TEST-START | kraken 18:38:21 INFO - operating with platform_type : linux_ 18:38:21 INFO - Initialising browser for kraken test... 18:38:21 INFO - TEST-INFO | started process 25082 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXXwkyf/profile http://localhost:40224/getInfo.html) 18:38:27 INFO - PROCESS | 25082 | __metrics Screen width/height:1600/1200 18:38:27 INFO - PROCESS | 25082 | colorDepth:24 18:38:27 INFO - PROCESS | 25082 | Browser inner width/height: 1024/697 18:38:27 INFO - PROCESS | 25082 | __metrics 18:38:28 INFO - PROCESS | 25082 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:38:28 INFO - PROCESS | 25082 | console.error: PushService: 18:38:28 INFO - PROCESS | 25082 | stateChangeProcessEnqueue: Error transitioning state 18:38:28 INFO - PROCESS | 25082 | UnknownError 18:38:29 INFO - TEST-INFO | 25082: exit 0 18:38:29 INFO - Browser initialized. 18:38:29 INFO - Running cycle 1/1 for kraken test... 18:38:29 INFO - TEST-INFO | started process 25163 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXXwkyf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:38:41 INFO - PROCESS | 25163 | RSS: Main: 175284224 18:38:41 INFO - PROCESS | 25163 | 18:38:44 INFO - PROCESS | 25163 | Cycle 1(1): loaded http://localhost:40224/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40224/tests/kraken/driver.html?testName=audio-beat-detection) 18:38:45 INFO - PROCESS | 25163 | RSS: Main: 233172992 18:38:45 INFO - PROCESS | 25163 | 18:38:47 INFO - PROCESS | 25163 | Cycle 1(1): loaded http://localhost:40224/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40224/tests/kraken/driver.html?testName=audio-dft) 18:38:48 INFO - PROCESS | 25163 | RSS: Main: 221114368 18:38:48 INFO - PROCESS | 25163 | 18:38:51 INFO - PROCESS | 25163 | Cycle 1(1): loaded http://localhost:40224/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40224/tests/kraken/driver.html?testName=audio-fft) 18:38:52 INFO - PROCESS | 25163 | RSS: Main: 288903168 18:38:52 INFO - PROCESS | 25163 | 18:38:54 INFO - PROCESS | 25163 | Cycle 1(1): loaded http://localhost:40224/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40224/tests/kraken/driver.html?testName=audio-oscillator) 18:38:55 INFO - PROCESS | 25163 | RSS: Main: 199819264 18:38:55 INFO - PROCESS | 25163 | 18:38:57 INFO - PROCESS | 25163 | Cycle 1(1): loaded http://localhost:40224/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40224/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:38:57 INFO - PROCESS | 25163 | RSS: Main: 203759616 18:38:57 INFO - PROCESS | 25163 | 18:39:01 INFO - PROCESS | 25163 | Cycle 1(1): loaded http://localhost:40224/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40224/tests/kraken/driver.html?testName=imaging-darkroom) 18:39:01 INFO - PROCESS | 25163 | RSS: Main: 239751168 18:39:01 INFO - PROCESS | 25163 | 18:39:05 INFO - PROCESS | 25163 | Cycle 1(1): loaded http://localhost:40224/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40224/tests/kraken/driver.html?testName=imaging-desaturate) 18:39:05 INFO - PROCESS | 25163 | RSS: Main: 240021504 18:39:05 INFO - PROCESS | 25163 | 18:39:08 INFO - PROCESS | 25163 | Cycle 1(1): loaded http://localhost:40224/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40224/tests/kraken/driver.html?testName=json-parse-financial) 18:39:09 INFO - PROCESS | 25163 | RSS: Main: 240041984 18:39:09 INFO - PROCESS | 25163 | 18:39:10 INFO - PROCESS | 25163 | Cycle 1(1): loaded http://localhost:40224/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40224/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:39:11 INFO - PROCESS | 25163 | RSS: Main: 227958784 18:39:11 INFO - PROCESS | 25163 | 18:39:13 INFO - PROCESS | 25163 | Cycle 1(1): loaded http://localhost:40224/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40224/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:39:14 INFO - PROCESS | 25163 | RSS: Main: 231866368 18:39:14 INFO - PROCESS | 25163 | 18:39:16 INFO - PROCESS | 25163 | Cycle 1(1): loaded http://localhost:40224/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40224/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:39:16 INFO - PROCESS | 25163 | RSS: Main: 239116288 18:39:16 INFO - PROCESS | 25163 | 18:39:19 INFO - PROCESS | 25163 | Cycle 1(1): loaded http://localhost:40224/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40224/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:39:20 INFO - PROCESS | 25163 | RSS: Main: 242663424 18:39:20 INFO - PROCESS | 25163 | 18:39:23 INFO - PROCESS | 25163 | Cycle 1(1): loaded http://localhost:40224/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40224/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:39:23 INFO - PROCESS | 25163 | RSS: Main: 242044928 18:39:23 INFO - PROCESS | 25163 | 18:39:25 INFO - PROCESS | 25163 | Cycle 1(1): loaded http://localhost:40224/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40224/tests/kraken/driver.html?testName=ai-astar) 18:39:25 INFO - PROCESS | 25163 | RSS: Main: 285167616 18:39:25 INFO - PROCESS | 25163 | 18:39:25 INFO - PROCESS | 25163 | __start_tp_report 18:39:25 INFO - PROCESS | 25163 | _x_x_mozilla_page_load 18:39:25 INFO - PROCESS | 25163 | _x_x_mozilla_page_load_details 18:39:25 INFO - PROCESS | 25163 | |i|pagename|runs| 18:39:25 INFO - PROCESS | 25163 | |0;ai-astar;112;108;112;112;112;113;112;111;113;112 18:39:25 INFO - PROCESS | 25163 | |1;audio-beat-detection;161;131;139;181;131;153;154;131;181;133 18:39:25 INFO - PROCESS | 25163 | |2;audio-dft;161;161;162;160;161;162;163;161;162;162 18:39:25 INFO - PROCESS | 25163 | |3;audio-fft;77;76;79;108;75;77;75;76;102;76 18:39:25 INFO - PROCESS | 25163 | |4;audio-oscillator;85;85;117;86;86;86;122;85;85;126 18:39:25 INFO - PROCESS | 25163 | |5;imaging-gaussian-blur;117;117;117;116;117;116;117;117;116;116 18:39:25 INFO - PROCESS | 25163 | |6;imaging-darkroom;146;148;147;146;146;147;146;146;146;146 18:39:25 INFO - PROCESS | 25163 | |7;imaging-desaturate;95;95;94;95;94;95;94;95;94;94 18:39:25 INFO - PROCESS | 25163 | |8;json-parse-financial;64;61;62;62;62;63;62;62;62;63 18:39:25 INFO - PROCESS | 25163 | |9;json-stringify-tinderbox;66;66;65;65;66;65;65;67;65;66 18:39:25 INFO - PROCESS | 25163 | |10;stanford-crypto-aes;83;89;83;84;83;85;90;85;121;83 18:39:25 INFO - PROCESS | 25163 | |11;stanford-crypto-ccm;135;145;147;131;131;137;138;129;141;133 18:39:25 INFO - PROCESS | 25163 | |12;stanford-crypto-pbkdf2;170;170;169;175;169;177;171;169;168;167 18:39:25 INFO - PROCESS | 25163 | |13;stanford-crypto-sha256-iterative;70;67;67;67;66;67;67;67;66;66 18:39:25 INFO - PROCESS | 25163 | __end_tp_report 18:39:25 INFO - PROCESS | 25163 | __start_cc_report 18:39:25 INFO - PROCESS | 25163 | _x_x_mozilla_cycle_collect,1874 18:39:25 INFO - PROCESS | 25163 | __end_cc_report 18:39:25 INFO - PROCESS | 25163 | __startTimestamp1465954765798__endTimestamp 18:39:25 INFO - PROCESS | 25163 | 18:39:25 INFO - PROCESS | 25163 | ------- Summary: start ------- 18:39:25 INFO - PROCESS | 25163 | Number of tests: 14 18:39:25 INFO - PROCESS | 25163 | 18:39:25 INFO - PROCESS | 25163 | [#0] ai-astar Cycles:10 Average:111.70 Median:112.00 stddev:1.42 (1.3%) stddev-sans-first:1.50 18:39:25 INFO - PROCESS | 25163 | Values: 112.0 108.0 112.0 112.0 112.0 113.0 112.0 111.0 113.0 112.0 18:39:25 INFO - PROCESS | 25163 | 18:39:25 INFO - PROCESS | 25163 | [#1] audio-beat-detection Cycles:10 Average:149.50 Median:153.50 stddev:19.88 (13.0%) stddev-sans-first:20.65 18:39:25 INFO - PROCESS | 25163 | Values: 161.0 131.0 139.0 181.0 131.0 153.0 154.0 131.0 181.0 133.0 18:39:25 INFO - PROCESS | 25163 | 18:39:25 INFO - PROCESS | 25163 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 18:39:25 INFO - PROCESS | 25163 | Values: 161.0 161.0 162.0 160.0 161.0 162.0 163.0 161.0 162.0 162.0 18:39:25 INFO - PROCESS | 25163 | 18:39:25 INFO - PROCESS | 25163 | [#3] audio-fft Cycles:10 Average:82.10 Median:76.00 stddev:12.21 (16.1%) stddev-sans-first:12.81 18:39:25 INFO - PROCESS | 25163 | Values: 77.0 76.0 79.0 108.0 75.0 77.0 75.0 76.0 102.0 76.0 18:39:25 INFO - PROCESS | 25163 | 18:39:25 INFO - PROCESS | 25163 | [#4] audio-oscillator Cycles:10 Average:96.30 Median:85.00 stddev:17.64 (20.8%) stddev-sans-first:18.23 18:39:25 INFO - PROCESS | 25163 | Values: 85.0 85.0 117.0 86.0 86.0 86.0 122.0 85.0 85.0 126.0 18:39:25 INFO - PROCESS | 25163 | 18:39:25 INFO - PROCESS | 25163 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 18:39:25 INFO - PROCESS | 25163 | Values: 117.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 116.0 116.0 18:39:25 INFO - PROCESS | 25163 | 18:39:25 INFO - PROCESS | 25163 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 18:39:25 INFO - PROCESS | 25163 | Values: 146.0 148.0 147.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 18:39:25 INFO - PROCESS | 25163 | 18:39:25 INFO - PROCESS | 25163 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 18:39:25 INFO - PROCESS | 25163 | Values: 95.0 95.0 94.0 95.0 94.0 95.0 94.0 95.0 94.0 94.0 18:39:25 INFO - PROCESS | 25163 | 18:39:25 INFO - PROCESS | 25163 | [#8] json-parse-financial Cycles:10 Average:62.30 Median:62.00 stddev:0.82 (1.3%) stddev-sans-first:0.60 18:39:25 INFO - PROCESS | 25163 | Values: 64.0 61.0 62.0 62.0 62.0 63.0 62.0 62.0 62.0 63.0 18:39:25 INFO - PROCESS | 25163 | 18:39:25 INFO - PROCESS | 25163 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 18:39:25 INFO - PROCESS | 25163 | Values: 66.0 66.0 65.0 65.0 66.0 65.0 65.0 67.0 65.0 66.0 18:39:25 INFO - PROCESS | 25163 | 18:39:25 INFO - PROCESS | 25163 | [#10] stanford-crypto-aes Cycles:10 Average:88.60 Median:84.50 stddev:11.66 (13.8%) stddev-sans-first:12.19 18:39:25 INFO - PROCESS | 25163 | Values: 83.0 89.0 83.0 84.0 83.0 85.0 90.0 85.0 121.0 83.0 18:39:25 INFO - PROCESS | 25163 | 18:39:25 INFO - PROCESS | 25163 | [#11] stanford-crypto-ccm Cycles:10 Average:136.70 Median:137.50 stddev:6.11 (4.4%) stddev-sans-first:6.45 18:39:25 INFO - PROCESS | 25163 | Values: 135.0 145.0 147.0 131.0 131.0 137.0 138.0 129.0 141.0 133.0 18:39:25 INFO - PROCESS | 25163 | 18:39:25 INFO - PROCESS | 25163 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.50 Median:170.00 stddev:3.14 (1.8%) stddev-sans-first:3.32 18:39:25 INFO - PROCESS | 25163 | Values: 170.0 170.0 169.0 175.0 169.0 177.0 171.0 169.0 168.0 167.0 18:39:25 INFO - PROCESS | 25163 | 18:39:25 INFO - PROCESS | 25163 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:1.15 (1.7%) stddev-sans-first:0.50 18:39:25 INFO - PROCESS | 25163 | Values: 70.0 67.0 67.0 67.0 66.0 67.0 67.0 67.0 66.0 66.0 18:39:25 INFO - PROCESS | 25163 | -------- Summary: end -------- 18:39:25 INFO - PROCESS | 25163 | 18:39:26 INFO - TEST-INFO | 25163: exit 0 18:39:27 INFO - TEST-OK | kraken | took 65118ms 18:39:27 INFO - SUITE-END | took 1186s 18:39:27 INFO - Completed test suite (00:19:47) 18:39:27 INFO - javascript benchmark 18:39:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2592.4944635796023, 2605.088219123306, 2615.581506958888, 2619.4891996060765, 2622.7508386703257, 4534.546545345472, 4596.563326483987, 4634.930476042858, 4692.202325604647, 4734.100520901026, 4680.648951328655, 4691.2024955757515, 4691.272852707827, 4749.4063242094735, 4749.786259618317, 4101.548829628753, 4244.405783190348, 4334.414853994702, 4362.8036738346855, 4490.5509449055, 4392.407025051609, 4404.2512772828695, 4432.0, 4432.556744325574, 4475.507694153641, 4239.215745087169, 4295.012147206129, 4299.978500107511, 4315.029118448356, 4354.455693038371, 4307.0, 4316.633086187647, 4325.156594464081, 4372.628326592244, 4406.471223453174, 4295.892602684958, 4306.117245964601, 4307.763073030982, 4344.131173765228, 4352.804123814436, 4635.490096089427, 4637.6289896808175, 4680.95319046812, 4727.739974301412, 4728.0, 4999.750012499397, 5007.84976450707, 5062.215356619729, 5076.771545280471, 5077.64456488046, 5068.645194836363, 5095.515925987025, 5101.923471147936, 5113.795448182068, 5114.820981265638, 4588.082383523309, 4682.41469816273, 4740.762961851928, 4743.0, 4774.809007639725, 5204.531592156724, 5223.503767142115, 5261.552768014762, 5275.419703832576, 5277.736113194325, 4995.125852975715, 4996.525330093636, 5033.899322013539, 5049.545540901337, 5051.924221136685, 4891.095147397743, 5000.299958005882, 5086.465921078234, 5092.745362731848, 5140.203268493389, 5013.799448022039, 5023.2214006829, 5033.798648054037, 5037.647364684511, 5099.490050994871, 5002.299678045077, 5006.274090256965, 5008.749562521859, 5009.348784657971, 5010.64925455222, 4193.895152621209, 4229.365595160751, 4235.576442355801, 4235.703500754979, 4273.829046838092, 3718.3678774608384, 3727.8508859645854, 3750.624937506282, 3781.1303400218103, 3818.9236215275537, 4274.316109422478, 4289.935650965238, 4290.849820256276, 4296.183725092223, 4336.934945975813, 4948.356713627278, 5004.0, 5018.89962200754, 5039.44566097729, 5093.541581257705, 4291.699581029298, 4315.352697095398, 4318.978405107954, 4360.236958532308, 4361.996740749645, 4545.568171023748, 4550.97724511382, 4552.066826300666, 4554.203014472454, 4601.700889442175, 4598.724076555417, 4777.928331075037, 4781.497942715965, 4782.832600858953, 4830.7101573905675, 5078.949210507848, 5099.209622508517, 5099.439061703284, 5101.234814777813, 5145.485451454824, 4795.232762757942, 4797.520247975174, 4797.952020479751, 4800.975995120002, 4834.806607735652, 4879.756012199447, 4920.630952678635, 4942.357493525818, 4960.751962401938, 5055.090083784954, 4990.076835785391, 5013.147764879906, 5013.39839219296, 5015.072211640858, 5061.797528098835, 4826.155422800925, 4848.054629347384, 4856.320115183948, 4857.708537487762, 4906.3376444181, 4664.93002604968, 4833.10587541306, 4860.513948605111, 4890.388701412324, 4894.094592500399, 4752.809887604457, 4757.167495688172, 4815.3258543803195, 4836.0, 4853.587445067067, 4828.517148285144, 4930.408350997904, 4936.432310284364, 4978.975105124451, 4988.102141614544, 4846.418429788448, 4875.634327425528, 4885.609151267961, 4892.951070489249, 4905.264210368473], "value": 4625.528145893839, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [537.1236136848937, 578.2309528327324, 585.5374254339073, 585.6544638663188, 596.2338395162216, 27031.729682703168, 40372.39441408378, 41146.58853411465, 41200.79399603005, 41255.793721031354, 41053.17893642125, 41752.79123604386, 41773.58226417735, 41811.58188418115, 41831.163376732446, 7685.654145563463, 7878.724244651438, 7889.644965976545, 8000.799980000503, 8157.836843263131, 7794.922050779504, 10119.848202276935, 10389.48052597371, 10390.584376624925, 10718.732031699192, 10525.947370263139, 10573.418461984587, 10606.628767993121, 10606.681799546026, 10614.522346494388, 7707.383409327296, 10188.898111018869, 10433.42616156111, 10491.94754026225, 10503.894961050368, 10093.798124037552, 10447.52986115619, 10452.216083793746, 10452.634157804516, 10452.895471045344, 39225.41161882574, 39506.40740388897, 39519.0, 39549.60450395488, 39621.801890990646, 3093.133922501703, 3185.9362812743616, 3262.7389808815237, 3380.171857894807, 3521.3485505181625, 30130.096097117123, 30163.547546786816, 30357.544636830466, 30449.695503044906, 30749.692503074908, 3459.4810778383194, 3533.575970883485, 3535.8585656573705, 3585.1395665040463, 3600.47793070006, 251025.0, 253838.0, 254973.72513137502, 255363.0, 255651.0, 31029.224269393446, 54694.085707000064, 55464.16803747947, 55474.44525554773, 55493.16760248599, 32043.839780800947, 33646.831765841016, 33686.831565842505, 33742.32515349728, 33774.155646109044, 13256.337183140997, 13362.131461454974, 13362.599122026355, 13367.59897203066, 13368.064235503616, 9999.150072243796, 10823.458827058615, 10900.236983411085, 10979.231453798158, 11205.551777928791, 7896.763097107096, 7937.722179723682, 7946.364290856717, 8009.759707208793, 8018.79953001168, 3124.8437578121, 3132.7963682360573, 3163.209197700575, 3166.794158379698, 3191.3138675184946, 873.8231254603007, 878.0736323179108, 910.5993362920426, 937.6765016069445, 967.5452537307455, 28271.717282826907, 28317.0, 28424.573631395546, 28824.855875720907, 28901.421971560452, 933.4725879877848, 950.9286803489766, 955.6655170690203, 964.5177411294353, 983.311681822727, 14838.40646374133, 14926.477573284883, 15130.167840768863, 15432.768508472382, 15435.536933892, 693623.0, 715754.0, 716573.0, 716678.0, 717593.0, 50128.0, 51149.0, 51172.74413627908, 51196.488035119175, 51204.74397627988, 1121.3608243301403, 1165.1436194396942, 1182.379250893288, 1196.802527582939, 1234.8703386144325, 27687.0, 28905.710942891143, 29136.7086329134, 29251.561226582045, 29659.703402966556, 42724.35913461363, 43029.78485107554, 43451.565484346014, 43457.0, 43459.56540434682, 330982.0, 334471.0, 334890.0, 335001.0, 335099.0, 22868.88565557228, 23391.649125263473, 24980.875095624404, 25654.871725641253, 25826.741732582435, 40507.59492405038, 40540.189196215324, 41081.1783764329, 41294.0, 41431.37852932269, 35830.82084589561, 36031.0, 36452.08869778277, 36626.633733662326, 37088.07279818026, 35916.64083359238, 35969.64030359663, 36199.45700814542, 36652.45021324629, 36829.26341473102, 35283.47074793932, 35591.28817423689, 35816.46275305925, 35897.64102358943, 36089.0, 32403.08372246509, 32479.512807308383, 32816.835915820266, 33207.33585328232, 33294.16764580905, 24905.501889962463, 25276.74723252744, 25506.48987020212, 25506.86918255205, 25751.227463176136], "value": 17396.275175723877, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.8664880642969, 370.8998570385994, 373.18086799475157, 383.37509858929974, 393.56314490915076, 16870.746938795914, 17062.232199551036, 17972.55068623282, 18230.635387292263, 18240.726389104173, 16971.236294366754, 17104.743428848546, 17669.91165044176, 17728.64542709145, 17740.0, 4941.654084214107, 5088.465711100337, 5151.6908985460805, 5180.404253510838, 5184.326037615105, 3638.945415818765, 3705.8147092645395, 4939.382577177853, 5798.478136967672, 5905.43898329658, 5820.156077368779, 5846.444587764156, 5854.853628659275, 5866.354700982888, 5903.645781253117, 5636.408177141403, 5834.3873893241025, 5850.502707269887, 5869.559783016248, 5915.556333274979, 5151.922721159186, 5151.9484805152215, 5187.0, 5191.922121168148, 5214.504622060898, 12302.261864288083, 17426.518745906615, 18590.90704546482, 19690.113944872515, 19698.70451943222, 1925.075963537496, 2007.8694884832585, 2260.8530445520987, 2299.9190380521295, 2310.607196776552, 8758.912410875873, 9388.389754665925, 9410.811783764355, 9522.0954009369, 9593.808123837554, 1730.2473424060574, 1742.8605711543173, 1750.2823842224627, 1837.7702787151607, 1841.4567702527786, 51167.744161278955, 53719.73140134313, 64257.67871160661, 64820.027699584076, 71865.64067179683, 9760.511974401252, 10079.875238676033, 10116.0, 10130.848037279447, 10163.745906352253, 13952.720945581032, 13977.0, 13977.510787122403, 13990.650233744238, 14002.439902403994, 7369.189389167187, 7479.177290498041, 7493.325600695964, 7581.12817026038, 7586.772396828104, 7193.136823581099, 7215.783526494213, 7271.272872712792, 7345.70617175307, 7376.299251571092, 4320.4383430153875, 4356.738595684269, 4404.55954404557, 4434.357018232403, 4490.371348011281, 1765.4615342320458, 1817.191349849331, 1849.7687789026372, 1850.7501487299312, 1877.7371168036486, 803.4536515169741, 845.0830848529414, 857.8455877941906, 860.2257967828879, 913.3013244867682, 16969.745453818203, 17058.48824535266, 17240.137993100296, 17428.041457719948, 17484.0, 840.5881118252013, 850.0776657326869, 912.9087091290951, 925.6713866577403, 939.7838497145694, 9087.863682044775, 9507.809843803085, 9661.0, 9718.173955213744, 9837.262205334628, 432624.0, 433758.0, 441817.0, 443645.0, 445438.0, 74336.62831685915, 77128.0, 77499.22500775033, 77547.22452775513, 77969.88120475231, 873.9388242823069, 895.3980703824483, 901.1034021148998, 905.800723840754, 907.1654078248027, 15523.84476155224, 15573.299201536185, 15607.375704972128, 15704.685906281582, 15791.447299344467, 26286.4742705141, 34325.79859704898, 34548.30903381868, 37941.241175176896, 38232.42651360288, 48876.2668559979, 50027.499725002286, 50437.24344134767, 50463.24305135352, 51166.23250651317, 7462.552246865205, 7546.320831125225, 7600.619969001638, 7630.961845190738, 7736.92263077362, 8281.751547453587, 10363.274570779973, 10884.0, 11510.079193664655, 11763.941180294043, 9852.802943941224, 10105.696829095139, 10155.0, 10209.336393134423, 10308.072273495422, 9902.504874756378, 9914.553845077133, 9974.850377244493, 9982.900170998197, 10008.899911000797, 9699.70900872975, 9770.951145244228, 10006.44964526958, 10151.478072388041, 10288.228382871164, 6466.805995820133, 6785.1518560179975, 7017.0, 7093.609851458219, 7820.84358312842, 4982.900341993212, 4986.675866068694, 7791.961040194763, 9505.809883802147, 10325.845112323172], "value": 8110.652491900065, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1212.0424864357158, 1371.2595198592758, 1395.9651008724784, 1459.1536908593016, 1692.644544645625, 6684.632345221011, 7574.204708505604, 7815.0231221097365, 7831.490953088052, 7980.201979802031, 7682.692692292301, 7853.057633084024, 7854.410919181056, 7860.685572577105, 7866.056073271201, 1870.6258748250336, 1940.4372731907729, 1940.922363105481, 2193.166596693254, 2230.2194232018824, 1948.0649288341604, 2149.795769401912, 2249.730032396115, 2250.5948929192737, 2260.9434764130865, 2124.097258665061, 2184.8798316092607, 2191.9890400548056, 2192.7697591752876, 2194.1113848891223, 1790.239148361941, 2128.7658357580654, 2135.95728085439, 2138.027197625077, 2139.0908863733007, 2122.5118222808687, 2212.4911270407733, 2215.9113635454564, 2225.9109635614554, 2228.0196713446194, 7975.282224599814, 8032.3172530335, 8037.276645101969, 8052.838943221162, 8059.919400805976, 4534.13851368239, 4704.64715146362, 4705.647076469244, 4709.788059537329, 4709.882252943669, 2856.957145642817, 3012.0361484325026, 3053.40458610571, 3094.675059118805, 3112.9221769455717, 933.8365785987424, 946.3675160348413, 964.2575217082878, 978.1343510992751, 1760.542259012666, 10335.483225838752, 10706.678799636024, 10732.248742588023, 10736.516856741466, 10741.0, 4114.177164567099, 4243.27864263076, 4294.441722576045, 4307.07397909451, 4311.073119279307, 8382.07797142314, 8386.077531471534, 8448.0, 8448.239658430648, 8449.493030418073, 4626.606738427204, 4627.213373726475, 4632.953670463319, 4633.930491042637, 4634.0, 3217.404780115686, 3620.9197672053583, 4245.0, 4305.440292761984, 4311.8706438806885, 3345.8661653533586, 3440.4667276572172, 3464.72282217422, 3468.5144079828337, 3480.7041401481156, 1064.6646306413609, 1069.059227879461, 1080.287010573018, 1088.0479580367178, 1091.7161538000178, 686.2417029182781, 695.6904177640902, 734.8126227811874, 769.6228847864618, 807.7738233294687, 4997.200447928314, 5193.662411943212, 5236.24074509194, 5301.920471192935, 5351.491608297206, 417.39477757252104, 421.05473212637213, 425.71902544321216, 430.7329455737463, 432.78793391238696, 3636.29092326999, 3696.8890933272046, 3730.720195985312, 3836.4245363195187, 3842.1547259602844, 9286.62853485853, 9814.214862810957, 9823.656172033945, 9836.311458198, 9840.015998400246, 9629.903700963041, 9729.70810875675, 9734.41593504392, 9735.367201131903, 9743.317967742332, 7394.667239974214, 7439.702411903571, 7448.590327532038, 7459.8508029839095, 7467.066616672916, 5208.140656791587, 5250.133727934848, 5260.473952604709, 5332.813351532678, 5440.537554307928, 8900.332475064266, 9017.188453039258, 9031.232345250728, 9298.95350523243, 9304.906950930404, 9173.862392064259, 9358.298127640319, 9359.953200233955, 9366.391184572982, 9425.952870235606, 5560.221568980265, 5811.535077193899, 5813.09896965971, 5924.377940316377, 5930.377310382348, 7314.232005639544, 7663.31030207284, 7670.156282808998, 7671.424643151898, 7826.7651970440975, 6787.185537735306, 6933.7226510939, 6966.0, 6978.302169782981, 7203.639818008974, 7046.506744527834, 7094.53885497441, 7149.785506434815, 7179.210286868336, 7194.352508274281, 5979.940200597938, 6171.907421388593, 6174.320824709368, 6270.655113968775, 6273.247210334789, 4696.765161741968, 4715.740634265011, 4773.594244489257, 4814.7833347498745, 4860.465348811698, 4711.78796954131, 4739.336492891067, 4757.928631070467, 4777.4267087949665, 4785.712857228577], "value": 4049.004295486388, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.50607449113033, 286.8952832216241, 288.5080937002411, 295.030823744001, 295.61274730103565, 4811.8797030074265, 4825.420949486067, 4879.194932836078, 4888.462269150395, 4895.926561101586, 4730.290456431529, 4768.734850945808, 4793.1132740443045, 4809.927851082237, 4826.0, 3585.3187894300063, 3703.907402314937, 3708.2768860072297, 3720.9255814883686, 3731.0112820102695, 3616.1682812952904, 3701.592824789271, 3810.161764411825, 3812.8856134315874, 3813.084859633682, 3721.9069523262, 3751.756135851175, 3763.3978563429855, 3770.7360484766077, 3775.3581891078447, 3520.260745243502, 3671.889843304705, 3766.359718847789, 3769.9444155636465, 3772.1135533149686, 3258.2506023614465, 3260.3316320154313, 3267.428200064979, 3280.1471617379416, 3283.1792051987004, 4674.789634466423, 4709.893175103848, 4726.243800991859, 4737.976310118462, 4777.952220477786, 4248.620772367453, 4294.3343781713575, 4302.462192225972, 4308.375285583573, 4312.698111132222, 4930.654854160211, 5055.797768089272, 5059.696418214919, 5060.569851562622, 5069.822556210515, 3566.5185199997927, 3582.6059133495296, 3604.441311596707, 3609.4405367168133, 3610.3501369753435, 5274.5780337572905, 5278.366596008504, 5287.312649355559, 5292.417834038252, 5294.258803767476, 3514.525539052246, 3666.1934374437583, 3689.3912504436466, 3691.2315763177617, 3696.242270334575, 3716.6283371663158, 3730.8247901910813, 3752.3058234226755, 3777.20678657485, 3783.3920583751797, 4268.935965960513, 4271.530131685512, 4275.893102672458, 4301.462317210348, 4311.461067366579, 4848.733319667382, 5031.77357018935, 5037.546620804145, 5041.6722913010535, 5052.191649336089, 1286.7233544787916, 1287.1183239480986, 1290.296788250387, 1292.0, 1298.1367390685277, 818.43119032272, 825.5418242875262, 839.6809212499334, 847.8261956298944, 855.5764896376334, 4341.565843415633, 4460.665450091256, 4472.105578884236, 4501.122281155209, 4503.774811259424, 5159.819406320761, 5171.9482805171465, 5189.7405129743365, 5211.400688920747, 5216.347956505437, 4396.538363471854, 4406.405135306757, 4416.712913660602, 4439.578240067189, 4466.6873318867365, 2599.8440093594445, 2754.187514683173, 2761.5305398082373, 2793.2877116335203, 2799.3561480859516, 4896.698551680704, 4915.5330243626795, 4921.458639549646, 4925.581325587365, 5003.224500202475, 5168.9999999999245, 5291.470852914677, 5370.140777475585, 5373.489518495737, 5445.455454454523, 4854.931914978699, 4859.489753575824, 4876.5854902332985, 4910.238912968495, 4929.186684197139, 5196.428392876856, 5201.843944681666, 5220.243064755513, 5263.394664627325, 5300.522952934254, 4795.616350692006, 5085.364329458817, 5108.386993560796, 5125.410577783603, 5133.435322114639, 4873.634477414279, 4895.485973972682, 4905.484924083063, 4916.582090522345, 4927.408710954708, 3580.266045460726, 3589.366838088611, 3595.676389124991, 3608.80151591665, 3624.873129440457, 5147.2536482209125, 5225.817096401608, 5235.769594145297, 5265.868353291198, 5277.076511610376, 5051.217061355495, 5101.693898365961, 5105.7191854448365, 5107.719075450886, 5109.74451277442, 5091.530607655211, 5107.438181799925, 5108.28484012246, 5142.254373115802, 5148.58811295088, 4690.507496712796, 4914.967856750122, 4970.27930950003, 4984.258657738302, 4993.300937868628, 4854.95145048545, 4977.0294792515115, 4978.950210497848, 4986.351774269322, 5113.156329205788, 4843.370361852936, 4869.805207791649, 4869.926951095807, 4977.312251384212, 5013.649044566845], "value": 3797.099604439184, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [654.5788431824575, 700.4326495538614, 719.564663378656, 747.6598147842732, 748.0873334531871, 12718.936405317972, 12893.09748317617, 13172.802407963889, 13177.934110329446, 13196.076274660754, 12599.748005039917, 12860.549880754175, 12871.742565148692, 13020.93489532551, 13045.80431293529, 631.3339426904614, 785.7485604606528, 790.549386849496, 797.7407342613644, 798.732424637747, 777.3159619534802, 800.0559339978822, 804.0672819529348, 804.8148925747082, 806.9031716194065, 841.3521588376946, 843.6245870587591, 846.6359465429863, 847.1697736218509, 847.5126802088793, 654.9443297319733, 814.8573999550114, 840.2353857989231, 840.5587066789923, 840.8990921089478, 612.8437248501648, 613.7913109542777, 616.5191150902303, 617.2901163661825, 618.1068356225256, 13412.329383530785, 13425.127366721132, 13438.798418023738, 13466.0, 13477.123986940818, 12990.350482475838, 13580.728385432236, 13592.252426116658, 13654.385552650154, 13690.794638080437, 11920.821187682192, 12018.939905300418, 12158.635240942785, 12337.50649974, 12880.42038108278, 4129.566395528456, 4129.587041295877, 4226.281532139544, 4261.6590672746415, 4336.6530677545725, 64764.67617661929, 65932.67033664849, 66848.0, 67033.3296667032, 68175.31824681739, 9263.53682315895, 9293.256539476826, 9365.531723413802, 9522.571484283224, 9601.615935362646, 18365.7245141323, 18431.447056588324, 18467.261309547735, 18469.168887399832, 18635.254589816257, 6589.670516474157, 6681.899771503431, 6682.732690692415, 6809.182898052166, 6815.897761533581, 3440.6559344065895, 3479.4780782882262, 3554.235839294564, 3567.696745776638, 3585.390483617739, 2768.5708715149185, 2866.5986761853355, 2869.655641323013, 2872.784541159421, 2875.525538286159, 468.12227074235807, 488.11650911849665, 497.2615665736379, 500.65955150498013, 502.1513641945101, 449.0, 473.6826326361277, 523.17338605004, 525.4561528817655, 547.6932917566176, 7470.327670509571, 7589.533401644488, 7675.616219189018, 7697.23027697237, 7830.021247344082, 392.548569145485, 472.85568923205926, 506.344284152024, 515.7730598536632, 536.8443151486103, 3352.983235083809, 3602.6397360263763, 3627.183883626163, 3642.2897534980425, 3700.870469533553, 104052.47973760082, 105436.0, 106713.0, 107678.0, 107813.0, 52756.73621631944, 53945.730271348395, 78924.60537697274, 89469.55265223763, 90237.09762902287, 49651.0, 51505.48494515007, 79633.28996116306, 80837.0, 81882.59058704668, 6653.0, 6851.725930962705, 6890.655467226518, 6991.545549539263, 7045.612491313027, 46057.30914036225, 47234.52765472301, 48048.51951480441, 48147.0, 48571.75714121407, 67344.66327668526, 69038.65480672565, 69667.30332696608, 69710.0, 73185.6340718293, 9919.355241909252, 10132.0, 10473.0, 10528.36829790215, 10849.728756781144, 10653.680389588324, 10851.240413171003, 10931.289466184673, 11221.495032723384, 11254.493547790533, 9826.65606703762, 9832.950835245778, 10291.176705863663, 10343.534540945526, 10531.526081326512, 8831.249343805848, 9904.158146557624, 10172.13536849376, 10367.170626349724, 10392.896071039193, 9202.865765438715, 9447.24422046221, 9968.0, 10132.392056476636, 10173.593056277667, 8003.279704826594, 8076.394270429624, 8134.959325203336, 8197.262246397853, 8247.876281855897, 7783.571903545359, 7908.920910791048, 8026.157253488534, 8033.758987230392, 8230.21812927771], "value": 6317.628151620058, "unit": "score"}], "name": "dromaeo_css", "value": 6314.606577278103, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 108.0, 112.0, 112.0, 112.0, 113.0, 112.0, 111.0, 113.0, 112.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 131.0, 139.0, 181.0, 131.0, 153.0, 154.0, 131.0, 181.0, 133.0], "value": 149.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 160.0, 161.0, 162.0, 163.0, 161.0, 162.0, 162.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 79.0, 108.0, 75.0, 77.0, 75.0, 76.0, 102.0, 76.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 117.0, 86.0, 86.0, 86.0, 122.0, 85.0, 85.0, 126.0], "value": 96.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 61.0, 62.0, 62.0, 62.0, 63.0, 62.0, 62.0, 62.0, 63.0], "value": 62.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 65.0, 66.0, 65.0, 65.0, 67.0, 65.0, 66.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 89.0, 83.0, 84.0, 83.0, 85.0, 90.0, 85.0, 121.0, 83.0], "value": 88.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 145.0, 147.0, 131.0, 131.0, 137.0, 138.0, 129.0, 141.0, 133.0], "value": 136.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 170.0, 169.0, 175.0, 169.0, 177.0, 171.0, 169.0, 168.0, 167.0], "value": 170.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 67.0, 67.0, 66.0, 67.0, 67.0, 67.0, 66.0, 66.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1549.2999999999997, "alertThreshold": 2.0}]} 18:39:27 INFO - Return code: 0 18:39:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:39:27 INFO - # TBPL SUCCESS # 18:39:27 INFO - Running post-action listener: _resource_record_post_action 18:39:27 INFO - ##### 18:39:27 INFO - ##### Finished run-tests step (success) 18:39:27 INFO - ##### 18:39:27 INFO - Running post-run listener: _resource_record_post_run 18:39:27 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 8192; Write bytes: 539422720; Read time: 764; Write time: 1725800 18:39:27 INFO - TinderboxPrint: CPU usage
13.3% 18:39:27 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 764 18:39:27 INFO - TinderboxPrint: I/O write bytes / time
539,422,720 / 1,725,800 18:39:27 INFO - TinderboxPrint: CPU idle
8,329.2 (86.7%) 18:39:27 INFO - TinderboxPrint: CPU user
1,213.4 (12.6%) 18:39:27 INFO - TinderboxPrint: Swap in / out
0 / 0 18:39:27 INFO - install - Wall time: 16s; CPU: 17.0%; Read bytes: 0; Write bytes: 244838400; Read time: 0; Write time: 659028 18:39:27 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 8192; Write bytes: 294584320; Read time: 764; Write time: 1066772 18:39:28 INFO - Running post-run listener: _upload_blobber_files 18:39:28 INFO - Blob upload gear active. 18:39:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:39:28 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 18:39:28 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'] 18:39:28 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 18:39:28 INFO - (blobuploader) - INFO - Open directory for files ... 18:39:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:39:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:39:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:39:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:39:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:39:29 INFO - (blobuploader) - INFO - Done attempting. 18:39:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:39:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:39:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:39:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:39:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:39:33 INFO - (blobuploader) - INFO - Done attempting. 18:39:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:39:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:39:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:39:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:39:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:39:33 INFO - (blobuploader) - INFO - Done attempting. 18:39:33 INFO - (blobuploader) - INFO - Iteration through files over. 18:39:33 INFO - Return code: 0 18:39:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:39:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:39:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a3febb2e75a963fd13d98d5b3742321f1a37f19ef1ed5d23872c8e1315a0927dcfcfb0b9027379af09a94cc8dc703d42edd69dcd1d63ecd26e746699aa4f0d5a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9b01838cc36345becbb977b852a998ff181f595a2b7234b6b21cebe509a1c7cfc185cd422344ebf5372a6e81d5ad9fbe0d9c299e6623419704a612a39a73f95a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7293b1968eba59e46ee48e4a76476c79057cb2708ce39924d0bb68da458c52145b80ea17755cd689de05db33730a36ae4ed93252fcfd8ce33dada9d911d583ad"} 18:39:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:39:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:39:33 INFO - Contents: 18:39:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a3febb2e75a963fd13d98d5b3742321f1a37f19ef1ed5d23872c8e1315a0927dcfcfb0b9027379af09a94cc8dc703d42edd69dcd1d63ecd26e746699aa4f0d5a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9b01838cc36345becbb977b852a998ff181f595a2b7234b6b21cebe509a1c7cfc185cd422344ebf5372a6e81d5ad9fbe0d9c299e6623419704a612a39a73f95a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7293b1968eba59e46ee48e4a76476c79057cb2708ce39924d0bb68da458c52145b80ea17755cd689de05db33730a36ae4ed93252fcfd8ce33dada9d911d583ad"} 18:39:33 INFO - Running post-run listener: copy_logs_to_upload_dir 18:39:33 INFO - Copying logs to upload dir... 18:39:33 INFO - mkdir: /builds/slave/test/build/upload/logs 18:39:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.879076 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-14 18:39:33.707670) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-14 18:39:33.711016) ========= 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=8783db0840cc980e80bb0bd400000236-1465953523.624962-904656020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a3febb2e75a963fd13d98d5b3742321f1a37f19ef1ed5d23872c8e1315a0927dcfcfb0b9027379af09a94cc8dc703d42edd69dcd1d63ecd26e746699aa4f0d5a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9b01838cc36345becbb977b852a998ff181f595a2b7234b6b21cebe509a1c7cfc185cd422344ebf5372a6e81d5ad9fbe0d9c299e6623419704a612a39a73f95a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7293b1968eba59e46ee48e4a76476c79057cb2708ce39924d0bb68da458c52145b80ea17755cd689de05db33730a36ae4ed93252fcfd8ce33dada9d911d583ad"} build_url:https://queue.taskcluster.net/v1/task/G0T1sskeQNiGGZrSFu2b8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011373 build_url: 'https://queue.taskcluster.net/v1/task/G0T1sskeQNiGGZrSFu2b8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a3febb2e75a963fd13d98d5b3742321f1a37f19ef1ed5d23872c8e1315a0927dcfcfb0b9027379af09a94cc8dc703d42edd69dcd1d63ecd26e746699aa4f0d5a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9b01838cc36345becbb977b852a998ff181f595a2b7234b6b21cebe509a1c7cfc185cd422344ebf5372a6e81d5ad9fbe0d9c299e6623419704a612a39a73f95a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7293b1968eba59e46ee48e4a76476c79057cb2708ce39924d0bb68da458c52145b80ea17755cd689de05db33730a36ae4ed93252fcfd8ce33dada9d911d583ad"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-14 18:39:33.736673) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 18:39:33.736999) ========= 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=8783db0840cc980e80bb0bd400000236-1465953523.624962-904656020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004541 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 18:39:33.822664) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-14 18:39:33.822997) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-14 18:39:33.823325) ========= ========= Total master_lag: 0.18 =========