builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-019 starttime: 1465953653.71 results: success (0) buildid: 20160614170925 builduid: 694114dbed4d4e6889572070acf6230b revision: 53f5b5c289fba6ad82c675578cf1c548ae37f0c1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-14 18:20:53.709051) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-14 18:20:53.709539) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-14 18:20:53.709824) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-14 18:20:53.724673) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 18:20:53.725055) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1465953653.117090-1448919995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-14 18:20:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 112M=0s 2016-06-14 18:20:53 (112 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.141673 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 18:20:53.880599) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 18:20:53.880914) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1465953653.117090-1448919995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014202 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 18:20:53.932324) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 18:20:53.932707) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1465953653.117090-1448919995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-14 18:20:54,018 truncating revision to first 12 chars 2016-06-14 18:20:54,018 Setting DEBUG logging. 2016-06-14 18:20:54,018 attempt 1/10 2016-06-14 18:20:54,018 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:20:54,467 unpacking tar archive at: fx-team-53f5b5c289fb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.803148 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 18:20:54.749637) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-14 18:20:54.749981) ========= script_repo_revision: 53f5b5c289fba6ad82c675578cf1c548ae37f0c1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-14 18:20:54.750402) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-14 18:20:54.750687) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-14 18:20:54.760142) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-14 18:20:54.760546) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1465953653.117090-1448919995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:20:54 INFO - MultiFileLogger online at 20160614 18:20:54 in /builds/slave/test 18:20:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 18:20:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:20:54 INFO - {'append_to_log': False, 18:20:54 INFO - 'base_work_dir': '/builds/slave/test', 18:20:54 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 18:20:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:20:54 INFO - 'branch': 'Fx-Team-Non-PGO', 18:20:54 INFO - 'buildbot_json_path': 'buildprops.json', 18:20:54 INFO - 'config_files': ('talos/linux_config.py',), 18:20:54 INFO - 'default_actions': ('clobber', 18:20:54 INFO - 'read-buildbot-config', 18:20:54 INFO - 'download-and-extract', 18:20:54 INFO - 'populate-webroot', 18:20:54 INFO - 'create-virtualenv', 18:20:54 INFO - 'install', 18:20:54 INFO - 'run-tests'), 18:20:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:20:54 INFO - 'download_minidump_stackwalk': True, 18:20:54 INFO - 'download_symbols': 'ondemand', 18:20:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:20:54 INFO - 'tooltool.py': '/tools/tooltool.py', 18:20:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:20:54 INFO - '/tools/misc-python/virtualenv.py')}, 18:20:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:20:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:20:54 INFO - 'installer_path': 'installer.exe', 18:20:54 INFO - 'log_level': 'info', 18:20:54 INFO - 'log_name': 'talos', 18:20:54 INFO - 'log_to_console': True, 18:20:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:20:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:20:54 INFO - 'opt_config_files': (), 18:20:54 INFO - 'pip_index': False, 18:20:54 INFO - 'sps_profile': False, 18:20:54 INFO - 'sps_profile_interval': 0, 18:20:54 INFO - 'suite': 'dromaeojs-e10s', 18:20:54 INFO - 'system_bits': '32', 18:20:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:20:54 INFO - 'title': 'talos-linux64-ix-019', 18:20:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:20:54 INFO - 'use_talos_json': True, 18:20:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:20:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:20:54 INFO - 'work_dir': 'build'} 18:20:54 INFO - ##### 18:20:54 INFO - ##### Running clobber step. 18:20:54 INFO - ##### 18:20:54 INFO - Running pre-action listener: _resource_record_pre_action 18:20:54 INFO - Running main action method: clobber 18:20:54 INFO - rmtree: /builds/slave/test/build 18:20:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:20:55 INFO - Running post-action listener: _resource_record_post_action 18:20:55 INFO - ##### 18:20:55 INFO - ##### Finished clobber step (success) 18:20:55 INFO - ##### 18:20:55 INFO - ##### 18:20:55 INFO - ##### Running read-buildbot-config step. 18:20:55 INFO - ##### 18:20:55 INFO - Running pre-action listener: _resource_record_pre_action 18:20:55 INFO - Running main action method: read_buildbot_config 18:20:55 INFO - Using buildbot properties: 18:20:55 INFO - { 18:20:55 INFO - "project": "", 18:20:55 INFO - "product": "firefox", 18:20:55 INFO - "script_repo_revision": "production", 18:20:55 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 18:20:55 INFO - "repository": "", 18:20:55 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 18:20:55 INFO - "buildid": "20160614170925", 18:20:55 INFO - "pgo_build": "False", 18:20:55 INFO - "basedir": "/builds/slave/test", 18:20:55 INFO - "buildnumber": 1412, 18:20:55 INFO - "slavename": "talos-linux64-ix-019", 18:20:55 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:20:55 INFO - "platform": "ubuntu64_hw", 18:20:55 INFO - "scheduler": "tests-fx-team-linux64-talos", 18:20:55 INFO - "branch": "fx-team", 18:20:55 INFO - "repo_path": "integration/fx-team", 18:20:55 INFO - "revision": "53f5b5c289fba6ad82c675578cf1c548ae37f0c1", 18:20:55 INFO - "stage_platform": "linux64", 18:20:55 INFO - "builduid": "694114dbed4d4e6889572070acf6230b", 18:20:55 INFO - "slavebuilddir": "test" 18:20:55 INFO - } 18:20:55 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:20:55 INFO - Running post-action listener: _resource_record_post_action 18:20:55 INFO - ##### 18:20:55 INFO - ##### Finished read-buildbot-config step (success) 18:20:55 INFO - ##### 18:20:55 INFO - ##### 18:20:55 INFO - ##### Running download-and-extract step. 18:20:55 INFO - ##### 18:20:55 INFO - Running pre-action listener: _resource_record_pre_action 18:20:55 INFO - Running main action method: download_and_extract 18:20:55 INFO - mkdir: /builds/slave/test/build/tests 18:20:55 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:20:55 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:20:55 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:20:55 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:20:55 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:20:55 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:20:56 INFO - Downloaded 1361 bytes. 18:20:56 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:20:56 INFO - Using the following test package requirements: 18:20:56 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:20:56 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:20:56 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:20:56 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:20:56 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:20:56 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:20:56 INFO - u'jsshell-linux-x86_64.zip'], 18:20:56 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:20:56 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:20:56 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:20:56 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:20:56 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:20:56 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:20:56 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:20:56 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:20:56 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:20:56 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:20:56 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:20:56 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:20: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:20:56 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:20: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.common.tests.zip 18:20: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.common.tests.zip 18:20: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.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:20:56 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:20:57 INFO - Downloaded 22653673 bytes. 18:20:57 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:20:57 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:20:58 INFO - Return code: 0 18:20:58 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:20:58 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:20:58 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:20:58 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:20:58 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:20:58 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:20:58 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:21:00 INFO - Downloaded 22653673 bytes. 18:21:00 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:21:00 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:21:01 INFO - Return code: 0 18:21: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:21:01 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:21:01 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:21:01 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:21:01 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:21:01 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:21:02 INFO - Downloaded 14405384 bytes. 18:21:02 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:21:02 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:21:02 INFO - Return code: 0 18:21:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:02 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:21:02 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:21:02 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:21:02 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:21:02 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:21:04 INFO - Downloaded 55396806 bytes. 18:21:04 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:21:04 INFO - mkdir: /builds/slave/test/properties 18:21:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:21:04 INFO - Writing to file /builds/slave/test/properties/build_url 18:21:04 INFO - Contents: 18:21:04 INFO - build_url:https://queue.taskcluster.net/v1/task/G0T1sskeQNiGGZrSFu2b8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:21:05 INFO - Running post-action listener: _resource_record_post_action 18:21:05 INFO - Running post-action listener: set_extra_try_arguments 18:21:05 INFO - ##### 18:21:05 INFO - ##### Finished download-and-extract step (success) 18:21:05 INFO - ##### 18:21:05 INFO - ##### 18:21:05 INFO - ##### Running populate-webroot step. 18:21:05 INFO - ##### 18:21:05 INFO - Running pre-action listener: _resource_record_pre_action 18:21:05 INFO - Running main action method: populate_webroot 18:21:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:21:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:21:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:21:05 INFO - '--tppagecycles', 18:21:05 INFO - '7'], 18:21:05 INFO - 'tests': ['tsvgm']}}, 18:21:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:21:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:21:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:21:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:21:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:21:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:21:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:05 INFO - 'talos_options': ['--disable-e10s'], 18:21:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:21:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:21:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:05 INFO - 'talos_options': ['--disable-e10s'], 18:21:05 INFO - 'tests': ['damp', 'tps']}, 18:21:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:05 INFO - 'tests': ['damp', 'tps']}, 18:21:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:21:05 INFO - 'tests': ['dromaeo_dom']}, 18:21:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:21:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:21:05 INFO - 'tests': ['basic_compositor_video']}, 18:21:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:21:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:21:05 INFO - 'tests': ['a11yr', 18:21:05 INFO - 'ts_paint', 18:21:05 INFO - 'tpaint', 18:21:05 INFO - 'sessionrestore', 18:21:05 INFO - 'sessionrestore_no_auto_restore', 18:21:05 INFO - 'tabpaint']}, 18:21:05 INFO - 'other-e10s': {'tests': ['a11yr', 18:21:05 INFO - 'ts_paint', 18:21:05 INFO - 'tpaint', 18:21:05 INFO - 'sessionrestore', 18:21:05 INFO - 'sessionrestore_no_auto_restore', 18:21:05 INFO - 'tabpaint']}, 18:21:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:21:05 INFO - 'ts_paint', 18:21:05 INFO - 'tpaint', 18:21:05 INFO - 'sessionrestore', 18:21:05 INFO - 'sessionrestore_no_auto_restore', 18:21:05 INFO - 'tabpaint']}, 18:21:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:21:05 INFO - 'ts_paint', 18:21:05 INFO - 'tpaint', 18:21:05 INFO - 'sessionrestore', 18:21:05 INFO - 'sessionrestore_no_auto_restore', 18:21:05 INFO - 'tabpaint']}, 18:21:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:21:05 INFO - 'tests': ['a11yr', 18:21:05 INFO - 'ts_paint', 18:21:05 INFO - 'tpaint', 18:21:05 INFO - 'sessionrestore', 18:21:05 INFO - 'sessionrestore_no_auto_restore', 18:21:05 INFO - 'tabpaint']}, 18:21:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:21:05 INFO - 'tests': ['a11yr', 18:21:05 INFO - 'ts_paint', 18:21:05 INFO - 'tpaint', 18:21:05 INFO - 'sessionrestore', 18:21:05 INFO - 'sessionrestore_no_auto_restore', 18:21:05 INFO - 'tabpaint']}, 18:21:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:21:05 INFO - 'tests': ['tsvgx', 18:21:05 INFO - 'tsvgr_opacity', 18:21:05 INFO - 'tart', 18:21:05 INFO - 'tscrollx', 18:21:05 INFO - 'cart']}, 18:21:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:21:05 INFO - 'tsvgr_opacity', 18:21:05 INFO - 'tart', 18:21:05 INFO - 'tscrollx', 18:21:05 INFO - 'cart']}, 18:21:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:05 INFO - 'talos_options': ['--disable-e10s'], 18:21:05 INFO - 'tests': ['tp5o']}, 18:21:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:05 INFO - 'tests': ['tp5o']}, 18:21:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:05 INFO - 'talos_options': ['--disable-e10s', 18:21:05 INFO - '--xperf_path', 18:21:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:21:05 INFO - 'tests': ['tp5n']}, 18:21:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:05 INFO - 'talos_options': ['--xperf_path', 18:21:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:21:05 INFO - 'tests': ['tp5n']}}, 18:21:05 INFO - 'talos.zip': {'path': '', 18:21:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:21:05 INFO - Running post-action listener: _resource_record_post_action 18:21:05 INFO - ##### 18:21:05 INFO - ##### Finished populate-webroot step (success) 18:21:05 INFO - ##### 18:21:05 INFO - ##### 18:21:05 INFO - ##### Running create-virtualenv step. 18:21:05 INFO - ##### 18:21:05 INFO - Running pre-action listener: _resource_record_pre_action 18:21:05 INFO - Running main action method: create_virtualenv 18:21:05 INFO - Creating virtualenv /builds/slave/test/build/venv 18:21:05 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:21:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:21:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:21:05 INFO - Using real prefix '/usr' 18:21:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:21:05 INFO - Installing distribute.............................................................................................................................................................................................done. 18:21:07 INFO - Installing pip.................done. 18:21:07 INFO - Return code: 0 18:21:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:21:07 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:21:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:07 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:21:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:07 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 0x7f9bd5957f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a78350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b071c0>, '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 0x1b080c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b08550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465953653.117090-1448919995', '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:21:07 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:21:07 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:21:07 INFO - Using env: {'DISPLAY': ':0', 18:21:07 INFO - 'HOME': '/home/cltbld', 18:21:07 INFO - 'LANG': 'en_US.UTF-8', 18:21:07 INFO - 'LANGUAGE': 'en_US:en', 18:21:07 INFO - 'LOGNAME': 'cltbld', 18:21:07 INFO - 'MAIL': '/var/mail/cltbld', 18:21:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:07 INFO - 'MOZ_NO_REMOTE': '1', 18:21:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:07 INFO - 'NO_EM_RESTART': '1', 18:21:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:07 INFO - 'PWD': '/builds/slave/test', 18:21:07 INFO - 'SHELL': '/bin/bash', 18:21:07 INFO - 'SHLVL': '1', 18:21:07 INFO - 'TERM': 'linux', 18:21:07 INFO - 'TMOUT': '86400', 18:21:07 INFO - 'USER': 'cltbld', 18:21:07 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465953653.117090-1448919995', 18:21:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:07 INFO - '_': '/tools/buildbot/bin/python'} 18:21:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:08 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:21:08 INFO - Cleaning up... 18:21:08 INFO - Return code: 0 18:21:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:21: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:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21: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:21:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21: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', '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 0x7f9bd5957f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a78350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b071c0>, '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 0x1b080c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b08550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465953653.117090-1448919995', '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:21: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', 'psutil>=3.1.1'] in /builds/slave/test/build 18:21: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 psutil>=3.1.1 18:21:08 INFO - Using env: {'DISPLAY': ':0', 18:21:08 INFO - 'HOME': '/home/cltbld', 18:21:08 INFO - 'LANG': 'en_US.UTF-8', 18:21:08 INFO - 'LANGUAGE': 'en_US:en', 18:21:08 INFO - 'LOGNAME': 'cltbld', 18:21:08 INFO - 'MAIL': '/var/mail/cltbld', 18:21:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:08 INFO - 'MOZ_NO_REMOTE': '1', 18:21:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:08 INFO - 'NO_EM_RESTART': '1', 18:21:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:08 INFO - 'PWD': '/builds/slave/test', 18:21:08 INFO - 'SHELL': '/bin/bash', 18:21:08 INFO - 'SHLVL': '1', 18:21:08 INFO - 'TERM': 'linux', 18:21:08 INFO - 'TMOUT': '86400', 18:21:08 INFO - 'USER': 'cltbld', 18:21:08 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465953653.117090-1448919995', 18:21:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:08 INFO - '_': '/tools/buildbot/bin/python'} 18:21:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:08 INFO - Downloading/unpacking psutil>=3.1.1 18:21: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:21: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:21: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:21: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:21: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:21: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:21:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:21:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:21:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:21:10 INFO - Installing collected packages: psutil 18:21:10 INFO - Running setup.py install for psutil 18:21:11 INFO - building 'psutil._psutil_linux' extension 18:21:11 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:21:11 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:21:11 INFO - building 'psutil._psutil_posix' extension 18:21:11 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:21:11 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:21:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:21:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:21:11 INFO - Successfully installed psutil 18:21:11 INFO - Cleaning up... 18:21:11 INFO - Return code: 0 18:21:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:21:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:11 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 0x7f9bd5957f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a78350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b071c0>, '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 0x1b080c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b08550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465953653.117090-1448919995', '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:21:11 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:21:11 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:21:11 INFO - Using env: {'DISPLAY': ':0', 18:21:11 INFO - 'HOME': '/home/cltbld', 18:21:11 INFO - 'LANG': 'en_US.UTF-8', 18:21:11 INFO - 'LANGUAGE': 'en_US:en', 18:21:11 INFO - 'LOGNAME': 'cltbld', 18:21:11 INFO - 'MAIL': '/var/mail/cltbld', 18:21:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:11 INFO - 'MOZ_NO_REMOTE': '1', 18:21:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:11 INFO - 'NO_EM_RESTART': '1', 18:21:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:11 INFO - 'PWD': '/builds/slave/test', 18:21:11 INFO - 'SHELL': '/bin/bash', 18:21:11 INFO - 'SHLVL': '1', 18:21:11 INFO - 'TERM': 'linux', 18:21:11 INFO - 'TMOUT': '86400', 18:21:11 INFO - 'USER': 'cltbld', 18:21:11 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465953653.117090-1448919995', 18:21:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:11 INFO - '_': '/tools/buildbot/bin/python'} 18:21:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:21: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:21: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:21: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:21: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:21: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:21: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:21:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:21:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:21:13 INFO - Installing collected packages: mozsystemmonitor 18:21:13 INFO - Running setup.py install for mozsystemmonitor 18:21:13 INFO - Successfully installed mozsystemmonitor 18:21:13 INFO - Cleaning up... 18:21:13 INFO - Return code: 0 18:21:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:13 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 0x7f9bd5957f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a78350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b071c0>, '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 0x1b080c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b08550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465953653.117090-1448919995', '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:21:13 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:21:13 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:21:13 INFO - Using env: {'DISPLAY': ':0', 18:21:13 INFO - 'HOME': '/home/cltbld', 18:21:13 INFO - 'LANG': 'en_US.UTF-8', 18:21:13 INFO - 'LANGUAGE': 'en_US:en', 18:21:13 INFO - 'LOGNAME': 'cltbld', 18:21:13 INFO - 'MAIL': '/var/mail/cltbld', 18:21:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:13 INFO - 'MOZ_NO_REMOTE': '1', 18:21:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:13 INFO - 'NO_EM_RESTART': '1', 18:21:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:13 INFO - 'PWD': '/builds/slave/test', 18:21:13 INFO - 'SHELL': '/bin/bash', 18:21:13 INFO - 'SHLVL': '1', 18:21:13 INFO - 'TERM': 'linux', 18:21:13 INFO - 'TMOUT': '86400', 18:21:13 INFO - 'USER': 'cltbld', 18:21:13 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465953653.117090-1448919995', 18:21:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:13 INFO - '_': '/tools/buildbot/bin/python'} 18:21:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:14 INFO - Downloading/unpacking jsonschema==2.5.1 18:21:14 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:21:14 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:21:14 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:21:14 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:21:14 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:21:14 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:21:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:21:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:21:15 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:21:15 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:21:15 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:21:15 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:21:15 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:21:15 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:21:16 INFO - Downloading functools32-3.2.3-2.tar.gz 18:21:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:21:16 INFO - warning: no files found matching '*.txt' 18:21:16 INFO - no previously-included directories found matching 'build' 18:21:16 INFO - no previously-included directories found matching 'dist' 18:21:16 INFO - no previously-included directories found matching '.git*' 18:21:16 INFO - Installing collected packages: jsonschema, functools32 18:21:16 INFO - Running setup.py install for functools32 18:21:16 INFO - warning: no files found matching '*.txt' 18:21:16 INFO - no previously-included directories found matching 'build' 18:21:16 INFO - no previously-included directories found matching 'dist' 18:21:16 INFO - no previously-included directories found matching '.git*' 18:21:16 INFO - Successfully installed jsonschema functools32 18:21:16 INFO - Cleaning up... 18:21:16 INFO - Return code: 0 18:21:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9bd5957f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a78350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b071c0>, '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 0x1b080c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b08550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465953653.117090-1448919995', '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:21:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:21:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:21:16 INFO - Using env: {'DISPLAY': ':0', 18:21:16 INFO - 'HOME': '/home/cltbld', 18:21:16 INFO - 'LANG': 'en_US.UTF-8', 18:21:16 INFO - 'LANGUAGE': 'en_US:en', 18:21:16 INFO - 'LOGNAME': 'cltbld', 18:21:16 INFO - 'MAIL': '/var/mail/cltbld', 18:21:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:16 INFO - 'MOZ_NO_REMOTE': '1', 18:21:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:16 INFO - 'NO_EM_RESTART': '1', 18:21:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:16 INFO - 'PWD': '/builds/slave/test', 18:21:16 INFO - 'SHELL': '/bin/bash', 18:21:16 INFO - 'SHLVL': '1', 18:21:16 INFO - 'TERM': 'linux', 18:21:16 INFO - 'TMOUT': '86400', 18:21:16 INFO - 'USER': 'cltbld', 18:21:16 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465953653.117090-1448919995', 18:21:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:16 INFO - '_': '/tools/buildbot/bin/python'} 18:21:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:16 INFO - Downloading/unpacking blobuploader==1.2.4 18:21: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:21: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:21: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:21: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:21: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:21: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:21:18 INFO - Downloading blobuploader-1.2.4.tar.gz 18:21:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:21:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:21:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:21:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:21:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:21:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:21:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:21:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:21:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:21:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:21:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:21:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:21:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:21:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:21:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:21:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:21:19 INFO - Downloading docopt-0.6.1.tar.gz 18:21:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:21:19 INFO - Installing collected packages: blobuploader, requests, docopt 18:21:19 INFO - Running setup.py install for blobuploader 18:21:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:21:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:21:19 INFO - Running setup.py install for requests 18:21:19 INFO - Running setup.py install for docopt 18:21:19 INFO - Successfully installed blobuploader requests docopt 18:21:19 INFO - Cleaning up... 18:21:19 INFO - Return code: 0 18:21:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:21: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:21:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21: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:21:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:19 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 0x7f9bd5957f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a78350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b071c0>, '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 0x1b080c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b08550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465953653.117090-1448919995', '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:21:19 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:21:19 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:21:19 INFO - Using env: {'DISPLAY': ':0', 18:21:19 INFO - 'HOME': '/home/cltbld', 18:21:19 INFO - 'LANG': 'en_US.UTF-8', 18:21:19 INFO - 'LANGUAGE': 'en_US:en', 18:21:19 INFO - 'LOGNAME': 'cltbld', 18:21:19 INFO - 'MAIL': '/var/mail/cltbld', 18:21:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:19 INFO - 'MOZ_NO_REMOTE': '1', 18:21:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:19 INFO - 'NO_EM_RESTART': '1', 18:21:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:19 INFO - 'PWD': '/builds/slave/test', 18:21:19 INFO - 'SHELL': '/bin/bash', 18:21:19 INFO - 'SHLVL': '1', 18:21:19 INFO - 'TERM': 'linux', 18:21:19 INFO - 'TMOUT': '86400', 18:21:19 INFO - 'USER': 'cltbld', 18:21:19 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465953653.117090-1448919995', 18:21:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:19 INFO - '_': '/tools/buildbot/bin/python'} 18:21:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:21:20 INFO - Running setup.py (path:/tmp/pip-ArrEe4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:21:20 INFO - Running setup.py (path:/tmp/pip-oywDJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:21:20 INFO - Running setup.py (path:/tmp/pip-lclYQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:21:20 INFO - Running setup.py (path:/tmp/pip-XirV1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:21:20 INFO - Running setup.py (path:/tmp/pip-KaVJki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:21:20 INFO - Running setup.py (path:/tmp/pip-ByPU8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:21:20 INFO - Running setup.py (path:/tmp/pip-ZoRggV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:21:20 INFO - Running setup.py (path:/tmp/pip-G8g3K9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:21:20 INFO - Running setup.py (path:/tmp/pip-YLl1cJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:21:20 INFO - Running setup.py (path:/tmp/pip-HX2ASt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:21:20 INFO - Running setup.py (path:/tmp/pip-_tWmhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:21:20 INFO - Running setup.py (path:/tmp/pip-I6fydB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:21:20 INFO - Running setup.py (path:/tmp/pip-vLOvsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:21:20 INFO - Running setup.py (path:/tmp/pip-llMagi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:21:21 INFO - Running setup.py (path:/tmp/pip-iVz08N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:21:21 INFO - Running setup.py (path:/tmp/pip-fwiZaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:21:21 INFO - Running setup.py (path:/tmp/pip-YC0Amq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:21:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:21:21 INFO - Running setup.py install for manifestparser 18:21:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:21:21 INFO - Running setup.py install for mozcrash 18:21:21 INFO - Running setup.py install for mozdebug 18:21:21 INFO - Running setup.py install for mozdevice 18:21:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:21:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:21:21 INFO - Running setup.py install for mozfile 18:21:21 INFO - Running setup.py install for mozhttpd 18:21:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:21:21 INFO - Running setup.py install for mozinfo 18:21:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:21:21 INFO - Running setup.py install for mozInstall 18:21:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:21:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:21:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:21:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:21:22 INFO - Running setup.py install for mozleak 18:21:22 INFO - Running setup.py install for mozlog 18:21:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:21:22 INFO - Running setup.py install for moznetwork 18:21:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:21:22 INFO - Running setup.py install for mozprocess 18:21:22 INFO - Running setup.py install for mozprofile 18:21:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:21:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:21:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:21:22 INFO - Running setup.py install for mozrunner 18:21:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:21:22 INFO - Running setup.py install for mozscreenshot 18:21:22 INFO - Running setup.py install for moztest 18:21:22 INFO - Running setup.py install for mozversion 18:21:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:21:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:21:23 INFO - Cleaning up... 18:21:23 INFO - Return code: 0 18:21:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:21:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:23 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 0x7f9bd5957f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a78350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b071c0>, '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 0x1b080c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b08550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465953653.117090-1448919995', '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:21:23 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:21:23 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:21:23 INFO - Using env: {'DISPLAY': ':0', 18:21:23 INFO - 'HOME': '/home/cltbld', 18:21:23 INFO - 'LANG': 'en_US.UTF-8', 18:21:23 INFO - 'LANGUAGE': 'en_US:en', 18:21:23 INFO - 'LOGNAME': 'cltbld', 18:21:23 INFO - 'MAIL': '/var/mail/cltbld', 18:21:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:23 INFO - 'MOZ_NO_REMOTE': '1', 18:21:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:23 INFO - 'NO_EM_RESTART': '1', 18:21:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:23 INFO - 'PWD': '/builds/slave/test', 18:21:23 INFO - 'SHELL': '/bin/bash', 18:21:23 INFO - 'SHLVL': '1', 18:21:23 INFO - 'TERM': 'linux', 18:21:23 INFO - 'TMOUT': '86400', 18:21:23 INFO - 'USER': 'cltbld', 18:21:23 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465953653.117090-1448919995', 18:21:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:23 INFO - '_': '/tools/buildbot/bin/python'} 18:21:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:21:23 INFO - Running setup.py (path:/tmp/pip-Wj0Giv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:21:23 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:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:21:23 INFO - Running setup.py (path:/tmp/pip-uL80mP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:21:23 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:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:21:23 INFO - Running setup.py (path:/tmp/pip-HN881d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:21:23 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:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:21:23 INFO - Running setup.py (path:/tmp/pip-KUrEiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:21:23 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:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:21:23 INFO - Running setup.py (path:/tmp/pip-L3ipsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:21:23 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:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:21:23 INFO - Running setup.py (path:/tmp/pip-EF4WQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:21:23 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:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:21:23 INFO - Running setup.py (path:/tmp/pip-JruclK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:21:23 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:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:21:23 INFO - Running setup.py (path:/tmp/pip-_GUSHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:21:23 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:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:21:23 INFO - Running setup.py (path:/tmp/pip-O06ptX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:21:23 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:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:21:23 INFO - Running setup.py (path:/tmp/pip-a77dLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:21:23 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:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:21:23 INFO - Running setup.py (path:/tmp/pip-mccqt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:21:24 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:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:21:24 INFO - Running setup.py (path:/tmp/pip-5Vr5BM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:21:24 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:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:21:24 INFO - Running setup.py (path:/tmp/pip-5KNSrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:21:24 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:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:21:24 INFO - Running setup.py (path:/tmp/pip-omp7mz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:21:24 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:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:21:24 INFO - Running setup.py (path:/tmp/pip-8YAskR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:21:24 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:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:21:24 INFO - Running setup.py (path:/tmp/pip-MP_zkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:21:24 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:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:21:24 INFO - Running setup.py (path:/tmp/pip-InCK6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:21:24 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:21:24 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:21:24 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:21:24 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:21:24 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:21:24 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:21:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:21:24 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:21:24 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:21:24 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:21:24 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:21:24 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:21:24 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:21:26 INFO - Downloading blessings-1.6.tar.gz 18:21:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:21:26 INFO - Installing collected packages: blessings 18:21:26 INFO - Running setup.py install for blessings 18:21:26 INFO - Successfully installed blessings 18:21:26 INFO - Cleaning up... 18:21:26 INFO - Return code: 0 18:21:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:21:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:21:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:21:26 INFO - Reading from file tmpfile_stdout 18:21:26 INFO - Current package versions: 18:21:26 INFO - argparse == 1.2.1 18:21:26 INFO - blessings == 1.6 18:21:26 INFO - blobuploader == 1.2.4 18:21:26 INFO - docopt == 0.6.1 18:21:26 INFO - functools32 == 3.2.3-2 18:21:26 INFO - jsonschema == 2.5.1 18:21:26 INFO - manifestparser == 1.1 18:21:26 INFO - mozInstall == 1.12 18:21:26 INFO - mozcrash == 0.17 18:21:26 INFO - mozdebug == 0.1 18:21:26 INFO - mozdevice == 0.48 18:21:26 INFO - mozfile == 1.2 18:21:26 INFO - mozhttpd == 0.7 18:21:26 INFO - mozinfo == 0.9 18:21:26 INFO - mozleak == 0.1 18:21:26 INFO - mozlog == 3.2 18:21:26 INFO - moznetwork == 0.27 18:21:26 INFO - mozprocess == 0.22 18:21:26 INFO - mozprofile == 0.28 18:21:26 INFO - mozrunner == 6.11 18:21:26 INFO - mozscreenshot == 0.1 18:21:26 INFO - mozsystemmonitor == 0.3 18:21:26 INFO - moztest == 0.7 18:21:26 INFO - mozversion == 1.4 18:21:26 INFO - psutil == 3.1.1 18:21:26 INFO - requests == 1.2.3 18:21:26 INFO - wsgiref == 0.1.2 18:21:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:21:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:26 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 0x7f9bd5957f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a78350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b071c0>, '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 0x1b080c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b08550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465953653.117090-1448919995', '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:21:26 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:21:26 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:21:26 INFO - Using env: {'DISPLAY': ':0', 18:21:26 INFO - 'HOME': '/home/cltbld', 18:21:26 INFO - 'LANG': 'en_US.UTF-8', 18:21:26 INFO - 'LANGUAGE': 'en_US:en', 18:21:26 INFO - 'LOGNAME': 'cltbld', 18:21:26 INFO - 'MAIL': '/var/mail/cltbld', 18:21:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:26 INFO - 'MOZ_NO_REMOTE': '1', 18:21:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:26 INFO - 'NO_EM_RESTART': '1', 18:21:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:26 INFO - 'PWD': '/builds/slave/test', 18:21:26 INFO - 'SHELL': '/bin/bash', 18:21:26 INFO - 'SHLVL': '1', 18:21:26 INFO - 'TERM': 'linux', 18:21:26 INFO - 'TMOUT': '86400', 18:21:26 INFO - 'USER': 'cltbld', 18:21:26 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465953653.117090-1448919995', 18:21:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:26 INFO - '_': '/tools/buildbot/bin/python'} 18:21:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:27 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:21:27 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:21:27 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:21:27 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:21:27 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:21:27 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:21:27 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:21:27 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:21:27 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:21:27 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:21:27 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:21:27 INFO - Cleaning up... 18:21:27 INFO - Return code: 0 18:21:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:21:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:27 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 0x7f9bd5957f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a78350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b071c0>, '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 0x1b080c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b08550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465953653.117090-1448919995', '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:21:27 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:21:27 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:21:27 INFO - Using env: {'DISPLAY': ':0', 18:21:27 INFO - 'HOME': '/home/cltbld', 18:21:27 INFO - 'LANG': 'en_US.UTF-8', 18:21:27 INFO - 'LANGUAGE': 'en_US:en', 18:21:27 INFO - 'LOGNAME': 'cltbld', 18:21:27 INFO - 'MAIL': '/var/mail/cltbld', 18:21:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:27 INFO - 'MOZ_NO_REMOTE': '1', 18:21:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:27 INFO - 'NO_EM_RESTART': '1', 18:21:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:27 INFO - 'PWD': '/builds/slave/test', 18:21:27 INFO - 'SHELL': '/bin/bash', 18:21:27 INFO - 'SHLVL': '1', 18:21:27 INFO - 'TERM': 'linux', 18:21:27 INFO - 'TMOUT': '86400', 18:21:27 INFO - 'USER': 'cltbld', 18:21:27 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465953653.117090-1448919995', 18:21:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:27 INFO - '_': '/tools/buildbot/bin/python'} 18:21:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:21:27 INFO - Cleaning up... 18:21:27 INFO - Return code: 0 18:21:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:21:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:27 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 0x7f9bd5957f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a78350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b071c0>, '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 0x1b080c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b08550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465953653.117090-1448919995', '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:21:27 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:21:27 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:21:27 INFO - Using env: {'DISPLAY': ':0', 18:21:27 INFO - 'HOME': '/home/cltbld', 18:21:27 INFO - 'LANG': 'en_US.UTF-8', 18:21:27 INFO - 'LANGUAGE': 'en_US:en', 18:21:27 INFO - 'LOGNAME': 'cltbld', 18:21:27 INFO - 'MAIL': '/var/mail/cltbld', 18:21:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:27 INFO - 'MOZ_NO_REMOTE': '1', 18:21:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:27 INFO - 'NO_EM_RESTART': '1', 18:21:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:27 INFO - 'PWD': '/builds/slave/test', 18:21:27 INFO - 'SHELL': '/bin/bash', 18:21:27 INFO - 'SHLVL': '1', 18:21:27 INFO - 'TERM': 'linux', 18:21:27 INFO - 'TMOUT': '86400', 18:21:27 INFO - 'USER': 'cltbld', 18:21:27 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465953653.117090-1448919995', 18:21:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:27 INFO - '_': '/tools/buildbot/bin/python'} 18:21:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:27 INFO - Downloading/unpacking flake8 18:21:27 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:21:27 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:21:27 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:21:27 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:21:27 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:21:27 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:21:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:21:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:21:29 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:21:29 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:21:29 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:21:29 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:21:29 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:21:29 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:21:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:21:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:21:29 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:21:29 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:21:29 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:21:29 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:21:29 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:21:29 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:21:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:21:29 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:21:29 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:21:29 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:21:29 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:21:29 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:21:29 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:21:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:21:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:21:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:21:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:21:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:21:30 INFO - no previously-included directories found matching 'docs/_build' 18:21:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:21:30 INFO - Running setup.py install for pep8 18:21:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:21:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:21:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:21:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:21:30 INFO - no previously-included directories found matching 'docs/_build' 18:21:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:21:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:21:30 INFO - Cleaning up... 18:21:30 INFO - Return code: 0 18:21:30 INFO - Running post-action listener: _resource_record_post_action 18:21:30 INFO - Running post-action listener: _start_resource_monitoring 18:21:30 INFO - Starting resource monitoring. 18:21:30 INFO - ##### 18:21:30 INFO - ##### Finished create-virtualenv step (success) 18:21:30 INFO - ##### 18:21:30 INFO - ##### 18:21:30 INFO - ##### Running install step. 18:21:30 INFO - ##### 18:21:30 INFO - Running pre-action listener: _resource_record_pre_action 18:21:30 INFO - Running main action method: install 18:21:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:21:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:21:30 INFO - Reading from file tmpfile_stdout 18:21:30 INFO - Detecting whether we're running mozinstall >=1.0... 18:21:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:21:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:21:30 INFO - Reading from file tmpfile_stdout 18:21:30 INFO - Output received: 18:21:30 INFO - Usage: mozinstall [options] installer 18:21:30 INFO - Options: 18:21:30 INFO - -h, --help show this help message and exit 18:21:30 INFO - -d DEST, --destination=DEST 18:21:30 INFO - Directory to install application into. [default: 18:21:30 INFO - "/builds/slave/test"] 18:21:30 INFO - --app=APP Application being installed. [default: firefox] 18:21:30 INFO - mkdir: /builds/slave/test/build/application 18:21:30 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:21:30 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:21:46 INFO - Reading from file tmpfile_stdout 18:21:46 INFO - Output received: 18:21:46 INFO - /builds/slave/test/build/application/firefox/firefox 18:21:46 INFO - Running post-action listener: _resource_record_post_action 18:21:46 INFO - ##### 18:21:46 INFO - ##### Finished install step (success) 18:21:46 INFO - ##### 18:21:46 INFO - ##### 18:21:46 INFO - ##### Running run-tests step. 18:21:46 INFO - ##### 18:21:46 INFO - Running pre-action listener: _resource_record_pre_action 18:21:46 INFO - Running main action method: run_tests 18:21:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:21:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:21:46 INFO - Python 2.7.3 18:21:46 INFO - Return code: 0 18:21:46 INFO - grabbing minidump binary from tooltool 18:21:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:46 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 0x1b071c0>, '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 0x1b080c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b08550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:21:46 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:21:46 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:21:46 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:21:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:21:46 INFO - Return code: 0 18:21:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:21:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:21:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:21:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:21:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:21:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:21:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:21:47 INFO - Return code: 0 18:21:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G0T1sskeQNiGGZrSFu2b8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:21:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/G0T1sskeQNiGGZrSFu2b8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:21:47 INFO - Using env: {'DISPLAY': ':0', 18:21:47 INFO - 'HOME': '/home/cltbld', 18:21:47 INFO - 'LANG': 'en_US.UTF-8', 18:21:47 INFO - 'LANGUAGE': 'en_US:en', 18:21:47 INFO - 'LOGNAME': 'cltbld', 18:21:47 INFO - 'MAIL': '/var/mail/cltbld', 18:21:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:21:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:47 INFO - 'MOZ_NO_REMOTE': '1', 18:21:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:21:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:47 INFO - 'NO_EM_RESTART': '1', 18:21:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:47 INFO - 'PWD': '/builds/slave/test', 18:21:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:21:47 INFO - 'SHELL': '/bin/bash', 18:21:47 INFO - 'SHLVL': '1', 18:21:47 INFO - 'TERM': 'linux', 18:21:47 INFO - 'TMOUT': '86400', 18:21:47 INFO - 'USER': 'cltbld', 18:21:47 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465953653.117090-1448919995', 18:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:47 INFO - '_': '/tools/buildbot/bin/python'} 18:21:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G0T1sskeQNiGGZrSFu2b8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:21:47 INFO - mozversion application_buildid: 20160614170925 18:21:47 INFO - mozversion application_changeset: 53f5b5c289fba6ad82c675578cf1c548ae37f0c1 18:21:47 INFO - mozversion application_display_name: Nightly 18:21:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:21:47 INFO - mozversion application_name: Firefox 18:21:47 INFO - mozversion application_remotingname: firefox 18:21:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:21:47 INFO - mozversion application_vendor: Mozilla 18:21:47 INFO - mozversion application_version: 50.0a1 18:21:47 INFO - mozversion platform_buildid: 20160614170925 18:21:47 INFO - mozversion platform_changeset: 53f5b5c289fba6ad82c675578cf1c548ae37f0c1 18:21:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:21:47 INFO - mozversion platform_version: 50.0a1 18:21:47 INFO - using testdate: 1465953707 18:21:47 INFO - actual date: 1465953707 18:21:47 INFO - starting webserver on 'localhost:56534' 18:21:47 INFO - SUITE-START | Running 2 tests 18:21:47 INFO - TEST-START | dromaeo_css 18:21:47 INFO - operating with platform_type : linux_ 18:21:47 INFO - Initialising browser for dromaeo_css test... 18:21:47 INFO - TEST-INFO | started process 4456 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDhP4pq/profile http://localhost:56534/getInfo.html) 18:21:52 INFO - PROCESS | 4456 | __metrics Screen width/height:1600/1200 18:21:52 INFO - PROCESS | 4456 | colorDepth:24 18:21:52 INFO - PROCESS | 4456 | Browser inner width/height: 1024/697 18:21:52 INFO - PROCESS | 4456 | __metrics 18:21:53 ERROR - PROCESS | 4456 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 18:21:54 INFO - TEST-INFO | 4456: exit 0 18:21:54 INFO - Browser initialized. 18:21:54 INFO - Running cycle 1/1 for dromaeo_css test... 18:21:54 INFO - TEST-INFO | started process 4574 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDhP4pq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:22:06 INFO - PROCESS | 4574 | RSS: Main: 185774080 18:22:06 INFO - PROCESS | 4574 | 18:22:56 INFO - PROCESS | 4574 | 1465953776191 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:25:08 INFO - PROCESS | 4574 | Cycle 1(1): loaded http://localhost:56534/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56534/tests/dromaeo/cssquery-ext.html) 18:25:09 INFO - PROCESS | 4574 | RSS: Main: 188907520 18:25:09 INFO - PROCESS | 4574 | 18:28:11 INFO - PROCESS | 4574 | Cycle 1(1): loaded http://localhost:56534/tests/dromaeo/cssquery-ext.html (next: http://localhost:56534/tests/dromaeo/cssquery-jquery.html) 18:28:12 INFO - PROCESS | 4574 | RSS: Main: 188080128 18:28:12 INFO - PROCESS | 4574 | 18:31:14 INFO - PROCESS | 4574 | Cycle 1(1): loaded http://localhost:56534/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56534/tests/dromaeo/cssquery-mootools.html) 18:31:14 INFO - PROCESS | 4574 | RSS: Main: 189116416 18:31:14 INFO - PROCESS | 4574 | 18:34:16 INFO - PROCESS | 4574 | Cycle 1(1): loaded http://localhost:56534/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56534/tests/dromaeo/cssquery-prototype.html) 18:34:17 INFO - PROCESS | 4574 | RSS: Main: 186757120 18:34:17 INFO - PROCESS | 4574 | 18:37:19 INFO - PROCESS | 4574 | Cycle 1(1): loaded http://localhost:56534/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56534/tests/dromaeo/cssquery-yui.html) 18:37:20 INFO - PROCESS | 4574 | RSS: Main: 188809216 18:37:20 INFO - PROCESS | 4574 | 18:40:23 INFO - PROCESS | 4574 | Cycle 1(1): loaded http://localhost:56534/tests/dromaeo/cssquery-yui.html (next: http://localhost:56534/tests/dromaeo/cssquery-dojo.html) 18:40:23 INFO - PROCESS | 4574 | RSS: Main: 190013440 18:40:23 INFO - PROCESS | 4574 | 18:40:23 INFO - PROCESS | 4574 | __start_tp_report 18:40:23 INFO - PROCESS | 4574 | _x_x_mozilla_page_load 18:40:23 INFO - PROCESS | 4574 | _x_x_mozilla_page_load_details 18:40:23 INFO - PROCESS | 4574 | |i|pagename|runs| 18:40:23 INFO - PROCESS | 4574 | |0;dojo.html;2608.778253848423;2673.3049407154144;2682.557378032625;2697.716739742327;2715.497632937908;4795.832145874895;4832.4684284728655;4906.190478571036;4924.753762311888;4931.235658472933;4706.670533062687;4813.49458306878;4849.418069831617;4852.611791056715;4891.315215869781;4449.9987502811855;4479.776011199427;4582.19811532982;4584.106099310636;4597.977010114962;552.3187384510559;4287.1425714857;4359.062801497677;4377.496587892385;4390.8902277443;4388.42950416447;4434.689571729948;4438.866833994985;4440.222960981848;4482.887927801831;4410.779461026936;4457.509673935897;4462.352958820985;4468.084042771224;4492.707973981681;4378.233809083397;4403.163398954221;4443.155800397914;4447.043885564619;4455.331700244957;4828.324034635154;4852.8544143675745;4862.343583616202;4867.367242258484;4872.4153101628035;5002.7248501332415;5189.247559103909;5226.085435048852;5232.895342093175;5259.737013149327;5179.093658609729;5198.506141916512;5206.505381988705;5209.635325527177;5237.13587258102;4885.975570122162;4911.7298548580175;4918.704877707349;4919.680220785637;4968.478309777493;5264.842054738364;5319.867003324948;5340.599455040888;5382.3541175059245;5413.025655382069;5100.770465329069;5124.308218390544;5125.231215317732;5128.358955130609;5140.845774626767;5209.088409528317;5218.712970786643;5219.42586315505;5227.895442091137;5237.188235823453;5002.57478114357;5052.242163675478;5070.543651071422;5093.0577843099145;5094.261332106824;5048.29323894655;5055.140626093573;5085.796568137307;5098.821541246039;5126.769295381717;4270.12462445198;4343.239933011773;4349.325854492558;4351.282038463618;4396.318570621559;3699.8520059197867;3804.771713697187;3841.2317536492255;3845.6346647068485;3859.9228015440094;4436.889077773017;4445.355423463579;4451.933221001687;4501.819927202875;4527.592516673515;5260.184671375943;5272.630915835932;5280.155175171954;5280.339957505312;5285.788568457296;4287.614114729689;4335.176316499855;4393.560643935645;4426.3581780641625;4453.755043472575;4645.581897629229;4647.512011238839;4656.674032817738;4672.08894265615;4691.014886873726;4833.371661684029;4876.853694389174;4889.657723959431;4892.877678058006;4929.334539837219;5036.521530454601;5184.637075404837;5228.895422091613;5240.240165176105;5275.525202731773;4912.091263116335;4940.752962351796;4942.308076869169;4942.481039490802;4977.253411988231;5007.39911210657;5175.275461435477;5183.455737147696;5192.688438693691;5199.66202196856;5196.064708352382;5231.267622532924;5261.158214685632;5265.183896496049;5272.868178295574;5136.049830781318;5136.743162841918;5140.151874940742;5143.948560514347;5196.584273258055;4863.659543831898;4870.561649451566;5129.58963282929;5139.588832893285;5148.845534633967;4855.101806165871;4876.561109500162;4889.828855990023;4898.191798353232;4918.852434426973;5045.722485263345;5057.190849464068;5064.772085256099;5074.492550744896;5110.105731496898;4843.685160464559;4946.109700253989;4946.8763280918265;4954.380702412199;5010.073136469619 18:40:23 INFO - PROCESS | 4574 | |1;ext.html;543.0668626656183;586.5454272938473;592.4253474130095;602.4036204157883;613.9938600613992;35333.46999795002;40000.000000000015;40070.398944015826;40234.19531609366;40448.19103617926;40369.19261614766;40696.59303406965;41101.17797644053;41126.383104253386;41301.173976520455;7731.845363092735;7940.205979402042;7965.442419030641;7968.60156992148;7968.920310796905;7861.410394220427;7977.601119944009;7979.481333713319;7984.201579842027;8029.237222463886;8008;8075.717349892755;8092.109867914524;8096.838063238732;8100.756977290661;7981.481203721769;7992.160823113577;8031.95984020082;8046.396520260945;8057.073436554754;7837.529748215068;7840.882386764203;7914.366850651934;7922.683092676286;7932.643031063558;38656.22687546261;38738.80630596829;38913.221735565414;39014;39059.804700976594;3077.5999120114466;3250.674932506754;3440.139965008748;3522.489239060322;3785.9053523661855;30325.090247292617;30648.540271895938;30824.8458757707;30942;31024.0692779217;3399.8130102844334;3427.3316703242876;3458.8616455341758;3477.7565570410084;3520.084777957724;235388;236238;236330;237322;237990;31636.841815790773;54063;54324.45675543273;54329.72835135799;54393.37656299259;32844.83577582097;34365.82817085949;34521.30957380889;34665;34719.13202169915;12132.5146994121;12267.38663066843;12309.876901230873;12310.13829031977;12329.568465103679;10783.299085559414;10852.837207441895;10903.509342079626;10906.236563440641;10947.178961577914;7930.881036784453;7947.880781788278;7951.920480795234;7985.640646170937;8018.4787988780545;3136.952945705816;3142.088794249688;3207.33218726261;3223.838808059588;3248.6751324867323;856.3320609924269;915.7435917942987;959.640134949394;978.2125389061731;980.4901451245313;28177.57733633997;29165.56251656227;29343.413131737674;29376.412471750446;29656;990.5938565188383;998.8102260570469;1002.7693630465034;1032.7965181710367;1041.0890470838017;15420.46028389001;15470.226488675522;15571.844281557265;15575.143367114917;15603.843961560466;423711;428568;429420;429666;430001;32264.83867580647;32563.18592035218;33066;33154;33200.33599328048;1167.9708007299716;1170.268582136165;1187.0444292344573;1218.7867123253395;1228.6314105768233;27413;28459.573106403008;28529;29170;29388.7061129386;43133.352999705654;43890.56109438865;44389.55610443854;44446.77776611225;44476.55523444724;335766;338456;339535;339831;339869;25669.229923102335;25875.353116172246;26024.089156879418;26057;26182.73817261803;40685;43190.13619727651;43922.560774391844;44321.77839110784;44637;37355.43966840554;37405.62594374021;37726;37958.24083518259;38975.41536877006;36521.08697282589;37256.81371593125;37397.43903841499;37489.625103749706;37510.24979500449;32252.35495290128;36853.63146368609;37202.25595488129;37336.6266337344;37533.62466375301;32761;33878.66121338755;34382.14044648904;34445.31109377849;34490.96527104191;25690.871545642152;26045.348866278495;26415.735842641327;26560.601590976537;26974.730252697223 18:40:23 INFO - PROCESS | 4574 | |2;jquery.html;364.79753736676145;366.5747732630149;366.7322854316351;383.97120215983807;384.51359030825995;16044.35822567096;17104.572385690364;17840.37558685448;17910;17922.19350129244;15864.920675396606;16264.512064638051;16944.745828812578;16974.15129243536;16999.745003824923;5030.647854650167;5195.740212989335;5225.581953443715;5229.947700523003;5233.8953220935555;3624.8187590620364;5063.645544811865;5723.713814309289;6027.879442411149;6031.668258245794;6039.1243269725865;6058.0610005449225;6094.268687757475;6105.145279660829;6117.418845209698;4973.4280557735965;5290.709011004393;5297.258383826267;5301.973490132544;5330.946690533103;5074.2895994560795;5097.7960881564695;5141.562967147797;5170.663906846043;5178.818741344035;12239.69400764988;12488.687782805411;12511.186772859826;15996.920015399848;20725.170993160256;1827.1412436154985;1914.8755330903446;1941.9126139323764;1983.226541648758;1996.0418998880473;8978.102189781035;9171.358004939657;9277.58250878712;9316.627334906596;9395.248380129573;1665.7834481517325;1731.705610046295;1771.5039788859012;1774.3346245158066;1817.1277786662345;60477.69761151166;69210;71461.28538714598;72301;72703.2729672707;9570.33007689455;9584.712458626253;9785.36395134314;9809.362391444532;10166.745831354276;13355.599332020054;13380.866191338157;13384.263865487492;13462.326883655778;13473.191608503521;6641.37286364834;6795.490338224653;6824.41992430639;6839.931600684029;6906.412954898789;6240.251169859646;6361.141245931833;6365.204349456318;6422.550421470546;6466.870662586722;4107.802325755766;4138.813753381045;4207.326827707613;4232.217039847638;4282.678799090081;1636.729939559983;1724.4567961092216;1797.63148554546;1828.4240464253717;1849.8890066596048;769.6536558548676;843.6414523827349;880.3617377401333;881.1584936385736;917.3624331089962;16417.261223244983;16727.996320220827;16830.158492075592;16974.32102715902;16974.40589579359;853.7396094191207;859.282499113235;872.912708729122;873.9650413983496;887.2059506741431;9341.673041443517;9500.762480938032;9504.762380940532;9666.178374838077;9689.51552422376;401821;433291;447997;451922;456265;50488.495115048376;80293;83322.58338708268;83579.5821020891;84095.579522102;914.3690853311194;923.8383282925461;930.4463844012937;941.7598512379436;947.4410098042188;14940.327685254408;14958.551243462714;15116.697666046837;15171.848281517043;15506.612334691272;35663.64336356603;36457.45313820348;36862.44706329353;36912;37300.253994920495;51932.74033629808;54352;54501.72749136229;55429.44570554243;55696.72151639216;7567.9243207567215;7593.848123037398;7671.654775535226;7784.649690763816;7848.450608457353;10451.58193672275;11249.71875703114;11395.658130256106;11479.540818367172;11542.19204655666;5101.362329708786;10492.370457772558;10729.356238625707;10826.945865270623;10852.782944341227;4635.6986795858165;7455.478116531791;10083.747906302107;10104.595816167272;10638.680839574825;10555.736106597089;10612.257141999986;10751.6236931707;10799.67600971972;10856.294340867818;7700.1144868338615;7808.141104478389;7997.640106195119;8011.6394762237005;8118.309943654619;10066.446345450777;10318.122959548522;10434.843477347695;10467.633632822815;10473.21450891171 18:40:23 INFO - PROCESS | 4574 | |3;mootools.html;1369.6986662934157;1406.0700342542593;1489.5829167833003;1662.1356894414896;1674.2549565443383;6942.548734332265;7570.318671319594;7578.39372850172;8080.797980050502;8089.433739638228;7606.581638009908;7839.412044096702;7883.172266911978;7898.605069746518;7928.6432110555015;2217.057750456058;2242.091952759135;2243.427925878899;2249.403907964391;2254.3462395905167;2167.4798048468333;2202.3503066595395;2206.2388475975763;2208.569328980849;2210.18223257395;2194.7037149984785;2197.9340619781433;2199.0214354612203;2203.911843526257;2216.4902072523328;2071.4924843413387;2078.5323302256947;2083.614531311712;2103.7580678221893;2107.8735275883496;2155.5257843274453;2171;2187.58435897179;2190.7042549255966;2191.0359441845535;7922.524648521049;8006;8037.5579343136105;8053.959730201312;8056.919430805676;4635.258358662598;4648.790804413809;4694.647901407374;4732.526747325274;4746.240601503743;2922.576226447153;2975.7619390448713;3084.1826915867314;3087.922801929947;3112.4553203189353;975.3465178330465;999.8400255959084;1002.6991902429243;1031.3811712972156;1048.7273308939655;10638.893611063944;10642.57429702811;10649.627263045757;10694.358338499715;10707.518161682743;4134.937975930364;4176.540580536139;4256.1487702459635;4282.957170428256;4300.118475712534;9125.68060117906;9216.815663686688;9236;9241.722748317561;9244.90755092454;4558.293464513005;4560.475545312265;4561.749103799323;4562.726236425825;4588.3805686231935;3797.145642230476;4105.630493255621;4112.794360281974;4246.256905041667;4253.48958125027;3700.8149592520267;3717.851285948586;3843.7117216208894;3856.9807150964625;3993.9001524961527;1204.608502236759;1211.3821950805152;1217.0871846115413;1222.6882145053132;1229;724.8550289942033;845.9365547583956;851.344464762142;860.9956950215334;873.3711727556149;5174.663646862942;5331.840044798662;5362;5402.783888644411;5509.338879334506;402.59338068550977;410.50329101786576;412.05022423314546;414.3846388113709;416.01404670929486;3713.294474049922;3731.2164445466756;3736.663700266989;3797.18360552477;3833.15670552478;9459.716208513755;9751.414915105117;9772.755681108029;9842.360246584092;9850;9567.282453815853;9743.220542356736;9771.755706107404;9808.509574521246;9827.213822894151;7465;7467.290607392398;7481.064866891638;7572.886406703904;7578.772636820904;5144.639875208849;5282.392524859691;5375.247465354932;5398.46015398457;5441.5102640762525;8881.245094167069;8970.506622135845;9128.817423651622;9228.95385523068;9258.814823703622;9001.36990410665;9082.137196966278;9147.268218542633;9246.815063698823;9259.074092590687;5988.071848863433;6361.650109244036;6539.574927629689;6632.568883022588;6660.167479065117;7526.736564220226;7537.54774713519;7566.508176968479;7607.201243869314;7622.123455802654;6425.453836423956;6661.600303981777;6703.463722902058;6750.257471678014;6788.626625535446;6451.1936007999;6457.903131453126;6481.708323125565;6486.286508484157;6556.213254409501;6277.278113016879;6333.923233050485;6358.650274234777;6401.9436792928645;6416.967915160394;4330.35044743291;4447.421835161408;4489.236829739018;4520.683552151318;4547.3633691282585;4536.160810250114;4561.680682352204;4571.771411429481;4573.702709323883;4612.561806628365 18:40:23 INFO - PROCESS | 4574 | |4;prototype.html;288.6536156612065;288.65505720663816;289.09945519706093;290.3901806206964;293.64322348346764;5052.924206136906;5135.204043373274;5146;5154.896902061962;5158.922616160756;4976.129177393959;4992.152903425728;5000.674956127849;5023.171176755831;5043.36957880265;3707.8516859325664;3796.5444146702434;3867.4088360798332;3871.9612803871883;3873.9806300968457;3907.589703081178;3911.2399420260854;3915.9804200978956;3916.158026024404;3938.8424463021443;3904.1020565270005;3912.5500567434683;3915.4714113594728;3916.6291797870804;3919.608039196086;3805.162864169878;3857.189990102082;3858.864939727096;3912.1979994101284;3914.451976723261;3387.458006718913;3402.812845293508;3404.6254911959663;3408.454647256427;3411.714151518464;4874.2201247800185;4875.219964805614;4880.316755654211;4909.2881532177635;4923.310736496894;4411.514733379326;4459.598636122764;4478.529754375809;4491.6855820092605;4501.627003763851;5208.109499227927;5209.739513024334;5214.947850521522;5242.266082748418;5252.107141785906;3694.4827724118645;3714;3733.1600389912323;3735;3752.1745216052423;5450.746328344503;5506.0089183947275;5543.390227075019;5552.41699621542;5562.554995600342;3600.0999750062483;3769.1142581493327;3789.726164301397;3792.7724336539895;3826.7321287510163;3798.3542797724454;3814.6566808987322;3835.0412396900774;3849.1339448624394;3850.6726928211415;4403.471583409947;4412.4705035395955;4426.911461770811;4429.15845989261;4465.280866866215;5120.155174396183;5250.606204534675;5265.289185959923;5268.788178718916;5316.149416093406;1324.6953200763878;1335.3990704183157;1338.5448947357945;1347.2253454263641;1348.885344745688;829.8174401631632;842.6376658037103;855.482433127961;855.6449073634496;861.5132450165636;4446;4526.88682782933;4542.500324964251;4618.422697162855;4632.97683511587;5344.518993290622;5348.1442969124755;5381.273528073738;5418.428655689884;5440.3743569489225;4391.934120988188;4586.3579098926175;4589.2886602576655;4593.747343896051;4604.58558729716;2839.162447078117;2846.8576571171357;2871.052552657618;2874.3532705141592;2880.545324611058;4960.429550601655;5063.721495317793;5070.949290507047;5073.822416215415;5099.490050994871;5295.867603309948;5467.043267428184;5500.669959802424;5531.032069387841;5576.498115169654;5030.4466508684745;5064.468230835783;5109.718965456861;5121.206213036985;5135.460776618476;5378.354597448331;5383.40782513931;5395.595330350161;5430.918536222039;5453.7818487260065;5178.663386879841;5302.337207849019;5302.681839089667;5315.6279060465395;5318.97340513295;5048.64659473848;5051.267566202953;5080.237964305384;5104.1578139606545;5133.050385678512;3733.8319775610707;3734.3278209922473;3746.4567637692926;3748.5126933498473;3770.170562476251;5277.2875661785165;5388.137897936312;5410.296661433988;5413.891722165456;5464.18037294409;5201.375834899836;5259.368875734936;5263.447338029452;5278.920816187683;5306.469353064817;5260.763265653131;5277.920831187458;5283.4452382499285;5293.206019097012;5298.06620583492;4947.12707982644;5127.769250383667;5142.51146141116;5156.097682905402;5183.248428977852;5069.695818250917;5137.842106315431;5266.552343050884;5307.708076055854;5322.760475778522;5189.584833213409;5221.686698798084;5221.973890130525;5227.9215811763615;5228.607854410859 18:40:23 INFO - PROCESS | 4574 | |5;yui.html;669.9765508207211;684.4285022006625;696.1646024770276;735.2537174767612;738.394516496473;12496.812547811778;12754.936225318872;12907.612771616843;12986.675333116666;14406.639834004156;14094.295285235748;14548.563543093724;14848;14850.257487125655;14902.776458353106;793.218679600593;800.1638287989066;808.6159074439653;809.1544336168718;810.1979040749645;622.1165944359021;781.9569923654196;805.5931754464017;805.8186907945724;806.4314658166008;835.5989125219899;843.5866425451516;846.6232526525698;852.1138016462871;855.7133360324299;846.5597889097696;848.240824462106;850.4472093139478;852.2627926843267;852.5992783391858;603.9818805435845;614.720302262474;614.8217017065045;616.8797084568511;617.5059952038396;13302.135361201588;13340.266285354302;13356.198628082346;13393.330333483287;13428.261445620486;12518.687032824162;12857.935710321388;12864.29246391448;12918.095733298673;13166.473341066347;10270.6405275815;10340.638077667245;10412.583496660125;10698.304610200312;10776.299540529919;3299.934001319984;3305.5537502437346;3345.799252044885;3404.14896275931;3407.2504049109157;53239;60799.392006080256;61032.38967610356;61204.693976530274;61280.387196127915;10095.697129086138;10199.439030853375;10215.131713804261;10269.281150319406;10308.690739277834;18775.342863;18806.341778037702;18834.623307533773;18878.716819247722;18921.95929223906;6054.7275372607455;6337.556371053982;6362.459190968727;6532.41208291256;6544.869102617921;3713.702903767692;3755.661990420875;3792.1846802937503;3797.031756901972;3809.12390150267;2956.3200463892995;3075.2465645916895;3091.335362896988;3091.412631599989;3095.721385075309;532.1459058211592;536.4045909040962;544.8419958212074;551.8978988886988;556.0852397805587;598.4912824099481;599.78107990584;611.5230120506012;612.9141920131185;619.5074915442234;7259.782206533707;7362.7423040193335;7642.235776422424;7679.731209407644;8003.5197888126895;497.2466712929914;506.68838664221977;514.4109994056784;576.3084298841408;635.4566845347161;3597.3165098631175;3729.68297694699;3760.646167379741;3824.655780979725;3866.903327416781;51930.22104668433;89322.55338723394;93167.53416232875;93294.53352733194;93869.53065234766;64887.35112648908;68935.65532172307;70257.29742702507;79447;83597.58201209077;44135.33796993112;44543.777281113384;53303;83665;84788;8586.570671466277;8713.433626814236;9008.729738107868;9063.274938004812;9098.135677110664;29675.703242968157;44894.77552612216;45775;46006.76996614996;46061.76969115133;64145.3585464158;66283.33716662772;66337.66831165813;66499.66750166219;66910;11001.559937602726;11024.393658348868;11141.665750027512;11158.274712143684;11438.714032149262;12969.610911672666;13012.934935325262;13097.672558186121;13151.60545183646;13697.178169309873;11449.94275028653;11788.764224715285;12145.514179432723;12154.513819447124;12203.511859525519;11403.98757480452;11680.591179308683;11773.705657358634;11807.645770626896;11812.291262524275;11359;11781.646550603497;11969.341686206993;12361.505539778309;12385.62843114708;9248.583813728534;9499.335046546952;9836.852447213441;10083.394996300245;10147.898521014991;9566.760830979003;9603.951980240054;9617.471039092918;10092.747681308027;10165.339252948535 18:40:23 INFO - PROCESS | 4574 | __end_tp_report 18:40:23 INFO - PROCESS | 4574 | __start_cc_report 18:40:23 INFO - PROCESS | 4574 | _x_x_mozilla_cycle_collect,391 18:40:23 INFO - PROCESS | 4574 | __end_cc_report 18:40:23 INFO - PROCESS | 4574 | __startTimestamp1465954823373__endTimestamp 18:40:23 INFO - PROCESS | 4574 | 18:40:23 INFO - PROCESS | 4574 | ------- Summary: start ------- 18:40:23 INFO - PROCESS | 4574 | Number of tests: 6 18:40:23 INFO - PROCESS | 4574 | 18:40:23 INFO - PROCESS | 4574 | [#0] dojo.html Cycles:165 Average:4765.79 Median:4918.85 stddev:613.38 (12.5%) stddev-sans-first:591.46 18:40:23 INFO - PROCESS | 4574 | Values: 2608.8 2673.3 2682.6 2697.7 2715.5 4795.8 4832.5 4906.2 4924.8 4931.2 4706.7 4813.5 4849.4 4852.6 4891.3 4450.0 4479.8 4582.2 4584.1 4598.0 552.3 4287.1 4359.1 4377.5 4390.9 4388.4 4434.7 4438.9 4440.2 4482.9 4410.8 4457.5 4462.4 4468.1 4492.7 4378.2 4403.2 4443.2 4447.0 4455.3 4828.3 4852.9 4862.3 4867.4 4872.4 5002.7 5189.2 5226.1 5232.9 5259.7 5179.1 5198.5 5206.5 5209.6 5237.1 4886.0 4911.7 4918.7 4919.7 4968.5 5264.8 5319.9 5340.6 5382.4 5413.0 5100.8 5124.3 5125.2 5128.4 5140.8 5209.1 5218.7 5219.4 5227.9 5237.2 5002.6 5052.2 5070.5 5093.1 5094.3 5048.3 5055.1 5085.8 5098.8 5126.8 4270.1 4343.2 4349.3 4351.3 4396.3 3699.9 3804.8 3841.2 3845.6 3859.9 4436.9 4445.4 4451.9 4501.8 4527.6 5260.2 5272.6 5280.2 5280.3 5285.8 4287.6 4335.2 4393.6 4426.4 4453.8 4645.6 4647.5 4656.7 4672.1 4691.0 4833.4 4876.9 4889.7 4892.9 4929.3 5036.5 5184.6 5228.9 5240.2 5275.5 4912.1 4940.8 4942.3 4942.5 4977.3 5007.4 5175.3 5183.5 5192.7 5199.7 5196.1 5231.3 5261.2 5265.2 5272.9 5136.0 5136.7 5140.2 5143.9 5196.6 4863.7 4870.6 5129.6 5139.6 5148.8 4855.1 4876.6 4889.8 4898.2 4918.9 5045.7 5057.2 5064.8 5074.5 5110.1 4843.7 4946.1 4946.9 4954.4 5010.1 18:40:23 INFO - PROCESS | 4574 | 18:40:23 INFO - PROCESS | 4574 | [#1] ext.html Cycles:180 Average:47592.08 Median:36687.36 stddev:90955.15 (247.9%) stddev-sans-first:91141.71 18:40:23 INFO - PROCESS | 4574 | Values: 543.1 586.5 592.4 602.4 614.0 35333.5 40000.0 40070.4 40234.2 40448.2 40369.2 40696.6 41101.2 41126.4 41301.2 7731.8 7940.2 7965.4 7968.6 7968.9 7861.4 7977.6 7979.5 7984.2 8029.2 8008.0 8075.7 8092.1 8096.8 8100.8 7981.5 7992.2 8032.0 8046.4 8057.1 7837.5 7840.9 7914.4 7922.7 7932.6 38656.2 38738.8 38913.2 39014.0 39059.8 3077.6 3250.7 3440.1 3522.5 3785.9 30325.1 30648.5 30824.8 30942.0 31024.1 3399.8 3427.3 3458.9 3477.8 3520.1 235388.0 236238.0 236330.0 237322.0 237990.0 31636.8 54063.0 54324.5 54329.7 54393.4 32844.8 34365.8 34521.3 34665.0 34719.1 12132.5 12267.4 12309.9 12310.1 12329.6 10783.3 10852.8 10903.5 10906.2 10947.2 7930.9 7947.9 7951.9 7985.6 8018.5 3137.0 3142.1 3207.3 3223.8 3248.7 856.3 915.7 959.6 978.2 980.5 28177.6 29165.6 29343.4 29376.4 29656.0 990.6 998.8 1002.8 1032.8 1041.1 15420.5 15470.2 15571.8 15575.1 15603.8 423711.0 428568.0 429420.0 429666.0 430001.0 32264.8 32563.2 33066.0 33154.0 33200.3 1168.0 1170.3 1187.0 1218.8 1228.6 27413.0 28459.6 28529.0 29170.0 29388.7 43133.4 43890.6 44389.6 44446.8 44476.6 335766.0 338456.0 339535.0 339831.0 339869.0 25669.2 25875.4 26024.1 26057.0 26182.7 40685.0 43190.1 43922.6 44321.8 44637.0 37355.4 37405.6 37726.0 37958.2 38975.4 36521.1 37256.8 37397.4 37489.6 37510.2 32252.4 36853.6 37202.3 37336.6 37533.6 32761.0 33878.7 34382.1 34445.3 34491.0 25690.9 26045.3 26415.7 26560.6 26974.7 18:40:23 INFO - PROCESS | 4574 | 18:40:23 INFO - PROCESS | 4574 | [#2] jquery.html Cycles:180 Average:25455.53 Median:5002.04 stddev:72260.06 (1444.6%) stddev-sans-first:72438.21 18:40:23 INFO - PROCESS | 4574 | Values: 364.8 366.6 366.7 384.0 384.5 16044.4 17104.6 17840.4 17910.0 17922.2 15864.9 16264.5 16944.7 16974.2 16999.7 5030.6 5195.7 5225.6 5229.9 5233.9 3624.8 5063.6 5723.7 6027.9 6031.7 6039.1 6058.1 6094.3 6105.1 6117.4 4973.4 5290.7 5297.3 5302.0 5330.9 5074.3 5097.8 5141.6 5170.7 5178.8 12239.7 12488.7 12511.2 15996.9 20725.2 1827.1 1914.9 1941.9 1983.2 1996.0 8978.1 9171.4 9277.6 9316.6 9395.2 1665.8 1731.7 1771.5 1774.3 1817.1 60477.7 69210.0 71461.3 72301.0 72703.3 9570.3 9584.7 9785.4 9809.4 10166.7 13355.6 13380.9 13384.3 13462.3 13473.2 6641.4 6795.5 6824.4 6839.9 6906.4 6240.3 6361.1 6365.2 6422.6 6466.9 4107.8 4138.8 4207.3 4232.2 4282.7 1636.7 1724.5 1797.6 1828.4 1849.9 769.7 843.6 880.4 881.2 917.4 16417.3 16728.0 16830.2 16974.3 16974.4 853.7 859.3 872.9 874.0 887.2 9341.7 9500.8 9504.8 9666.2 9689.5 401821.0 433291.0 447997.0 451922.0 456265.0 50488.5 80293.0 83322.6 83579.6 84095.6 914.4 923.8 930.4 941.8 947.4 14940.3 14958.6 15116.7 15171.8 15506.6 35663.6 36457.5 36862.4 36912.0 37300.3 51932.7 54352.0 54501.7 55429.4 55696.7 7567.9 7593.8 7671.7 7784.6 7848.5 10451.6 11249.7 11395.7 11479.5 11542.2 5101.4 10492.4 10729.4 10826.9 10852.8 4635.7 7455.5 10083.7 10104.6 10638.7 10555.7 10612.3 10751.6 10799.7 10856.3 7700.1 7808.1 7997.6 8011.6 8118.3 10066.4 10318.1 10434.8 10467.6 10473.2 18:40:23 INFO - PROCESS | 4574 | 18:40:23 INFO - PROCESS | 4574 | [#3] mootools.html Cycles:180 Average:5165.77 Median:4713.59 stddev:2913.06 (61.8%) stddev-sans-first:2907.27 18:40:23 INFO - PROCESS | 4574 | Values: 1369.7 1406.1 1489.6 1662.1 1674.3 6942.5 7570.3 7578.4 8080.8 8089.4 7606.6 7839.4 7883.2 7898.6 7928.6 2217.1 2242.1 2243.4 2249.4 2254.3 2167.5 2202.4 2206.2 2208.6 2210.2 2194.7 2197.9 2199.0 2203.9 2216.5 2071.5 2078.5 2083.6 2103.8 2107.9 2155.5 2171.0 2187.6 2190.7 2191.0 7922.5 8006.0 8037.6 8054.0 8056.9 4635.3 4648.8 4694.6 4732.5 4746.2 2922.6 2975.8 3084.2 3087.9 3112.5 975.3 999.8 1002.7 1031.4 1048.7 10638.9 10642.6 10649.6 10694.4 10707.5 4134.9 4176.5 4256.1 4283.0 4300.1 9125.7 9216.8 9236.0 9241.7 9244.9 4558.3 4560.5 4561.7 4562.7 4588.4 3797.1 4105.6 4112.8 4246.3 4253.5 3700.8 3717.9 3843.7 3857.0 3993.9 1204.6 1211.4 1217.1 1222.7 1229.0 724.9 845.9 851.3 861.0 873.4 5174.7 5331.8 5362.0 5402.8 5509.3 402.6 410.5 412.1 414.4 416.0 3713.3 3731.2 3736.7 3797.2 3833.2 9459.7 9751.4 9772.8 9842.4 9850.0 9567.3 9743.2 9771.8 9808.5 9827.2 7465.0 7467.3 7481.1 7572.9 7578.8 5144.6 5282.4 5375.2 5398.5 5441.5 8881.2 8970.5 9128.8 9229.0 9258.8 9001.4 9082.1 9147.3 9246.8 9259.1 5988.1 6361.7 6539.6 6632.6 6660.2 7526.7 7537.5 7566.5 7607.2 7622.1 6425.5 6661.6 6703.5 6750.3 6788.6 6451.2 6457.9 6481.7 6486.3 6556.2 6277.3 6333.9 6358.7 6401.9 6417.0 4330.4 4447.4 4489.2 4520.7 4547.4 4536.2 4561.7 4571.8 4573.7 4612.6 18:40:23 INFO - PROCESS | 4574 | 18:40:23 INFO - PROCESS | 4574 | [#4] prototype.html Cycles:180 Average:4350.50 Median:5026.81 stddev:1277.49 (25.4%) stddev-sans-first:1244.16 18:40:23 INFO - PROCESS | 4574 | Values: 288.7 288.7 289.1 290.4 293.6 5052.9 5135.2 5146.0 5154.9 5158.9 4976.1 4992.2 5000.7 5023.2 5043.4 3707.9 3796.5 3867.4 3872.0 3874.0 3907.6 3911.2 3916.0 3916.2 3938.8 3904.1 3912.6 3915.5 3916.6 3919.6 3805.2 3857.2 3858.9 3912.2 3914.5 3387.5 3402.8 3404.6 3408.5 3411.7 4874.2 4875.2 4880.3 4909.3 4923.3 4411.5 4459.6 4478.5 4491.7 4501.6 5208.1 5209.7 5214.9 5242.3 5252.1 3694.5 3714.0 3733.2 3735.0 3752.2 5450.7 5506.0 5543.4 5552.4 5562.6 3600.1 3769.1 3789.7 3792.8 3826.7 3798.4 3814.7 3835.0 3849.1 3850.7 4403.5 4412.5 4426.9 4429.2 4465.3 5120.2 5250.6 5265.3 5268.8 5316.1 1324.7 1335.4 1338.5 1347.2 1348.9 829.8 842.6 855.5 855.6 861.5 4446.0 4526.9 4542.5 4618.4 4633.0 5344.5 5348.1 5381.3 5418.4 5440.4 4391.9 4586.4 4589.3 4593.7 4604.6 2839.2 2846.9 2871.1 2874.4 2880.5 4960.4 5063.7 5070.9 5073.8 5099.5 5295.9 5467.0 5500.7 5531.0 5576.5 5030.4 5064.5 5109.7 5121.2 5135.5 5378.4 5383.4 5395.6 5430.9 5453.8 5178.7 5302.3 5302.7 5315.6 5319.0 5048.6 5051.3 5080.2 5104.2 5133.1 3733.8 3734.3 3746.5 3748.5 3770.2 5277.3 5388.1 5410.3 5413.9 5464.2 5201.4 5259.4 5263.4 5278.9 5306.5 5260.8 5277.9 5283.4 5293.2 5298.1 4947.1 5127.8 5142.5 5156.1 5183.2 5069.7 5137.8 5266.6 5307.7 5322.8 5189.6 5221.7 5222.0 5227.9 5228.6 18:40:23 INFO - PROCESS | 4574 | 18:40:23 INFO - PROCESS | 4574 | [#5] yui.html Cycles:180 Average:16778.07 Median:23279.51 stddev:23083.68 (99.2%) stddev-sans-first:23116.75 18:40:23 INFO - PROCESS | 4574 | Values: 670.0 684.4 696.2 735.3 738.4 12496.8 12754.9 12907.6 12986.7 14406.6 14094.3 14548.6 14848.0 14850.3 14902.8 793.2 800.2 808.6 809.2 810.2 622.1 782.0 805.6 805.8 806.4 835.6 843.6 846.6 852.1 855.7 846.6 848.2 850.4 852.3 852.6 604.0 614.7 614.8 616.9 617.5 13302.1 13340.3 13356.2 13393.3 13428.3 12518.7 12857.9 12864.3 12918.1 13166.5 10270.6 10340.6 10412.6 10698.3 10776.3 3299.9 3305.6 3345.8 3404.1 3407.3 53239.0 60799.4 61032.4 61204.7 61280.4 10095.7 10199.4 10215.1 10269.3 10308.7 18775.3 18806.3 18834.6 18878.7 18922.0 6054.7 6337.6 6362.5 6532.4 6544.9 3713.7 3755.7 3792.2 3797.0 3809.1 2956.3 3075.2 3091.3 3091.4 3095.7 532.1 536.4 544.8 551.9 556.1 598.5 599.8 611.5 612.9 619.5 7259.8 7362.7 7642.2 7679.7 8003.5 497.2 506.7 514.4 576.3 635.5 3597.3 3729.7 3760.6 3824.7 3866.9 51930.2 89322.6 93167.5 93294.5 93869.5 64887.4 68935.7 70257.3 79447.0 83597.6 44135.3 44543.8 53303.0 83665.0 84788.0 8586.6 8713.4 9008.7 9063.3 9098.1 29675.7 44894.8 45775.0 46006.8 46061.8 64145.4 66283.3 66337.7 66499.7 66910.0 11001.6 11024.4 11141.7 11158.3 11438.7 12969.6 13012.9 13097.7 13151.6 13697.2 11449.9 11788.8 12145.5 12154.5 12203.5 11404.0 11680.6 11773.7 11807.6 11812.3 11359.0 11781.6 11969.3 12361.5 12385.6 9248.6 9499.3 9836.9 10083.4 10147.9 9566.8 9604.0 9617.5 10092.7 10165.3 18:40:23 INFO - PROCESS | 4574 | -------- Summary: end -------- 18:40:23 INFO - PROCESS | 4574 | 18:40:24 INFO - TEST-INFO | 4574: exit 0 18:40:24 INFO - TEST-OK | dromaeo_css | took 1116421ms 18:40:24 INFO - TEST-START | kraken 18:40:24 INFO - operating with platform_type : linux_ 18:40:24 INFO - Initialising browser for kraken test... 18:40:24 INFO - TEST-INFO | started process 4809 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWT2y7l/profile http://localhost:56534/getInfo.html) 18:40:29 INFO - PROCESS | 4809 | __metrics Screen width/height:1600/1200 18:40:29 INFO - PROCESS | 4809 | colorDepth:24 18:40:29 INFO - PROCESS | 4809 | Browser inner width/height: 1024/697 18:40:29 INFO - PROCESS | 4809 | __metrics 18:40:30 ERROR - PROCESS | 4809 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 18:40:31 INFO - TEST-INFO | 4809: exit 0 18:40:31 INFO - Browser initialized. 18:40:31 INFO - Running cycle 1/1 for kraken test... 18:40:31 INFO - TEST-INFO | started process 4927 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWT2y7l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:40:43 INFO - PROCESS | 4927 | RSS: Main: 186560512 18:40:43 INFO - PROCESS | 4927 | 18:40:45 INFO - PROCESS | 4927 | Cycle 1(1): loaded http://localhost:56534/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56534/tests/kraken/driver.html?testName=audio-beat-detection) 18:40:46 INFO - PROCESS | 4927 | RSS: Main: 191926272 18:40:46 INFO - PROCESS | 4927 | 18:40:49 INFO - PROCESS | 4927 | Cycle 1(1): loaded http://localhost:56534/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56534/tests/kraken/driver.html?testName=audio-dft) 18:40:50 INFO - PROCESS | 4927 | RSS: Main: 190861312 18:40:50 INFO - PROCESS | 4927 | 18:40:53 INFO - PROCESS | 4927 | Cycle 1(1): loaded http://localhost:56534/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56534/tests/kraken/driver.html?testName=audio-fft) 18:40:53 INFO - PROCESS | 4927 | RSS: Main: 186941440 18:40:53 INFO - PROCESS | 4927 | 18:40:55 INFO - PROCESS | 4927 | Cycle 1(1): loaded http://localhost:56534/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56534/tests/kraken/driver.html?testName=audio-oscillator) 18:40:56 INFO - PROCESS | 4927 | RSS: Main: 187187200 18:40:56 INFO - PROCESS | 4927 | 18:40:58 INFO - PROCESS | 4927 | Cycle 1(1): loaded http://localhost:56534/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56534/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:40:59 INFO - PROCESS | 4927 | RSS: Main: 187494400 18:40:59 INFO - PROCESS | 4927 | 18:41:02 INFO - PROCESS | 4927 | Cycle 1(1): loaded http://localhost:56534/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56534/tests/kraken/driver.html?testName=imaging-darkroom) 18:41:03 INFO - PROCESS | 4927 | RSS: Main: 188334080 18:41:03 INFO - PROCESS | 4927 | 18:41:06 INFO - PROCESS | 4927 | Cycle 1(1): loaded http://localhost:56534/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56534/tests/kraken/driver.html?testName=imaging-desaturate) 18:41:07 INFO - PROCESS | 4927 | RSS: Main: 185192448 18:41:07 INFO - PROCESS | 4927 | 18:41:10 INFO - PROCESS | 4927 | Cycle 1(1): loaded http://localhost:56534/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56534/tests/kraken/driver.html?testName=json-parse-financial) 18:41:11 INFO - PROCESS | 4927 | RSS: Main: 186376192 18:41:11 INFO - PROCESS | 4927 | 18:41:12 INFO - PROCESS | 4927 | Cycle 1(1): loaded http://localhost:56534/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56534/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:41:13 INFO - PROCESS | 4927 | RSS: Main: 186916864 18:41:13 INFO - PROCESS | 4927 | 18:41:15 INFO - PROCESS | 4927 | Cycle 1(1): loaded http://localhost:56534/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56534/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:41:16 INFO - PROCESS | 4927 | RSS: Main: 186892288 18:41:16 INFO - PROCESS | 4927 | 18:41:18 INFO - PROCESS | 4927 | Cycle 1(1): loaded http://localhost:56534/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56534/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:41:18 INFO - PROCESS | 4927 | RSS: Main: 187785216 18:41:18 INFO - PROCESS | 4927 | 18:41:21 INFO - PROCESS | 4927 | Cycle 1(1): loaded http://localhost:56534/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56534/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:41:22 INFO - PROCESS | 4927 | RSS: Main: 187863040 18:41:22 INFO - PROCESS | 4927 | 18:41:25 INFO - PROCESS | 4927 | Cycle 1(1): loaded http://localhost:56534/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56534/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:41:25 INFO - PROCESS | 4927 | RSS: Main: 187662336 18:41:25 INFO - PROCESS | 4927 | 18:41:27 INFO - PROCESS | 4927 | Cycle 1(1): loaded http://localhost:56534/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56534/tests/kraken/driver.html?testName=ai-astar) 18:41:27 INFO - PROCESS | 4927 | RSS: Main: 188805120 18:41:27 INFO - PROCESS | 4927 | 18:41:27 INFO - PROCESS | 4927 | __start_tp_report 18:41:27 INFO - PROCESS | 4927 | _x_x_mozilla_page_load 18:41:27 INFO - PROCESS | 4927 | _x_x_mozilla_page_load_details 18:41:27 INFO - PROCESS | 4927 | |i|pagename|runs| 18:41:27 INFO - PROCESS | 4927 | |0;ai-astar;114;110;112;113;112;113;113;113;113;112 18:41:27 INFO - PROCESS | 4927 | |1;audio-beat-detection;169;132;157;195;132;159;165;134;196;131 18:41:27 INFO - PROCESS | 4927 | |2;audio-dft;162;165;175;164;163;164;163;162;162;161 18:41:27 INFO - PROCESS | 4927 | |3;audio-fft;75;77;76;151;77;78;77;75;161;79 18:41:27 INFO - PROCESS | 4927 | |4;audio-oscillator;87;87;145;86;87;91;135;86;85;135 18:41:27 INFO - PROCESS | 4927 | |5;imaging-gaussian-blur;118;117;119;118;118;118;119;118;118;120 18:41:27 INFO - PROCESS | 4927 | |6;imaging-darkroom;148;148;148;147;148;147;147;146;148;146 18:41:27 INFO - PROCESS | 4927 | |7;imaging-desaturate;95;96;96;96;95;96;96;96;95;95 18:41:27 INFO - PROCESS | 4927 | |8;json-parse-financial;69;64;64;64;65;64;65;65;64;65 18:41:27 INFO - PROCESS | 4927 | |9;json-stringify-tinderbox;65;66;65;65;66;65;66;67;66;67 18:41:27 INFO - PROCESS | 4927 | |10;stanford-crypto-aes;84;83;89;86;88;83;84;84;119;85 18:41:27 INFO - PROCESS | 4927 | |11;stanford-crypto-ccm;143;134;141;132;140;136;135;137;149;134 18:41:27 INFO - PROCESS | 4927 | |12;stanford-crypto-pbkdf2;178;171;174;172;168;171;173;169;168;167 18:41:27 INFO - PROCESS | 4927 | |13;stanford-crypto-sha256-iterative;68;70;70;73;67;69;67;71;71;68 18:41:27 INFO - PROCESS | 4927 | __end_tp_report 18:41:27 INFO - PROCESS | 4927 | __start_cc_report 18:41:27 INFO - PROCESS | 4927 | _x_x_mozilla_cycle_collect,979 18:41:27 INFO - PROCESS | 4927 | __end_cc_report 18:41:27 INFO - PROCESS | 4927 | __startTimestamp1465954887968__endTimestamp 18:41:27 INFO - PROCESS | 4927 | 18:41:27 INFO - PROCESS | 4927 | ------- Summary: start ------- 18:41:27 INFO - PROCESS | 4927 | Number of tests: 14 18:41:27 INFO - PROCESS | 4927 | 18:41:27 INFO - PROCESS | 4927 | [#0] ai-astar Cycles:10 Average:112.50 Median:113.00 stddev:1.08 (1.0%) stddev-sans-first:1.00 18:41:27 INFO - PROCESS | 4927 | Values: 114.0 110.0 112.0 113.0 112.0 113.0 113.0 113.0 113.0 112.0 18:41:27 INFO - PROCESS | 4927 | 18:41:27 INFO - PROCESS | 4927 | [#1] audio-beat-detection Cycles:10 Average:157.00 Median:162.00 stddev:25.02 (15.4%) stddev-sans-first:26.15 18:41:27 INFO - PROCESS | 4927 | Values: 169.0 132.0 157.0 195.0 132.0 159.0 165.0 134.0 196.0 131.0 18:41:27 INFO - PROCESS | 4927 | 18:41:27 INFO - PROCESS | 4927 | [#2] audio-dft Cycles:10 Average:164.10 Median:163.50 stddev:4.01 (2.5%) stddev-sans-first:4.18 18:41:27 INFO - PROCESS | 4927 | Values: 162.0 165.0 175.0 164.0 163.0 164.0 163.0 162.0 162.0 161.0 18:41:27 INFO - PROCESS | 4927 | 18:41:27 INFO - PROCESS | 4927 | [#3] audio-fft Cycles:10 Average:92.60 Median:77.00 stddev:33.52 (43.5%) stddev-sans-first:34.94 18:41:27 INFO - PROCESS | 4927 | Values: 75.0 77.0 76.0 151.0 77.0 78.0 77.0 75.0 161.0 79.0 18:41:27 INFO - PROCESS | 4927 | 18:41:27 INFO - PROCESS | 4927 | [#4] audio-oscillator Cycles:10 Average:102.40 Median:86.50 stddev:24.99 (28.9%) stddev-sans-first:25.88 18:41:27 INFO - PROCESS | 4927 | Values: 87.0 87.0 145.0 86.0 87.0 91.0 135.0 86.0 85.0 135.0 18:41:27 INFO - PROCESS | 4927 | 18:41:27 INFO - PROCESS | 4927 | [#5] imaging-gaussian-blur Cycles:10 Average:118.30 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 18:41:27 INFO - PROCESS | 4927 | Values: 118.0 117.0 119.0 118.0 118.0 118.0 119.0 118.0 118.0 120.0 18:41:27 INFO - PROCESS | 4927 | 18:41:27 INFO - PROCESS | 4927 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 18:41:27 INFO - PROCESS | 4927 | Values: 148.0 148.0 148.0 147.0 148.0 147.0 147.0 146.0 148.0 146.0 18:41:27 INFO - PROCESS | 4927 | 18:41:27 INFO - PROCESS | 4927 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 18:41:27 INFO - PROCESS | 4927 | Values: 95.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 95.0 95.0 18:41:27 INFO - PROCESS | 4927 | 18:41:27 INFO - PROCESS | 4927 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:65.00 stddev:1.52 (2.3%) stddev-sans-first:0.53 18:41:27 INFO - PROCESS | 4927 | Values: 69.0 64.0 64.0 64.0 65.0 64.0 65.0 65.0 64.0 65.0 18:41:27 INFO - PROCESS | 4927 | 18:41:27 INFO - PROCESS | 4927 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.79 (1.2%) stddev-sans-first:0.78 18:41:27 INFO - PROCESS | 4927 | Values: 65.0 66.0 65.0 65.0 66.0 65.0 66.0 67.0 66.0 67.0 18:41:27 INFO - PROCESS | 4927 | 18:41:27 INFO - PROCESS | 4927 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:84.50 stddev:10.91 (12.9%) stddev-sans-first:11.45 18:41:27 INFO - PROCESS | 4927 | Values: 84.0 83.0 89.0 86.0 88.0 83.0 84.0 84.0 119.0 85.0 18:41:27 INFO - PROCESS | 4927 | 18:41:27 INFO - PROCESS | 4927 | [#11] stanford-crypto-ccm Cycles:10 Average:138.10 Median:138.50 stddev:5.17 (3.7%) stddev-sans-first:5.17 18:41:27 INFO - PROCESS | 4927 | Values: 143.0 134.0 141.0 132.0 140.0 136.0 135.0 137.0 149.0 134.0 18:41:27 INFO - PROCESS | 4927 | 18:41:27 INFO - PROCESS | 4927 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.10 Median:171.50 stddev:3.35 (2.0%) stddev-sans-first:2.45 18:41:27 INFO - PROCESS | 4927 | Values: 178.0 171.0 174.0 172.0 168.0 171.0 173.0 169.0 168.0 167.0 18:41:27 INFO - PROCESS | 4927 | 18:41:27 INFO - PROCESS | 4927 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:70.00 stddev:1.96 (2.8%) stddev-sans-first:2.01 18:41:27 INFO - PROCESS | 4927 | Values: 68.0 70.0 70.0 73.0 67.0 69.0 67.0 71.0 71.0 68.0 18:41:27 INFO - PROCESS | 4927 | -------- Summary: end -------- 18:41:27 INFO - PROCESS | 4927 | 18:41:29 INFO - TEST-INFO | 4927: exit 0 18:41:29 INFO - TEST-OK | kraken | took 64904ms 18:41:29 INFO - SUITE-END | took 1181s 18:41:29 INFO - Completed test suite (00:19:41) 18:41:29 INFO - javascript benchmark 18:41:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6373.016392960372, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2608.778253848423, 2673.3049407154144, 2682.557378032625, 2697.716739742327, 2715.497632937908, 4795.832145874895, 4832.4684284728655, 4906.190478571036, 4924.753762311888, 4931.235658472933, 4706.670533062687, 4813.49458306878, 4849.418069831617, 4852.611791056715, 4891.315215869781, 4449.9987502811855, 4479.776011199427, 4582.19811532982, 4584.106099310636, 4597.977010114962, 552.3187384510559, 4287.1425714857, 4359.062801497677, 4377.496587892385, 4390.8902277443, 4388.42950416447, 4434.689571729948, 4438.866833994985, 4440.222960981848, 4482.887927801831, 4410.779461026936, 4457.509673935897, 4462.352958820985, 4468.084042771224, 4492.707973981681, 4378.233809083397, 4403.163398954221, 4443.155800397914, 4447.043885564619, 4455.331700244957, 4828.324034635154, 4852.8544143675745, 4862.343583616202, 4867.367242258484, 4872.4153101628035, 5002.7248501332415, 5189.247559103909, 5226.085435048852, 5232.895342093175, 5259.737013149327, 5179.093658609729, 5198.506141916512, 5206.505381988705, 5209.635325527177, 5237.13587258102, 4885.975570122162, 4911.7298548580175, 4918.704877707349, 4919.680220785637, 4968.478309777493, 5264.842054738364, 5319.867003324948, 5340.599455040888, 5382.3541175059245, 5413.025655382069, 5100.770465329069, 5124.308218390544, 5125.231215317732, 5128.358955130609, 5140.845774626767, 5209.088409528317, 5218.712970786643, 5219.42586315505, 5227.895442091137, 5237.188235823453, 5002.57478114357, 5052.242163675478, 5070.543651071422, 5093.0577843099145, 5094.261332106824, 5048.29323894655, 5055.140626093573, 5085.796568137307, 5098.821541246039, 5126.769295381717, 4270.12462445198, 4343.239933011773, 4349.325854492558, 4351.282038463618, 4396.318570621559, 3699.8520059197867, 3804.771713697187, 3841.2317536492255, 3845.6346647068485, 3859.9228015440094, 4436.889077773017, 4445.355423463579, 4451.933221001687, 4501.819927202875, 4527.592516673515, 5260.184671375943, 5272.630915835932, 5280.155175171954, 5280.339957505312, 5285.788568457296, 4287.614114729689, 4335.176316499855, 4393.560643935645, 4426.3581780641625, 4453.755043472575, 4645.581897629229, 4647.512011238839, 4656.674032817738, 4672.08894265615, 4691.014886873726, 4833.371661684029, 4876.853694389174, 4889.657723959431, 4892.877678058006, 4929.334539837219, 5036.521530454601, 5184.637075404837, 5228.895422091613, 5240.240165176105, 5275.525202731773, 4912.091263116335, 4940.752962351796, 4942.308076869169, 4942.481039490802, 4977.253411988231, 5007.39911210657, 5175.275461435477, 5183.455737147696, 5192.688438693691, 5199.66202196856, 5196.064708352382, 5231.267622532924, 5261.158214685632, 5265.183896496049, 5272.868178295574, 5136.049830781318, 5136.743162841918, 5140.151874940742, 5143.948560514347, 5196.584273258055, 4863.659543831898, 4870.561649451566, 5129.58963282929, 5139.588832893285, 5148.845534633967, 4855.101806165871, 4876.561109500162, 4889.828855990023, 4898.191798353232, 4918.852434426973, 5045.722485263345, 5057.190849464068, 5064.772085256099, 5074.492550744896, 5110.105731496898, 4843.685160464559, 4946.109700253989, 4946.8763280918265, 4954.380702412199, 5010.073136469619], "value": 4727.145256763583, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.0668626656183, 586.5454272938473, 592.4253474130095, 602.4036204157883, 613.9938600613992, 35333.46999795002, 40000.000000000015, 40070.398944015826, 40234.19531609366, 40448.19103617926, 40369.19261614766, 40696.59303406965, 41101.17797644053, 41126.383104253386, 41301.173976520455, 7731.845363092735, 7940.205979402042, 7965.442419030641, 7968.60156992148, 7968.920310796905, 7861.410394220427, 7977.601119944009, 7979.481333713319, 7984.201579842027, 8029.237222463886, 8008.0, 8075.717349892755, 8092.109867914524, 8096.838063238732, 8100.756977290661, 7981.481203721769, 7992.160823113577, 8031.95984020082, 8046.396520260945, 8057.073436554754, 7837.529748215068, 7840.882386764203, 7914.366850651934, 7922.683092676286, 7932.643031063558, 38656.22687546261, 38738.80630596829, 38913.221735565414, 39014.0, 39059.804700976594, 3077.5999120114466, 3250.674932506754, 3440.139965008748, 3522.489239060322, 3785.9053523661855, 30325.090247292617, 30648.540271895938, 30824.8458757707, 30942.0, 31024.0692779217, 3399.8130102844334, 3427.3316703242876, 3458.8616455341758, 3477.7565570410084, 3520.084777957724, 235388.0, 236238.0, 236330.0, 237322.0, 237990.0, 31636.841815790773, 54063.0, 54324.45675543273, 54329.72835135799, 54393.37656299259, 32844.83577582097, 34365.82817085949, 34521.30957380889, 34665.0, 34719.13202169915, 12132.5146994121, 12267.38663066843, 12309.876901230873, 12310.13829031977, 12329.568465103679, 10783.299085559414, 10852.837207441895, 10903.509342079626, 10906.236563440641, 10947.178961577914, 7930.881036784453, 7947.880781788278, 7951.920480795234, 7985.640646170937, 8018.4787988780545, 3136.952945705816, 3142.088794249688, 3207.33218726261, 3223.838808059588, 3248.6751324867323, 856.3320609924269, 915.7435917942987, 959.640134949394, 978.2125389061731, 980.4901451245313, 28177.57733633997, 29165.56251656227, 29343.413131737674, 29376.412471750446, 29656.0, 990.5938565188383, 998.8102260570469, 1002.7693630465034, 1032.7965181710367, 1041.0890470838017, 15420.46028389001, 15470.226488675522, 15571.844281557265, 15575.143367114917, 15603.843961560466, 423711.0, 428568.0, 429420.0, 429666.0, 430001.0, 32264.83867580647, 32563.18592035218, 33066.0, 33154.0, 33200.33599328048, 1167.9708007299716, 1170.268582136165, 1187.0444292344573, 1218.7867123253395, 1228.6314105768233, 27413.0, 28459.573106403008, 28529.0, 29170.0, 29388.7061129386, 43133.352999705654, 43890.56109438865, 44389.55610443854, 44446.77776611225, 44476.55523444724, 335766.0, 338456.0, 339535.0, 339831.0, 339869.0, 25669.229923102335, 25875.353116172246, 26024.089156879418, 26057.0, 26182.73817261803, 40685.0, 43190.13619727651, 43922.560774391844, 44321.77839110784, 44637.0, 37355.43966840554, 37405.62594374021, 37726.0, 37958.24083518259, 38975.41536877006, 36521.08697282589, 37256.81371593125, 37397.43903841499, 37489.625103749706, 37510.24979500449, 32252.35495290128, 36853.63146368609, 37202.25595488129, 37336.6266337344, 37533.62466375301, 32761.0, 33878.66121338755, 34382.14044648904, 34445.31109377849, 34490.96527104191, 25690.871545642152, 26045.348866278495, 26415.735842641327, 26560.601590976537, 26974.730252697223], "value": 16650.629132338818, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.79753736676145, 366.5747732630149, 366.7322854316351, 383.97120215983807, 384.51359030825995, 16044.35822567096, 17104.572385690364, 17840.37558685448, 17910.0, 17922.19350129244, 15864.920675396606, 16264.512064638051, 16944.745828812578, 16974.15129243536, 16999.745003824923, 5030.647854650167, 5195.740212989335, 5225.581953443715, 5229.947700523003, 5233.8953220935555, 3624.8187590620364, 5063.645544811865, 5723.713814309289, 6027.879442411149, 6031.668258245794, 6039.1243269725865, 6058.0610005449225, 6094.268687757475, 6105.145279660829, 6117.418845209698, 4973.4280557735965, 5290.709011004393, 5297.258383826267, 5301.973490132544, 5330.946690533103, 5074.2895994560795, 5097.7960881564695, 5141.562967147797, 5170.663906846043, 5178.818741344035, 12239.69400764988, 12488.687782805411, 12511.186772859826, 15996.920015399848, 20725.170993160256, 1827.1412436154985, 1914.8755330903446, 1941.9126139323764, 1983.226541648758, 1996.0418998880473, 8978.102189781035, 9171.358004939657, 9277.58250878712, 9316.627334906596, 9395.248380129573, 1665.7834481517325, 1731.705610046295, 1771.5039788859012, 1774.3346245158066, 1817.1277786662345, 60477.69761151166, 69210.0, 71461.28538714598, 72301.0, 72703.2729672707, 9570.33007689455, 9584.712458626253, 9785.36395134314, 9809.362391444532, 10166.745831354276, 13355.599332020054, 13380.866191338157, 13384.263865487492, 13462.326883655778, 13473.191608503521, 6641.37286364834, 6795.490338224653, 6824.41992430639, 6839.931600684029, 6906.412954898789, 6240.251169859646, 6361.141245931833, 6365.204349456318, 6422.550421470546, 6466.870662586722, 4107.802325755766, 4138.813753381045, 4207.326827707613, 4232.217039847638, 4282.678799090081, 1636.729939559983, 1724.4567961092216, 1797.63148554546, 1828.4240464253717, 1849.8890066596048, 769.6536558548676, 843.6414523827349, 880.3617377401333, 881.1584936385736, 917.3624331089962, 16417.261223244983, 16727.996320220827, 16830.158492075592, 16974.32102715902, 16974.40589579359, 853.7396094191207, 859.282499113235, 872.912708729122, 873.9650413983496, 887.2059506741431, 9341.673041443517, 9500.762480938032, 9504.762380940532, 9666.178374838077, 9689.51552422376, 401821.0, 433291.0, 447997.0, 451922.0, 456265.0, 50488.495115048376, 80293.0, 83322.58338708268, 83579.5821020891, 84095.579522102, 914.3690853311194, 923.8383282925461, 930.4463844012937, 941.7598512379436, 947.4410098042188, 14940.327685254408, 14958.551243462714, 15116.697666046837, 15171.848281517043, 15506.612334691272, 35663.64336356603, 36457.45313820348, 36862.44706329353, 36912.0, 37300.253994920495, 51932.74033629808, 54352.0, 54501.72749136229, 55429.44570554243, 55696.72151639216, 7567.9243207567215, 7593.848123037398, 7671.654775535226, 7784.649690763816, 7848.450608457353, 10451.58193672275, 11249.71875703114, 11395.658130256106, 11479.540818367172, 11542.19204655666, 5101.362329708786, 10492.370457772558, 10729.356238625707, 10826.945865270623, 10852.782944341227, 4635.6986795858165, 7455.478116531791, 10083.747906302107, 10104.595816167272, 10638.680839574825, 10555.736106597089, 10612.257141999986, 10751.6236931707, 10799.67600971972, 10856.294340867818, 7700.1144868338615, 7808.141104478389, 7997.640106195119, 8011.6394762237005, 8118.309943654619, 10066.446345450777, 10318.122959548522, 10434.843477347695, 10467.633632822815, 10473.21450891171], "value": 8078.470010975557, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1369.6986662934157, 1406.0700342542593, 1489.5829167833003, 1662.1356894414896, 1674.2549565443383, 6942.548734332265, 7570.318671319594, 7578.39372850172, 8080.797980050502, 8089.433739638228, 7606.581638009908, 7839.412044096702, 7883.172266911978, 7898.605069746518, 7928.6432110555015, 2217.057750456058, 2242.091952759135, 2243.427925878899, 2249.403907964391, 2254.3462395905167, 2167.4798048468333, 2202.3503066595395, 2206.2388475975763, 2208.569328980849, 2210.18223257395, 2194.7037149984785, 2197.9340619781433, 2199.0214354612203, 2203.911843526257, 2216.4902072523328, 2071.4924843413387, 2078.5323302256947, 2083.614531311712, 2103.7580678221893, 2107.8735275883496, 2155.5257843274453, 2171.0, 2187.58435897179, 2190.7042549255966, 2191.0359441845535, 7922.524648521049, 8006.0, 8037.5579343136105, 8053.959730201312, 8056.919430805676, 4635.258358662598, 4648.790804413809, 4694.647901407374, 4732.526747325274, 4746.240601503743, 2922.576226447153, 2975.7619390448713, 3084.1826915867314, 3087.922801929947, 3112.4553203189353, 975.3465178330465, 999.8400255959084, 1002.6991902429243, 1031.3811712972156, 1048.7273308939655, 10638.893611063944, 10642.57429702811, 10649.627263045757, 10694.358338499715, 10707.518161682743, 4134.937975930364, 4176.540580536139, 4256.1487702459635, 4282.957170428256, 4300.118475712534, 9125.68060117906, 9216.815663686688, 9236.0, 9241.722748317561, 9244.90755092454, 4558.293464513005, 4560.475545312265, 4561.749103799323, 4562.726236425825, 4588.3805686231935, 3797.145642230476, 4105.630493255621, 4112.794360281974, 4246.256905041667, 4253.48958125027, 3700.8149592520267, 3717.851285948586, 3843.7117216208894, 3856.9807150964625, 3993.9001524961527, 1204.608502236759, 1211.3821950805152, 1217.0871846115413, 1222.6882145053132, 1229.0, 724.8550289942033, 845.9365547583956, 851.344464762142, 860.9956950215334, 873.3711727556149, 5174.663646862942, 5331.840044798662, 5362.0, 5402.783888644411, 5509.338879334506, 402.59338068550977, 410.50329101786576, 412.05022423314546, 414.3846388113709, 416.01404670929486, 3713.294474049922, 3731.2164445466756, 3736.663700266989, 3797.18360552477, 3833.15670552478, 9459.716208513755, 9751.414915105117, 9772.755681108029, 9842.360246584092, 9850.0, 9567.282453815853, 9743.220542356736, 9771.755706107404, 9808.509574521246, 9827.213822894151, 7465.0, 7467.290607392398, 7481.064866891638, 7572.886406703904, 7578.772636820904, 5144.639875208849, 5282.392524859691, 5375.247465354932, 5398.46015398457, 5441.5102640762525, 8881.245094167069, 8970.506622135845, 9128.817423651622, 9228.95385523068, 9258.814823703622, 9001.36990410665, 9082.137196966278, 9147.268218542633, 9246.815063698823, 9259.074092590687, 5988.071848863433, 6361.650109244036, 6539.574927629689, 6632.568883022588, 6660.167479065117, 7526.736564220226, 7537.54774713519, 7566.508176968479, 7607.201243869314, 7622.123455802654, 6425.453836423956, 6661.600303981777, 6703.463722902058, 6750.257471678014, 6788.626625535446, 6451.1936007999, 6457.903131453126, 6481.708323125565, 6486.286508484157, 6556.213254409501, 6277.278113016879, 6333.923233050485, 6358.650274234777, 6401.9436792928645, 6416.967915160394, 4330.35044743291, 4447.421835161408, 4489.236829739018, 4520.683552151318, 4547.3633691282585, 4536.160810250114, 4561.680682352204, 4571.771411429481, 4573.702709323883, 4612.561806628365], "value": 4097.72330590098, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.6536156612065, 288.65505720663816, 289.09945519706093, 290.3901806206964, 293.64322348346764, 5052.924206136906, 5135.204043373274, 5146.0, 5154.896902061962, 5158.922616160756, 4976.129177393959, 4992.152903425728, 5000.674956127849, 5023.171176755831, 5043.36957880265, 3707.8516859325664, 3796.5444146702434, 3867.4088360798332, 3871.9612803871883, 3873.9806300968457, 3907.589703081178, 3911.2399420260854, 3915.9804200978956, 3916.158026024404, 3938.8424463021443, 3904.1020565270005, 3912.5500567434683, 3915.4714113594728, 3916.6291797870804, 3919.608039196086, 3805.162864169878, 3857.189990102082, 3858.864939727096, 3912.1979994101284, 3914.451976723261, 3387.458006718913, 3402.812845293508, 3404.6254911959663, 3408.454647256427, 3411.714151518464, 4874.2201247800185, 4875.219964805614, 4880.316755654211, 4909.2881532177635, 4923.310736496894, 4411.514733379326, 4459.598636122764, 4478.529754375809, 4491.6855820092605, 4501.627003763851, 5208.109499227927, 5209.739513024334, 5214.947850521522, 5242.266082748418, 5252.107141785906, 3694.4827724118645, 3714.0, 3733.1600389912323, 3735.0, 3752.1745216052423, 5450.746328344503, 5506.0089183947275, 5543.390227075019, 5552.41699621542, 5562.554995600342, 3600.0999750062483, 3769.1142581493327, 3789.726164301397, 3792.7724336539895, 3826.7321287510163, 3798.3542797724454, 3814.6566808987322, 3835.0412396900774, 3849.1339448624394, 3850.6726928211415, 4403.471583409947, 4412.4705035395955, 4426.911461770811, 4429.15845989261, 4465.280866866215, 5120.155174396183, 5250.606204534675, 5265.289185959923, 5268.788178718916, 5316.149416093406, 1324.6953200763878, 1335.3990704183157, 1338.5448947357945, 1347.2253454263641, 1348.885344745688, 829.8174401631632, 842.6376658037103, 855.482433127961, 855.6449073634496, 861.5132450165636, 4446.0, 4526.88682782933, 4542.500324964251, 4618.422697162855, 4632.97683511587, 5344.518993290622, 5348.1442969124755, 5381.273528073738, 5418.428655689884, 5440.3743569489225, 4391.934120988188, 4586.3579098926175, 4589.2886602576655, 4593.747343896051, 4604.58558729716, 2839.162447078117, 2846.8576571171357, 2871.052552657618, 2874.3532705141592, 2880.545324611058, 4960.429550601655, 5063.721495317793, 5070.949290507047, 5073.822416215415, 5099.490050994871, 5295.867603309948, 5467.043267428184, 5500.669959802424, 5531.032069387841, 5576.498115169654, 5030.4466508684745, 5064.468230835783, 5109.718965456861, 5121.206213036985, 5135.460776618476, 5378.354597448331, 5383.40782513931, 5395.595330350161, 5430.918536222039, 5453.7818487260065, 5178.663386879841, 5302.337207849019, 5302.681839089667, 5315.6279060465395, 5318.97340513295, 5048.64659473848, 5051.267566202953, 5080.237964305384, 5104.1578139606545, 5133.050385678512, 3733.8319775610707, 3734.3278209922473, 3746.4567637692926, 3748.5126933498473, 3770.170562476251, 5277.2875661785165, 5388.137897936312, 5410.296661433988, 5413.891722165456, 5464.18037294409, 5201.375834899836, 5259.368875734936, 5263.447338029452, 5278.920816187683, 5306.469353064817, 5260.763265653131, 5277.920831187458, 5283.4452382499285, 5293.206019097012, 5298.06620583492, 4947.12707982644, 5127.769250383667, 5142.51146141116, 5156.097682905402, 5183.248428977852, 5069.695818250917, 5137.842106315431, 5266.552343050884, 5307.708076055854, 5322.760475778522, 5189.584833213409, 5221.686698798084, 5221.973890130525, 5227.9215811763615, 5228.607854410859], "value": 3935.6734003927763, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [669.9765508207211, 684.4285022006625, 696.1646024770276, 735.2537174767612, 738.394516496473, 12496.812547811778, 12754.936225318872, 12907.612771616843, 12986.675333116666, 14406.639834004156, 14094.295285235748, 14548.563543093724, 14848.0, 14850.257487125655, 14902.776458353106, 793.218679600593, 800.1638287989066, 808.6159074439653, 809.1544336168718, 810.1979040749645, 622.1165944359021, 781.9569923654196, 805.5931754464017, 805.8186907945724, 806.4314658166008, 835.5989125219899, 843.5866425451516, 846.6232526525698, 852.1138016462871, 855.7133360324299, 846.5597889097696, 848.240824462106, 850.4472093139478, 852.2627926843267, 852.5992783391858, 603.9818805435845, 614.720302262474, 614.8217017065045, 616.8797084568511, 617.5059952038396, 13302.135361201588, 13340.266285354302, 13356.198628082346, 13393.330333483287, 13428.261445620486, 12518.687032824162, 12857.935710321388, 12864.29246391448, 12918.095733298673, 13166.473341066347, 10270.6405275815, 10340.638077667245, 10412.583496660125, 10698.304610200312, 10776.299540529919, 3299.934001319984, 3305.5537502437346, 3345.799252044885, 3404.14896275931, 3407.2504049109157, 53239.0, 60799.392006080256, 61032.38967610356, 61204.693976530274, 61280.387196127915, 10095.697129086138, 10199.439030853375, 10215.131713804261, 10269.281150319406, 10308.690739277834, 18775.342863, 18806.341778037702, 18834.623307533773, 18878.716819247722, 18921.95929223906, 6054.7275372607455, 6337.556371053982, 6362.459190968727, 6532.41208291256, 6544.869102617921, 3713.702903767692, 3755.661990420875, 3792.1846802937503, 3797.031756901972, 3809.12390150267, 2956.3200463892995, 3075.2465645916895, 3091.335362896988, 3091.412631599989, 3095.721385075309, 532.1459058211592, 536.4045909040962, 544.8419958212074, 551.8978988886988, 556.0852397805587, 598.4912824099481, 599.78107990584, 611.5230120506012, 612.9141920131185, 619.5074915442234, 7259.782206533707, 7362.7423040193335, 7642.235776422424, 7679.731209407644, 8003.5197888126895, 497.2466712929914, 506.68838664221977, 514.4109994056784, 576.3084298841408, 635.4566845347161, 3597.3165098631175, 3729.68297694699, 3760.646167379741, 3824.655780979725, 3866.903327416781, 51930.22104668433, 89322.55338723394, 93167.53416232875, 93294.53352733194, 93869.53065234766, 64887.35112648908, 68935.65532172307, 70257.29742702507, 79447.0, 83597.58201209077, 44135.33796993112, 44543.777281113384, 53303.0, 83665.0, 84788.0, 8586.570671466277, 8713.433626814236, 9008.729738107868, 9063.274938004812, 9098.135677110664, 29675.703242968157, 44894.77552612216, 45775.0, 46006.76996614996, 46061.76969115133, 64145.3585464158, 66283.33716662772, 66337.66831165813, 66499.66750166219, 66910.0, 11001.559937602726, 11024.393658348868, 11141.665750027512, 11158.274712143684, 11438.714032149262, 12969.610911672666, 13012.934935325262, 13097.672558186121, 13151.60545183646, 13697.178169309873, 11449.94275028653, 11788.764224715285, 12145.514179432723, 12154.513819447124, 12203.511859525519, 11403.98757480452, 11680.591179308683, 11773.705657358634, 11807.645770626896, 11812.291262524275, 11359.0, 11781.646550603497, 11969.341686206993, 12361.505539778309, 12385.62843114708, 9248.583813728534, 9499.335046546952, 9836.852447213441, 10083.394996300245, 10147.898521014991, 9566.760830979003, 9603.951980240054, 9617.471039092918, 10092.747681308027, 10165.339252948535], "value": 6532.872509761405, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1587.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 110.0, 112.0, 113.0, 112.0, 113.0, 113.0, 113.0, 113.0, 112.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 132.0, 157.0, 195.0, 132.0, 159.0, 165.0, 134.0, 196.0, 131.0], "value": 157.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 175.0, 164.0, 163.0, 164.0, 163.0, 162.0, 162.0, 161.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 151.0, 77.0, 78.0, 77.0, 75.0, 161.0, 79.0], "value": 92.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 145.0, 86.0, 87.0, 91.0, 135.0, 86.0, 85.0, 135.0], "value": 102.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 119.0, 118.0, 118.0, 118.0, 119.0, 118.0, 118.0, 120.0], "value": 118.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 147.0, 148.0, 147.0, 147.0, 146.0, 148.0, 146.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 64.0, 64.0, 64.0, 65.0, 64.0, 65.0, 65.0, 64.0, 65.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 65.0, 66.0, 65.0, 66.0, 67.0, 66.0, 67.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 89.0, 86.0, 88.0, 83.0, 84.0, 84.0, 119.0, 85.0], "value": 88.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 134.0, 141.0, 132.0, 140.0, 136.0, 135.0, 137.0, 149.0, 134.0], "value": 138.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 171.0, 174.0, 172.0, 168.0, 171.0, 173.0, 169.0, 168.0, 167.0], "value": 171.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 70.0, 73.0, 67.0, 69.0, 67.0, 71.0, 71.0, 68.0], "value": 69.4, "unit": "score"}]}]} 18:41:29 INFO - Return code: 0 18:41:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:41:29 ERROR - # TBPL SUCCESS # 18:41:29 INFO - Running post-action listener: _resource_record_post_action 18:41:29 INFO - ##### 18:41:29 INFO - ##### Finished run-tests step (success) 18:41:29 INFO - ##### 18:41:29 INFO - Running post-run listener: _resource_record_post_run 18:41:29 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 12288; Write bytes: 310009856; Read time: 52; Write time: 188936 18:41:29 INFO - TinderboxPrint: CPU usage
13.4% 18:41:29 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 52 18:41:29 INFO - TinderboxPrint: I/O write bytes / time
310,009,856 / 188,936 18:41:29 INFO - TinderboxPrint: CPU idle
8,280.5 (86.6%) 18:41:29 INFO - TinderboxPrint: CPU user
1,229.4 (12.9%) 18:41:29 INFO - TinderboxPrint: Swap in / out
0 / 0 18:41:29 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 17547264; Read time: 0; Write time: 9624 18:41:29 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 12288; Write bytes: 292462592; Read time: 52; Write time: 179312 18:41:30 INFO - Running post-run listener: _upload_blobber_files 18:41:30 INFO - Blob upload gear active. 18:41:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:41:30 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:41:30 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:41:30 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:41:30 INFO - (blobuploader) - INFO - Open directory for files ... 18:41:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:41:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:41:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:41:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:41:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:41:31 INFO - (blobuploader) - INFO - Done attempting. 18:41:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:41:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:41:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:41:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:41:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:41:32 INFO - (blobuploader) - INFO - Done attempting. 18:41:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:41:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:41:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:41:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:41:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:41:35 INFO - (blobuploader) - INFO - Done attempting. 18:41:35 INFO - (blobuploader) - INFO - Iteration through files over. 18:41:35 INFO - Return code: 0 18:41:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:41:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:41:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a86eb2ebeaf89bad1edd43a071c6556ef49f82deb76ec880c6e9cadbaadf01bfd7ce05b406b4f8a316ea7000d7fbc0c6f5ddc7d964295d01f44ff781ae061853", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bbbb9bed8ba1ca8f3d10261efeff1bb68a29a96155703589369779f19d38385e081b548ce9857df92c9578913cd1866dea3a4916503211ddb935319d17425bad", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e7ca139526f6762e9ac8fb06ebb98035f4ae6cdcfa819f9c5f754ef932a2352d0615cbe2b2365910bbfebf5a4dc2471840156fa2406b1b65c155256ddbcec426"} 18:41:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:41:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:41:35 INFO - Contents: 18:41:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a86eb2ebeaf89bad1edd43a071c6556ef49f82deb76ec880c6e9cadbaadf01bfd7ce05b406b4f8a316ea7000d7fbc0c6f5ddc7d964295d01f44ff781ae061853", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bbbb9bed8ba1ca8f3d10261efeff1bb68a29a96155703589369779f19d38385e081b548ce9857df92c9578913cd1866dea3a4916503211ddb935319d17425bad", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e7ca139526f6762e9ac8fb06ebb98035f4ae6cdcfa819f9c5f754ef932a2352d0615cbe2b2365910bbfebf5a4dc2471840156fa2406b1b65c155256ddbcec426"} 18:41:35 INFO - Running post-run listener: copy_logs_to_upload_dir 18:41:35 INFO - Copying logs to upload dir... 18:41:35 INFO - mkdir: /builds/slave/test/build/upload/logs 18:41:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.217055 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-14 18:41:35.995170) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-14 18:41:35.998762) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1465953653.117090-1448919995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a86eb2ebeaf89bad1edd43a071c6556ef49f82deb76ec880c6e9cadbaadf01bfd7ce05b406b4f8a316ea7000d7fbc0c6f5ddc7d964295d01f44ff781ae061853", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bbbb9bed8ba1ca8f3d10261efeff1bb68a29a96155703589369779f19d38385e081b548ce9857df92c9578913cd1866dea3a4916503211ddb935319d17425bad", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e7ca139526f6762e9ac8fb06ebb98035f4ae6cdcfa819f9c5f754ef932a2352d0615cbe2b2365910bbfebf5a4dc2471840156fa2406b1b65c155256ddbcec426"} 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.011145 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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a86eb2ebeaf89bad1edd43a071c6556ef49f82deb76ec880c6e9cadbaadf01bfd7ce05b406b4f8a316ea7000d7fbc0c6f5ddc7d964295d01f44ff781ae061853", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bbbb9bed8ba1ca8f3d10261efeff1bb68a29a96155703589369779f19d38385e081b548ce9857df92c9578913cd1866dea3a4916503211ddb935319d17425bad", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e7ca139526f6762e9ac8fb06ebb98035f4ae6cdcfa819f9c5f754ef932a2352d0615cbe2b2365910bbfebf5a4dc2471840156fa2406b1b65c155256ddbcec426"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-14 18:41:36.024889) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 18:41:36.025331) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1465953653.117090-1448919995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004496 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 18:41:36.107193) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-14 18:41:36.107522) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-14 18:41:36.107819) ========= ========= Total master_lag: 0.17 =========