builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-038 starttime: 1465768739.88 results: success (0) buildid: 20160612135307 builduid: fc85b97583ad43eaa8598c02485b1d03 revision: 4fb66e8edacad1ab21a6b52d6ef8c0f078728090 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-12 14:58:59.876889) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-12 14:58:59.877488) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-12 14:58:59.877823) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-12 14:58:59.892718) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 14:58:59.893065) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1465768739.577772-877673692 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-12 14:59:00-- 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% 46.7M=0s 2016-06-12 14:59:00 (46.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.267096 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 14:59:00.174339) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 14:59:00.174720) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1465768739.577772-877673692 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018492 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 14:59:00.224710) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-12 14:59:00.225109) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4fb66e8edacad1ab21a6b52d6ef8c0f078728090 --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 4fb66e8edacad1ab21a6b52d6ef8c0f078728090 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1465768739.577772-877673692 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-12 14:59:00,699 truncating revision to first 12 chars 2016-06-12 14:59:00,699 Setting DEBUG logging. 2016-06-12 14:59:00,699 attempt 1/10 2016-06-12 14:59:00,699 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4fb66e8edaca?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-12 14:59:02,006 unpacking tar archive at: fx-team-4fb66e8edaca/testing/mozharness/ program finished with exit code 0 elapsedTime=1.668159 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-12 14:59:01.907731) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-12 14:59:01.908099) ========= script_repo_revision: 4fb66e8edacad1ab21a6b52d6ef8c0f078728090 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-12 14:59:01.908586) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-12 14:59:01.908913) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-12 14:59:01.919785) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-12 14:59:01.920139) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1465768739.577772-877673692 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:59:02 INFO - MultiFileLogger online at 20160612 14:59:02 in /builds/slave/test 14:59:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 14:59:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:59:02 INFO - {'append_to_log': False, 14:59:02 INFO - 'base_work_dir': '/builds/slave/test', 14:59:02 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 14:59:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:59:02 INFO - 'branch': 'Fx-Team-Non-PGO', 14:59:02 INFO - 'buildbot_json_path': 'buildprops.json', 14:59:02 INFO - 'config_files': ('talos/linux_config.py',), 14:59:02 INFO - 'default_actions': ('clobber', 14:59:02 INFO - 'read-buildbot-config', 14:59:02 INFO - 'download-and-extract', 14:59:02 INFO - 'populate-webroot', 14:59:02 INFO - 'create-virtualenv', 14:59:02 INFO - 'install', 14:59:02 INFO - 'run-tests'), 14:59:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:59:02 INFO - 'download_minidump_stackwalk': True, 14:59:02 INFO - 'download_symbols': 'ondemand', 14:59:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:59:02 INFO - 'tooltool.py': '/tools/tooltool.py', 14:59:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:59:02 INFO - '/tools/misc-python/virtualenv.py')}, 14:59:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:59:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:59:02 INFO - 'installer_path': 'installer.exe', 14:59:02 INFO - 'log_level': 'info', 14:59:02 INFO - 'log_name': 'talos', 14:59:02 INFO - 'log_to_console': True, 14:59:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:59:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:59:02 INFO - 'opt_config_files': (), 14:59:02 INFO - 'pip_index': False, 14:59:02 INFO - 'sps_profile': False, 14:59:02 INFO - 'sps_profile_interval': 0, 14:59:02 INFO - 'suite': 'dromaeojs', 14:59:02 INFO - 'system_bits': '32', 14:59:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:59:02 INFO - 'title': 'talos-linux64-ix-038', 14:59:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:59:02 INFO - 'use_talos_json': True, 14:59:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:59:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:59:02 INFO - 'work_dir': 'build'} 14:59:02 INFO - ##### 14:59:02 INFO - ##### Running clobber step. 14:59:02 INFO - ##### 14:59:02 INFO - Running pre-action listener: _resource_record_pre_action 14:59:02 INFO - Running main action method: clobber 14:59:02 INFO - rmtree: /builds/slave/test/build 14:59:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:59:02 INFO - Running post-action listener: _resource_record_post_action 14:59:02 INFO - ##### 14:59:02 INFO - ##### Finished clobber step (success) 14:59:02 INFO - ##### 14:59:02 INFO - ##### 14:59:02 INFO - ##### Running read-buildbot-config step. 14:59:02 INFO - ##### 14:59:02 INFO - Running pre-action listener: _resource_record_pre_action 14:59:02 INFO - Running main action method: read_buildbot_config 14:59:02 INFO - Using buildbot properties: 14:59:02 INFO - { 14:59:02 INFO - "project": "", 14:59:02 INFO - "product": "firefox", 14:59:02 INFO - "script_repo_revision": "production", 14:59:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:59:02 INFO - "repository": "", 14:59:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 14:59:02 INFO - "buildid": "20160612135307", 14:59:02 INFO - "pgo_build": "False", 14:59:02 INFO - "basedir": "/builds/slave/test", 14:59:02 INFO - "buildnumber": 1852, 14:59:02 INFO - "slavename": "talos-linux64-ix-038", 14:59:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:59:02 INFO - "platform": "ubuntu64_hw", 14:59:02 INFO - "scheduler": "tests-fx-team-linux64-talos", 14:59:02 INFO - "branch": "fx-team", 14:59:02 INFO - "repo_path": "integration/fx-team", 14:59:02 INFO - "revision": "4fb66e8edacad1ab21a6b52d6ef8c0f078728090", 14:59:02 INFO - "stage_platform": "linux64", 14:59:02 INFO - "builduid": "fc85b97583ad43eaa8598c02485b1d03", 14:59:02 INFO - "slavebuilddir": "test" 14:59:02 INFO - } 14:59:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/A6UeXKmvSbawQ4MsU3ISJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 14:59:02 INFO - Running post-action listener: _resource_record_post_action 14:59:02 INFO - ##### 14:59:02 INFO - ##### Finished read-buildbot-config step (success) 14:59:02 INFO - ##### 14:59:02 INFO - ##### 14:59:02 INFO - ##### Running download-and-extract step. 14:59:02 INFO - ##### 14:59:02 INFO - Running pre-action listener: _resource_record_pre_action 14:59:02 INFO - Running main action method: download_and_extract 14:59:02 INFO - mkdir: /builds/slave/test/build/tests 14:59: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')]} 14:59:02 INFO - https://queue.taskcluster.net/v1/task/A6UeXKmvSbawQ4MsU3ISJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:59:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UeXKmvSbawQ4MsU3ISJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:59:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UeXKmvSbawQ4MsU3ISJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:59:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UeXKmvSbawQ4MsU3ISJQ/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 14:59:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UeXKmvSbawQ4MsU3ISJQ/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 14:59:03 INFO - Downloaded 1361 bytes. 14:59:03 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:59:03 INFO - Using the following test package requirements: 14:59:03 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:59:03 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:59:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:59:03 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:59:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:59:03 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:59:03 INFO - u'jsshell-linux-x86_64.zip'], 14:59:03 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:59:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:59:03 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:59:03 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:59:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:59:03 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:59:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:59:03 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:59:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:59:03 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:59:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:59:03 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:59:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:59:03 INFO - https://queue.taskcluster.net/v1/task/A6UeXKmvSbawQ4MsU3ISJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:59:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UeXKmvSbawQ4MsU3ISJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:59:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UeXKmvSbawQ4MsU3ISJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:59:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UeXKmvSbawQ4MsU3ISJQ/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 14:59:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UeXKmvSbawQ4MsU3ISJQ/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 14:59:04 INFO - Downloaded 22879686 bytes. 14:59:04 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'] 14:59:04 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 14:59:05 INFO - Return code: 0 14:59:05 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 14:59:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:59:05 INFO - https://queue.taskcluster.net/v1/task/A6UeXKmvSbawQ4MsU3ISJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:59:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UeXKmvSbawQ4MsU3ISJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:59:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UeXKmvSbawQ4MsU3ISJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:59:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UeXKmvSbawQ4MsU3ISJQ/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 14:59:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UeXKmvSbawQ4MsU3ISJQ/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 14:59:06 INFO - Downloaded 22879686 bytes. 14:59:06 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'] 14:59:06 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 14:59:09 INFO - Return code: 0 14:59:09 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')]} 14:59:09 INFO - https://queue.taskcluster.net/v1/task/A6UeXKmvSbawQ4MsU3ISJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:59:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UeXKmvSbawQ4MsU3ISJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:59:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UeXKmvSbawQ4MsU3ISJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:59:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UeXKmvSbawQ4MsU3ISJQ/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 14:59:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UeXKmvSbawQ4MsU3ISJQ/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 14:59:10 INFO - Downloaded 10833377 bytes. 14:59:10 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'] 14:59:10 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 14:59:11 INFO - Return code: 0 14:59: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')]} 14:59:11 INFO - https://queue.taskcluster.net/v1/task/A6UeXKmvSbawQ4MsU3ISJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:59:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UeXKmvSbawQ4MsU3ISJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:59:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UeXKmvSbawQ4MsU3ISJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:59:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UeXKmvSbawQ4MsU3ISJQ/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 14:59:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A6UeXKmvSbawQ4MsU3ISJQ/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 14:59:12 INFO - Downloaded 55379266 bytes. 14:59:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A6UeXKmvSbawQ4MsU3ISJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:59:12 INFO - mkdir: /builds/slave/test/properties 14:59:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:59:12 INFO - Writing to file /builds/slave/test/properties/build_url 14:59:12 INFO - Contents: 14:59:12 INFO - build_url:https://queue.taskcluster.net/v1/task/A6UeXKmvSbawQ4MsU3ISJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:59:13 INFO - Running post-action listener: _resource_record_post_action 14:59:13 INFO - Running post-action listener: set_extra_try_arguments 14:59:13 INFO - ##### 14:59:13 INFO - ##### Finished download-and-extract step (success) 14:59:13 INFO - ##### 14:59:13 INFO - ##### 14:59:13 INFO - ##### Running populate-webroot step. 14:59:13 INFO - ##### 14:59:13 INFO - Running pre-action listener: _resource_record_pre_action 14:59:13 INFO - Running main action method: populate_webroot 14:59:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:59:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:59:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:59:13 INFO - '--tppagecycles', 14:59:13 INFO - '7'], 14:59:13 INFO - 'tests': ['tsvgm']}}, 14:59:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:59:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:59:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:59:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:59:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:59:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:59:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:59:13 INFO - 'talos_options': ['--disable-e10s'], 14:59:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:59:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:59:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:59:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:59:13 INFO - 'talos_options': ['--disable-e10s'], 14:59:13 INFO - 'tests': ['damp', 'tps']}, 14:59:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:59:13 INFO - 'tests': ['damp', 'tps']}, 14:59:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:59:13 INFO - 'tests': ['dromaeo_dom']}, 14:59:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:59:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:59:13 INFO - 'tests': ['a11yr', 14:59:13 INFO - 'ts_paint', 14:59:13 INFO - 'tpaint', 14:59:13 INFO - 'sessionrestore', 14:59:13 INFO - 'sessionrestore_no_auto_restore', 14:59:13 INFO - 'tabpaint']}, 14:59:13 INFO - 'other-e10s': {'tests': ['a11yr', 14:59:13 INFO - 'ts_paint', 14:59:13 INFO - 'tpaint', 14:59:13 INFO - 'sessionrestore', 14:59:13 INFO - 'sessionrestore_no_auto_restore', 14:59:13 INFO - 'tabpaint']}, 14:59:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:59:13 INFO - 'ts_paint', 14:59:13 INFO - 'tpaint', 14:59:13 INFO - 'sessionrestore', 14:59:13 INFO - 'sessionrestore_no_auto_restore', 14:59:13 INFO - 'tabpaint']}, 14:59:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:59:13 INFO - 'ts_paint', 14:59:13 INFO - 'tpaint', 14:59:13 INFO - 'sessionrestore', 14:59:13 INFO - 'sessionrestore_no_auto_restore', 14:59:13 INFO - 'tabpaint']}, 14:59:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:59:13 INFO - 'tests': ['a11yr', 14:59:13 INFO - 'ts_paint', 14:59:13 INFO - 'tpaint', 14:59:13 INFO - 'sessionrestore', 14:59:13 INFO - 'sessionrestore_no_auto_restore', 14:59:13 INFO - 'tabpaint']}, 14:59:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:59:13 INFO - 'tests': ['a11yr', 14:59:13 INFO - 'ts_paint', 14:59:13 INFO - 'tpaint', 14:59:13 INFO - 'sessionrestore', 14:59:13 INFO - 'sessionrestore_no_auto_restore', 14:59:13 INFO - 'tabpaint']}, 14:59:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:59:13 INFO - 'tests': ['tsvgx', 14:59:13 INFO - 'tsvgr_opacity', 14:59:13 INFO - 'tart', 14:59:13 INFO - 'tscrollx', 14:59:13 INFO - 'cart']}, 14:59:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:59:13 INFO - 'tsvgr_opacity', 14:59:13 INFO - 'tart', 14:59:13 INFO - 'tscrollx', 14:59:13 INFO - 'cart']}, 14:59:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:59:13 INFO - 'talos_options': ['--disable-e10s'], 14:59:13 INFO - 'tests': ['tp5o']}, 14:59:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:59:13 INFO - 'tests': ['tp5o']}, 14:59:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:59:13 INFO - 'talos_options': ['--disable-e10s', 14:59:13 INFO - '--xperf_path', 14:59:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:59:13 INFO - 'tests': ['tp5n']}, 14:59:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:59:13 INFO - 'talos_options': ['--xperf_path', 14:59:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:59:13 INFO - 'tests': ['tp5n']}}, 14:59:13 INFO - 'talos.zip': {'path': '', 14:59:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:59:13 INFO - Running post-action listener: _resource_record_post_action 14:59:13 INFO - ##### 14:59:13 INFO - ##### Finished populate-webroot step (success) 14:59:13 INFO - ##### 14:59:13 INFO - ##### 14:59:13 INFO - ##### Running create-virtualenv step. 14:59:13 INFO - ##### 14:59:13 INFO - Running pre-action listener: _resource_record_pre_action 14:59:13 INFO - Running main action method: create_virtualenv 14:59:13 INFO - Creating virtualenv /builds/slave/test/build/venv 14:59:13 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 14:59:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:59:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:59:13 INFO - Using real prefix '/usr' 14:59:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:59:14 INFO - Installing distribute.............................................................................................................................................................................................done. 14:59:16 INFO - Installing pip.................done. 14:59:16 INFO - Return code: 0 14:59:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:59: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')]} 14:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59: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')]} 14:59:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf1c6e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e431c0>, '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 0x1e440c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e44550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465768739.577772-877673692', '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 14:59: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', 'pip>=1.5'] in /builds/slave/test/build 14:59: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 pip>=1.5 14:59:16 INFO - Using env: {'DISPLAY': ':0', 14:59:16 INFO - 'HOME': '/home/cltbld', 14:59:16 INFO - 'LANG': 'en_US.UTF-8', 14:59:16 INFO - 'LANGUAGE': 'en_US:en', 14:59:16 INFO - 'LOGNAME': 'cltbld', 14:59:16 INFO - 'MAIL': '/var/mail/cltbld', 14:59:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:16 INFO - 'MOZ_NO_REMOTE': '1', 14:59:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:16 INFO - 'NO_EM_RESTART': '1', 14:59:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:16 INFO - 'PWD': '/builds/slave/test', 14:59:16 INFO - 'SHELL': '/bin/bash', 14:59:16 INFO - 'SHLVL': '1', 14:59:16 INFO - 'TERM': 'linux', 14:59:16 INFO - 'TMOUT': '86400', 14:59:16 INFO - 'USER': 'cltbld', 14:59:16 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465768739.577772-877673692', 14:59:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:16 INFO - '_': '/tools/buildbot/bin/python'} 14:59:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:16 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 14:59:16 INFO - Cleaning up... 14:59:16 INFO - Return code: 0 14:59:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:59: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')]} 14:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59: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')]} 14:59:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59: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', '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 0x7fcf1c6e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e431c0>, '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 0x1e440c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e44550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465768739.577772-877673692', '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 14:59: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', 'psutil>=3.1.1'] in /builds/slave/test/build 14:59: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 psutil>=3.1.1 14:59:16 INFO - Using env: {'DISPLAY': ':0', 14:59:16 INFO - 'HOME': '/home/cltbld', 14:59:16 INFO - 'LANG': 'en_US.UTF-8', 14:59:16 INFO - 'LANGUAGE': 'en_US:en', 14:59:16 INFO - 'LOGNAME': 'cltbld', 14:59:16 INFO - 'MAIL': '/var/mail/cltbld', 14:59:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:16 INFO - 'MOZ_NO_REMOTE': '1', 14:59:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:16 INFO - 'NO_EM_RESTART': '1', 14:59:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:16 INFO - 'PWD': '/builds/slave/test', 14:59:16 INFO - 'SHELL': '/bin/bash', 14:59:16 INFO - 'SHLVL': '1', 14:59:16 INFO - 'TERM': 'linux', 14:59:16 INFO - 'TMOUT': '86400', 14:59:16 INFO - 'USER': 'cltbld', 14:59:16 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465768739.577772-877673692', 14:59:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:16 INFO - '_': '/tools/buildbot/bin/python'} 14:59:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:16 INFO - Downloading/unpacking psutil>=3.1.1 14:59: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 14:59: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 14:59: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 14:59: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 14:59: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 14:59: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 14:59:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:59:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:59:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:59:18 INFO - Installing collected packages: psutil 14:59:18 INFO - Running setup.py install for psutil 14:59:18 INFO - building 'psutil._psutil_linux' extension 14:59:18 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 14:59:18 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 14:59:18 INFO - building 'psutil._psutil_posix' extension 14:59:18 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 14:59:19 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 14:59:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:59:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:59:19 INFO - Successfully installed psutil 14:59:19 INFO - Cleaning up... 14:59:19 INFO - Return code: 0 14:59:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:59: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')]} 14:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59: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')]} 14:59:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf1c6e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e431c0>, '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 0x1e440c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e44550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465768739.577772-877673692', '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 14:59:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:59:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:59:19 INFO - Using env: {'DISPLAY': ':0', 14:59:19 INFO - 'HOME': '/home/cltbld', 14:59:19 INFO - 'LANG': 'en_US.UTF-8', 14:59:19 INFO - 'LANGUAGE': 'en_US:en', 14:59:19 INFO - 'LOGNAME': 'cltbld', 14:59:19 INFO - 'MAIL': '/var/mail/cltbld', 14:59:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:19 INFO - 'MOZ_NO_REMOTE': '1', 14:59:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:19 INFO - 'NO_EM_RESTART': '1', 14:59:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:19 INFO - 'PWD': '/builds/slave/test', 14:59:19 INFO - 'SHELL': '/bin/bash', 14:59:19 INFO - 'SHLVL': '1', 14:59:19 INFO - 'TERM': 'linux', 14:59:19 INFO - 'TMOUT': '86400', 14:59:19 INFO - 'USER': 'cltbld', 14:59:19 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465768739.577772-877673692', 14:59:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:19 INFO - '_': '/tools/buildbot/bin/python'} 14:59:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:59:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:59:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:59:21 INFO - Installing collected packages: mozsystemmonitor 14:59:21 INFO - Running setup.py install for mozsystemmonitor 14:59:21 INFO - Successfully installed mozsystemmonitor 14:59:21 INFO - Cleaning up... 14:59:21 INFO - Return code: 0 14:59:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:59:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:59:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:59:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:21 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 0x7fcf1c6e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e431c0>, '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 0x1e440c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e44550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465768739.577772-877673692', '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 14:59:21 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 14:59:21 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 14:59:21 INFO - Using env: {'DISPLAY': ':0', 14:59:21 INFO - 'HOME': '/home/cltbld', 14:59:21 INFO - 'LANG': 'en_US.UTF-8', 14:59:21 INFO - 'LANGUAGE': 'en_US:en', 14:59:21 INFO - 'LOGNAME': 'cltbld', 14:59:21 INFO - 'MAIL': '/var/mail/cltbld', 14:59:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:21 INFO - 'MOZ_NO_REMOTE': '1', 14:59:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:21 INFO - 'NO_EM_RESTART': '1', 14:59:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:21 INFO - 'PWD': '/builds/slave/test', 14:59:21 INFO - 'SHELL': '/bin/bash', 14:59:21 INFO - 'SHLVL': '1', 14:59:21 INFO - 'TERM': 'linux', 14:59:21 INFO - 'TMOUT': '86400', 14:59:21 INFO - 'USER': 'cltbld', 14:59:21 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465768739.577772-877673692', 14:59:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:21 INFO - '_': '/tools/buildbot/bin/python'} 14:59:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:21 INFO - Downloading/unpacking jsonschema==2.5.1 14:59:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:59:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:59:23 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 14:59:23 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 14:59:23 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 14:59:23 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 14:59:23 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 14:59:23 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 14:59:23 INFO - Downloading functools32-3.2.3-2.tar.gz 14:59:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:59:23 INFO - warning: no files found matching '*.txt' 14:59:23 INFO - no previously-included directories found matching 'build' 14:59:23 INFO - no previously-included directories found matching 'dist' 14:59:23 INFO - no previously-included directories found matching '.git*' 14:59:23 INFO - Installing collected packages: jsonschema, functools32 14:59:23 INFO - Running setup.py install for functools32 14:59:23 INFO - warning: no files found matching '*.txt' 14:59:23 INFO - no previously-included directories found matching 'build' 14:59:23 INFO - no previously-included directories found matching 'dist' 14:59:23 INFO - no previously-included directories found matching '.git*' 14:59:24 INFO - Successfully installed jsonschema functools32 14:59:24 INFO - Cleaning up... 14:59:24 INFO - Return code: 0 14:59:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:59:24 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')]} 14:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:24 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')]} 14:59:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:24 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 0x7fcf1c6e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e431c0>, '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 0x1e440c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e44550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465768739.577772-877673692', '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 14:59:24 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 14:59:24 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 14:59:24 INFO - Using env: {'DISPLAY': ':0', 14:59:24 INFO - 'HOME': '/home/cltbld', 14:59:24 INFO - 'LANG': 'en_US.UTF-8', 14:59:24 INFO - 'LANGUAGE': 'en_US:en', 14:59:24 INFO - 'LOGNAME': 'cltbld', 14:59:24 INFO - 'MAIL': '/var/mail/cltbld', 14:59:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:24 INFO - 'MOZ_NO_REMOTE': '1', 14:59:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:24 INFO - 'NO_EM_RESTART': '1', 14:59:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:24 INFO - 'PWD': '/builds/slave/test', 14:59:24 INFO - 'SHELL': '/bin/bash', 14:59:24 INFO - 'SHLVL': '1', 14:59:24 INFO - 'TERM': 'linux', 14:59:24 INFO - 'TMOUT': '86400', 14:59:24 INFO - 'USER': 'cltbld', 14:59:24 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465768739.577772-877673692', 14:59:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:24 INFO - '_': '/tools/buildbot/bin/python'} 14:59:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:24 INFO - Downloading/unpacking blobuploader==1.2.4 14:59: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 14:59: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 14:59: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 14:59: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 14:59: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 14:59: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 14:59:26 INFO - Downloading blobuploader-1.2.4.tar.gz 14:59:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:59:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:59:26 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 14:59:26 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 14:59:26 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 14:59:26 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 14:59:26 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 14:59:26 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 14:59:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:59:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:59:26 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 14:59:26 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 14:59:26 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 14:59:26 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 14:59:26 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 14:59:26 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 14:59:26 INFO - Downloading docopt-0.6.1.tar.gz 14:59:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:59:26 INFO - Installing collected packages: blobuploader, requests, docopt 14:59:26 INFO - Running setup.py install for blobuploader 14:59:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:59:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:59:27 INFO - Running setup.py install for requests 14:59:27 INFO - Running setup.py install for docopt 14:59:27 INFO - Successfully installed blobuploader requests docopt 14:59:27 INFO - Cleaning up... 14:59:27 INFO - Return code: 0 14:59:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:59: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')]} 14:59:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59: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')]} 14:59:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:27 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 0x7fcf1c6e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e431c0>, '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 0x1e440c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e44550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465768739.577772-877673692', '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 14:59:27 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 14:59:27 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 14:59:27 INFO - Using env: {'DISPLAY': ':0', 14:59:27 INFO - 'HOME': '/home/cltbld', 14:59:27 INFO - 'LANG': 'en_US.UTF-8', 14:59:27 INFO - 'LANGUAGE': 'en_US:en', 14:59:27 INFO - 'LOGNAME': 'cltbld', 14:59:27 INFO - 'MAIL': '/var/mail/cltbld', 14:59:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:27 INFO - 'MOZ_NO_REMOTE': '1', 14:59:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:27 INFO - 'NO_EM_RESTART': '1', 14:59:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:27 INFO - 'PWD': '/builds/slave/test', 14:59:27 INFO - 'SHELL': '/bin/bash', 14:59:27 INFO - 'SHLVL': '1', 14:59:27 INFO - 'TERM': 'linux', 14:59:27 INFO - 'TMOUT': '86400', 14:59:27 INFO - 'USER': 'cltbld', 14:59:27 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465768739.577772-877673692', 14:59:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:27 INFO - '_': '/tools/buildbot/bin/python'} 14:59:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:59:27 INFO - Running setup.py (path:/tmp/pip-bC3O6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:59:27 INFO - Running setup.py (path:/tmp/pip-xWOl50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:59:27 INFO - Running setup.py (path:/tmp/pip-PkN6PP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:59:27 INFO - Running setup.py (path:/tmp/pip-zHLDXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:59:28 INFO - Running setup.py (path:/tmp/pip-Hlk29x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:59:28 INFO - Running setup.py (path:/tmp/pip-YE2sii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:59:28 INFO - Running setup.py (path:/tmp/pip-ITElTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:59:28 INFO - Running setup.py (path:/tmp/pip-s8IQ1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:59:28 INFO - Running setup.py (path:/tmp/pip-SbSqPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:59:28 INFO - Running setup.py (path:/tmp/pip-FTpkTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:59:28 INFO - Running setup.py (path:/tmp/pip-WctHyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:59:28 INFO - Running setup.py (path:/tmp/pip-kvtWtI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:59:28 INFO - Running setup.py (path:/tmp/pip-I2cA0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:59:28 INFO - Running setup.py (path:/tmp/pip-ZU5nsv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:59:28 INFO - Running setup.py (path:/tmp/pip-fxgSsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:59:28 INFO - Running setup.py (path:/tmp/pip-cJWBrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:59:28 INFO - Running setup.py (path:/tmp/pip-dIjPHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:59:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:59:28 INFO - Running setup.py install for manifestparser 14:59:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:59:29 INFO - Running setup.py install for mozcrash 14:59:29 INFO - Running setup.py install for mozdebug 14:59:29 INFO - Running setup.py install for mozdevice 14:59:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:59:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:59:29 INFO - Running setup.py install for mozfile 14:59:29 INFO - Running setup.py install for mozhttpd 14:59:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:59:29 INFO - Running setup.py install for mozinfo 14:59:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:59:29 INFO - Running setup.py install for mozInstall 14:59:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:59:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:59:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:59:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:59:29 INFO - Running setup.py install for mozleak 14:59:29 INFO - Running setup.py install for mozlog 14:59:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:59:30 INFO - Running setup.py install for moznetwork 14:59:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:59:30 INFO - Running setup.py install for mozprocess 14:59:30 INFO - Running setup.py install for mozprofile 14:59:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:59:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:59:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:59:30 INFO - Running setup.py install for mozrunner 14:59:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:59:30 INFO - Running setup.py install for mozscreenshot 14:59:30 INFO - Running setup.py install for moztest 14:59:30 INFO - Running setup.py install for mozversion 14:59:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:59:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:59:30 INFO - Cleaning up... 14:59:30 INFO - Return code: 0 14:59:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:59:30 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')]} 14:59:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:30 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')]} 14:59:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:30 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 0x7fcf1c6e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e431c0>, '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 0x1e440c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e44550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465768739.577772-877673692', '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 14:59:30 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 14:59:30 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 14:59:30 INFO - Using env: {'DISPLAY': ':0', 14:59:30 INFO - 'HOME': '/home/cltbld', 14:59:30 INFO - 'LANG': 'en_US.UTF-8', 14:59:30 INFO - 'LANGUAGE': 'en_US:en', 14:59:30 INFO - 'LOGNAME': 'cltbld', 14:59:30 INFO - 'MAIL': '/var/mail/cltbld', 14:59:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:30 INFO - 'MOZ_NO_REMOTE': '1', 14:59:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:30 INFO - 'NO_EM_RESTART': '1', 14:59:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:30 INFO - 'PWD': '/builds/slave/test', 14:59:30 INFO - 'SHELL': '/bin/bash', 14:59:30 INFO - 'SHLVL': '1', 14:59:30 INFO - 'TERM': 'linux', 14:59:30 INFO - 'TMOUT': '86400', 14:59:30 INFO - 'USER': 'cltbld', 14:59:30 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465768739.577772-877673692', 14:59:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:30 INFO - '_': '/tools/buildbot/bin/python'} 14:59:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:59:31 INFO - Running setup.py (path:/tmp/pip-3he3HH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:59:31 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)) 14:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:59:31 INFO - Running setup.py (path:/tmp/pip-zV7X_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:59:31 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)) 14:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:59:31 INFO - Running setup.py (path:/tmp/pip-8XGn_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:59:31 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)) 14:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:59:31 INFO - Running setup.py (path:/tmp/pip-42zykW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:59:31 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)) 14:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:59:31 INFO - Running setup.py (path:/tmp/pip-raJtg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:59:31 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)) 14:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:59:31 INFO - Running setup.py (path:/tmp/pip-uieNPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:59:31 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)) 14:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:59:31 INFO - Running setup.py (path:/tmp/pip-vVBnD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:59:31 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)) 14:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:59:31 INFO - Running setup.py (path:/tmp/pip-cTFL4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:59:31 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)) 14:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:59:31 INFO - Running setup.py (path:/tmp/pip-aCq06v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:59:31 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)) 14:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:59:31 INFO - Running setup.py (path:/tmp/pip-Ce4_yP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:59:31 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)) 14:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:59:31 INFO - Running setup.py (path:/tmp/pip-8HYwoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:59:31 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)) 14:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:59:31 INFO - Running setup.py (path:/tmp/pip-A1HbzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:59:31 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)) 14:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:59:31 INFO - Running setup.py (path:/tmp/pip-NNntea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:59:31 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)) 14:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:59:31 INFO - Running setup.py (path:/tmp/pip-H1J4vf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:59:32 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)) 14:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:59:32 INFO - Running setup.py (path:/tmp/pip-ersna6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:59:32 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)) 14:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:59:32 INFO - Running setup.py (path:/tmp/pip-WXz8kO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:59:32 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)) 14:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:59:32 INFO - Running setup.py (path:/tmp/pip-DF3oDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:59:32 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)) 14:59:32 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)) 14:59:32 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)) 14:59:32 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)) 14:59:32 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)) 14:59:32 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)) 14:59:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:59:32 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 14:59:32 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 14:59:32 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 14:59:32 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 14:59:32 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 14:59:32 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 14:59:34 INFO - Downloading blessings-1.6.tar.gz 14:59:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:59:34 INFO - Installing collected packages: blessings 14:59:34 INFO - Running setup.py install for blessings 14:59:34 INFO - Successfully installed blessings 14:59:34 INFO - Cleaning up... 14:59:34 INFO - Return code: 0 14:59:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:59:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:59:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:59:34 INFO - Reading from file tmpfile_stdout 14:59:34 INFO - Current package versions: 14:59:34 INFO - argparse == 1.2.1 14:59:34 INFO - blessings == 1.6 14:59:34 INFO - blobuploader == 1.2.4 14:59:34 INFO - docopt == 0.6.1 14:59:34 INFO - functools32 == 3.2.3-2 14:59:34 INFO - jsonschema == 2.5.1 14:59:34 INFO - manifestparser == 1.1 14:59:34 INFO - mozInstall == 1.12 14:59:34 INFO - mozcrash == 0.17 14:59:34 INFO - mozdebug == 0.1 14:59:34 INFO - mozdevice == 0.48 14:59:34 INFO - mozfile == 1.2 14:59:34 INFO - mozhttpd == 0.7 14:59:34 INFO - mozinfo == 0.9 14:59:34 INFO - mozleak == 0.1 14:59:34 INFO - mozlog == 3.2 14:59:34 INFO - moznetwork == 0.27 14:59:34 INFO - mozprocess == 0.22 14:59:34 INFO - mozprofile == 0.28 14:59:34 INFO - mozrunner == 6.11 14:59:34 INFO - mozscreenshot == 0.1 14:59:34 INFO - mozsystemmonitor == 0.3 14:59:34 INFO - moztest == 0.7 14:59:34 INFO - mozversion == 1.4 14:59:34 INFO - psutil == 3.1.1 14:59:34 INFO - requests == 1.2.3 14:59:34 INFO - wsgiref == 0.1.2 14:59:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:59:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:59:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:59:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:34 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 0x7fcf1c6e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e431c0>, '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 0x1e440c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e44550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465768739.577772-877673692', '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 14:59:34 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 14:59:34 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 14:59:34 INFO - Using env: {'DISPLAY': ':0', 14:59:34 INFO - 'HOME': '/home/cltbld', 14:59:34 INFO - 'LANG': 'en_US.UTF-8', 14:59:34 INFO - 'LANGUAGE': 'en_US:en', 14:59:34 INFO - 'LOGNAME': 'cltbld', 14:59:34 INFO - 'MAIL': '/var/mail/cltbld', 14:59:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:34 INFO - 'MOZ_NO_REMOTE': '1', 14:59:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:34 INFO - 'NO_EM_RESTART': '1', 14:59:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:34 INFO - 'PWD': '/builds/slave/test', 14:59:34 INFO - 'SHELL': '/bin/bash', 14:59:34 INFO - 'SHLVL': '1', 14:59:34 INFO - 'TERM': 'linux', 14:59:34 INFO - 'TMOUT': '86400', 14:59:34 INFO - 'USER': 'cltbld', 14:59:34 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465768739.577772-877673692', 14:59:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:34 INFO - '_': '/tools/buildbot/bin/python'} 14:59:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:34 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)) 14:59:34 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)) 14:59:34 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)) 14:59:34 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)) 14:59:34 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)) 14:59:34 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)) 14:59:34 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)) 14:59:34 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)) 14:59:34 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)) 14:59:34 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)) 14:59:34 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)) 14:59:34 INFO - Cleaning up... 14:59:34 INFO - Return code: 0 14:59:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:59:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:59:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:59:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf1c6e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e431c0>, '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 0x1e440c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e44550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465768739.577772-877673692', '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 14:59:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:59:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:59:34 INFO - Using env: {'DISPLAY': ':0', 14:59:34 INFO - 'HOME': '/home/cltbld', 14:59:34 INFO - 'LANG': 'en_US.UTF-8', 14:59:34 INFO - 'LANGUAGE': 'en_US:en', 14:59:34 INFO - 'LOGNAME': 'cltbld', 14:59:34 INFO - 'MAIL': '/var/mail/cltbld', 14:59:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:34 INFO - 'MOZ_NO_REMOTE': '1', 14:59:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:34 INFO - 'NO_EM_RESTART': '1', 14:59:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:34 INFO - 'PWD': '/builds/slave/test', 14:59:34 INFO - 'SHELL': '/bin/bash', 14:59:34 INFO - 'SHLVL': '1', 14:59:34 INFO - 'TERM': 'linux', 14:59:34 INFO - 'TMOUT': '86400', 14:59:34 INFO - 'USER': 'cltbld', 14:59:34 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465768739.577772-877673692', 14:59:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:34 INFO - '_': '/tools/buildbot/bin/python'} 14:59:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:59:35 INFO - Cleaning up... 14:59:35 INFO - Return code: 0 14:59:35 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:59:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:59:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:59:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf1c6e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e431c0>, '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 0x1e440c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e44550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465768739.577772-877673692', '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 14:59:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:59:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:59:35 INFO - Using env: {'DISPLAY': ':0', 14:59:35 INFO - 'HOME': '/home/cltbld', 14:59:35 INFO - 'LANG': 'en_US.UTF-8', 14:59:35 INFO - 'LANGUAGE': 'en_US:en', 14:59:35 INFO - 'LOGNAME': 'cltbld', 14:59:35 INFO - 'MAIL': '/var/mail/cltbld', 14:59:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:35 INFO - 'MOZ_NO_REMOTE': '1', 14:59:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:35 INFO - 'NO_EM_RESTART': '1', 14:59:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:35 INFO - 'PWD': '/builds/slave/test', 14:59:35 INFO - 'SHELL': '/bin/bash', 14:59:35 INFO - 'SHLVL': '1', 14:59:35 INFO - 'TERM': 'linux', 14:59:35 INFO - 'TMOUT': '86400', 14:59:35 INFO - 'USER': 'cltbld', 14:59:35 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465768739.577772-877673692', 14:59:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:35 INFO - '_': '/tools/buildbot/bin/python'} 14:59:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:35 INFO - Downloading/unpacking flake8 14:59:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:37 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:59:37 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:37 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:59:37 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:37 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:59:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:59:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:59:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:59:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:59:37 INFO - no previously-included directories found matching 'docs/_build' 14:59:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:59:37 INFO - Running setup.py install for pep8 14:59:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:59:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:59:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:59:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:59:38 INFO - no previously-included directories found matching 'docs/_build' 14:59:38 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:59:38 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:59:38 INFO - Cleaning up... 14:59:38 INFO - Return code: 0 14:59:38 INFO - Running post-action listener: _resource_record_post_action 14:59:38 INFO - Running post-action listener: _start_resource_monitoring 14:59:38 INFO - Starting resource monitoring. 14:59:38 INFO - ##### 14:59:38 INFO - ##### Finished create-virtualenv step (success) 14:59:38 INFO - ##### 14:59:38 INFO - ##### 14:59:38 INFO - ##### Running install step. 14:59:38 INFO - ##### 14:59:38 INFO - Running pre-action listener: _resource_record_pre_action 14:59:38 INFO - Running main action method: install 14:59:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:59:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:59:38 INFO - Reading from file tmpfile_stdout 14:59:38 INFO - Detecting whether we're running mozinstall >=1.0... 14:59:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:59:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:59:38 INFO - Reading from file tmpfile_stdout 14:59:38 INFO - Output received: 14:59:38 INFO - Usage: mozinstall [options] installer 14:59:38 INFO - Options: 14:59:38 INFO - -h, --help show this help message and exit 14:59:38 INFO - -d DEST, --destination=DEST 14:59:38 INFO - Directory to install application into. [default: 14:59:38 INFO - "/builds/slave/test"] 14:59:38 INFO - --app=APP Application being installed. [default: firefox] 14:59:38 INFO - mkdir: /builds/slave/test/build/application 14:59:38 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'] 14:59:38 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 14:59:54 INFO - Reading from file tmpfile_stdout 14:59:54 INFO - Output received: 14:59:54 INFO - /builds/slave/test/build/application/firefox/firefox 14:59:54 INFO - Running post-action listener: _resource_record_post_action 14:59:54 INFO - ##### 14:59:54 INFO - ##### Finished install step (success) 14:59:54 INFO - ##### 14:59:54 INFO - ##### 14:59:54 INFO - ##### Running run-tests step. 14:59:54 INFO - ##### 14:59:54 INFO - Running pre-action listener: _resource_record_pre_action 14:59:54 INFO - Running main action method: run_tests 14:59:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:59:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:59:54 INFO - Python 2.7.3 14:59:54 INFO - Return code: 0 14:59:54 INFO - grabbing minidump binary from tooltool 14:59:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:59:54 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 0x1e431c0>, '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 0x1e440c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e44550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:59:54 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 14:59:54 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 14:59:54 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 14:59:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:59:54 INFO - Return code: 0 14:59:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:59:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:59:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:59:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:59:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:59:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:59:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:59:55 INFO - Return code: 0 14:59:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A6UeXKmvSbawQ4MsU3ISJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:59:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/A6UeXKmvSbawQ4MsU3ISJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:59:55 INFO - Using env: {'DISPLAY': ':0', 14:59:55 INFO - 'HOME': '/home/cltbld', 14:59:55 INFO - 'LANG': 'en_US.UTF-8', 14:59:55 INFO - 'LANGUAGE': 'en_US:en', 14:59:55 INFO - 'LOGNAME': 'cltbld', 14:59:55 INFO - 'MAIL': '/var/mail/cltbld', 14:59:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:59:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:59:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:55 INFO - 'MOZ_NO_REMOTE': '1', 14:59:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:59:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:55 INFO - 'NO_EM_RESTART': '1', 14:59:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:55 INFO - 'PWD': '/builds/slave/test', 14:59:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:59:55 INFO - 'SHELL': '/bin/bash', 14:59:55 INFO - 'SHLVL': '1', 14:59:55 INFO - 'TERM': 'linux', 14:59:55 INFO - 'TMOUT': '86400', 14:59:55 INFO - 'USER': 'cltbld', 14:59:55 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465768739.577772-877673692', 14:59:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:55 INFO - '_': '/tools/buildbot/bin/python'} 14:59:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A6UeXKmvSbawQ4MsU3ISJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:59:55 INFO - mozversion application_buildid: 20160612135307 14:59:55 INFO - mozversion application_changeset: 4fb66e8edacad1ab21a6b52d6ef8c0f078728090 14:59:55 INFO - mozversion application_display_name: Nightly 14:59:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:59:55 INFO - mozversion application_name: Firefox 14:59:55 INFO - mozversion application_remotingname: firefox 14:59:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:59:55 INFO - mozversion application_vendor: Mozilla 14:59:55 INFO - mozversion application_version: 50.0a1 14:59:55 INFO - mozversion platform_buildid: 20160612135307 14:59:55 INFO - mozversion platform_changeset: 4fb66e8edacad1ab21a6b52d6ef8c0f078728090 14:59:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:59:55 INFO - mozversion platform_version: 50.0a1 14:59:55 INFO - using testdate: 1465768795 14:59:55 INFO - actual date: 1465768795 14:59:55 INFO - starting webserver on 'localhost:51762' 14:59:55 INFO - SUITE-START | Running 2 tests 14:59:55 INFO - TEST-START | dromaeo_css 14:59:55 INFO - operating with platform_type : linux_ 14:59:55 INFO - Initialising browser for dromaeo_css test... 14:59:55 INFO - TEST-INFO | started process 22245 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNnHhqW/profile http://localhost:51762/getInfo.html) 15:00:01 INFO - PROCESS | 22245 | __metrics Screen width/height:1600/1200 15:00:01 INFO - PROCESS | 22245 | colorDepth:24 15:00:01 INFO - PROCESS | 22245 | Browser inner width/height: 1024/697 15:00:01 INFO - PROCESS | 22245 | __metrics 15:00:02 ERROR - PROCESS | 22245 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:00:03 INFO - PROCESS | 22245 | console.error: PushService: 15:00:03 INFO - PROCESS | 22245 | stateChangeProcessEnqueue: Error transitioning state 15:00:03 INFO - PROCESS | 22245 | UnknownError 15:00:04 INFO - TEST-INFO | 22245: exit 0 15:00:04 INFO - Browser initialized. 15:00:04 INFO - Running cycle 1/1 for dromaeo_css test... 15:00:04 INFO - TEST-INFO | started process 22326 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNnHhqW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:00:16 INFO - PROCESS | 22326 | RSS: Main: 175099904 15:00:16 INFO - PROCESS | 22326 | 15:01:08 INFO - PROCESS | 22326 | 1465768868153 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] 15:03:20 INFO - PROCESS | 22326 | Cycle 1(1): loaded http://localhost:51762/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51762/tests/dromaeo/cssquery-ext.html) 15:03:21 INFO - PROCESS | 22326 | RSS: Main: 257118208 15:03:21 INFO - PROCESS | 22326 | 15:06:23 INFO - PROCESS | 22326 | Cycle 1(1): loaded http://localhost:51762/tests/dromaeo/cssquery-ext.html (next: http://localhost:51762/tests/dromaeo/cssquery-jquery.html) 15:06:24 INFO - PROCESS | 22326 | RSS: Main: 259485696 15:06:24 INFO - PROCESS | 22326 | 15:09:26 INFO - PROCESS | 22326 | Cycle 1(1): loaded http://localhost:51762/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51762/tests/dromaeo/cssquery-mootools.html) 15:09:27 INFO - PROCESS | 22326 | RSS: Main: 256929792 15:09:27 INFO - PROCESS | 22326 | 15:12:29 INFO - PROCESS | 22326 | Cycle 1(1): loaded http://localhost:51762/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51762/tests/dromaeo/cssquery-prototype.html) 15:12:30 INFO - PROCESS | 22326 | RSS: Main: 261910528 15:12:30 INFO - PROCESS | 22326 | 15:15:33 INFO - PROCESS | 22326 | Cycle 1(1): loaded http://localhost:51762/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51762/tests/dromaeo/cssquery-yui.html) 15:15:33 INFO - PROCESS | 22326 | RSS: Main: 232747008 15:15:33 INFO - PROCESS | 22326 | 15:18:36 INFO - PROCESS | 22326 | Cycle 1(1): loaded http://localhost:51762/tests/dromaeo/cssquery-yui.html (next: http://localhost:51762/tests/dromaeo/cssquery-dojo.html) 15:18:36 INFO - PROCESS | 22326 | RSS: Main: 311541760 15:18:36 INFO - PROCESS | 22326 | 15:18:36 INFO - PROCESS | 22326 | __start_tp_report 15:18:36 INFO - PROCESS | 22326 | _x_x_mozilla_page_load 15:18:36 INFO - PROCESS | 22326 | _x_x_mozilla_page_load_details 15:18:36 INFO - PROCESS | 22326 | |i|pagename|runs| 15:18:36 INFO - PROCESS | 22326 | |0;dojo.html;2612.908548200813;2634.1965700461374;2643.2334622959343;2646.07387414405;2663.560512515435;4636.930446043312;4724.551167639069;4734.4792072872;4793.1132740443045;4850.927236091457;4735.242361222206;4743.786529606167;4749.810007599692;4767.809287628491;4789.233722604384;4298.032942587916;4311.2024275508975;4364.67264955128;4398.626116780061;4524.751138687371;4417.315316126005;4436.44544431946;4455.153520831048;4456.286994080948;4498.865034048984;4217.894552636178;4273.1240095780295;4334.631556317717;4359.149965756678;4404.977975110136;4341.088371442001;4357.128574285156;4386.385905973167;4392.165488557164;4396.494403143615;4373.387725718402;4374.868753937387;4375.628071613916;4402.8679139625865;4410.713303635285;4536.841210557614;4762.57136857681;4838.129136755382;4839.395075615548;4877.51224877513;5133.486651334874;5137.178051511778;5200.583953283728;5201.9479805201845;5202.97398513005;4910.7299098549565;5194.142966410538;5203.843884683465;5238.816641417532;5241.397239317489;4645.628349732047;4721.929171062437;4737.8104875805275;4738.336632871401;4764.499727528629;5235.110031294689;5245.239440281138;5246.186841039645;5246.947530524722;5248.396434410091;4873.926891096637;4948.653594248368;5061.873453163626;5068.923966140511;5073.1122053640465;5018.698878067327;5055.620828437882;5077.898442031213;5079.644424890296;5115.948840511547;4996.800127994912;4997.25041243809;4997.525235102659;5016.5485106339875;5046.142155833517;4767.856964291077;4962.975185124052;4963.329950456642;4977.427595826526;4994.275830004702;4316.115196384733;4319.67602429819;4320.941369364526;4346.348047792793;4356.172327257811;3787.299349620329;3807.638274363931;3816.160444702161;3844.4233364994916;3844.59631738669;4230.386593943923;4276.037891474393;4365.628921541641;4371.453568303962;4404.867853964386;5148.6910785353;5172.818951336685;5175.14610089331;5177.58579313654;5211.1922651989;4413.668974826901;4418.536053714313;4418.64650827933;4448.688591798607;4463.397441345442;4457.3091170868565;4538.478075021415;4572.291294849238;4580.931286030712;4639.536046395401;4744.098621262087;4759.857204283877;4773.236282194832;4774.976125119491;4809.975950120367;5039.697618142924;5041.369828771403;5045.62157838171;5074.873128171826;5104.770285337095;4596.724196548218;4780.211265141352;4838.685485443435;4844.927326090041;4909.140900342497;5055.317532133115;5069.670471419346;5070.03669302846;5082.2122571001555;5129.692218466904;5145.279660847559;5154.690718556899;5159.355080614923;5159.793608255628;5163.148080566814;4725.740084295397;4913.533214344631;4916.901661966812;4917.164082106122;4920.21276595743;4906.8773280668265;4910.288960828521;4922.335484709519;4942.728149951788;4960.727160006234;4720.961388494526;4873.439554451284;4881.09765171582;4886;4940.950590494049;4985.551300382983;5002.52476014778;5022.171341728574;5032.899342013066;5046.899062018666;4933.605311574994;4937.333459982857;4939.135651261086;4943.3573635427165;4995.275685025724 15:18:36 INFO - PROCESS | 22326 | |1;ext.html;569.1150261343612;583.786917775012;591.0366103251702;592.0763608770321;600.9188759517464;28146.718532814666;40225.3966190507;41863.58136418635;41883.371749423706;45707;41952;42595.14809703804;42618;42650.360244596355;42690.359644605276;7445.181030086686;7803.960980195091;7947.642356093989;7954.443188976774;7955.761327160194;9851.40891546506;10132.189424845994;10135.138513226384;10421.426821524814;10426.791464170712;10186.847197292047;10299.948500257487;10304.484775761219;10306.536205870754;10309.53607087683;7557.886631700529;9918.90081099187;10132.696019119438;10192.694219173436;10198;9981.80036399268;10059.245556583286;10075.496225188712;10085.647002354955;10093.798124037552;39625.60374396277;39965.20069598592;40006;40008.199836003114;40055.39916901249;2961.8370989595564;3115.252339438541;3156.494960806283;3219.9034028979167;3300.933981320384;30595;31025.8448707755;31039;31088.222794430094;31361.84319078413;3176.896745873165;3199.7054081490514;3209.6950789674943;3275.894716909678;3281.96718032819;245074;246033;246233;246392.76803616047;246475;54667;55482;55528.44471555314;55563;55635;33147.66852331446;34211.65788342134;34214.48678269828;35934.64065359313;59653.70173149106;14655.560333190022;14710.190939498216;14812;14818.33317500715;14855.034422762486;9957.701268961942;10988.835167472495;11171.106311495061;11421.714457138472;11471.598494052669;18568.164432600566;18645.440636780917;18683.813161868205;18767.3431429902;18768.906155469136;6776.254611992776;6784.966075169691;6961.443084553223;7026.402755765715;7137.536060156073;772.4901564967095;864.446754077391;869.6608322754131;952.7332346942867;960.9429627409793;27814.3046423841;28336.43327133446;29046;29134.417311653648;29158.562621560694;933.3466573398648;962.7689354554857;989.2333441582831;995.8605795188679;1000.7498125468633;14834.703305933821;15048.247587620575;15157;15188.924055379652;15243.923780381027;360245;361745;363523;364144;365054;49604;50055.24917126246;50079.49920500749;50085;50201.24698129531;1061.628430049492;1171.2328424881716;1202.7233736240714;1214.4170798017178;1222.7432239229684;28940.276493087;29034;29405.411891761618;29887.55168672428;29949.55075673823;42506.14987700291;42813.785931070146;42997.785011074746;43105.13789724251;43109;289398;289796;290078;293089;293497;22283.885805709975;22597.774022259568;23082.884585576965;23153.65269520925;25840;42817;43184.35223471588;43461.130777383645;43952.34071488866;44127.558724413626;35690.46464303089;36479.27041459103;36796.26407471889;37020.25959480849;37225.627743722216;36004.819975901;37029.25941481209;37146;37202.9076801557;37280.254394912496;35530.467042993856;36078;37155.62844371521;37193;37268;31000;33297.66702332946;33336.83331583327;33494.33011339711;33634.831825840716;25013.249602511954;25446;25524;25788.742112578635;25816.741832581432 15:18:36 INFO - PROCESS | 22326 | |2;jquery.html;354.11647938393713;356.54362416107375;360.9837557309921;374.93438648236554;375.99624003759953;16152.515424537269;16249.512514624565;17299.481015569523;17398.82601173988;17433.21550530226;16122.274497647604;16359;16595.585110372245;16821.41125060623;16845.4104106356;4817.662763606549;5027.396712394518;5074;5075.137226671456;5075.873103172414;2704.7836173106202;2838.6877443481303;4983.252512123175;5335.5198032177095;5659.688717120557;5665.830025099253;5679.375268720438;5681.403452637475;5689.886202275952;5697.886042279152;5539.806106786264;5674.404187560309;5836.795712150097;5839.211706419622;5885.970570147122;5062.873428164288;5094.490550944913;5112.207607820794;5126.333576635051;5133.691978481265;19282.903585482123;19890.602187956305;20081.698774518394;20112.497187570283;20340.389788306373;1890.1116475256608;1903.5526651236949;1964.5972575621963;1996.9201231950703;2515.1448507507534;12210.694732631666;12746.36268186587;12940.094193406465;13201.087253591537;13322.733545329136;1627.096961186541;1685.6881476926685;1742.7037403641411;1791.5073354827396;1810.2125575374755;65956.67021664909;67380.66309668469;67602;67871.32128678748;68460;7979.960100199578;8533.829323413496;8702.303815694855;8762.649494020296;8994.685186018458;11580.073594112451;11669.183157179086;11689.18175727708;11726.179167458367;11748.530058797553;6948.6178260195165;7008.894866577006;7055.753048643272;7190.137183538009;7195.784126476214;7187.928120718726;7236.131664200329;7246.275372462817;7296.963515182496;7315.487915845946;3687.225682606629;3714.3499887520115;3768.6419790119894;3785.2051069275763;3890.6692931101175;1555.5488908216491;1650.2326418215587;1728.8271172882612;1791.8835275707038;1797.604527004057;829.3531045784298;881.0968757024101;886.742844575066;893.0801274687083;895.7268033249791;15373.538793836204;16178.67642647164;16207.513774586781;16708.24812883423;17048.48854534366;828.3368968765448;837.4012581004611;870.1950695606539;872.1322284327135;887.3921363865644;9083.81832363349;9476.052394760607;9507.57215925285;9517.476538790295;9661.806763864683;382777;386676;401055;402510;410234;75530.89382123598;75998.24001760023;77050;77533;78844;892.5403417240127;912.9726108216764;924.2236521322121;924.408378637659;924.7734305095295;14517.374517374434;14683.632909177357;14821.851781482048;14899.329530171384;14963.32665030098;34847.303053938274;35133.648663513035;35905.46141807823;37037.25925481421;37381.43927841139;48315.75842120907;49218;49222.26166607432;49864.00271994467;50055.24917126319;7482.476226664081;7537.057867766529;7627.275408836152;7665.6550455228535;7709.922900770921;10167.339122956984;10851;10866.348019118877;10965.945170274097;11031.338119712844;5830.096335068071;9098.226650734761;9169.40398874071;9324.440533568008;9544.952275238857;9931.702048938254;9970.052844979715;9991.700248992542;10109.34289271195;10156;9015.504147271962;9168.954155229181;9319.58061887203;9323.627054917999;9344.97205307402;6588.901166482602;6985.5808651481075;7023.403010743939;7147.428205743632;7778.883316750366;7509.399248060251;9152.359334846764;9933.056359645821;9959.601615935282;10088.495575221063 15:18:36 INFO - PROCESS | 22326 | |3;mootools.html;1199.2864245773762;1363.9386227619757;1389.3400634698519;1464.2532308522657;1652.9090900000504;6609.603423794576;7252.601106939116;7469.887951680722;7489.176190619041;7746.690132394698;7238.855222895539;7325.267473252672;7353.448491363142;7363.374113200371;7365.226651201627;2162.362103179558;2192.8465007449486;2193;2193.396815875631;2194.901229444679;2100.663893776996;2128.5104425982036;2130.2437634639714;2132.4135862637745;2136.177571634916;2125.4155107345528;2144.0673307111456;2148.1085349579907;2148.6132496150685;2169.533550286688;2086.9582608347823;2090.4042347930845;2093.769685334612;2094.1204694028543;2100.6743954686895;2082.864613800113;2131.5204079082237;2137.5724855029057;2138.2409244718056;2141.925032623866;7615.124260710034;7658.195889431641;7705.653245603961;7774.922250777533;7995.200479952016;4631.62946964242;4742.668013239075;4764.904701905977;4778.928316075262;4784.497627749071;2833.5891295762203;2900.3329234276025;2979.0913771299747;2980.165553644983;2997.2357048952595;898.6899519665704;907.3920473282916;916.4913473022469;924.2098006204666;938.9624415023391;10762.515686794113;10831.404272764994;10861.3483191008;10882.020618144326;10893.83659245104;4056.7768772717195;4139.91720165595;4173.52004519478;4204.747715137101;4214.473190851144;8473.195046470575;8519.062903080656;8546.188112129337;8567.186117318844;8572.014218364842;4667.323238130452;4669.4396672399525;4712.222483290218;4712.340272361872;4717.127331443694;3600.0819790953137;3736;3817.064819119278;4276.657867370603;4352.347147927836;3341.348437054751;3411.096059544223;3448.5344478495585;3495.405781017233;3504.929901402009;954.7613096725819;965.0687086961116;967.1634036558467;978.9265805064506;983.6458874805064;783.7962129846281;785.9350579964066;813.1218284252992;815.967361305553;837.4263629413871;5054.620903432257;5172.172452407597;5184.714840683723;5242.685438873604;5302.390225124083;882.4837470079947;899.4243684042087;911.8814554107923;913.6117150211267;919.9264058875274;3475.739319551044;3546.184377593168;3558.9644103558635;3570.535830342039;3606.927861442809;9587.472689002032;9742.171915387271;9841.753956151153;9905.05901939329;9927.354721943051;9422.717318480456;9622.230221582256;9669.419834809934;9717.951410242904;9745.12293893553;7187.38907192884;7307.3423391894985;7373.410127189812;7388.408927285805;7404.222556631584;5051.4443411225475;5176.534111929945;5235.345581802275;5349.1976203569775;5484.533814625802;8730.476171429735;8861;9047.68333108338;9077.68228112013;9120.361574689709;8705.434146780439;8939;9070.229030532479;9138.314626402913;9161.77095572616;5547.639403438763;6090.299615544269;6263.561550691408;6267.592606480564;6334.683265836782;7318.6706598202145;7381.741639042608;7392.149902761252;7410.333070023724;7460.328570428687;6555.3772391622715;6767.695453704497;6805.4895882808;6905.827354316182;6951;6629.303923088007;6675.766348177791;6686.866262674622;6759.898601521079;6861.073755043005;6011.428914253139;6023.488003519575;6031.065184896348;6106.145139680537;6141.570090093829;4181.623653871166;4225.746455212697;4245.639120674778;4248.171606536695;4256.3189889617515;4207.579242075891;4323.567643235777;4349.173657005159;4443.200223959719;4481.103779244229 15:18:36 INFO - PROCESS | 22326 | |4;prototype.html;287.8776519979009;299.00729577801695;299.15936219223994;299.49236044903887;301.6214650613481;4955.900881982363;4975.8258460953875;4983.401991760994;4984.950150498494;5008.874778130548;4904.386951631046;4909.975450122744;4930.260460930853;4930.654854160211;4951.746955135413;3639.927201455976;3744.9251014979686;3748.0629842539365;3830.6360895715;3870.7290489665734;3814.771113733171;3839.3856982882744;3843.673287770543;3852.460655508231;3874.341361968458;3806.8667596634123;3817.522809648794;3817.618238176174;3836.6547010769027;3838.750481218726;3624.2932628137523;3702.148505843671;3835.137094153793;3848.749831260959;3856.3636999894984;3385;3396.9490457643155;3398;3409.335179639971;3410.7271418286477;4786.760661966922;4791.2813078038225;4794.688345257582;4797.280407938802;4807.158747219258;4201.894952626179;4385.166818304544;4398.73607583546;4403.471583410012;4426.7122637028815;5090.592752579785;5143.922841157386;5156.123459011977;5167.870803229912;5168.483151684839;3716.9070773230615;3727.8322475488667;3734.73856830022;3735.402335626287;3739.9626003739886;5139.768710408003;5355.161764264946;5363.275957745694;5393.622446428752;5425.701586412746;3754.2303827715255;3771.6794072503594;3782.924341513154;3783.621637836249;3794.354959656865;3832.865849695247;3860.575336712959;3867.6712479439;3869.032741814546;3881.3207688654375;4346.21768081742;4377.4965878923695;4377.562243775597;4393.319035549495;4415.072834704683;4844.2007068833245;5124.871878203;5131.820386286462;5160.767765450564;5170.922436163461;1325.389651573343;1331.4607583928525;1334.8464926533572;1344.1397505596426;1344.9193048417126;848.898132224137;849.6431498770531;857.1257317536079;865.1219012702112;900.7252787899754;4445.155420470101;4452.977735111303;4455.710378825366;4497.268551607654;4497.370368148462;5239.659422137625;5244.947550524446;5256.211568264791;5257.447967963309;5283.920741188886;4313.180495705806;4454.728088674799;4483.977580112079;4486.147631949919;4514.781009127517;2815.5354366529295;2819.8167119137192;2826.943461130766;2827.377976845091;2838.7445129938405;4864.683795553277;4867.707937523689;4884.340614017134;4887.535684110004;4895.681780684244;5141.2545180948555;5334.146536554133;5350;5368.147988943808;5384.246205531229;4878.707277563358;4895.583875370633;4918.360613120271;4923.75381230937;4934.432540257844;5188.299579556862;5213.765380557808;5222;5318.79270102903;5330.173823057432;5046.747662616928;5199.272101905812;5207.791688332424;5219.5029330348;5238.580913526985;4960.404751429707;4978.377702787152;4985.825496107619;4997.450280469218;5002.52476014778;3695.6119607441906;3774.8675397380125;3786.3373909565166;3792.1088544192644;3805;5039.3448851649055;5153.871153221199;5218.66078704883;5305.628605997697;5312.521873031291;4987.401511818605;4997.425296090851;5025.497450254945;5032.874178145576;5037.093323201859;4996.875078123076;5009.524095210949;5014.297998280171;5030.3148445271245;5032.446430892672;4771.308636584653;4984.975075124601;4994.650374473752;5012.122878496321;5019.52314530119;4903.901921961612;5041.1430056889685;5107.310513080686;5176.456472070529;5179.229112424835;5049.368828896388;5057.951529630505;5072.289879416959;5081.976224146627;5089.414717307557 15:18:36 INFO - PROCESS | 22326 | |5;yui.html;551.8151419274542;559.602682095712;576.2336092996316;581.3343721438949;586.4135864135864;10940.288881222725;11533.423328833556;11536.077113830894;11553.942230288858;12373.628791136258;14809.555713328591;14912.776308355384;14921.92539037306;14933;14933;769.242296338108;775.3990657240655;778.7702627724807;779.1157036763286;779.3180966654178;612.3967891626744;736.135041326442;773.7021246819959;778.715768744407;781.9061712594469;795.7930937956144;798.8202654402771;800.131856935223;801.887735717;804.3685706720225;633.4868756307405;796.295278678368;796.5459687977855;796.5618909599726;796.6415113199083;557.8075563930438;573.7618888161408;578.7222133376004;579.568221674855;579.5942840012009;11956.342401167933;11969.102317326147;11975.580854670045;11984.880151198464;11999.700007499796;10766.838497422545;10825.458727063695;10896.673099807018;10984.835227471594;11651.94174029133;11410.885891141066;11486.655400338002;11724.589639362666;11734.706632334175;11957.521699132025;4006.399040144002;4082.3468245080644;4088.1619268050276;4112.280350938574;4144.564820693814;48218.51781482175;48517.514824852005;48639;48652.27021594679;61219.38780612181;9179.908200918038;9274.30442716799;9395.953020234854;9425.481598512148;9718.854217186748;17849.46451606428;18027.549311267325;18078.09609519519;18803.623927521374;18823.90588047051;6760.019797129388;6760.290169532227;6761.256261811197;6792.150981127359;6822.317768223138;3397.2695870387493;3437.5359326491102;3467.219875527986;3511.1046683096156;3571.6964058055355;2620.4366061296914;2684.154491335223;2687.1535466328046;2688.1129227354927;2691.650085488913;456.51153266005053;465.2764950502002;470.99764501177276;473.8838984448763;478.4450037955954;396.97221194516686;447.28211220990494;462.9514150449235;537.8758394954564;570.5321636258311;6869.278725733826;7005.334493223136;7122;7146.2496437874315;7155.67799449026;491.8401519506175;505.4010996968604;507.73502578341487;527.8099884041742;532.6910391972647;3288.621808492006;3384.7799893006877;3398.2523844754114;3482.233908540117;3509.701675357623;82689.58655206686;90871.54564227269;92267.53866230627;92769;92880.53559732158;47810.521894780606;74036.25963740401;74736;75185.11296765693;79920.20079799244;67414.66292668505;67725.66137169283;67798.66100669465;68470.3152968464;68666.65666671634;6611.603303801788;6854.177498700188;6892.724291028303;6938.895916561155;6948.5483443576;31126.844365778026;32368.190795230308;37645.81177094097;38112;38686.613133868304;58221.126683100636;58975.705121474115;59028;59056;59371.40628593831;11091;11239.775204496027;11372.545098196311;11551.653450396501;12071.698207544881;10583.5237414315;10662.25364224528;11151.665450036511;11156.10751139923;11490.77018459643;9933.701988940344;10236.129928955825;10537.104346130358;10616.097631701392;10632.096271816983;10213.591456341663;10759.89240107589;11060.336379817236;11064.455175309562;11073.390963497084;10161.441120738431;10718.410487423267;10915.345079295268;10924.836127457935;10947.616833410792;8549.743507694779;8836.779080522781;8943.508107054175;9010.774730631787;9074.228690561376;8996.415233009833;9069.546522673973;9193.448393096436;9282.535873206447;9309.20871725911 15:18:36 INFO - PROCESS | 22326 | __end_tp_report 15:18:36 INFO - PROCESS | 22326 | __start_cc_report 15:18:36 INFO - PROCESS | 22326 | _x_x_mozilla_cycle_collect,934 15:18:36 INFO - PROCESS | 22326 | __end_cc_report 15:18:36 INFO - PROCESS | 22326 | __startTimestamp1465769916733__endTimestamp 15:18:36 INFO - PROCESS | 22326 | 15:18:36 INFO - PROCESS | 22326 | ------- Summary: start ------- 15:18:36 INFO - PROCESS | 22326 | Number of tests: 6 15:18:36 INFO - PROCESS | 22326 | 15:18:36 INFO - PROCESS | 22326 | [#0] dojo.html Cycles:165 Average:4705.95 Median:4838.69 stddev:497.53 (10.3%) stddev-sans-first:471.19 15:18:36 INFO - PROCESS | 22326 | Values: 2612.9 2634.2 2643.2 2646.1 2663.6 4636.9 4724.6 4734.5 4793.1 4850.9 4735.2 4743.8 4749.8 4767.8 4789.2 4298.0 4311.2 4364.7 4398.6 4524.8 4417.3 4436.4 4455.2 4456.3 4498.9 4217.9 4273.1 4334.6 4359.1 4405.0 4341.1 4357.1 4386.4 4392.2 4396.5 4373.4 4374.9 4375.6 4402.9 4410.7 4536.8 4762.6 4838.1 4839.4 4877.5 5133.5 5137.2 5200.6 5201.9 5203.0 4910.7 5194.1 5203.8 5238.8 5241.4 4645.6 4721.9 4737.8 4738.3 4764.5 5235.1 5245.2 5246.2 5246.9 5248.4 4873.9 4948.7 5061.9 5068.9 5073.1 5018.7 5055.6 5077.9 5079.6 5115.9 4996.8 4997.3 4997.5 5016.5 5046.1 4767.9 4963.0 4963.3 4977.4 4994.3 4316.1 4319.7 4320.9 4346.3 4356.2 3787.3 3807.6 3816.2 3844.4 3844.6 4230.4 4276.0 4365.6 4371.5 4404.9 5148.7 5172.8 5175.1 5177.6 5211.2 4413.7 4418.5 4418.6 4448.7 4463.4 4457.3 4538.5 4572.3 4580.9 4639.5 4744.1 4759.9 4773.2 4775.0 4810.0 5039.7 5041.4 5045.6 5074.9 5104.8 4596.7 4780.2 4838.7 4844.9 4909.1 5055.3 5069.7 5070.0 5082.2 5129.7 5145.3 5154.7 5159.4 5159.8 5163.1 4725.7 4913.5 4916.9 4917.2 4920.2 4906.9 4910.3 4922.3 4942.7 4960.7 4721.0 4873.4 4881.1 4886.0 4941.0 4985.6 5002.5 5022.2 5032.9 5046.9 4933.6 4937.3 4939.1 4943.4 4995.3 15:18:36 INFO - PROCESS | 22326 | 15:18:36 INFO - PROCESS | 22326 | [#1] ext.html Cycles:180 Average:46085.42 Median:33415.58 stddev:79628.62 (238.3%) stddev-sans-first:79778.66 15:18:36 INFO - PROCESS | 22326 | Values: 569.1 583.8 591.0 592.1 600.9 28146.7 40225.4 41863.6 41883.4 45707.0 41952.0 42595.1 42618.0 42650.4 42690.4 7445.2 7804.0 7947.6 7954.4 7955.8 9851.4 10132.2 10135.1 10421.4 10426.8 10186.8 10299.9 10304.5 10306.5 10309.5 7557.9 9918.9 10132.7 10192.7 10198.0 9981.8 10059.2 10075.5 10085.6 10093.8 39625.6 39965.2 40006.0 40008.2 40055.4 2961.8 3115.3 3156.5 3219.9 3300.9 30595.0 31025.8 31039.0 31088.2 31361.8 3176.9 3199.7 3209.7 3275.9 3282.0 245074.0 246033.0 246233.0 246392.8 246475.0 54667.0 55482.0 55528.4 55563.0 55635.0 33147.7 34211.7 34214.5 35934.6 59653.7 14655.6 14710.2 14812.0 14818.3 14855.0 9957.7 10988.8 11171.1 11421.7 11471.6 18568.2 18645.4 18683.8 18767.3 18768.9 6776.3 6785.0 6961.4 7026.4 7137.5 772.5 864.4 869.7 952.7 960.9 27814.3 28336.4 29046.0 29134.4 29158.6 933.3 962.8 989.2 995.9 1000.7 14834.7 15048.2 15157.0 15188.9 15243.9 360245.0 361745.0 363523.0 364144.0 365054.0 49604.0 50055.2 50079.5 50085.0 50201.2 1061.6 1171.2 1202.7 1214.4 1222.7 28940.3 29034.0 29405.4 29887.6 29949.6 42506.1 42813.8 42997.8 43105.1 43109.0 289398.0 289796.0 290078.0 293089.0 293497.0 22283.9 22597.8 23082.9 23153.7 25840.0 42817.0 43184.4 43461.1 43952.3 44127.6 35690.5 36479.3 36796.3 37020.3 37225.6 36004.8 37029.3 37146.0 37202.9 37280.3 35530.5 36078.0 37155.6 37193.0 37268.0 31000.0 33297.7 33336.8 33494.3 33634.8 25013.2 25446.0 25524.0 25788.7 25816.7 15:18:36 INFO - PROCESS | 22326 | 15:18:36 INFO - PROCESS | 22326 | [#2] jquery.html Cycles:180 Average:24131.36 Median:5075.51 stddev:65467.52 (1289.9%) stddev-sans-first:65626.83 15:18:36 INFO - PROCESS | 22326 | Values: 354.1 356.5 361.0 374.9 376.0 16152.5 16249.5 17299.5 17398.8 17433.2 16122.3 16359.0 16595.6 16821.4 16845.4 4817.7 5027.4 5074.0 5075.1 5075.9 2704.8 2838.7 4983.3 5335.5 5659.7 5665.8 5679.4 5681.4 5689.9 5697.9 5539.8 5674.4 5836.8 5839.2 5886.0 5062.9 5094.5 5112.2 5126.3 5133.7 19282.9 19890.6 20081.7 20112.5 20340.4 1890.1 1903.6 1964.6 1996.9 2515.1 12210.7 12746.4 12940.1 13201.1 13322.7 1627.1 1685.7 1742.7 1791.5 1810.2 65956.7 67380.7 67602.0 67871.3 68460.0 7980.0 8533.8 8702.3 8762.6 8994.7 11580.1 11669.2 11689.2 11726.2 11748.5 6948.6 7008.9 7055.8 7190.1 7195.8 7187.9 7236.1 7246.3 7297.0 7315.5 3687.2 3714.3 3768.6 3785.2 3890.7 1555.5 1650.2 1728.8 1791.9 1797.6 829.4 881.1 886.7 893.1 895.7 15373.5 16178.7 16207.5 16708.2 17048.5 828.3 837.4 870.2 872.1 887.4 9083.8 9476.1 9507.6 9517.5 9661.8 382777.0 386676.0 401055.0 402510.0 410234.0 75530.9 75998.2 77050.0 77533.0 78844.0 892.5 913.0 924.2 924.4 924.8 14517.4 14683.6 14821.9 14899.3 14963.3 34847.3 35133.6 35905.5 37037.3 37381.4 48315.8 49218.0 49222.3 49864.0 50055.2 7482.5 7537.1 7627.3 7665.7 7709.9 10167.3 10851.0 10866.3 10965.9 11031.3 5830.1 9098.2 9169.4 9324.4 9545.0 9931.7 9970.1 9991.7 10109.3 10156.0 9015.5 9169.0 9319.6 9323.6 9345.0 6588.9 6985.6 7023.4 7147.4 7778.9 7509.4 9152.4 9933.1 9959.6 10088.5 15:18:36 INFO - PROCESS | 22326 | 15:18:36 INFO - PROCESS | 22326 | [#3] mootools.html Cycles:180 Average:5050.17 Median:5779.53 stddev:2867.88 (49.6%) stddev-sans-first:2861.32 15:18:36 INFO - PROCESS | 22326 | Values: 1199.3 1363.9 1389.3 1464.3 1652.9 6609.6 7252.6 7469.9 7489.2 7746.7 7238.9 7325.3 7353.4 7363.4 7365.2 2162.4 2192.8 2193.0 2193.4 2194.9 2100.7 2128.5 2130.2 2132.4 2136.2 2125.4 2144.1 2148.1 2148.6 2169.5 2087.0 2090.4 2093.8 2094.1 2100.7 2082.9 2131.5 2137.6 2138.2 2141.9 7615.1 7658.2 7705.7 7774.9 7995.2 4631.6 4742.7 4764.9 4778.9 4784.5 2833.6 2900.3 2979.1 2980.2 2997.2 898.7 907.4 916.5 924.2 939.0 10762.5 10831.4 10861.3 10882.0 10893.8 4056.8 4139.9 4173.5 4204.7 4214.5 8473.2 8519.1 8546.2 8567.2 8572.0 4667.3 4669.4 4712.2 4712.3 4717.1 3600.1 3736.0 3817.1 4276.7 4352.3 3341.3 3411.1 3448.5 3495.4 3504.9 954.8 965.1 967.2 978.9 983.6 783.8 785.9 813.1 816.0 837.4 5054.6 5172.2 5184.7 5242.7 5302.4 882.5 899.4 911.9 913.6 919.9 3475.7 3546.2 3559.0 3570.5 3606.9 9587.5 9742.2 9841.8 9905.1 9927.4 9422.7 9622.2 9669.4 9718.0 9745.1 7187.4 7307.3 7373.4 7388.4 7404.2 5051.4 5176.5 5235.3 5349.2 5484.5 8730.5 8861.0 9047.7 9077.7 9120.4 8705.4 8939.0 9070.2 9138.3 9161.8 5547.6 6090.3 6263.6 6267.6 6334.7 7318.7 7381.7 7392.1 7410.3 7460.3 6555.4 6767.7 6805.5 6905.8 6951.0 6629.3 6675.8 6686.9 6759.9 6861.1 6011.4 6023.5 6031.1 6106.1 6141.6 4181.6 4225.7 4245.6 4248.2 4256.3 4207.6 4323.6 4349.2 4443.2 4481.1 15:18:36 INFO - PROCESS | 22326 | 15:18:36 INFO - PROCESS | 22326 | [#4] prototype.html Cycles:180 Average:4253.89 Median:4885.94 stddev:1223.04 (25.0%) stddev-sans-first:1189.70 15:18:36 INFO - PROCESS | 22326 | Values: 287.9 299.0 299.2 299.5 301.6 4955.9 4975.8 4983.4 4985.0 5008.9 4904.4 4910.0 4930.3 4930.7 4951.7 3639.9 3744.9 3748.1 3830.6 3870.7 3814.8 3839.4 3843.7 3852.5 3874.3 3806.9 3817.5 3817.6 3836.7 3838.8 3624.3 3702.1 3835.1 3848.7 3856.4 3385.0 3396.9 3398.0 3409.3 3410.7 4786.8 4791.3 4794.7 4797.3 4807.2 4201.9 4385.2 4398.7 4403.5 4426.7 5090.6 5143.9 5156.1 5167.9 5168.5 3716.9 3727.8 3734.7 3735.4 3740.0 5139.8 5355.2 5363.3 5393.6 5425.7 3754.2 3771.7 3782.9 3783.6 3794.4 3832.9 3860.6 3867.7 3869.0 3881.3 4346.2 4377.5 4377.6 4393.3 4415.1 4844.2 5124.9 5131.8 5160.8 5170.9 1325.4 1331.5 1334.8 1344.1 1344.9 848.9 849.6 857.1 865.1 900.7 4445.2 4453.0 4455.7 4497.3 4497.4 5239.7 5244.9 5256.2 5257.4 5283.9 4313.2 4454.7 4484.0 4486.1 4514.8 2815.5 2819.8 2826.9 2827.4 2838.7 4864.7 4867.7 4884.3 4887.5 4895.7 5141.3 5334.1 5350.0 5368.1 5384.2 4878.7 4895.6 4918.4 4923.8 4934.4 5188.3 5213.8 5222.0 5318.8 5330.2 5046.7 5199.3 5207.8 5219.5 5238.6 4960.4 4978.4 4985.8 4997.5 5002.5 3695.6 3774.9 3786.3 3792.1 3805.0 5039.3 5153.9 5218.7 5305.6 5312.5 4987.4 4997.4 5025.5 5032.9 5037.1 4996.9 5009.5 5014.3 5030.3 5032.4 4771.3 4985.0 4994.7 5012.1 5019.5 4903.9 5041.1 5107.3 5176.5 5179.2 5049.4 5058.0 5072.3 5082.0 5089.4 15:18:36 INFO - PROCESS | 22326 | 15:18:36 INFO - PROCESS | 22326 | [#5] yui.html Cycles:180 Average:15988.85 Median:48645.64 stddev:22537.38 (46.3%) stddev-sans-first:22570.80 15:18:36 INFO - PROCESS | 22326 | Values: 551.8 559.6 576.2 581.3 586.4 10940.3 11533.4 11536.1 11553.9 12373.6 14809.6 14912.8 14921.9 14933.0 14933.0 769.2 775.4 778.8 779.1 779.3 612.4 736.1 773.7 778.7 781.9 795.8 798.8 800.1 801.9 804.4 633.5 796.3 796.5 796.6 796.6 557.8 573.8 578.7 579.6 579.6 11956.3 11969.1 11975.6 11984.9 11999.7 10766.8 10825.5 10896.7 10984.8 11651.9 11410.9 11486.7 11724.6 11734.7 11957.5 4006.4 4082.3 4088.2 4112.3 4144.6 48218.5 48517.5 48639.0 48652.3 61219.4 9179.9 9274.3 9396.0 9425.5 9718.9 17849.5 18027.5 18078.1 18803.6 18823.9 6760.0 6760.3 6761.3 6792.2 6822.3 3397.3 3437.5 3467.2 3511.1 3571.7 2620.4 2684.2 2687.2 2688.1 2691.7 456.5 465.3 471.0 473.9 478.4 397.0 447.3 463.0 537.9 570.5 6869.3 7005.3 7122.0 7146.2 7155.7 491.8 505.4 507.7 527.8 532.7 3288.6 3384.8 3398.3 3482.2 3509.7 82689.6 90871.5 92267.5 92769.0 92880.5 47810.5 74036.3 74736.0 75185.1 79920.2 67414.7 67725.7 67798.7 68470.3 68666.7 6611.6 6854.2 6892.7 6938.9 6948.5 31126.8 32368.2 37645.8 38112.0 38686.6 58221.1 58975.7 59028.0 59056.0 59371.4 11091.0 11239.8 11372.5 11551.7 12071.7 10583.5 10662.3 11151.7 11156.1 11490.8 9933.7 10236.1 10537.1 10616.1 10632.1 10213.6 10759.9 11060.3 11064.5 11073.4 10161.4 10718.4 10915.3 10924.8 10947.6 8549.7 8836.8 8943.5 9010.8 9074.2 8996.4 9069.5 9193.4 9282.5 9309.2 15:18:36 INFO - PROCESS | 22326 | -------- Summary: end -------- 15:18:36 INFO - PROCESS | 22326 | 15:18:37 INFO - TEST-INFO | 22326: exit 0 15:18:37 INFO - TEST-OK | dromaeo_css | took 1121933ms 15:18:37 INFO - TEST-START | kraken 15:18:37 INFO - operating with platform_type : linux_ 15:18:37 INFO - Initialising browser for kraken test... 15:18:37 INFO - TEST-INFO | started process 22506 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqWPK3I/profile http://localhost:51762/getInfo.html) 15:18:43 INFO - PROCESS | 22506 | __metrics Screen width/height:1600/1200 15:18:43 INFO - PROCESS | 22506 | colorDepth:24 15:18:43 INFO - PROCESS | 22506 | Browser inner width/height: 1024/697 15:18:43 INFO - PROCESS | 22506 | __metrics 15:18:44 ERROR - PROCESS | 22506 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:18:44 INFO - PROCESS | 22506 | console.error: PushService: 15:18:44 INFO - PROCESS | 22506 | stateChangeProcessEnqueue: Error transitioning state 15:18:44 INFO - PROCESS | 22506 | UnknownError 15:18:45 INFO - TEST-INFO | 22506: exit 0 15:18:45 INFO - Browser initialized. 15:18:45 INFO - Running cycle 1/1 for kraken test... 15:18:45 INFO - TEST-INFO | started process 22586 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqWPK3I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:18:57 INFO - PROCESS | 22586 | RSS: Main: 175689728 15:18:57 INFO - PROCESS | 22586 | 15:19:00 INFO - PROCESS | 22586 | Cycle 1(1): loaded http://localhost:51762/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51762/tests/kraken/driver.html?testName=audio-beat-detection) 15:19:01 INFO - PROCESS | 22586 | RSS: Main: 233058304 15:19:01 INFO - PROCESS | 22586 | 15:19:04 INFO - PROCESS | 22586 | Cycle 1(1): loaded http://localhost:51762/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51762/tests/kraken/driver.html?testName=audio-dft) 15:19:05 INFO - PROCESS | 22586 | RSS: Main: 221859840 15:19:05 INFO - PROCESS | 22586 | 15:19:08 INFO - PROCESS | 22586 | Cycle 1(1): loaded http://localhost:51762/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51762/tests/kraken/driver.html?testName=audio-fft) 15:19:08 INFO - PROCESS | 22586 | RSS: Main: 287354880 15:19:08 INFO - PROCESS | 22586 | 15:19:11 INFO - PROCESS | 22586 | Cycle 1(1): loaded http://localhost:51762/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51762/tests/kraken/driver.html?testName=audio-oscillator) 15:19:11 INFO - PROCESS | 22586 | RSS: Main: 198086656 15:19:11 INFO - PROCESS | 22586 | 15:19:13 INFO - PROCESS | 22586 | Cycle 1(1): loaded http://localhost:51762/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51762/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:19:14 INFO - PROCESS | 22586 | RSS: Main: 201945088 15:19:14 INFO - PROCESS | 22586 | 15:19:17 INFO - PROCESS | 22586 | Cycle 1(1): loaded http://localhost:51762/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51762/tests/kraken/driver.html?testName=imaging-darkroom) 15:19:18 INFO - PROCESS | 22586 | RSS: Main: 238047232 15:19:18 INFO - PROCESS | 22586 | 15:19:21 INFO - PROCESS | 22586 | Cycle 1(1): loaded http://localhost:51762/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51762/tests/kraken/driver.html?testName=imaging-desaturate) 15:19:22 INFO - PROCESS | 22586 | RSS: Main: 233947136 15:19:22 INFO - PROCESS | 22586 | 15:19:25 INFO - PROCESS | 22586 | Cycle 1(1): loaded http://localhost:51762/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51762/tests/kraken/driver.html?testName=json-parse-financial) 15:19:26 INFO - PROCESS | 22586 | RSS: Main: 237027328 15:19:26 INFO - PROCESS | 22586 | 15:19:27 INFO - PROCESS | 22586 | Cycle 1(1): loaded http://localhost:51762/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51762/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:19:28 INFO - PROCESS | 22586 | RSS: Main: 222388224 15:19:28 INFO - PROCESS | 22586 | 15:19:30 INFO - PROCESS | 22586 | Cycle 1(1): loaded http://localhost:51762/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51762/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:19:30 INFO - PROCESS | 22586 | RSS: Main: 227291136 15:19:30 INFO - PROCESS | 22586 | 15:19:32 INFO - PROCESS | 22586 | Cycle 1(1): loaded http://localhost:51762/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51762/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:19:33 INFO - PROCESS | 22586 | RSS: Main: 234618880 15:19:33 INFO - PROCESS | 22586 | 15:19:36 INFO - PROCESS | 22586 | Cycle 1(1): loaded http://localhost:51762/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51762/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:19:37 INFO - PROCESS | 22586 | RSS: Main: 240771072 15:19:37 INFO - PROCESS | 22586 | 15:19:39 INFO - PROCESS | 22586 | Cycle 1(1): loaded http://localhost:51762/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51762/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:19:40 INFO - PROCESS | 22586 | RSS: Main: 240463872 15:19:40 INFO - PROCESS | 22586 | 15:19:42 INFO - PROCESS | 22586 | Cycle 1(1): loaded http://localhost:51762/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51762/tests/kraken/driver.html?testName=ai-astar) 15:19:42 INFO - PROCESS | 22586 | RSS: Main: 282877952 15:19:42 INFO - PROCESS | 22586 | 15:19:42 INFO - PROCESS | 22586 | __start_tp_report 15:19:42 INFO - PROCESS | 22586 | _x_x_mozilla_page_load 15:19:42 INFO - PROCESS | 22586 | _x_x_mozilla_page_load_details 15:19:42 INFO - PROCESS | 22586 | |i|pagename|runs| 15:19:42 INFO - PROCESS | 22586 | |0;ai-astar;112;107;113;114;112;113;113;113;115;113 15:19:42 INFO - PROCESS | 22586 | |1;audio-beat-detection;155;138;139;180;139;159;165;141;201;130 15:19:42 INFO - PROCESS | 22586 | |2;audio-dft;161;161;162;161;162;162;162;160;161;162 15:19:42 INFO - PROCESS | 22586 | |3;audio-fft;76;76;76;126;76;77;77;75;98;77 15:19:42 INFO - PROCESS | 22586 | |4;audio-oscillator;85;87;115;86;88;87;116;85;87;117 15:19:42 INFO - PROCESS | 22586 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 15:19:42 INFO - PROCESS | 22586 | |6;imaging-darkroom;147;146;145;146;145;146;146;146;146;145 15:19:42 INFO - PROCESS | 22586 | |7;imaging-desaturate;94;97;94;95;94;94;95;94;94;94 15:19:42 INFO - PROCESS | 22586 | |8;json-parse-financial;63;62;63;63;64;63;62;64;63;63 15:19:42 INFO - PROCESS | 22586 | |9;json-stringify-tinderbox;66;66;66;66;69;64;66;64;65;65 15:19:42 INFO - PROCESS | 22586 | |10;stanford-crypto-aes;83;83;83;82;86;90;85;86;120;84 15:19:42 INFO - PROCESS | 22586 | |11;stanford-crypto-ccm;131;133;131;134;128;129;130;129;134;133 15:19:42 INFO - PROCESS | 22586 | |12;stanford-crypto-pbkdf2;168;168;169;167;167;165;167;166;167;164 15:19:42 INFO - PROCESS | 22586 | |13;stanford-crypto-sha256-iterative;67;71;66;68;68;67;66;66;66;67 15:19:42 INFO - PROCESS | 22586 | __end_tp_report 15:19:42 INFO - PROCESS | 22586 | __start_cc_report 15:19:42 INFO - PROCESS | 22586 | _x_x_mozilla_cycle_collect,1903 15:19:42 INFO - PROCESS | 22586 | __end_cc_report 15:19:42 INFO - PROCESS | 22586 | __startTimestamp1465769982536__endTimestamp 15:19:42 INFO - PROCESS | 22586 | 15:19:42 INFO - PROCESS | 22586 | ------- Summary: start ------- 15:19:42 INFO - PROCESS | 22586 | Number of tests: 14 15:19:42 INFO - PROCESS | 22586 | 15:19:42 INFO - PROCESS | 22586 | [#0] ai-astar Cycles:10 Average:112.50 Median:113.00 stddev:2.12 (1.9%) stddev-sans-first:2.24 15:19:42 INFO - PROCESS | 22586 | Values: 112.0 107.0 113.0 114.0 112.0 113.0 113.0 113.0 115.0 113.0 15:19:42 INFO - PROCESS | 22586 | 15:19:42 INFO - PROCESS | 22586 | [#1] audio-beat-detection Cycles:10 Average:154.70 Median:157.00 stddev:22.31 (14.2%) stddev-sans-first:23.66 15:19:42 INFO - PROCESS | 22586 | Values: 155.0 138.0 139.0 180.0 139.0 159.0 165.0 141.0 201.0 130.0 15:19:42 INFO - PROCESS | 22586 | 15:19:42 INFO - PROCESS | 22586 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.70 (0.4%) stddev-sans-first:0.73 15:19:42 INFO - PROCESS | 22586 | Values: 161.0 161.0 162.0 161.0 162.0 162.0 162.0 160.0 161.0 162.0 15:19:42 INFO - PROCESS | 22586 | 15:19:42 INFO - PROCESS | 22586 | [#3] audio-fft Cycles:10 Average:83.40 Median:76.50 stddev:16.47 (21.5%) stddev-sans-first:17.25 15:19:42 INFO - PROCESS | 22586 | Values: 76.0 76.0 76.0 126.0 76.0 77.0 77.0 75.0 98.0 77.0 15:19:42 INFO - PROCESS | 22586 | 15:19:42 INFO - PROCESS | 22586 | [#4] audio-oscillator Cycles:10 Average:95.30 Median:86.50 stddev:14.32 (16.6%) stddev-sans-first:14.70 15:19:42 INFO - PROCESS | 22586 | Values: 85.0 87.0 115.0 86.0 88.0 87.0 116.0 85.0 87.0 117.0 15:19:42 INFO - PROCESS | 22586 | 15:19:42 INFO - PROCESS | 22586 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 15:19:42 INFO - PROCESS | 22586 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 15:19:42 INFO - PROCESS | 22586 | 15:19:42 INFO - PROCESS | 22586 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 15:19:42 INFO - PROCESS | 22586 | Values: 147.0 146.0 145.0 146.0 145.0 146.0 146.0 146.0 146.0 145.0 15:19:42 INFO - PROCESS | 22586 | 15:19:42 INFO - PROCESS | 22586 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.00 stddev:0.97 (1.0%) stddev-sans-first:1.01 15:19:42 INFO - PROCESS | 22586 | Values: 94.0 97.0 94.0 95.0 94.0 94.0 95.0 94.0 94.0 94.0 15:19:42 INFO - PROCESS | 22586 | 15:19:42 INFO - PROCESS | 22586 | [#8] json-parse-financial Cycles:10 Average:63.00 Median:63.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 15:19:42 INFO - PROCESS | 22586 | Values: 63.0 62.0 63.0 63.0 64.0 63.0 62.0 64.0 63.0 63.0 15:19:42 INFO - PROCESS | 22586 | 15:19:42 INFO - PROCESS | 22586 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:1.42 (2.1%) stddev-sans-first:1.50 15:19:42 INFO - PROCESS | 22586 | Values: 66.0 66.0 66.0 66.0 69.0 64.0 66.0 64.0 65.0 65.0 15:19:42 INFO - PROCESS | 22586 | 15:19:42 INFO - PROCESS | 22586 | [#10] stanford-crypto-aes Cycles:10 Average:88.20 Median:84.50 stddev:11.41 (13.5%) stddev-sans-first:11.95 15:19:42 INFO - PROCESS | 22586 | Values: 83.0 83.0 83.0 82.0 86.0 90.0 85.0 86.0 120.0 84.0 15:19:42 INFO - PROCESS | 22586 | 15:19:42 INFO - PROCESS | 22586 | [#11] stanford-crypto-ccm Cycles:10 Average:131.20 Median:132.00 stddev:2.20 (1.7%) stddev-sans-first:2.33 15:19:42 INFO - PROCESS | 22586 | Values: 131.0 133.0 131.0 134.0 128.0 129.0 130.0 129.0 134.0 133.0 15:19:42 INFO - PROCESS | 22586 | 15:19:42 INFO - PROCESS | 22586 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.80 Median:167.00 stddev:1.48 (0.9%) stddev-sans-first:1.50 15:19:42 INFO - PROCESS | 22586 | Values: 168.0 168.0 169.0 167.0 167.0 165.0 167.0 166.0 167.0 164.0 15:19:42 INFO - PROCESS | 22586 | 15:19:42 INFO - PROCESS | 22586 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:1.55 (2.3%) stddev-sans-first:1.64 15:19:42 INFO - PROCESS | 22586 | Values: 67.0 71.0 66.0 68.0 68.0 67.0 66.0 66.0 66.0 67.0 15:19:42 INFO - PROCESS | 22586 | -------- Summary: end -------- 15:19:42 INFO - PROCESS | 22586 | 15:19:43 INFO - TEST-INFO | 22586: exit 0 15:19:43 INFO - TEST-OK | kraken | took 65997ms 15:19:43 INFO - SUITE-END | took 1187s 15:19:43 INFO - Completed test suite (00:19:48) 15:19:43 INFO - javascript benchmark 15:19:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2612.908548200813, 2634.1965700461374, 2643.2334622959343, 2646.07387414405, 2663.560512515435, 4636.930446043312, 4724.551167639069, 4734.4792072872, 4793.1132740443045, 4850.927236091457, 4735.242361222206, 4743.786529606167, 4749.810007599692, 4767.809287628491, 4789.233722604384, 4298.032942587916, 4311.2024275508975, 4364.67264955128, 4398.626116780061, 4524.751138687371, 4417.315316126005, 4436.44544431946, 4455.153520831048, 4456.286994080948, 4498.865034048984, 4217.894552636178, 4273.1240095780295, 4334.631556317717, 4359.149965756678, 4404.977975110136, 4341.088371442001, 4357.128574285156, 4386.385905973167, 4392.165488557164, 4396.494403143615, 4373.387725718402, 4374.868753937387, 4375.628071613916, 4402.8679139625865, 4410.713303635285, 4536.841210557614, 4762.57136857681, 4838.129136755382, 4839.395075615548, 4877.51224877513, 5133.486651334874, 5137.178051511778, 5200.583953283728, 5201.9479805201845, 5202.97398513005, 4910.7299098549565, 5194.142966410538, 5203.843884683465, 5238.816641417532, 5241.397239317489, 4645.628349732047, 4721.929171062437, 4737.8104875805275, 4738.336632871401, 4764.499727528629, 5235.110031294689, 5245.239440281138, 5246.186841039645, 5246.947530524722, 5248.396434410091, 4873.926891096637, 4948.653594248368, 5061.873453163626, 5068.923966140511, 5073.1122053640465, 5018.698878067327, 5055.620828437882, 5077.898442031213, 5079.644424890296, 5115.948840511547, 4996.800127994912, 4997.25041243809, 4997.525235102659, 5016.5485106339875, 5046.142155833517, 4767.856964291077, 4962.975185124052, 4963.329950456642, 4977.427595826526, 4994.275830004702, 4316.115196384733, 4319.67602429819, 4320.941369364526, 4346.348047792793, 4356.172327257811, 3787.299349620329, 3807.638274363931, 3816.160444702161, 3844.4233364994916, 3844.59631738669, 4230.386593943923, 4276.037891474393, 4365.628921541641, 4371.453568303962, 4404.867853964386, 5148.6910785353, 5172.818951336685, 5175.14610089331, 5177.58579313654, 5211.1922651989, 4413.668974826901, 4418.536053714313, 4418.64650827933, 4448.688591798607, 4463.397441345442, 4457.3091170868565, 4538.478075021415, 4572.291294849238, 4580.931286030712, 4639.536046395401, 4744.098621262087, 4759.857204283877, 4773.236282194832, 4774.976125119491, 4809.975950120367, 5039.697618142924, 5041.369828771403, 5045.62157838171, 5074.873128171826, 5104.770285337095, 4596.724196548218, 4780.211265141352, 4838.685485443435, 4844.927326090041, 4909.140900342497, 5055.317532133115, 5069.670471419346, 5070.03669302846, 5082.2122571001555, 5129.692218466904, 5145.279660847559, 5154.690718556899, 5159.355080614923, 5159.793608255628, 5163.148080566814, 4725.740084295397, 4913.533214344631, 4916.901661966812, 4917.164082106122, 4920.21276595743, 4906.8773280668265, 4910.288960828521, 4922.335484709519, 4942.728149951788, 4960.727160006234, 4720.961388494526, 4873.439554451284, 4881.09765171582, 4886.0, 4940.950590494049, 4985.551300382983, 5002.52476014778, 5022.171341728574, 5032.899342013066, 5046.899062018666, 4933.605311574994, 4937.333459982857, 4939.135651261086, 4943.3573635427165, 4995.275685025724], "value": 4674.001240764075, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.1150261343612, 583.786917775012, 591.0366103251702, 592.0763608770321, 600.9188759517464, 28146.718532814666, 40225.3966190507, 41863.58136418635, 41883.371749423706, 45707.0, 41952.0, 42595.14809703804, 42618.0, 42650.360244596355, 42690.359644605276, 7445.181030086686, 7803.960980195091, 7947.642356093989, 7954.443188976774, 7955.761327160194, 9851.40891546506, 10132.189424845994, 10135.138513226384, 10421.426821524814, 10426.791464170712, 10186.847197292047, 10299.948500257487, 10304.484775761219, 10306.536205870754, 10309.53607087683, 7557.886631700529, 9918.90081099187, 10132.696019119438, 10192.694219173436, 10198.0, 9981.80036399268, 10059.245556583286, 10075.496225188712, 10085.647002354955, 10093.798124037552, 39625.60374396277, 39965.20069598592, 40006.0, 40008.199836003114, 40055.39916901249, 2961.8370989595564, 3115.252339438541, 3156.494960806283, 3219.9034028979167, 3300.933981320384, 30595.0, 31025.8448707755, 31039.0, 31088.222794430094, 31361.84319078413, 3176.896745873165, 3199.7054081490514, 3209.6950789674943, 3275.894716909678, 3281.96718032819, 245074.0, 246033.0, 246233.0, 246392.76803616047, 246475.0, 54667.0, 55482.0, 55528.44471555314, 55563.0, 55635.0, 33147.66852331446, 34211.65788342134, 34214.48678269828, 35934.64065359313, 59653.70173149106, 14655.560333190022, 14710.190939498216, 14812.0, 14818.33317500715, 14855.034422762486, 9957.701268961942, 10988.835167472495, 11171.106311495061, 11421.714457138472, 11471.598494052669, 18568.164432600566, 18645.440636780917, 18683.813161868205, 18767.3431429902, 18768.906155469136, 6776.254611992776, 6784.966075169691, 6961.443084553223, 7026.402755765715, 7137.536060156073, 772.4901564967095, 864.446754077391, 869.6608322754131, 952.7332346942867, 960.9429627409793, 27814.3046423841, 28336.43327133446, 29046.0, 29134.417311653648, 29158.562621560694, 933.3466573398648, 962.7689354554857, 989.2333441582831, 995.8605795188679, 1000.7498125468633, 14834.703305933821, 15048.247587620575, 15157.0, 15188.924055379652, 15243.923780381027, 360245.0, 361745.0, 363523.0, 364144.0, 365054.0, 49604.0, 50055.24917126246, 50079.49920500749, 50085.0, 50201.24698129531, 1061.628430049492, 1171.2328424881716, 1202.7233736240714, 1214.4170798017178, 1222.7432239229684, 28940.276493087, 29034.0, 29405.411891761618, 29887.55168672428, 29949.55075673823, 42506.14987700291, 42813.785931070146, 42997.785011074746, 43105.13789724251, 43109.0, 289398.0, 289796.0, 290078.0, 293089.0, 293497.0, 22283.885805709975, 22597.774022259568, 23082.884585576965, 23153.65269520925, 25840.0, 42817.0, 43184.35223471588, 43461.130777383645, 43952.34071488866, 44127.558724413626, 35690.46464303089, 36479.27041459103, 36796.26407471889, 37020.25959480849, 37225.627743722216, 36004.819975901, 37029.25941481209, 37146.0, 37202.9076801557, 37280.254394912496, 35530.467042993856, 36078.0, 37155.62844371521, 37193.0, 37268.0, 31000.0, 33297.66702332946, 33336.83331583327, 33494.33011339711, 33634.831825840716, 25013.249602511954, 25446.0, 25524.0, 25788.742112578635, 25816.741832581432], "value": 17947.763276312264, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.11647938393713, 356.54362416107375, 360.9837557309921, 374.93438648236554, 375.99624003759953, 16152.515424537269, 16249.512514624565, 17299.481015569523, 17398.82601173988, 17433.21550530226, 16122.274497647604, 16359.0, 16595.585110372245, 16821.41125060623, 16845.4104106356, 4817.662763606549, 5027.396712394518, 5074.0, 5075.137226671456, 5075.873103172414, 2704.7836173106202, 2838.6877443481303, 4983.252512123175, 5335.5198032177095, 5659.688717120557, 5665.830025099253, 5679.375268720438, 5681.403452637475, 5689.886202275952, 5697.886042279152, 5539.806106786264, 5674.404187560309, 5836.795712150097, 5839.211706419622, 5885.970570147122, 5062.873428164288, 5094.490550944913, 5112.207607820794, 5126.333576635051, 5133.691978481265, 19282.903585482123, 19890.602187956305, 20081.698774518394, 20112.497187570283, 20340.389788306373, 1890.1116475256608, 1903.5526651236949, 1964.5972575621963, 1996.9201231950703, 2515.1448507507534, 12210.694732631666, 12746.36268186587, 12940.094193406465, 13201.087253591537, 13322.733545329136, 1627.096961186541, 1685.6881476926685, 1742.7037403641411, 1791.5073354827396, 1810.2125575374755, 65956.67021664909, 67380.66309668469, 67602.0, 67871.32128678748, 68460.0, 7979.960100199578, 8533.829323413496, 8702.303815694855, 8762.649494020296, 8994.685186018458, 11580.073594112451, 11669.183157179086, 11689.18175727708, 11726.179167458367, 11748.530058797553, 6948.6178260195165, 7008.894866577006, 7055.753048643272, 7190.137183538009, 7195.784126476214, 7187.928120718726, 7236.131664200329, 7246.275372462817, 7296.963515182496, 7315.487915845946, 3687.225682606629, 3714.3499887520115, 3768.6419790119894, 3785.2051069275763, 3890.6692931101175, 1555.5488908216491, 1650.2326418215587, 1728.8271172882612, 1791.8835275707038, 1797.604527004057, 829.3531045784298, 881.0968757024101, 886.742844575066, 893.0801274687083, 895.7268033249791, 15373.538793836204, 16178.67642647164, 16207.513774586781, 16708.24812883423, 17048.48854534366, 828.3368968765448, 837.4012581004611, 870.1950695606539, 872.1322284327135, 887.3921363865644, 9083.81832363349, 9476.052394760607, 9507.57215925285, 9517.476538790295, 9661.806763864683, 382777.0, 386676.0, 401055.0, 402510.0, 410234.0, 75530.89382123598, 75998.24001760023, 77050.0, 77533.0, 78844.0, 892.5403417240127, 912.9726108216764, 924.2236521322121, 924.408378637659, 924.7734305095295, 14517.374517374434, 14683.632909177357, 14821.851781482048, 14899.329530171384, 14963.32665030098, 34847.303053938274, 35133.648663513035, 35905.46141807823, 37037.25925481421, 37381.43927841139, 48315.75842120907, 49218.0, 49222.26166607432, 49864.00271994467, 50055.24917126319, 7482.476226664081, 7537.057867766529, 7627.275408836152, 7665.6550455228535, 7709.922900770921, 10167.339122956984, 10851.0, 10866.348019118877, 10965.945170274097, 11031.338119712844, 5830.096335068071, 9098.226650734761, 9169.40398874071, 9324.440533568008, 9544.952275238857, 9931.702048938254, 9970.052844979715, 9991.700248992542, 10109.34289271195, 10156.0, 9015.504147271962, 9168.954155229181, 9319.58061887203, 9323.627054917999, 9344.97205307402, 6588.901166482602, 6985.5808651481075, 7023.403010743939, 7147.428205743632, 7778.883316750366, 7509.399248060251, 9152.359334846764, 9933.056359645821, 9959.601615935282, 10088.495575221063], "value": 7966.438190120611, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1199.2864245773762, 1363.9386227619757, 1389.3400634698519, 1464.2532308522657, 1652.9090900000504, 6609.603423794576, 7252.601106939116, 7469.887951680722, 7489.176190619041, 7746.690132394698, 7238.855222895539, 7325.267473252672, 7353.448491363142, 7363.374113200371, 7365.226651201627, 2162.362103179558, 2192.8465007449486, 2193.0, 2193.396815875631, 2194.901229444679, 2100.663893776996, 2128.5104425982036, 2130.2437634639714, 2132.4135862637745, 2136.177571634916, 2125.4155107345528, 2144.0673307111456, 2148.1085349579907, 2148.6132496150685, 2169.533550286688, 2086.9582608347823, 2090.4042347930845, 2093.769685334612, 2094.1204694028543, 2100.6743954686895, 2082.864613800113, 2131.5204079082237, 2137.5724855029057, 2138.2409244718056, 2141.925032623866, 7615.124260710034, 7658.195889431641, 7705.653245603961, 7774.922250777533, 7995.200479952016, 4631.62946964242, 4742.668013239075, 4764.904701905977, 4778.928316075262, 4784.497627749071, 2833.5891295762203, 2900.3329234276025, 2979.0913771299747, 2980.165553644983, 2997.2357048952595, 898.6899519665704, 907.3920473282916, 916.4913473022469, 924.2098006204666, 938.9624415023391, 10762.515686794113, 10831.404272764994, 10861.3483191008, 10882.020618144326, 10893.83659245104, 4056.7768772717195, 4139.91720165595, 4173.52004519478, 4204.747715137101, 4214.473190851144, 8473.195046470575, 8519.062903080656, 8546.188112129337, 8567.186117318844, 8572.014218364842, 4667.323238130452, 4669.4396672399525, 4712.222483290218, 4712.340272361872, 4717.127331443694, 3600.0819790953137, 3736.0, 3817.064819119278, 4276.657867370603, 4352.347147927836, 3341.348437054751, 3411.096059544223, 3448.5344478495585, 3495.405781017233, 3504.929901402009, 954.7613096725819, 965.0687086961116, 967.1634036558467, 978.9265805064506, 983.6458874805064, 783.7962129846281, 785.9350579964066, 813.1218284252992, 815.967361305553, 837.4263629413871, 5054.620903432257, 5172.172452407597, 5184.714840683723, 5242.685438873604, 5302.390225124083, 882.4837470079947, 899.4243684042087, 911.8814554107923, 913.6117150211267, 919.9264058875274, 3475.739319551044, 3546.184377593168, 3558.9644103558635, 3570.535830342039, 3606.927861442809, 9587.472689002032, 9742.171915387271, 9841.753956151153, 9905.05901939329, 9927.354721943051, 9422.717318480456, 9622.230221582256, 9669.419834809934, 9717.951410242904, 9745.12293893553, 7187.38907192884, 7307.3423391894985, 7373.410127189812, 7388.408927285805, 7404.222556631584, 5051.4443411225475, 5176.534111929945, 5235.345581802275, 5349.1976203569775, 5484.533814625802, 8730.476171429735, 8861.0, 9047.68333108338, 9077.68228112013, 9120.361574689709, 8705.434146780439, 8939.0, 9070.229030532479, 9138.314626402913, 9161.77095572616, 5547.639403438763, 6090.299615544269, 6263.561550691408, 6267.592606480564, 6334.683265836782, 7318.6706598202145, 7381.741639042608, 7392.149902761252, 7410.333070023724, 7460.328570428687, 6555.3772391622715, 6767.695453704497, 6805.4895882808, 6905.827354316182, 6951.0, 6629.303923088007, 6675.766348177791, 6686.866262674622, 6759.898601521079, 6861.073755043005, 6011.428914253139, 6023.488003519575, 6031.065184896348, 6106.145139680537, 6141.570090093829, 4181.623653871166, 4225.746455212697, 4245.639120674778, 4248.171606536695, 4256.3189889617515, 4207.579242075891, 4323.567643235777, 4349.173657005159, 4443.200223959719, 4481.103779244229], "value": 4048.553722531471, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.8776519979009, 299.00729577801695, 299.15936219223994, 299.49236044903887, 301.6214650613481, 4955.900881982363, 4975.8258460953875, 4983.401991760994, 4984.950150498494, 5008.874778130548, 4904.386951631046, 4909.975450122744, 4930.260460930853, 4930.654854160211, 4951.746955135413, 3639.927201455976, 3744.9251014979686, 3748.0629842539365, 3830.6360895715, 3870.7290489665734, 3814.771113733171, 3839.3856982882744, 3843.673287770543, 3852.460655508231, 3874.341361968458, 3806.8667596634123, 3817.522809648794, 3817.618238176174, 3836.6547010769027, 3838.750481218726, 3624.2932628137523, 3702.148505843671, 3835.137094153793, 3848.749831260959, 3856.3636999894984, 3385.0, 3396.9490457643155, 3398.0, 3409.335179639971, 3410.7271418286477, 4786.760661966922, 4791.2813078038225, 4794.688345257582, 4797.280407938802, 4807.158747219258, 4201.894952626179, 4385.166818304544, 4398.73607583546, 4403.471583410012, 4426.7122637028815, 5090.592752579785, 5143.922841157386, 5156.123459011977, 5167.870803229912, 5168.483151684839, 3716.9070773230615, 3727.8322475488667, 3734.73856830022, 3735.402335626287, 3739.9626003739886, 5139.768710408003, 5355.161764264946, 5363.275957745694, 5393.622446428752, 5425.701586412746, 3754.2303827715255, 3771.6794072503594, 3782.924341513154, 3783.621637836249, 3794.354959656865, 3832.865849695247, 3860.575336712959, 3867.6712479439, 3869.032741814546, 3881.3207688654375, 4346.21768081742, 4377.4965878923695, 4377.562243775597, 4393.319035549495, 4415.072834704683, 4844.2007068833245, 5124.871878203, 5131.820386286462, 5160.767765450564, 5170.922436163461, 1325.389651573343, 1331.4607583928525, 1334.8464926533572, 1344.1397505596426, 1344.9193048417126, 848.898132224137, 849.6431498770531, 857.1257317536079, 865.1219012702112, 900.7252787899754, 4445.155420470101, 4452.977735111303, 4455.710378825366, 4497.268551607654, 4497.370368148462, 5239.659422137625, 5244.947550524446, 5256.211568264791, 5257.447967963309, 5283.920741188886, 4313.180495705806, 4454.728088674799, 4483.977580112079, 4486.147631949919, 4514.781009127517, 2815.5354366529295, 2819.8167119137192, 2826.943461130766, 2827.377976845091, 2838.7445129938405, 4864.683795553277, 4867.707937523689, 4884.340614017134, 4887.535684110004, 4895.681780684244, 5141.2545180948555, 5334.146536554133, 5350.0, 5368.147988943808, 5384.246205531229, 4878.707277563358, 4895.583875370633, 4918.360613120271, 4923.75381230937, 4934.432540257844, 5188.299579556862, 5213.765380557808, 5222.0, 5318.79270102903, 5330.173823057432, 5046.747662616928, 5199.272101905812, 5207.791688332424, 5219.5029330348, 5238.580913526985, 4960.404751429707, 4978.377702787152, 4985.825496107619, 4997.450280469218, 5002.52476014778, 3695.6119607441906, 3774.8675397380125, 3786.3373909565166, 3792.1088544192644, 3805.0, 5039.3448851649055, 5153.871153221199, 5218.66078704883, 5305.628605997697, 5312.521873031291, 4987.401511818605, 4997.425296090851, 5025.497450254945, 5032.874178145576, 5037.093323201859, 4996.875078123076, 5009.524095210949, 5014.297998280171, 5030.3148445271245, 5032.446430892672, 4771.308636584653, 4984.975075124601, 4994.650374473752, 5012.122878496321, 5019.52314530119, 4903.901921961612, 5041.1430056889685, 5107.310513080686, 5176.456472070529, 5179.229112424835, 5049.368828896388, 5057.951529630505, 5072.289879416959, 5081.976224146627, 5089.414717307557], "value": 3863.2030705796774, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.8151419274542, 559.602682095712, 576.2336092996316, 581.3343721438949, 586.4135864135864, 10940.288881222725, 11533.423328833556, 11536.077113830894, 11553.942230288858, 12373.628791136258, 14809.555713328591, 14912.776308355384, 14921.92539037306, 14933.0, 14933.0, 769.242296338108, 775.3990657240655, 778.7702627724807, 779.1157036763286, 779.3180966654178, 612.3967891626744, 736.135041326442, 773.7021246819959, 778.715768744407, 781.9061712594469, 795.7930937956144, 798.8202654402771, 800.131856935223, 801.887735717, 804.3685706720225, 633.4868756307405, 796.295278678368, 796.5459687977855, 796.5618909599726, 796.6415113199083, 557.8075563930438, 573.7618888161408, 578.7222133376004, 579.568221674855, 579.5942840012009, 11956.342401167933, 11969.102317326147, 11975.580854670045, 11984.880151198464, 11999.700007499796, 10766.838497422545, 10825.458727063695, 10896.673099807018, 10984.835227471594, 11651.94174029133, 11410.885891141066, 11486.655400338002, 11724.589639362666, 11734.706632334175, 11957.521699132025, 4006.399040144002, 4082.3468245080644, 4088.1619268050276, 4112.280350938574, 4144.564820693814, 48218.51781482175, 48517.514824852005, 48639.0, 48652.27021594679, 61219.38780612181, 9179.908200918038, 9274.30442716799, 9395.953020234854, 9425.481598512148, 9718.854217186748, 17849.46451606428, 18027.549311267325, 18078.09609519519, 18803.623927521374, 18823.90588047051, 6760.019797129388, 6760.290169532227, 6761.256261811197, 6792.150981127359, 6822.317768223138, 3397.2695870387493, 3437.5359326491102, 3467.219875527986, 3511.1046683096156, 3571.6964058055355, 2620.4366061296914, 2684.154491335223, 2687.1535466328046, 2688.1129227354927, 2691.650085488913, 456.51153266005053, 465.2764950502002, 470.99764501177276, 473.8838984448763, 478.4450037955954, 396.97221194516686, 447.28211220990494, 462.9514150449235, 537.8758394954564, 570.5321636258311, 6869.278725733826, 7005.334493223136, 7122.0, 7146.2496437874315, 7155.67799449026, 491.8401519506175, 505.4010996968604, 507.73502578341487, 527.8099884041742, 532.6910391972647, 3288.621808492006, 3384.7799893006877, 3398.2523844754114, 3482.233908540117, 3509.701675357623, 82689.58655206686, 90871.54564227269, 92267.53866230627, 92769.0, 92880.53559732158, 47810.521894780606, 74036.25963740401, 74736.0, 75185.11296765693, 79920.20079799244, 67414.66292668505, 67725.66137169283, 67798.66100669465, 68470.3152968464, 68666.65666671634, 6611.603303801788, 6854.177498700188, 6892.724291028303, 6938.895916561155, 6948.5483443576, 31126.844365778026, 32368.190795230308, 37645.81177094097, 38112.0, 38686.613133868304, 58221.126683100636, 58975.705121474115, 59028.0, 59056.0, 59371.40628593831, 11091.0, 11239.775204496027, 11372.545098196311, 11551.653450396501, 12071.698207544881, 10583.5237414315, 10662.25364224528, 11151.665450036511, 11156.10751139923, 11490.77018459643, 9933.701988940344, 10236.129928955825, 10537.104346130358, 10616.097631701392, 10632.096271816983, 10213.591456341663, 10759.89240107589, 11060.336379817236, 11064.455175309562, 11073.390963497084, 10161.441120738431, 10718.410487423267, 10915.345079295268, 10924.836127457935, 10947.616833410792, 8549.743507694779, 8836.779080522781, 8943.508107054175, 9010.774730631787, 9074.228690561376, 8996.415233009833, 9069.546522673973, 9193.448393096436, 9282.535873206447, 9309.20871725911], "value": 6063.569072312935, "unit": "score"}], "name": "dromaeo_css", "value": 6314.392340009365, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 107.0, 113.0, 114.0, 112.0, 113.0, 113.0, 113.0, 115.0, 113.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 138.0, 139.0, 180.0, 139.0, 159.0, 165.0, 141.0, 201.0, 130.0], "value": 154.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 161.0, 162.0, 162.0, 162.0, 160.0, 161.0, 162.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 126.0, 76.0, 77.0, 77.0, 75.0, 98.0, 77.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 115.0, 86.0, 88.0, 87.0, 116.0, 85.0, 87.0, 117.0], "value": 95.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 97.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 63.0, 64.0, 63.0, 62.0, 64.0, 63.0, 63.0], "value": 63.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 69.0, 64.0, 66.0, 64.0, 65.0, 65.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 82.0, 86.0, 90.0, 85.0, 86.0, 120.0, 84.0], "value": 88.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 133.0, 131.0, 134.0, 128.0, 129.0, 130.0, 129.0, 134.0, 133.0], "value": 131.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 168.0, 169.0, 167.0, 167.0, 165.0, 167.0, 166.0, 167.0, 164.0], "value": 166.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 66.0, 68.0, 68.0, 67.0, 66.0, 66.0, 66.0, 67.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1546.7, "alertThreshold": 2.0}]} 15:19:43 INFO - Return code: 0 15:19:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:19:43 ERROR - # TBPL SUCCESS # 15:19:43 INFO - Running post-action listener: _resource_record_post_action 15:19:43 INFO - ##### 15:19:43 INFO - ##### Finished run-tests step (success) 15:19:43 INFO - ##### 15:19:43 INFO - Running post-run listener: _resource_record_post_run 15:19:43 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 8192; Write bytes: 532336640; Read time: 936; Write time: 2358080 15:19:43 INFO - TinderboxPrint: CPU usage
13.4% 15:19:43 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 936 15:19:43 INFO - TinderboxPrint: I/O write bytes / time
532,336,640 / 2,358,080 15:19:43 INFO - TinderboxPrint: CPU idle
8,323.1 (86.5%) 15:19:43 INFO - TinderboxPrint: CPU user
1,215.0 (12.6%) 15:19:43 INFO - TinderboxPrint: Swap in / out
0 / 0 15:19:43 INFO - install - Wall time: 16s; CPU: 28.0%; Read bytes: 0; Write bytes: 239513600; Read time: 0; Write time: 1468364 15:19:43 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 8192; Write bytes: 292823040; Read time: 936; Write time: 889716 15:19:44 INFO - Running post-run listener: _upload_blobber_files 15:19:44 INFO - Blob upload gear active. 15:19:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:19:44 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 15:19:44 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'] 15:19:44 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 15:19:44 INFO - (blobuploader) - INFO - Open directory for files ... 15:19:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:19:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:19:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:19:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:19:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:19:45 INFO - (blobuploader) - INFO - Done attempting. 15:19:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:19:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:19:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:19:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:19:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:19:49 INFO - (blobuploader) - INFO - Done attempting. 15:19:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:19:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:19:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:19:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:19:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:19:50 INFO - (blobuploader) - INFO - Done attempting. 15:19:50 INFO - (blobuploader) - INFO - Iteration through files over. 15:19:50 INFO - Return code: 0 15:19:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:19:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:19:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eac34d9ce381e46e40df44d14fec56452abcdab8f92fe604744250c2cd1d89270ab8b22769a8e1f633e06673bee2f45795c57964161cd0bb974390e5ff0ea990", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/90b28e90fe89a65101a2b5a18c36c141d267420b89e7ab4b2afc49a8c21cb74ce1eeb953c2ea321cb6c6b05f076733fe864958190aa50cb8e865be408e67f363", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/277beab71dff8a7be404af11c14fd74c498be8836c3a1e04acbf80dfd9a6f7ff2c5f621fc51472b9219b2fc1e21712ffb000251de1e0082c6a72f023e12dd2ce"} 15:19:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:19:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:19:50 INFO - Contents: 15:19:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eac34d9ce381e46e40df44d14fec56452abcdab8f92fe604744250c2cd1d89270ab8b22769a8e1f633e06673bee2f45795c57964161cd0bb974390e5ff0ea990", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/90b28e90fe89a65101a2b5a18c36c141d267420b89e7ab4b2afc49a8c21cb74ce1eeb953c2ea321cb6c6b05f076733fe864958190aa50cb8e865be408e67f363", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/277beab71dff8a7be404af11c14fd74c498be8836c3a1e04acbf80dfd9a6f7ff2c5f621fc51472b9219b2fc1e21712ffb000251de1e0082c6a72f023e12dd2ce"} 15:19:50 INFO - Running post-run listener: copy_logs_to_upload_dir 15:19:50 INFO - Copying logs to upload dir... 15:19:50 INFO - mkdir: /builds/slave/test/build/upload/logs 15:19:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.855818 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-12 15:19:49.797110) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-12 15:19:49.800986) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1465768739.577772-877673692 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eac34d9ce381e46e40df44d14fec56452abcdab8f92fe604744250c2cd1d89270ab8b22769a8e1f633e06673bee2f45795c57964161cd0bb974390e5ff0ea990", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/90b28e90fe89a65101a2b5a18c36c141d267420b89e7ab4b2afc49a8c21cb74ce1eeb953c2ea321cb6c6b05f076733fe864958190aa50cb8e865be408e67f363", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/277beab71dff8a7be404af11c14fd74c498be8836c3a1e04acbf80dfd9a6f7ff2c5f621fc51472b9219b2fc1e21712ffb000251de1e0082c6a72f023e12dd2ce"} build_url:https://queue.taskcluster.net/v1/task/A6UeXKmvSbawQ4MsU3ISJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011286 build_url: 'https://queue.taskcluster.net/v1/task/A6UeXKmvSbawQ4MsU3ISJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eac34d9ce381e46e40df44d14fec56452abcdab8f92fe604744250c2cd1d89270ab8b22769a8e1f633e06673bee2f45795c57964161cd0bb974390e5ff0ea990", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/90b28e90fe89a65101a2b5a18c36c141d267420b89e7ab4b2afc49a8c21cb74ce1eeb953c2ea321cb6c6b05f076733fe864958190aa50cb8e865be408e67f363", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/277beab71dff8a7be404af11c14fd74c498be8836c3a1e04acbf80dfd9a6f7ff2c5f621fc51472b9219b2fc1e21712ffb000251de1e0082c6a72f023e12dd2ce"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-12 15:19:49.826300) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 15:19:49.826659) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1465768739.577772-877673692 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 15:19:49.914280) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-12 15:19:49.914983) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-12 15:19:49.915609) ========= ========= Total master_lag: 0.18 =========