builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-001 starttime: 1465238576.79 results: success (0) buildid: 20160606083115 builduid: b8910be4b18a4cf09cdff0b9cc7cee10 revision: 8ee8066ffeea90aabada756a2126349680bccb37 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 11:42:56.795303) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 11:42:56.795808) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 11:42:56.796132) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 11:42:56.811029) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 11:42:56.811321) ========= 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=8887e36bb8e381bfd44124ac000001a8-1465238576.52688-459128812 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-06 11:42:56-- 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% 222M=0s 2016-06-06 11:42:56 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105441 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 11:42:56.934765) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 11:42:56.935543) ========= 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=8887e36bb8e381bfd44124ac000001a8-1465238576.52688-459128812 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019983 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 11:42:56.988065) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 11:42:56.988889) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8ee8066ffeea90aabada756a2126349680bccb37 --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 8ee8066ffeea90aabada756a2126349680bccb37 --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=8887e36bb8e381bfd44124ac000001a8-1465238576.52688-459128812 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-06 11:42:56,990 truncating revision to first 12 chars 2016-06-06 11:42:56,990 Setting DEBUG logging. 2016-06-06 11:42:56,990 attempt 1/10 2016-06-06 11:42:56,990 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8ee8066ffeea?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 11:42:57,291 unpacking tar archive at: fx-team-8ee8066ffeea/testing/mozharness/ program finished with exit code 0 elapsedTime=0.625233 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 11:42:57.633275) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 11:42:57.634175) ========= script_repo_revision: 8ee8066ffeea90aabada756a2126349680bccb37 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 11:42:57.635175) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 11:42:57.635859) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 11:42:57.646303) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 43 secs) (at 2016-06-06 11:42:57.647019) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=8887e36bb8e381bfd44124ac000001a8-1465238576.52688-459128812 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:42:57 INFO - MultiFileLogger online at 20160606 11:42:57 in /builds/slave/test 11:42:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:42:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:42:57 INFO - {'append_to_log': False, 11:42:57 INFO - 'base_work_dir': '/builds/slave/test', 11:42:57 INFO - 'blob_upload_branch': 'Fx-Team', 11:42:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:42:57 INFO - 'branch': 'Fx-Team', 11:42:57 INFO - 'buildbot_json_path': 'buildprops.json', 11:42:57 INFO - 'config_files': ('talos/linux_config.py',), 11:42:57 INFO - 'default_actions': ('clobber', 11:42:57 INFO - 'read-buildbot-config', 11:42:57 INFO - 'download-and-extract', 11:42:57 INFO - 'populate-webroot', 11:42:57 INFO - 'create-virtualenv', 11:42:57 INFO - 'install', 11:42:57 INFO - 'run-tests'), 11:42:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:42:57 INFO - 'download_minidump_stackwalk': True, 11:42:57 INFO - 'download_symbols': 'ondemand', 11:42:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:42:57 INFO - 'tooltool.py': '/tools/tooltool.py', 11:42:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:42:57 INFO - '/tools/misc-python/virtualenv.py')}, 11:42:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:42:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:42:57 INFO - 'installer_path': 'installer.exe', 11:42:57 INFO - 'log_level': 'info', 11:42:57 INFO - 'log_name': 'talos', 11:42:57 INFO - 'log_to_console': True, 11:42:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:42:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:42:57 INFO - 'opt_config_files': (), 11:42:57 INFO - 'pip_index': False, 11:42:57 INFO - 'sps_profile': False, 11:42:57 INFO - 'sps_profile_interval': 0, 11:42:57 INFO - 'suite': 'dromaeojs', 11:42:57 INFO - 'system_bits': '32', 11:42:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:42:57 INFO - 'title': 'talos-linux64-ix-001', 11:42:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:42:57 INFO - 'use_talos_json': True, 11:42:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:42:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:42:57 INFO - 'work_dir': 'build'} 11:42:57 INFO - ##### 11:42:57 INFO - ##### Running clobber step. 11:42:57 INFO - ##### 11:42:57 INFO - Running pre-action listener: _resource_record_pre_action 11:42:57 INFO - Running main action method: clobber 11:42:57 INFO - rmtree: /builds/slave/test/build 11:42:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:42:58 INFO - Running post-action listener: _resource_record_post_action 11:42:58 INFO - ##### 11:42:58 INFO - ##### Finished clobber step (success) 11:42:58 INFO - ##### 11:42:58 INFO - ##### 11:42:58 INFO - ##### Running read-buildbot-config step. 11:42:58 INFO - ##### 11:42:58 INFO - Running pre-action listener: _resource_record_pre_action 11:42:58 INFO - Running main action method: read_buildbot_config 11:42:58 INFO - Using buildbot properties: 11:42:58 INFO - { 11:42:58 INFO - "project": "", 11:42:58 INFO - "product": "firefox", 11:42:58 INFO - "script_repo_revision": "production", 11:42:58 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:42:58 INFO - "repository": "", 11:42:58 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:42:58 INFO - "buildid": "20160606083115", 11:42:58 INFO - "pgo_build": "True", 11:42:58 INFO - "basedir": "/builds/slave/test", 11:42:58 INFO - "buildnumber": 1227, 11:42:58 INFO - "slavename": "talos-linux64-ix-001", 11:42:58 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:42:58 INFO - "platform": "ubuntu64_hw", 11:42:58 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:42:58 INFO - "branch": "fx-team", 11:42:58 INFO - "repo_path": "integration/fx-team", 11:42:58 INFO - "revision": "8ee8066ffeea90aabada756a2126349680bccb37", 11:42:58 INFO - "stage_platform": "linux64-pgo", 11:42:58 INFO - "builduid": "b8910be4b18a4cf09cdff0b9cc7cee10", 11:42:58 INFO - "slavebuilddir": "test" 11:42:58 INFO - } 11:42:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 11:42:58 INFO - Running post-action listener: _resource_record_post_action 11:42:58 INFO - ##### 11:42:58 INFO - ##### Finished read-buildbot-config step (success) 11:42:58 INFO - ##### 11:42:58 INFO - ##### 11:42:58 INFO - ##### Running download-and-extract step. 11:42:58 INFO - ##### 11:42:58 INFO - Running pre-action listener: _resource_record_pre_action 11:42:58 INFO - Running main action method: download_and_extract 11:42:58 INFO - mkdir: /builds/slave/test/build/tests 11:42:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:58 INFO - https://queue.taskcluster.net/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:42:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:42:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:42:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:42:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:42:59 INFO - Downloaded 1361 bytes. 11:42:59 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:42:59 INFO - Using the following test package requirements: 11:42:59 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:42:59 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:42:59 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:42:59 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:59 INFO - u'jsshell-linux-x86_64.zip'], 11:42:59 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:42:59 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:42:59 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:42:59 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:42:59 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:42:59 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:42:59 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:42:59 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')]} 11:42:59 INFO - https://queue.taskcluster.net/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:42:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:42:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:42:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:42:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:43:21 INFO - Downloaded 24443794 bytes. 11:43:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:43:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:43:22 INFO - Return code: 0 11:43:22 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:43:22 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')]} 11:43:22 INFO - https://queue.taskcluster.net/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:43:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:43:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:43:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:43:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:43:25 INFO - Downloaded 24443794 bytes. 11:43:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:43:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:43:26 INFO - Return code: 0 11:43:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:26 INFO - https://queue.taskcluster.net/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:43:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:43:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:43:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:43:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:43:30 INFO - Downloaded 10833369 bytes. 11:43:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:43:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:43:30 INFO - Return code: 0 11:43: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')]} 11:43:30 INFO - https://queue.taskcluster.net/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:43:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:43:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:43:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:43:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:45:15 INFO - Downloaded 59181725 bytes. 11:45:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:45:15 INFO - mkdir: /builds/slave/test/properties 11:45:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:45:15 INFO - Writing to file /builds/slave/test/properties/build_url 11:45:15 INFO - Contents: 11:45:15 INFO - build_url:https://queue.taskcluster.net/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:45:16 INFO - Running post-action listener: _resource_record_post_action 11:45:16 INFO - Running post-action listener: set_extra_try_arguments 11:45:16 INFO - ##### 11:45:16 INFO - ##### Finished download-and-extract step (success) 11:45:16 INFO - ##### 11:45:16 INFO - ##### 11:45:16 INFO - ##### Running populate-webroot step. 11:45:16 INFO - ##### 11:45:16 INFO - Running pre-action listener: _resource_record_pre_action 11:45:16 INFO - Running main action method: populate_webroot 11:45:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:45:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:45:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:45:16 INFO - '--tppagecycles', 11:45:16 INFO - '7'], 11:45:16 INFO - 'tests': ['tsvgm']}}, 11:45:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:45:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:45:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:45:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:45:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:45:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:45:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:45:16 INFO - 'talos_options': ['--disable-e10s'], 11:45:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:45:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:45:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:45:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:45:16 INFO - 'talos_options': ['--disable-e10s'], 11:45:16 INFO - 'tests': ['damp', 'tps']}, 11:45:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:45:16 INFO - 'tests': ['damp', 'tps']}, 11:45:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:45:16 INFO - 'tests': ['dromaeo_dom']}, 11:45:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:45:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:45:16 INFO - 'tests': ['a11yr', 11:45:16 INFO - 'ts_paint', 11:45:16 INFO - 'tpaint', 11:45:16 INFO - 'sessionrestore', 11:45:16 INFO - 'sessionrestore_no_auto_restore', 11:45:16 INFO - 'tabpaint']}, 11:45:16 INFO - 'other-e10s': {'tests': ['a11yr', 11:45:16 INFO - 'ts_paint', 11:45:16 INFO - 'tpaint', 11:45:16 INFO - 'sessionrestore', 11:45:16 INFO - 'sessionrestore_no_auto_restore', 11:45:16 INFO - 'tabpaint']}, 11:45:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:45:16 INFO - 'ts_paint', 11:45:16 INFO - 'tpaint', 11:45:16 INFO - 'sessionrestore', 11:45:16 INFO - 'sessionrestore_no_auto_restore', 11:45:16 INFO - 'tabpaint']}, 11:45:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:45:16 INFO - 'ts_paint', 11:45:16 INFO - 'tpaint', 11:45:16 INFO - 'sessionrestore', 11:45:16 INFO - 'sessionrestore_no_auto_restore', 11:45:16 INFO - 'tabpaint']}, 11:45:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:45:16 INFO - 'tests': ['a11yr', 11:45:16 INFO - 'ts_paint', 11:45:16 INFO - 'tpaint', 11:45:16 INFO - 'sessionrestore', 11:45:16 INFO - 'sessionrestore_no_auto_restore', 11:45:16 INFO - 'tabpaint']}, 11:45:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:45:16 INFO - 'tests': ['a11yr', 11:45:16 INFO - 'ts_paint', 11:45:16 INFO - 'tpaint', 11:45:16 INFO - 'sessionrestore', 11:45:16 INFO - 'sessionrestore_no_auto_restore', 11:45:16 INFO - 'tabpaint']}, 11:45:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:45:16 INFO - 'tests': ['tsvgx', 11:45:16 INFO - 'tsvgr_opacity', 11:45:16 INFO - 'tart', 11:45:16 INFO - 'tscrollx', 11:45:16 INFO - 'cart']}, 11:45:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:45:16 INFO - 'tsvgr_opacity', 11:45:16 INFO - 'tart', 11:45:16 INFO - 'tscrollx', 11:45:16 INFO - 'cart']}, 11:45:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:45:16 INFO - 'talos_options': ['--disable-e10s'], 11:45:16 INFO - 'tests': ['tp5o']}, 11:45:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:45:16 INFO - 'tests': ['tp5o']}, 11:45:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:45:16 INFO - 'talos_options': ['--disable-e10s', 11:45:16 INFO - '--xperf_path', 11:45:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:45:16 INFO - 'tests': ['tp5n']}, 11:45:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:45:16 INFO - 'talos_options': ['--xperf_path', 11:45:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:45:16 INFO - 'tests': ['tp5n']}}, 11:45:16 INFO - 'talos.zip': {'path': '', 11:45:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:45:16 INFO - Running post-action listener: _resource_record_post_action 11:45:16 INFO - ##### 11:45:16 INFO - ##### Finished populate-webroot step (success) 11:45:16 INFO - ##### 11:45:16 INFO - ##### 11:45:16 INFO - ##### Running create-virtualenv step. 11:45:16 INFO - ##### 11:45:16 INFO - Running pre-action listener: _resource_record_pre_action 11:45:16 INFO - Running main action method: create_virtualenv 11:45:16 INFO - Creating virtualenv /builds/slave/test/build/venv 11:45:16 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 11:45:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:45:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:45:16 INFO - Using real prefix '/usr' 11:45:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:45:16 INFO - Installing distribute.............................................................................................................................................................................................done. 11:45:18 INFO - Installing pip.................done. 11:45:18 INFO - Return code: 0 11:45:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:45:18 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')]} 11:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:45:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:18 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')]} 11:45:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:45:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:18 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 0x7fc462fe3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca00f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d32050>, '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 0x1c9e170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c9e620>, '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': '8887e36bb8e381bfd44124ac000001a8-1465238576.52688-459128812', '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 11:45:18 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 11:45:18 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 11:45:18 INFO - Using env: {'DISPLAY': ':0', 11:45:18 INFO - 'HOME': '/home/cltbld', 11:45:18 INFO - 'LANG': 'en_US.UTF-8', 11:45:18 INFO - 'LANGUAGE': 'en_US:en', 11:45:18 INFO - 'LOGNAME': 'cltbld', 11:45:18 INFO - 'MAIL': '/var/mail/cltbld', 11:45:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:18 INFO - 'MOZ_NO_REMOTE': '1', 11:45:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:45:18 INFO - 'NO_EM_RESTART': '1', 11:45:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:45:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:18 INFO - 'PWD': '/builds/slave/test', 11:45:18 INFO - 'SHELL': '/bin/bash', 11:45:18 INFO - 'SHLVL': '1', 11:45:18 INFO - 'TERM': 'linux', 11:45:18 INFO - 'TMOUT': '86400', 11:45:18 INFO - 'USER': 'cltbld', 11:45:18 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465238576.52688-459128812', 11:45:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:18 INFO - '_': '/tools/buildbot/bin/python'} 11:45:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:45:18 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 11:45:18 INFO - Cleaning up... 11:45:18 INFO - Return code: 0 11:45:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:45:18 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')]} 11:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:45:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:18 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')]} 11:45:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:45:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:18 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 0x7fc462fe3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca00f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d32050>, '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 0x1c9e170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c9e620>, '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': '8887e36bb8e381bfd44124ac000001a8-1465238576.52688-459128812', '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 11:45:18 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 11:45:18 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 11:45:19 INFO - Using env: {'DISPLAY': ':0', 11:45:19 INFO - 'HOME': '/home/cltbld', 11:45:19 INFO - 'LANG': 'en_US.UTF-8', 11:45:19 INFO - 'LANGUAGE': 'en_US:en', 11:45:19 INFO - 'LOGNAME': 'cltbld', 11:45:19 INFO - 'MAIL': '/var/mail/cltbld', 11:45:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:19 INFO - 'MOZ_NO_REMOTE': '1', 11:45:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:45:19 INFO - 'NO_EM_RESTART': '1', 11:45:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:45:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:19 INFO - 'PWD': '/builds/slave/test', 11:45:19 INFO - 'SHELL': '/bin/bash', 11:45:19 INFO - 'SHLVL': '1', 11:45:19 INFO - 'TERM': 'linux', 11:45:19 INFO - 'TMOUT': '86400', 11:45:19 INFO - 'USER': 'cltbld', 11:45:19 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465238576.52688-459128812', 11:45:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:19 INFO - '_': '/tools/buildbot/bin/python'} 11:45:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:45:19 INFO - Downloading/unpacking psutil>=3.1.1 11:45: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 11:45: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 11:45: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 11:45: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 11:45: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 11:45: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 11:45:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:45:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:45:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:45:21 INFO - Installing collected packages: psutil 11:45:21 INFO - Running setup.py install for psutil 11:45:21 INFO - building 'psutil._psutil_linux' extension 11:45:21 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 11:45:21 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 11:45:21 INFO - building 'psutil._psutil_posix' extension 11:45:21 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 11:45:21 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 11:45:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:45:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:45:21 INFO - Successfully installed psutil 11:45:21 INFO - Cleaning up... 11:45:21 INFO - Return code: 0 11:45:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:45: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')]} 11:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:45:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45: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')]} 11:45:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:45:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc462fe3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca00f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d32050>, '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 0x1c9e170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c9e620>, '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': '8887e36bb8e381bfd44124ac000001a8-1465238576.52688-459128812', '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 11:45: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:45: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 mozsystemmonitor==0.3 11:45:21 INFO - Using env: {'DISPLAY': ':0', 11:45:21 INFO - 'HOME': '/home/cltbld', 11:45:21 INFO - 'LANG': 'en_US.UTF-8', 11:45:21 INFO - 'LANGUAGE': 'en_US:en', 11:45:21 INFO - 'LOGNAME': 'cltbld', 11:45:21 INFO - 'MAIL': '/var/mail/cltbld', 11:45:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:21 INFO - 'MOZ_NO_REMOTE': '1', 11:45:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:45:21 INFO - 'NO_EM_RESTART': '1', 11:45:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:45:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:21 INFO - 'PWD': '/builds/slave/test', 11:45:21 INFO - 'SHELL': '/bin/bash', 11:45:21 INFO - 'SHLVL': '1', 11:45:21 INFO - 'TERM': 'linux', 11:45:21 INFO - 'TMOUT': '86400', 11:45:21 INFO - 'USER': 'cltbld', 11:45:21 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465238576.52688-459128812', 11:45:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:21 INFO - '_': '/tools/buildbot/bin/python'} 11:45:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:45:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:45: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 11:45: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 11:45: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 11:45: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 11:45: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 11:45: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 11:45:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:45:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:45:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:45:23 INFO - Installing collected packages: mozsystemmonitor 11:45:23 INFO - Running setup.py install for mozsystemmonitor 11:45:24 INFO - Successfully installed mozsystemmonitor 11:45:24 INFO - Cleaning up... 11:45:24 INFO - Return code: 0 11:45:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:45: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')]} 11:45:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:45:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45: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')]} 11:45:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:45:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45: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', '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 0x7fc462fe3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca00f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d32050>, '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 0x1c9e170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c9e620>, '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': '8887e36bb8e381bfd44124ac000001a8-1465238576.52688-459128812', '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 11:45: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:45: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 jsonschema==2.5.1 11:45:24 INFO - Using env: {'DISPLAY': ':0', 11:45:24 INFO - 'HOME': '/home/cltbld', 11:45:24 INFO - 'LANG': 'en_US.UTF-8', 11:45:24 INFO - 'LANGUAGE': 'en_US:en', 11:45:24 INFO - 'LOGNAME': 'cltbld', 11:45:24 INFO - 'MAIL': '/var/mail/cltbld', 11:45:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:24 INFO - 'MOZ_NO_REMOTE': '1', 11:45:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:45:24 INFO - 'NO_EM_RESTART': '1', 11:45:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:45:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:24 INFO - 'PWD': '/builds/slave/test', 11:45:24 INFO - 'SHELL': '/bin/bash', 11:45:24 INFO - 'SHLVL': '1', 11:45:24 INFO - 'TERM': 'linux', 11:45:24 INFO - 'TMOUT': '86400', 11:45:24 INFO - 'USER': 'cltbld', 11:45:24 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465238576.52688-459128812', 11:45:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:24 INFO - '_': '/tools/buildbot/bin/python'} 11:45:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:45:24 INFO - Downloading/unpacking jsonschema==2.5.1 11:45: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 11:45: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 11:45: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 11:45: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 11:45: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 11:45: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 11:45:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:45:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:45: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 11:45: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 11:45: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 11:45: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 11:45: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 11:45: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 11:45:26 INFO - Downloading functools32-3.2.3-2.tar.gz 11:45:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:45:26 INFO - warning: no files found matching '*.txt' 11:45:26 INFO - no previously-included directories found matching 'build' 11:45:26 INFO - no previously-included directories found matching 'dist' 11:45:26 INFO - no previously-included directories found matching '.git*' 11:45:26 INFO - Installing collected packages: jsonschema, functools32 11:45:26 INFO - Running setup.py install for functools32 11:45:26 INFO - warning: no files found matching '*.txt' 11:45:26 INFO - no previously-included directories found matching 'build' 11:45:26 INFO - no previously-included directories found matching 'dist' 11:45:26 INFO - no previously-included directories found matching '.git*' 11:45:26 INFO - Successfully installed jsonschema functools32 11:45:26 INFO - Cleaning up... 11:45:26 INFO - Return code: 0 11:45:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:45:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:45:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:45:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:45:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:26 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 0x7fc462fe3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca00f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d32050>, '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 0x1c9e170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c9e620>, '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': '8887e36bb8e381bfd44124ac000001a8-1465238576.52688-459128812', '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 11:45:26 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 11:45:26 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 11:45:26 INFO - Using env: {'DISPLAY': ':0', 11:45:26 INFO - 'HOME': '/home/cltbld', 11:45:26 INFO - 'LANG': 'en_US.UTF-8', 11:45:26 INFO - 'LANGUAGE': 'en_US:en', 11:45:26 INFO - 'LOGNAME': 'cltbld', 11:45:26 INFO - 'MAIL': '/var/mail/cltbld', 11:45:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:26 INFO - 'MOZ_NO_REMOTE': '1', 11:45:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:45:26 INFO - 'NO_EM_RESTART': '1', 11:45:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:45:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:26 INFO - 'PWD': '/builds/slave/test', 11:45:26 INFO - 'SHELL': '/bin/bash', 11:45:26 INFO - 'SHLVL': '1', 11:45:26 INFO - 'TERM': 'linux', 11:45:26 INFO - 'TMOUT': '86400', 11:45:26 INFO - 'USER': 'cltbld', 11:45:26 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465238576.52688-459128812', 11:45:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:26 INFO - '_': '/tools/buildbot/bin/python'} 11:45:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:45:26 INFO - Downloading/unpacking blobuploader==1.2.4 11:45: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 11:45: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 11:45: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 11:45: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 11:45: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 11:45: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 11:45:28 INFO - Downloading blobuploader-1.2.4.tar.gz 11:45:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:45:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:45:28 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 11:45:28 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 11:45:28 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 11:45:28 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 11:45:28 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 11:45:28 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 11:45:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:45:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:45:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:45:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:45:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:45:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:45:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:45:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:45:29 INFO - Downloading docopt-0.6.1.tar.gz 11:45:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:45:29 INFO - Installing collected packages: blobuploader, requests, docopt 11:45:29 INFO - Running setup.py install for blobuploader 11:45:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:45:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:45:29 INFO - Running setup.py install for requests 11:45:29 INFO - Running setup.py install for docopt 11:45:30 INFO - Successfully installed blobuploader requests docopt 11:45:30 INFO - Cleaning up... 11:45:30 INFO - Return code: 0 11:45:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:45: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')]} 11:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:45:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45: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')]} 11:45:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:45:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:30 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 0x7fc462fe3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca00f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d32050>, '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 0x1c9e170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c9e620>, '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': '8887e36bb8e381bfd44124ac000001a8-1465238576.52688-459128812', '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 11:45:30 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 11:45:30 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 11:45:30 INFO - Using env: {'DISPLAY': ':0', 11:45:30 INFO - 'HOME': '/home/cltbld', 11:45:30 INFO - 'LANG': 'en_US.UTF-8', 11:45:30 INFO - 'LANGUAGE': 'en_US:en', 11:45:30 INFO - 'LOGNAME': 'cltbld', 11:45:30 INFO - 'MAIL': '/var/mail/cltbld', 11:45:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:30 INFO - 'MOZ_NO_REMOTE': '1', 11:45:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:45:30 INFO - 'NO_EM_RESTART': '1', 11:45:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:45:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:30 INFO - 'PWD': '/builds/slave/test', 11:45:30 INFO - 'SHELL': '/bin/bash', 11:45:30 INFO - 'SHLVL': '1', 11:45:30 INFO - 'TERM': 'linux', 11:45:30 INFO - 'TMOUT': '86400', 11:45:30 INFO - 'USER': 'cltbld', 11:45:30 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465238576.52688-459128812', 11:45:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:30 INFO - '_': '/tools/buildbot/bin/python'} 11:45:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:45:30 INFO - Running setup.py (path:/tmp/pip-tLSkVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:45:30 INFO - Running setup.py (path:/tmp/pip-_FmRBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:45:30 INFO - Running setup.py (path:/tmp/pip-vwgzox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:45:30 INFO - Running setup.py (path:/tmp/pip-HZ0lmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:45:30 INFO - Running setup.py (path:/tmp/pip-etJ9mr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:45:30 INFO - Running setup.py (path:/tmp/pip-JDY73V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:45:30 INFO - Running setup.py (path:/tmp/pip-2BoiYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:45:30 INFO - Running setup.py (path:/tmp/pip-MepNlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:45:30 INFO - Running setup.py (path:/tmp/pip-GUu6Uu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:45:31 INFO - Running setup.py (path:/tmp/pip-DxpqOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:45:31 INFO - Running setup.py (path:/tmp/pip-C3KC9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:45:31 INFO - Running setup.py (path:/tmp/pip-KJiU64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:45:31 INFO - Running setup.py (path:/tmp/pip-eNbMOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:45:31 INFO - Running setup.py (path:/tmp/pip-2e8q8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:45:31 INFO - Running setup.py (path:/tmp/pip-4u3PrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:45:31 INFO - Running setup.py (path:/tmp/pip-1Wp4yz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:45:31 INFO - Running setup.py (path:/tmp/pip-0Pg7iF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:45:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:45:31 INFO - Running setup.py install for manifestparser 11:45:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:45:31 INFO - Running setup.py install for mozcrash 11:45:31 INFO - Running setup.py install for mozdebug 11:45:31 INFO - Running setup.py install for mozdevice 11:45:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:45:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:45:31 INFO - Running setup.py install for mozfile 11:45:32 INFO - Running setup.py install for mozhttpd 11:45:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:45:32 INFO - Running setup.py install for mozinfo 11:45:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:45:32 INFO - Running setup.py install for mozInstall 11:45:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:45:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:45:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:45:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:45:32 INFO - Running setup.py install for mozleak 11:45:32 INFO - Running setup.py install for mozlog 11:45:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:45:32 INFO - Running setup.py install for moznetwork 11:45:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:45:32 INFO - Running setup.py install for mozprocess 11:45:32 INFO - Running setup.py install for mozprofile 11:45:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:45:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:45:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:45:32 INFO - Running setup.py install for mozrunner 11:45:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:45:33 INFO - Running setup.py install for mozscreenshot 11:45:33 INFO - Running setup.py install for moztest 11:45:33 INFO - Running setup.py install for mozversion 11:45:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:45:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:45:33 INFO - Cleaning up... 11:45:33 INFO - Return code: 0 11:45:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:45:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:45:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:45:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:45:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:33 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 0x7fc462fe3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca00f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d32050>, '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 0x1c9e170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c9e620>, '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': '8887e36bb8e381bfd44124ac000001a8-1465238576.52688-459128812', '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 11:45:33 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 11:45:33 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 11:45:33 INFO - Using env: {'DISPLAY': ':0', 11:45:33 INFO - 'HOME': '/home/cltbld', 11:45:33 INFO - 'LANG': 'en_US.UTF-8', 11:45:33 INFO - 'LANGUAGE': 'en_US:en', 11:45:33 INFO - 'LOGNAME': 'cltbld', 11:45:33 INFO - 'MAIL': '/var/mail/cltbld', 11:45:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:33 INFO - 'MOZ_NO_REMOTE': '1', 11:45:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:45:33 INFO - 'NO_EM_RESTART': '1', 11:45:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:45:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:33 INFO - 'PWD': '/builds/slave/test', 11:45:33 INFO - 'SHELL': '/bin/bash', 11:45:33 INFO - 'SHLVL': '1', 11:45:33 INFO - 'TERM': 'linux', 11:45:33 INFO - 'TMOUT': '86400', 11:45:33 INFO - 'USER': 'cltbld', 11:45:33 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465238576.52688-459128812', 11:45:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:33 INFO - '_': '/tools/buildbot/bin/python'} 11:45:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:45:33 INFO - Running setup.py (path:/tmp/pip-RnxMR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:45:33 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)) 11:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:45:33 INFO - Running setup.py (path:/tmp/pip-xSAlhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:45:33 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)) 11:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:45:33 INFO - Running setup.py (path:/tmp/pip-uIDEVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:45:33 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)) 11:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:45:33 INFO - Running setup.py (path:/tmp/pip-s5qt_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:45:33 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)) 11:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:45:33 INFO - Running setup.py (path:/tmp/pip-CNv_pI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:45:33 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)) 11:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:45:33 INFO - Running setup.py (path:/tmp/pip-K6G96g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:45:34 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)) 11:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:45:34 INFO - Running setup.py (path:/tmp/pip-r0uZQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:45:34 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)) 11:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:45:34 INFO - Running setup.py (path:/tmp/pip-t7apir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:45:34 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)) 11:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:45:34 INFO - Running setup.py (path:/tmp/pip-Mbhlkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:45:34 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)) 11:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:45:34 INFO - Running setup.py (path:/tmp/pip-JhGBaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:45:34 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)) 11:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:45:34 INFO - Running setup.py (path:/tmp/pip-HXDtxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:45:34 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)) 11:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:45:34 INFO - Running setup.py (path:/tmp/pip-ibizOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:45:34 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)) 11:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:45:34 INFO - Running setup.py (path:/tmp/pip-WxtgXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:45:34 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)) 11:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:45:34 INFO - Running setup.py (path:/tmp/pip-oHNVsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:45:34 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)) 11:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:45:34 INFO - Running setup.py (path:/tmp/pip-11XnOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:45:34 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)) 11:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:45:34 INFO - Running setup.py (path:/tmp/pip-_2Nr1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:45:34 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)) 11:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:45:34 INFO - Running setup.py (path:/tmp/pip-ZCh5ec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:45:34 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)) 11:45:34 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)) 11:45:34 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)) 11:45:34 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)) 11:45:34 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)) 11:45:34 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)) 11:45:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:45:34 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 11:45:34 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 11:45:34 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 11:45:34 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 11:45:34 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 11:45:34 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 11:45:36 INFO - Downloading blessings-1.6.tar.gz 11:45:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:45:36 INFO - Installing collected packages: blessings 11:45:36 INFO - Running setup.py install for blessings 11:45:37 INFO - Successfully installed blessings 11:45:37 INFO - Cleaning up... 11:45:37 INFO - Return code: 0 11:45:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:45:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:45:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:45:37 INFO - Reading from file tmpfile_stdout 11:45:37 INFO - Current package versions: 11:45:37 INFO - argparse == 1.2.1 11:45:37 INFO - blessings == 1.6 11:45:37 INFO - blobuploader == 1.2.4 11:45:37 INFO - docopt == 0.6.1 11:45:37 INFO - functools32 == 3.2.3-2 11:45:37 INFO - jsonschema == 2.5.1 11:45:37 INFO - manifestparser == 1.1 11:45:37 INFO - mozInstall == 1.12 11:45:37 INFO - mozcrash == 0.17 11:45:37 INFO - mozdebug == 0.1 11:45:37 INFO - mozdevice == 0.48 11:45:37 INFO - mozfile == 1.2 11:45:37 INFO - mozhttpd == 0.7 11:45:37 INFO - mozinfo == 0.9 11:45:37 INFO - mozleak == 0.1 11:45:37 INFO - mozlog == 3.2 11:45:37 INFO - moznetwork == 0.27 11:45:37 INFO - mozprocess == 0.22 11:45:37 INFO - mozprofile == 0.28 11:45:37 INFO - mozrunner == 6.11 11:45:37 INFO - mozscreenshot == 0.1 11:45:37 INFO - mozsystemmonitor == 0.3 11:45:37 INFO - moztest == 0.7 11:45:37 INFO - mozversion == 1.4 11:45:37 INFO - psutil == 3.1.1 11:45:37 INFO - requests == 1.2.3 11:45:37 INFO - wsgiref == 0.1.2 11:45:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:45:37 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')]} 11:45:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:45:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:37 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')]} 11:45:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:45:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:37 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 0x7fc462fe3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca00f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d32050>, '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 0x1c9e170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c9e620>, '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': '8887e36bb8e381bfd44124ac000001a8-1465238576.52688-459128812', '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 11:45:37 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 11:45:37 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 11:45:37 INFO - Using env: {'DISPLAY': ':0', 11:45:37 INFO - 'HOME': '/home/cltbld', 11:45:37 INFO - 'LANG': 'en_US.UTF-8', 11:45:37 INFO - 'LANGUAGE': 'en_US:en', 11:45:37 INFO - 'LOGNAME': 'cltbld', 11:45:37 INFO - 'MAIL': '/var/mail/cltbld', 11:45:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:37 INFO - 'MOZ_NO_REMOTE': '1', 11:45:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:45:37 INFO - 'NO_EM_RESTART': '1', 11:45:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:45:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:37 INFO - 'PWD': '/builds/slave/test', 11:45:37 INFO - 'SHELL': '/bin/bash', 11:45:37 INFO - 'SHLVL': '1', 11:45:37 INFO - 'TERM': 'linux', 11:45:37 INFO - 'TMOUT': '86400', 11:45:37 INFO - 'USER': 'cltbld', 11:45:37 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465238576.52688-459128812', 11:45:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:37 INFO - '_': '/tools/buildbot/bin/python'} 11:45:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:45:37 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)) 11:45:37 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)) 11:45:37 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)) 11:45:37 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)) 11:45:37 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)) 11:45:37 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)) 11:45:37 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)) 11:45:37 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)) 11:45:37 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)) 11:45:37 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)) 11:45:37 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)) 11:45:37 INFO - Cleaning up... 11:45:37 INFO - Return code: 0 11:45:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:45:37 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')]} 11:45:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:45:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:37 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')]} 11:45:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:45:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:37 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 0x7fc462fe3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca00f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d32050>, '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 0x1c9e170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c9e620>, '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': '8887e36bb8e381bfd44124ac000001a8-1465238576.52688-459128812', '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 11:45:37 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 11:45:37 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 11:45:37 INFO - Using env: {'DISPLAY': ':0', 11:45:37 INFO - 'HOME': '/home/cltbld', 11:45:37 INFO - 'LANG': 'en_US.UTF-8', 11:45:37 INFO - 'LANGUAGE': 'en_US:en', 11:45:37 INFO - 'LOGNAME': 'cltbld', 11:45:37 INFO - 'MAIL': '/var/mail/cltbld', 11:45:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:37 INFO - 'MOZ_NO_REMOTE': '1', 11:45:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:45:37 INFO - 'NO_EM_RESTART': '1', 11:45:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:45:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:37 INFO - 'PWD': '/builds/slave/test', 11:45:37 INFO - 'SHELL': '/bin/bash', 11:45:37 INFO - 'SHLVL': '1', 11:45:37 INFO - 'TERM': 'linux', 11:45:37 INFO - 'TMOUT': '86400', 11:45:37 INFO - 'USER': 'cltbld', 11:45:37 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465238576.52688-459128812', 11:45:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:37 INFO - '_': '/tools/buildbot/bin/python'} 11:45:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:45:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:45:37 INFO - Cleaning up... 11:45:37 INFO - Return code: 0 11:45:37 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:45:37 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')]} 11:45:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:45:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:37 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')]} 11:45:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:45:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:37 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 0x7fc462fe3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca00f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d32050>, '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 0x1c9e170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c9e620>, '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': '8887e36bb8e381bfd44124ac000001a8-1465238576.52688-459128812', '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 11:45:37 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 11:45:37 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 11:45:37 INFO - Using env: {'DISPLAY': ':0', 11:45:37 INFO - 'HOME': '/home/cltbld', 11:45:37 INFO - 'LANG': 'en_US.UTF-8', 11:45:37 INFO - 'LANGUAGE': 'en_US:en', 11:45:37 INFO - 'LOGNAME': 'cltbld', 11:45:37 INFO - 'MAIL': '/var/mail/cltbld', 11:45:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:37 INFO - 'MOZ_NO_REMOTE': '1', 11:45:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:45:37 INFO - 'NO_EM_RESTART': '1', 11:45:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:45:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:37 INFO - 'PWD': '/builds/slave/test', 11:45:37 INFO - 'SHELL': '/bin/bash', 11:45:37 INFO - 'SHLVL': '1', 11:45:37 INFO - 'TERM': 'linux', 11:45:37 INFO - 'TMOUT': '86400', 11:45:37 INFO - 'USER': 'cltbld', 11:45:37 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465238576.52688-459128812', 11:45:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:37 INFO - '_': '/tools/buildbot/bin/python'} 11:45:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:45:37 INFO - Downloading/unpacking flake8 11:45: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 11:45: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 11:45: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 11:45: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 11:45: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 11:45: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 11:45:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:45:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:45:39 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 11:45:39 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 11:45:39 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 11:45:39 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 11:45:39 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 11:45:39 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 11:45:40 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:45:40 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:45:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:45:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:45:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:45:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:45:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:45:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:45:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:45:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:45:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:45:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:45:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:45:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:45:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:45:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:45:40 INFO - no previously-included directories found matching 'docs/_build' 11:45:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:45:40 INFO - Running setup.py install for pep8 11:45:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:45:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:45:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:45:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:45:40 INFO - no previously-included directories found matching 'docs/_build' 11:45:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:45:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:45:40 INFO - Cleaning up... 11:45:40 INFO - Return code: 0 11:45:40 INFO - Running post-action listener: _resource_record_post_action 11:45:40 INFO - Running post-action listener: _start_resource_monitoring 11:45:40 INFO - Starting resource monitoring. 11:45:40 INFO - ##### 11:45:40 INFO - ##### Finished create-virtualenv step (success) 11:45:40 INFO - ##### 11:45:40 INFO - ##### 11:45:40 INFO - ##### Running install step. 11:45:40 INFO - ##### 11:45:40 INFO - Running pre-action listener: _resource_record_pre_action 11:45:40 INFO - Running main action method: install 11:45:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:45:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:45:41 INFO - Reading from file tmpfile_stdout 11:45:41 INFO - Detecting whether we're running mozinstall >=1.0... 11:45:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:45:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:45:41 INFO - Reading from file tmpfile_stdout 11:45:41 INFO - Output received: 11:45:41 INFO - Usage: mozinstall [options] installer 11:45:41 INFO - Options: 11:45:41 INFO - -h, --help show this help message and exit 11:45:41 INFO - -d DEST, --destination=DEST 11:45:41 INFO - Directory to install application into. [default: 11:45:41 INFO - "/builds/slave/test"] 11:45:41 INFO - --app=APP Application being installed. [default: firefox] 11:45:41 INFO - mkdir: /builds/slave/test/build/application 11:45:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:45:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:45:57 INFO - Reading from file tmpfile_stdout 11:45:57 INFO - Output received: 11:45:57 INFO - /builds/slave/test/build/application/firefox/firefox 11:45:57 INFO - Running post-action listener: _resource_record_post_action 11:45:57 INFO - ##### 11:45:57 INFO - ##### Finished install step (success) 11:45:57 INFO - ##### 11:45:57 INFO - ##### 11:45:57 INFO - ##### Running run-tests step. 11:45:57 INFO - ##### 11:45:57 INFO - Running pre-action listener: _resource_record_pre_action 11:45:57 INFO - Running main action method: run_tests 11:45:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:45:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:45:57 INFO - Python 2.7.3 11:45:57 INFO - Return code: 0 11:45:57 INFO - grabbing minidump binary from tooltool 11:45:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:45:57 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 0x1d32050>, '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 0x1c9e170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c9e620>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:45:57 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 11:45:57 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 11:45:57 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 11:45:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:45:58 INFO - Return code: 0 11:45:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:45:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:45:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:45:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:45:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:45:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:45:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:45:58 INFO - Return code: 0 11:45:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 11:45:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 11:45:58 INFO - Using env: {'DISPLAY': ':0', 11:45:58 INFO - 'HOME': '/home/cltbld', 11:45:58 INFO - 'LANG': 'en_US.UTF-8', 11:45:58 INFO - 'LANGUAGE': 'en_US:en', 11:45:58 INFO - 'LOGNAME': 'cltbld', 11:45:58 INFO - 'MAIL': '/var/mail/cltbld', 11:45:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:45:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:45:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:58 INFO - 'MOZ_NO_REMOTE': '1', 11:45:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:45:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:45:58 INFO - 'NO_EM_RESTART': '1', 11:45:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:45:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:58 INFO - 'PWD': '/builds/slave/test', 11:45:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:45:58 INFO - 'SHELL': '/bin/bash', 11:45:58 INFO - 'SHLVL': '1', 11:45:58 INFO - 'TERM': 'linux', 11:45:58 INFO - 'TMOUT': '86400', 11:45:58 INFO - 'USER': 'cltbld', 11:45:58 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465238576.52688-459128812', 11:45:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:58 INFO - '_': '/tools/buildbot/bin/python'} 11:45:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 11:45:59 INFO - mozversion application_buildid: 20160606083115 11:45:59 INFO - mozversion application_changeset: 8ee8066ffeea90aabada756a2126349680bccb37 11:45:59 INFO - mozversion application_display_name: Nightly 11:45:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:45:59 INFO - mozversion application_name: Firefox 11:45:59 INFO - mozversion application_remotingname: firefox 11:45:59 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:45:59 INFO - mozversion application_vendor: Mozilla 11:45:59 INFO - mozversion application_version: 49.0a1 11:45:59 INFO - mozversion platform_buildid: 20160606083115 11:45:59 INFO - mozversion platform_changeset: 8ee8066ffeea90aabada756a2126349680bccb37 11:45:59 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:45:59 INFO - mozversion platform_version: 49.0a1 11:45:59 INFO - using testdate: 1465238759 11:45:59 INFO - actual date: 1465238759 11:45:59 INFO - starting webserver on 'localhost:52403' 11:45:59 INFO - SUITE-START | Running 2 tests 11:45:59 INFO - TEST-START | dromaeo_css 11:45:59 INFO - operating with platform_type : linux_ 11:45:59 INFO - Initialising browser for dromaeo_css test... 11:45:59 INFO - TEST-INFO | started process 10866 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZkFqDS/profile http://localhost:52403/getInfo.html) 11:46:03 INFO - PROCESS | 10866 | __metrics Screen width/height:1600/1200 11:46:03 INFO - PROCESS | 10866 | colorDepth:24 11:46:03 INFO - PROCESS | 10866 | Browser inner width/height: 1024/697 11:46:03 INFO - PROCESS | 10866 | __metrics 11:46:04 ERROR - PROCESS | 10866 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:46:04 INFO - PROCESS | 10866 | console.error: PushService: 11:46:04 INFO - PROCESS | 10866 | stateChangeProcessEnqueue: Error transitioning state 11:46:04 INFO - PROCESS | 10866 | UnknownError 11:46:04 INFO - TEST-INFO | 10866: exit 0 11:46:04 INFO - Browser initialized. 11:46:04 INFO - Running cycle 1/1 for dromaeo_css test... 11:46:04 INFO - TEST-INFO | started process 10945 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZkFqDS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:46:16 INFO - PROCESS | 10945 | RSS: Main: 156954624 11:46:16 INFO - PROCESS | 10945 | 11:47:07 INFO - PROCESS | 10945 | 1465238827841 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] 11:49:16 INFO - PROCESS | 10945 | Cycle 1(1): loaded http://localhost:52403/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52403/tests/dromaeo/cssquery-ext.html) 11:49:17 INFO - PROCESS | 10945 | RSS: Main: 255225856 11:49:17 INFO - PROCESS | 10945 | 11:52:19 INFO - PROCESS | 10945 | Cycle 1(1): loaded http://localhost:52403/tests/dromaeo/cssquery-ext.html (next: http://localhost:52403/tests/dromaeo/cssquery-jquery.html) 11:52:19 INFO - PROCESS | 10945 | RSS: Main: 246722560 11:52:19 INFO - PROCESS | 10945 | 11:55:21 INFO - PROCESS | 10945 | Cycle 1(1): loaded http://localhost:52403/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52403/tests/dromaeo/cssquery-mootools.html) 11:55:22 INFO - PROCESS | 10945 | RSS: Main: 244080640 11:55:22 INFO - PROCESS | 10945 | 11:58:24 INFO - PROCESS | 10945 | Cycle 1(1): loaded http://localhost:52403/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52403/tests/dromaeo/cssquery-prototype.html) 11:58:25 INFO - PROCESS | 10945 | RSS: Main: 240926720 11:58:25 INFO - PROCESS | 10945 | 12:01:27 INFO - PROCESS | 10945 | Cycle 1(1): loaded http://localhost:52403/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52403/tests/dromaeo/cssquery-yui.html) 12:01:28 INFO - PROCESS | 10945 | RSS: Main: 222703616 12:01:28 INFO - PROCESS | 10945 | 12:04:31 INFO - PROCESS | 10945 | Cycle 1(1): loaded http://localhost:52403/tests/dromaeo/cssquery-yui.html (next: http://localhost:52403/tests/dromaeo/cssquery-dojo.html) 12:04:31 INFO - PROCESS | 10945 | RSS: Main: 272105472 12:04:31 INFO - PROCESS | 10945 | 12:04:31 INFO - PROCESS | 10945 | __start_tp_report 12:04:31 INFO - PROCESS | 10945 | _x_x_mozilla_page_load 12:04:31 INFO - PROCESS | 10945 | _x_x_mozilla_page_load_details 12:04:31 INFO - PROCESS | 10945 | |i|pagename|runs| 12:04:31 INFO - PROCESS | 10945 | |0;dojo.html;3136.85884135214;3139.2465808206025;3157.226479512519;3175.8570864311105;3199.2641692410743;5295.920561191585;5371.167469042305;5405.513503784664;5498.312710911141;5505.697186654733;5468.863278418042;5490.478404551571;5504.587155963299;5508.366537848138;5544;4916.926246106311;4921.212605983034;5012.298278241049;5029.5221953914315;5174.456682048387;5064.215046667772;5099.209622508499;5128.230765385203;5140.074786538422;5142.460041695625;4878.560929516343;4938.456769755324;4947.307376967227;4970.900581988358;5019.196928491442;4939.160342741707;4944.629152813553;5026.145555255579;5032.446430892635;5048.192289233742;4848.127337079324;4961.603071754251;4973.701577905337;4998.200287953946;5028.472010438888;5339.5728341732565;5429.53848922842;5437.619366644337;5520.475554822286;5530.695811730353;5953.58324917256;5963.314218864799;5968.253968253968;5973.0144526153135;5982.282126144847;5722.856928576777;5797.4782269595935;5931.199288096138;5936;5953.047512398039;5391.703456309901;5536.2249285100115;5546.417626149277;5551.028570000234;5557.499825015768;6048.455638992512;6061.212042434456;6080.8783824324155;6081.422264884829;6085.6348619083;5617;5716.114002329646;5749.13762935563;5822.155787410802;5825.2135961644635;5895.41045895407;5932.3177834548715;5938.703064846827;5957.106434034929;5960.1059841023325;5822;5842.2405087338375;5844.386339434383;5860.443257890493;5872.677002764804;5584.888302233932;5717.799877004285;5722.284714410699;5770.942290577041;5860.589758716934;4399.406080179135;4399.626031787334;4401.361802538614;4413.624841888475;4430.977845110819;3926.6466018058513;3926.7447615904875;3948.1906209227614;3963.4451176835264;3974.066094467798;5355.303810504687;5405.297311349499;5495.807646732345;5537.723113844291;5547.55619550435;5987.790427335022;6000.369961154103;6005.819825405245;6009.399060093956;6036.215292012011;5583.74873130702;5592.664440133605;5596.804111856066;5599.412061733541;5602.775888964396;4942.085714142823;5059.418166910852;5104.2088476286235;5112.463191364927;5176.068307704574;6156.876862462816;6163.876722465615;6170.691465426711;6173.351798061229;6175.505959523227;5956.136360227742;5994.340622531431;5996.280446346466;5996.910046349221;5997.0404735242155;5865.736041878211;6023.277206735044;6025.728842202024;6077.118817771487;6108.08378743192;5809;5825.650460972355;5850.297964244318;5853.09277062056;5857.26784151981;5577;5898.262717160355;5939.376365481735;5951.672658003851;5962.880742385041;5725.370209276893;5765.250517432707;5769.336526299529;5801.912971305518;5819.15622234782;5776.797812076726;5799.768009279582;5802.303723553201;5809.593328466966;5810.070388737781;5470.863228419162;5602.411746766694;5701.287339082614;5702.515286200553;5717.113847353667;5789;5862.589618726648;5886.205362276038;5893.970530147321;5894.38108998549;5694.231278777312;5703.62926409782;5705.857353566028;5705.971470142788;5735.340435849931 12:04:31 INFO - PROCESS | 10945 | |1;ext.html;572.3761100400565;595.7736060297086;608.7838817219886;619.3527763487156;640.4876099120702;33442.16394590133;36100;43586.91032724179;44716.3292550612;44750.7762461188;46405.53594464054;46841;46889.29666055003;46914.29628555566;46968;8637.438566493189;8820.338474614398;8824.779380515474;8826.293896488298;8828.558572071403;8599.140085991414;8772.429792063496;8775.561221938877;8777.912220877804;8780.121987801233;8756.124387561256;8821.735347939572;8833.867491987625;8841.160089791492;8843.11568843117;8776.912230877673;8831.867521987175;8834.911650883474;8838.072002439747;8838.779030524256;8649.610767515476;8742.912570874274;8759.781005474913;8763.649454021832;8769.561521923943;43031.139377212596;43274.350884736756;43454.34818477726;43478.565214348084;43482.565174348165;3439.914002149941;3538.716902647782;3654.3239500692193;3848.826802793881;4263.87208383749;32228;32678.836605816818;32902.34195316104;32989.03701061644;32991.83504082464;4244.936325955113;4292.635126014261;4387.473503179607;4407.735535867858;4502.099580083996;374359;374899;375721;376918.99999999726;377786;59137;59293;59435.10847337294;59499.70250148721;59552.404475955555;63503.6824815873;63565.68217158884;63744.681276594245;63796;63839;16254;16419.753703694456;16455.753163702553;16459.753103703453;16467.176641168135;13363.665908352175;13448.193108413527;13477.258750768802;13485.123466974615;13496.122752021283;16036.358545658042;17304.307827687004;17334.913325433292;17356.739648905277;17516.824831751775;5829.854253643608;6356.523260755462;6718.193816741925;6968.407685346802;6974.825629359307;1007.4056306779036;1132.6375559820779;1140.7091191746051;1196.9646255988507;1201.5133870782347;33754.831225843714;33853.83073084619;33864.49203261953;33869.49195762065;33888.49167262493;1164.525383559935;1171.9062475001979;1186.7092562322287;1248.719038216394;1256.4220458588968;17163.534725861446;17381.391651292142;17438.215280312415;17518.562035948948;17667.38164164248;552315;552854;553322;553427;556513;59161.11258331128;59193.70403147957;59257.40742592605;59312;59324.40675593275;1227.821965814952;1286.9806952895715;1338.8326459192601;1342.2483409290828;1382.9170249785045;32262;35072.47391289082;35109;35149.47275790814;35183.49804915703;51665;51972.480275196765;52290.47709522856;52377.214341785664;52420.47579524156;396638;400420;400967;402107;402292;41372.793136034124;42509.36235956401;43019.56980430156;43314.78342608267;43492.782536087114;49465.25802113043;50119;50428;50730;51189;41984.94508331922;42298.36552451777;42916.785416073966;42932.35601466043;43017.354739679555;42235.95075620086;42311.3653295207;42634.51721083841;42716.57283427126;42829;42261.84875780603;42581.57418425776;42676;43126.568734312255;43446.78276608597;36869.81565092158;37539.62460375361;37815.43276850794;38173.61826381701;38529.614703853724;28723.856380717963;28932.27669308284;28978.27554311159;29165.625156226735;29326 12:04:31 INFO - PROCESS | 10945 | |2;jquery.html;365.35879531422347;370.53497860185473;384.85567912032985;398.3805182940528;406.36606893246517;17786.110694465275;19633.705494417576;19842;19970.301039463604;20030.899845500753;18361.173747181376;18553.81446185541;18805.24779008838;18943.62112757744;18987.715184272212;5568.972155139219;5620.887582248352;5756.740946657411;5760.2511673482595;5804.680742559158;5509.862253443676;5624.634398764088;5636.830895073154;5662.094064949609;5684.289463817023;5586.55307575395;5622.128570071645;5628.04323265046;5630.915536266939;5702.372738998707;5670.319561652587;5697.943020569783;5698.116791897262;5699.088145896637;5701.629394089392;4958.677685950402;5051.823186188466;5089.821856235051;5142.948570514322;5148.227765835155;22446.438839028993;22454.55090898189;22561.887190564106;23133.652995205084;23141.768582314297;2135.4981579328846;2305.7117860267467;2310.0413328468835;2927.2681829542616;3075.246564591667;10268.332558383756;11471.713207169803;12956.963442924638;14081.436742530286;14689.192094434802;1929.729837822706;1971.7338159348449;2024.3522072936667;2050.794920507952;2159.341400872733;82617;85254;86251;87041.56479217627;90499;9129.269658427309;9486;9726.659566915265;9747.658831940847;10022.444276709393;13081.672958176121;13113.737725245443;13146.60560183196;13172.628926793077;13246.602601921957;7508.324250817343;7803.531788092619;7826.0608726952;7957.880631790527;7986.480878742863;7776.844463110706;7906.841863162819;7953.2842044216295;8019.679212831538;8058.597070146469;4047.2714911315657;4066.898327541776;4145.067359844011;4156.480439945007;4202.810873510699;1831.6336732653256;1901.5341241395947;1903.3747992378653;1924.807519248064;1958.8824670519814;914.3873604684877;1064.3667018124204;1120.7478317378689;1121.0079080014084;1127.2785417332914;19015;19345.90327048356;19782.60434791325;19809.702854457195;19891.204351826054;996.566493575297;1024.8667673202585;1027.5889644142403;1061.6231237910586;1068.316277582348;10776.730581735363;11206.719832004264;11246.66260012201;11255.099592032782;11284.605038823765;477858;480778;481127;485942;515619;56738;71314.93027604486;86141;86645.566772167;87151;1013.8834034086027;1021.6373187518473;1026.1329176845554;1028.4395004722444;1032.02989190161;17420.82579174192;17553.59143532927;17800.287988480315;17825.46523604294;17898.10509474547;39166.41250381304;39418.40872386974;40296.597034029284;40658.1868362637;40964.79517602393;52841.735791320796;53732.19401709056;54022.459775401745;54334.72832635811;54601.72699136479;8710.956445217733;8800.735977920416;8894.200841612303;9066.456012639263;9149.588268528065;12667.30329831868;13519.324033798468;13556.661083472993;13721.382537786023;13758.587242382344;11832.408379580815;11885.108616853944;11889.346085965355;11916.344601047025;11919.523219071487;10125;10571.154307655523;11464.082873369944;11598.130140239347;11735.706607334885;12206.694832629255;12207;12353.505859765508;12408.689782755504;12752.298623575793;7551.773446796605;7791.142974272712;8521.105283945097;8707.825843482968;9059.954700226457;11746.941265293619;12036.879631203576;12041;12120.393980301125;12324.81512777327 12:04:31 INFO - PROCESS | 10945 | |3;mootools.html;1321.4912258780366;1474.8230212374513;1530.1507663246898;1662.7090259204645;1800.1539276540022;8631.30949524038;8992.955035224815;9015.639374425024;9196.540172991357;9237.584308706108;8848.823023539526;9079.500627465486;9087.182153606174;9099;9105.089491050892;2065.607534568427;2301.7122859642545;2330.1727886600265;2359.9174028908906;2375.8455700379504;2406.338256979327;2414.7223069346987;2419.5402873454077;2421.4672771990136;2422.2612103308484;2337.684412604302;2372.3120295114395;2379.6668466414717;2385.427497400629;2386.081358676913;2011.4669612552684;2216.8448208625405;2277.225743247304;2290.2900100968754;2294.655801629752;2307.180950762472;2341.285907798121;2344.4959333743154;2353.5645905507536;2355.1168311883043;8761.34289928258;8794.076621954731;8826;8836.072212417732;8841.823163536694;5216.478352164791;5341.813036543741;5348.224507446437;5356.9732151339385;5359.035373632744;3319.9834000830083;3380.3915295246848;3532.646735326447;3557.768745031565;3562.4834399012257;1161.285809227319;1195.1335281920624;1241.1312081542956;1244.7261602447447;2092.4559614500185;12213.816792748115;12699.365031748375;12710.42803073864;12713.300768457731;12727;4742.264948932852;4746.833860814855;4785.612172469945;4809.735464549483;4825.613950883921;10868.239223254297;10936.781264374667;10944.56221751137;10950.780984380268;10951.069159121405;5416.891662166813;5419.241306217133;5431.8098866539485;5436.184572314184;5437.864053398617;4303.505096913895;4792.880177995508;4942.9752851236235;4945.530174633404;5028.120078986163;4035.597674603816;4096.8566100186945;4204.264253755642;4211.241976444208;4217.810198541073;1281.9935900320625;1317.6244770240435;1319.960401187966;1331.081553727944;1340.5643165971098;960.577345967772;986.0780170540568;995.2983146881431;999.7550600102876;1015.0762805846645;5935.792247271324;6154.1999540059505;6196.287426945869;6245;6375.904361434582;967.1489089601106;979.0796651147898;991.0981007283337;1000.3297790480395;1025.1747343388645;4229.577042295808;4336.479622445327;4345.717528360647;4350.8042138103865;4368.563143685606;10902.236843420884;11233.55065797359;11242.213045086928;11266.267692599955;11271.211015229019;10645.627403041011;11101.222914395914;11119.332840029625;11444.14168937333;11448.828267575993;8213.548254845922;8387.496750195009;8420.621072051772;8425.620847061897;8430.494170349799;6020.90968635462;6363.809085727436;6399.232092148972;6470.450011749054;6481.287058423664;9943.751406214902;10348.120409764953;10550.997655222742;10623.468826558486;10634.89365106339;10431.061204491632;10652.8934710655;10701.143908487147;10794.56821727122;10796.622118225825;7003.824904377431;7384.298491643285;7794;7960.402969777174;8083.797905052421;8927.732168034969;8964.731058068268;9026.18764311215;9031.548422578977;9047.411918225294;7816.765497035098;8010.198980101944;8094.392920530866;8197.508149511048;8201;7846.960765196366;7928.127905930228;7966.880496792669;8014.438989270695;8032.076311224284;6884.793456196322;6937.89593156093;6953.026576279426;7017.298270172942;7017.649117544001;5022.372203474566;5078.7206703631655;5102.285680004728;5105.8723531912;5130.256112863689;5240.842774716612;5390.272313237662;5398.325209348832;5441.428649991693;5515.779368825202 12:04:31 INFO - PROCESS | 10945 | |4;prototype.html;326.3798782313604;332.95338652588634;337.6960735338195;339.2959608811715;342.7275316123681;5148.8415106601;5273.789048438058;5312.389075256347;5353.9196912046355;5362.356517217934;5278.973605131969;5342.652727572705;5354.518093371596;5367.221752845835;5373;4169.124483858378;4170.874873753793;4175.895602609936;4199.433076534675;4218.671118597647;3951.6245956634216;4010.9799451002705;4177.979110104445;4188.141431006651;4218.135282267143;4148.854790082348;4172.853950111731;4200.306949353353;4212.304969679999;4212.410262563244;4152.335626299778;4157.750534967911;4158.376243563474;4163.188178305231;4164.5210800758;3642.852501462031;3676.8863011932453;3734.8132593370224;3750.906227344311;3754.155315054118;5086.516780905808;5092.872678183038;5112.948870511284;5137.537621614073;5138.768755406016;4729.834455794031;4730.408698912636;4765.523447655241;4776.498467660915;4799.13615549201;5334.679919204821;5463.371712253102;5493.285872836545;5540.750666220029;5568.192612071227;3997.2405243003736;4003.11931375097;4008.318585840385;4035.757854528738;4052.3516237401873;5785.595008349417;5832.737526811304;5854.76580936762;5884.176215329857;5904.5276377890095;3898.142408670088;3993.2612466693754;4027.2549578328103;4055.106586695618;4129.525104613008;4023.8189281482405;4055.797210139481;4072.124493233969;4090.5500394957126;4091.0590564170407;4667.836625718083;4684.461286951976;4707.364505791675;4708.788104535304;4712.50518695532;5340.439253878365;5503.257060296809;5558.916616250759;5639.2668953035845;5639.295088113986;1339.2968691437075;1382.7165431086603;1399.8940836739066;1403.4736973634888;1406.21252098825;866.6273502394031;888.4629590807939;892.4734406700078;896.2068569316202;909.8126944337571;4761.40482439695;4780.330753694486;4795.520447955247;4812.711237325701;4821.445533763592;5117.720569857535;5124.795673016838;5127.179651255781;5140.460251673595;5154.510321519525;4799;4802.591779698695;4807.519248075165;4823.831165909176;5051.292819005343;3043.893463728759;3062.433449811792;3081.2450949517065;3104.549840273193;3107.9378412431624;5943.375945525744;5958.463738263577;5964.582479226499;5973.820785376446;6015.939840601625;5619.43805619443;5845.386234445407;5909.556783241188;5938.782549577326;5945.40545945402;5879.235699359056;5904.1734157218025;5907.316414821841;5908.084246941645;5910.763569457174;5498.120300751861;5714.885702286014;5723.8855222896145;5755.510781583613;5755.913661295168;5656.85857853557;5688.971555142363;5695.772169113189;5711.657300561979;5717.199592057199;5927.229460170322;5943.108533719977;5946;5956.463918247378;5981.700914954148;3940.8226629801156;4062.471878655756;4078.775667338325;4081.89795255121;4100.507939047334;5505.311836020497;5732.742026608896;5752.453516915886;5768.451997060272;5826.242588463472;5485.341758988947;5607.233721377753;5607.355154157324;5634.295713035871;5645.548356131581;5609.429359779268;5620.606557540933;5682.8579285516535;5684.2947115864245;5690.231818704422;5312.867178320418;5508.173773933942;5510.173473978935;5584.888302234014;5614.831555053355;5631.155326701028;5635.309407177912;5637.125066216341;5647.237622920853;5651;5523.779048838162;5530.198121272312;5533.972330138324;5547.362053363753;5565.916511252415 12:04:31 INFO - PROCESS | 10945 | |5;yui.html;801.2948605227401;820.5733018830205;824.2664029014175;863.248973393148;864.2696921101671;14787.186704731235;15973.840261597366;16039;16054.678906421865;16087.517374478784;14356.856431435683;15157.105361829772;15161.924190379033;15179.089254644728;15181.0891346519;687.0450074396592;806.6894245715413;814.1532805881891;822.0628483528782;826.962786674601;808.4340961327065;808.6765293882436;810.2828996338225;810.9148539403366;811.059171361221;865.0786911938765;866.1208872993885;866.3891956170916;866.5797088412115;866.9293422623056;710.5203987308546;723.8660847743184;725.6698202317932;833.7873842170269;858.1161403754144;625.2434554189437;626.573929727785;627.1721327847243;627.3318915355133;627.5293529852611;14885.33016014282;14886.181260030695;14946.850531494763;14980.625484362869;14996.700065998728;13952.93023534886;14351.928240358835;14555.490557830424;14588.781168282485;14648.853511464855;12640.873591264153;12671.619851404472;12733.87266127336;12954.352282385844;12962.935185324108;4319.805608747614;4384.671149663756;4401.537838526972;4443.733375997451;4485.618722408599;80841.59579202125;83021.16978830195;83979.5801020991;84794;85304.46955304543;11376.203665743318;11425.714357140972;11552.480138393625;11573.594924177612;11573.652790416301;19561.315353962542;20408.183672653224;22276.331710048726;22335.441613959458;22397;8416.579171041423;8485.490870547786;8547.35894807892;8596.140385961355;8819.867701984474;4814.494478079751;5000.6249531284575;5001.699898006132;5032.421271553818;5200.7139607321205;3493.7205023598053;3692.593814680383;3698.7041036716996;3720.981395093007;3726.832292546842;665.70043480434;670.6412069542869;678.4368973751774;678.5589366911547;694.8089275449291;634.6953462338104;667.2526770017514;757.7756645473476;761.9847603048019;762.0931092000612;9824.312298139062;10327.9483602583;10337.9483102584;10355.223358248162;10356.792864142826;648.4455790299321;716.2658275267892;750.2272659160964;770.603139383218;799.436397339874;4854.344663470457;4989.499204333973;5008.574271186917;5013.523715247045;5066.544011038951;68561.3143868565;93879.53060234655;111024.4448777751;115184.42407787907;116947.41526292314;95817;99694.5015274919;101019.49490252501;101113;102143;86512.13487865166;87063.56468217618;87281.99999999873;87606.12393876107;87658;9422;9449.43303401798;9532;9546.52267386614;9603.567839447382;52320.21519677284;52434;52834.73582632062;53404.1989370152;54354.18468723052;46302.30546541872;65282.347176529525;66242.33757662361;75275.62362188155;78678;13447.798283025566;13607.523736669169;13613.591592252249;13813.378397972316;14269.143851368952;14643.26783660834;15270;15278;15407.76888346698;16056.91971540135;14389.934341364873;14434.350454229794;14620.707585848011;14872.330745116713;15253.847461525243;14252.928735356258;14268.363416435719;14361.425542978164;14363.425462981364;14942.327595258022;13907.721845563234;14032.508862189774;14083.647908801951;14147.504837330644;14464.204468753898;10755.731106722395;11202.94398528002;11336.773264534828;11467.827982580102;11748.412579370826;11416.429178540873;11520.366379849189;11578.826317605075;11714.88285117138;11774.882251177378 12:04:31 INFO - PROCESS | 10945 | __end_tp_report 12:04:31 INFO - PROCESS | 10945 | __start_cc_report 12:04:31 INFO - PROCESS | 10945 | _x_x_mozilla_cycle_collect,850 12:04:31 INFO - PROCESS | 10945 | __end_cc_report 12:04:31 INFO - PROCESS | 10945 | __startTimestamp1465239871500__endTimestamp 12:04:31 INFO - PROCESS | 10945 | 12:04:31 INFO - PROCESS | 10945 | ------- Summary: start ------- 12:04:31 INFO - PROCESS | 10945 | Number of tests: 6 12:04:31 INFO - PROCESS | 10945 | 12:04:31 INFO - PROCESS | 10945 | [#0] dojo.html Cycles:165 Average:5467.64 Median:5702.52 stddev:641.61 (11.3%) stddev-sans-first:616.97 12:04:31 INFO - PROCESS | 10945 | Values: 3136.9 3139.2 3157.2 3175.9 3199.3 5295.9 5371.2 5405.5 5498.3 5505.7 5468.9 5490.5 5504.6 5508.4 5544.0 4916.9 4921.2 5012.3 5029.5 5174.5 5064.2 5099.2 5128.2 5140.1 5142.5 4878.6 4938.5 4947.3 4970.9 5019.2 4939.2 4944.6 5026.1 5032.4 5048.2 4848.1 4961.6 4973.7 4998.2 5028.5 5339.6 5429.5 5437.6 5520.5 5530.7 5953.6 5963.3 5968.3 5973.0 5982.3 5722.9 5797.5 5931.2 5936.0 5953.0 5391.7 5536.2 5546.4 5551.0 5557.5 6048.5 6061.2 6080.9 6081.4 6085.6 5617.0 5716.1 5749.1 5822.2 5825.2 5895.4 5932.3 5938.7 5957.1 5960.1 5822.0 5842.2 5844.4 5860.4 5872.7 5584.9 5717.8 5722.3 5770.9 5860.6 4399.4 4399.6 4401.4 4413.6 4431.0 3926.6 3926.7 3948.2 3963.4 3974.1 5355.3 5405.3 5495.8 5537.7 5547.6 5987.8 6000.4 6005.8 6009.4 6036.2 5583.7 5592.7 5596.8 5599.4 5602.8 4942.1 5059.4 5104.2 5112.5 5176.1 6156.9 6163.9 6170.7 6173.4 6175.5 5956.1 5994.3 5996.3 5996.9 5997.0 5865.7 6023.3 6025.7 6077.1 6108.1 5809.0 5825.7 5850.3 5853.1 5857.3 5577.0 5898.3 5939.4 5951.7 5962.9 5725.4 5765.3 5769.3 5801.9 5819.2 5776.8 5799.8 5802.3 5809.6 5810.1 5470.9 5602.4 5701.3 5702.5 5717.1 5789.0 5862.6 5886.2 5894.0 5894.4 5694.2 5703.6 5705.9 5706.0 5735.3 12:04:31 INFO - PROCESS | 10945 | 12:04:31 INFO - PROCESS | 10945 | [#1] ext.html Cycles:180 Average:61433.43 Median:23604.71 stddev:119238.75 (505.1%) stddev-sans-first:119485.68 12:04:31 INFO - PROCESS | 10945 | Values: 572.4 595.8 608.8 619.4 640.5 33442.2 36100.0 43586.9 44716.3 44750.8 46405.5 46841.0 46889.3 46914.3 46968.0 8637.4 8820.3 8824.8 8826.3 8828.6 8599.1 8772.4 8775.6 8777.9 8780.1 8756.1 8821.7 8833.9 8841.2 8843.1 8776.9 8831.9 8834.9 8838.1 8838.8 8649.6 8742.9 8759.8 8763.6 8769.6 43031.1 43274.4 43454.3 43478.6 43482.6 3439.9 3538.7 3654.3 3848.8 4263.9 32228.0 32678.8 32902.3 32989.0 32991.8 4244.9 4292.6 4387.5 4407.7 4502.1 374359.0 374899.0 375721.0 376919.0 377786.0 59137.0 59293.0 59435.1 59499.7 59552.4 63503.7 63565.7 63744.7 63796.0 63839.0 16254.0 16419.8 16455.8 16459.8 16467.2 13363.7 13448.2 13477.3 13485.1 13496.1 16036.4 17304.3 17334.9 17356.7 17516.8 5829.9 6356.5 6718.2 6968.4 6974.8 1007.4 1132.6 1140.7 1197.0 1201.5 33754.8 33853.8 33864.5 33869.5 33888.5 1164.5 1171.9 1186.7 1248.7 1256.4 17163.5 17381.4 17438.2 17518.6 17667.4 552315.0 552854.0 553322.0 553427.0 556513.0 59161.1 59193.7 59257.4 59312.0 59324.4 1227.8 1287.0 1338.8 1342.2 1382.9 32262.0 35072.5 35109.0 35149.5 35183.5 51665.0 51972.5 52290.5 52377.2 52420.5 396638.0 400420.0 400967.0 402107.0 402292.0 41372.8 42509.4 43019.6 43314.8 43492.8 49465.3 50119.0 50428.0 50730.0 51189.0 41984.9 42298.4 42916.8 42932.4 43017.4 42236.0 42311.4 42634.5 42716.6 42829.0 42261.8 42581.6 42676.0 43126.6 43446.8 36869.8 37539.6 37815.4 38173.6 38529.6 28723.9 28932.3 28978.3 29165.6 29326.0 12:04:31 INFO - PROCESS | 10945 | 12:04:31 INFO - PROCESS | 10945 | [#2] jquery.html Cycles:180 Average:28521.06 Median:23137.71 stddev:80354.89 (347.3%) stddev-sans-first:80552.50 12:04:31 INFO - PROCESS | 10945 | Values: 365.4 370.5 384.9 398.4 406.4 17786.1 19633.7 19842.0 19970.3 20030.9 18361.2 18553.8 18805.2 18943.6 18987.7 5569.0 5620.9 5756.7 5760.3 5804.7 5509.9 5624.6 5636.8 5662.1 5684.3 5586.6 5622.1 5628.0 5630.9 5702.4 5670.3 5697.9 5698.1 5699.1 5701.6 4958.7 5051.8 5089.8 5142.9 5148.2 22446.4 22454.6 22561.9 23133.7 23141.8 2135.5 2305.7 2310.0 2927.3 3075.2 10268.3 11471.7 12957.0 14081.4 14689.2 1929.7 1971.7 2024.4 2050.8 2159.3 82617.0 85254.0 86251.0 87041.6 90499.0 9129.3 9486.0 9726.7 9747.7 10022.4 13081.7 13113.7 13146.6 13172.6 13246.6 7508.3 7803.5 7826.1 7957.9 7986.5 7776.8 7906.8 7953.3 8019.7 8058.6 4047.3 4066.9 4145.1 4156.5 4202.8 1831.6 1901.5 1903.4 1924.8 1958.9 914.4 1064.4 1120.7 1121.0 1127.3 19015.0 19345.9 19782.6 19809.7 19891.2 996.6 1024.9 1027.6 1061.6 1068.3 10776.7 11206.7 11246.7 11255.1 11284.6 477858.0 480778.0 481127.0 485942.0 515619.0 56738.0 71314.9 86141.0 86645.6 87151.0 1013.9 1021.6 1026.1 1028.4 1032.0 17420.8 17553.6 17800.3 17825.5 17898.1 39166.4 39418.4 40296.6 40658.2 40964.8 52841.7 53732.2 54022.5 54334.7 54601.7 8711.0 8800.7 8894.2 9066.5 9149.6 12667.3 13519.3 13556.7 13721.4 13758.6 11832.4 11885.1 11889.3 11916.3 11919.5 10125.0 10571.2 11464.1 11598.1 11735.7 12206.7 12207.0 12353.5 12408.7 12752.3 7551.8 7791.1 8521.1 8707.8 9060.0 11746.9 12036.9 12041.0 12120.4 12324.8 12:04:31 INFO - PROCESS | 10945 | 12:04:31 INFO - PROCESS | 10945 | [#3] mootools.html Cycles:180 Average:5973.08 Median:4789.25 stddev:3402.62 (71.0%) stddev-sans-first:3394.21 12:04:31 INFO - PROCESS | 10945 | Values: 1321.5 1474.8 1530.2 1662.7 1800.2 8631.3 8993.0 9015.6 9196.5 9237.6 8848.8 9079.5 9087.2 9099.0 9105.1 2065.6 2301.7 2330.2 2359.9 2375.8 2406.3 2414.7 2419.5 2421.5 2422.3 2337.7 2372.3 2379.7 2385.4 2386.1 2011.5 2216.8 2277.2 2290.3 2294.7 2307.2 2341.3 2344.5 2353.6 2355.1 8761.3 8794.1 8826.0 8836.1 8841.8 5216.5 5341.8 5348.2 5357.0 5359.0 3320.0 3380.4 3532.6 3557.8 3562.5 1161.3 1195.1 1241.1 1244.7 2092.5 12213.8 12699.4 12710.4 12713.3 12727.0 4742.3 4746.8 4785.6 4809.7 4825.6 10868.2 10936.8 10944.6 10950.8 10951.1 5416.9 5419.2 5431.8 5436.2 5437.9 4303.5 4792.9 4943.0 4945.5 5028.1 4035.6 4096.9 4204.3 4211.2 4217.8 1282.0 1317.6 1320.0 1331.1 1340.6 960.6 986.1 995.3 999.8 1015.1 5935.8 6154.2 6196.3 6245.0 6375.9 967.1 979.1 991.1 1000.3 1025.2 4229.6 4336.5 4345.7 4350.8 4368.6 10902.2 11233.6 11242.2 11266.3 11271.2 10645.6 11101.2 11119.3 11444.1 11448.8 8213.5 8387.5 8420.6 8425.6 8430.5 6020.9 6363.8 6399.2 6470.5 6481.3 9943.8 10348.1 10551.0 10623.5 10634.9 10431.1 10652.9 10701.1 10794.6 10796.6 7003.8 7384.3 7794.0 7960.4 8083.8 8927.7 8964.7 9026.2 9031.5 9047.4 7816.8 8010.2 8094.4 8197.5 8201.0 7847.0 7928.1 7966.9 8014.4 8032.1 6884.8 6937.9 6953.0 7017.3 7017.6 5022.4 5078.7 5102.3 5105.9 5130.3 5240.8 5390.3 5398.3 5441.4 5515.8 12:04:31 INFO - PROCESS | 10945 | 12:04:31 INFO - PROCESS | 10945 | [#4] prototype.html Cycles:180 Average:4660.62 Median:5214.15 stddev:1376.36 (26.4%) stddev-sans-first:1341.23 12:04:31 INFO - PROCESS | 10945 | Values: 326.4 333.0 337.7 339.3 342.7 5148.8 5273.8 5312.4 5353.9 5362.4 5279.0 5342.7 5354.5 5367.2 5373.0 4169.1 4170.9 4175.9 4199.4 4218.7 3951.6 4011.0 4178.0 4188.1 4218.1 4148.9 4172.9 4200.3 4212.3 4212.4 4152.3 4157.8 4158.4 4163.2 4164.5 3642.9 3676.9 3734.8 3750.9 3754.2 5086.5 5092.9 5112.9 5137.5 5138.8 4729.8 4730.4 4765.5 4776.5 4799.1 5334.7 5463.4 5493.3 5540.8 5568.2 3997.2 4003.1 4008.3 4035.8 4052.4 5785.6 5832.7 5854.8 5884.2 5904.5 3898.1 3993.3 4027.3 4055.1 4129.5 4023.8 4055.8 4072.1 4090.6 4091.1 4667.8 4684.5 4707.4 4708.8 4712.5 5340.4 5503.3 5558.9 5639.3 5639.3 1339.3 1382.7 1399.9 1403.5 1406.2 866.6 888.5 892.5 896.2 909.8 4761.4 4780.3 4795.5 4812.7 4821.4 5117.7 5124.8 5127.2 5140.5 5154.5 4799.0 4802.6 4807.5 4823.8 5051.3 3043.9 3062.4 3081.2 3104.5 3107.9 5943.4 5958.5 5964.6 5973.8 6015.9 5619.4 5845.4 5909.6 5938.8 5945.4 5879.2 5904.2 5907.3 5908.1 5910.8 5498.1 5714.9 5723.9 5755.5 5755.9 5656.9 5689.0 5695.8 5711.7 5717.2 5927.2 5943.1 5946.0 5956.5 5981.7 3940.8 4062.5 4078.8 4081.9 4100.5 5505.3 5732.7 5752.5 5768.5 5826.2 5485.3 5607.2 5607.4 5634.3 5645.5 5609.4 5620.6 5682.9 5684.3 5690.2 5312.9 5508.2 5510.2 5584.9 5614.8 5631.2 5635.3 5637.1 5647.2 5651.0 5523.8 5530.2 5534.0 5547.4 5565.9 12:04:31 INFO - PROCESS | 10945 | 12:04:31 INFO - PROCESS | 10945 | [#5] yui.html Cycles:180 Average:20712.42 Median:25558.40 stddev:29132.51 (114.0%) stddev-sans-first:29175.87 12:04:31 INFO - PROCESS | 10945 | Values: 801.3 820.6 824.3 863.2 864.3 14787.2 15973.8 16039.0 16054.7 16087.5 14356.9 15157.1 15161.9 15179.1 15181.1 687.0 806.7 814.2 822.1 827.0 808.4 808.7 810.3 810.9 811.1 865.1 866.1 866.4 866.6 866.9 710.5 723.9 725.7 833.8 858.1 625.2 626.6 627.2 627.3 627.5 14885.3 14886.2 14946.9 14980.6 14996.7 13952.9 14351.9 14555.5 14588.8 14648.9 12640.9 12671.6 12733.9 12954.4 12962.9 4319.8 4384.7 4401.5 4443.7 4485.6 80841.6 83021.2 83979.6 84794.0 85304.5 11376.2 11425.7 11552.5 11573.6 11573.7 19561.3 20408.2 22276.3 22335.4 22397.0 8416.6 8485.5 8547.4 8596.1 8819.9 4814.5 5000.6 5001.7 5032.4 5200.7 3493.7 3692.6 3698.7 3721.0 3726.8 665.7 670.6 678.4 678.6 694.8 634.7 667.3 757.8 762.0 762.1 9824.3 10327.9 10337.9 10355.2 10356.8 648.4 716.3 750.2 770.6 799.4 4854.3 4989.5 5008.6 5013.5 5066.5 68561.3 93879.5 111024.4 115184.4 116947.4 95817.0 99694.5 101019.5 101113.0 102143.0 86512.1 87063.6 87282.0 87606.1 87658.0 9422.0 9449.4 9532.0 9546.5 9603.6 52320.2 52434.0 52834.7 53404.2 54354.2 46302.3 65282.3 66242.3 75275.6 78678.0 13447.8 13607.5 13613.6 13813.4 14269.1 14643.3 15270.0 15278.0 15407.8 16056.9 14389.9 14434.4 14620.7 14872.3 15253.8 14252.9 14268.4 14361.4 14363.4 14942.3 13907.7 14032.5 14083.6 14147.5 14464.2 10755.7 11202.9 11336.8 11467.8 11748.4 11416.4 11520.4 11578.8 11714.9 11774.9 12:04:31 INFO - PROCESS | 10945 | -------- Summary: end -------- 12:04:31 INFO - PROCESS | 10945 | 12:04:32 INFO - TEST-INFO | 10945: exit 0 12:04:32 INFO - TEST-OK | dromaeo_css | took 1113074ms 12:04:32 INFO - TEST-START | kraken 12:04:32 INFO - operating with platform_type : linux_ 12:04:32 INFO - Initialising browser for kraken test... 12:04:32 INFO - TEST-INFO | started process 11126 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD47_eD/profile http://localhost:52403/getInfo.html) 12:04:36 INFO - PROCESS | 11126 | __metrics Screen width/height:1600/1200 12:04:36 INFO - PROCESS | 11126 | colorDepth:24 12:04:36 INFO - PROCESS | 11126 | Browser inner width/height: 1024/697 12:04:36 INFO - PROCESS | 11126 | __metrics 12:04:37 ERROR - PROCESS | 11126 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:04:37 INFO - PROCESS | 11126 | console.error: PushService: 12:04:37 INFO - PROCESS | 11126 | stateChangeProcessEnqueue: Error transitioning state 12:04:37 INFO - PROCESS | 11126 | UnknownError 12:04:38 INFO - TEST-INFO | 11126: exit 0 12:04:38 INFO - Browser initialized. 12:04:38 INFO - Running cycle 1/1 for kraken test... 12:04:38 INFO - TEST-INFO | started process 11211 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD47_eD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:04:49 INFO - PROCESS | 11211 | RSS: Main: 156004352 12:04:49 INFO - PROCESS | 11211 | 12:04:52 INFO - PROCESS | 11211 | Cycle 1(1): loaded http://localhost:52403/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52403/tests/kraken/driver.html?testName=audio-beat-detection) 12:04:53 INFO - PROCESS | 11211 | RSS: Main: 214134784 12:04:53 INFO - PROCESS | 11211 | 12:04:55 INFO - PROCESS | 11211 | Cycle 1(1): loaded http://localhost:52403/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52403/tests/kraken/driver.html?testName=audio-dft) 12:04:56 INFO - PROCESS | 11211 | RSS: Main: 201744384 12:04:56 INFO - PROCESS | 11211 | 12:04:59 INFO - PROCESS | 11211 | Cycle 1(1): loaded http://localhost:52403/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52403/tests/kraken/driver.html?testName=audio-fft) 12:05:00 INFO - PROCESS | 11211 | RSS: Main: 268374016 12:05:00 INFO - PROCESS | 11211 | 12:05:02 INFO - PROCESS | 11211 | Cycle 1(1): loaded http://localhost:52403/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52403/tests/kraken/driver.html?testName=audio-oscillator) 12:05:02 INFO - PROCESS | 11211 | RSS: Main: 179568640 12:05:02 INFO - PROCESS | 11211 | 12:05:05 INFO - PROCESS | 11211 | Cycle 1(1): loaded http://localhost:52403/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52403/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:05:05 INFO - PROCESS | 11211 | RSS: Main: 182878208 12:05:05 INFO - PROCESS | 11211 | 12:05:08 INFO - PROCESS | 11211 | Cycle 1(1): loaded http://localhost:52403/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52403/tests/kraken/driver.html?testName=imaging-darkroom) 12:05:09 INFO - PROCESS | 11211 | RSS: Main: 217563136 12:05:09 INFO - PROCESS | 11211 | 12:05:12 INFO - PROCESS | 11211 | Cycle 1(1): loaded http://localhost:52403/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52403/tests/kraken/driver.html?testName=imaging-desaturate) 12:05:13 INFO - PROCESS | 11211 | RSS: Main: 220348416 12:05:13 INFO - PROCESS | 11211 | 12:05:16 INFO - PROCESS | 11211 | Cycle 1(1): loaded http://localhost:52403/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52403/tests/kraken/driver.html?testName=json-parse-financial) 12:05:16 INFO - PROCESS | 11211 | RSS: Main: 220868608 12:05:16 INFO - PROCESS | 11211 | 12:05:18 INFO - PROCESS | 11211 | Cycle 1(1): loaded http://localhost:52403/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52403/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:05:18 INFO - PROCESS | 11211 | RSS: Main: 206716928 12:05:18 INFO - PROCESS | 11211 | 12:05:20 INFO - PROCESS | 11211 | Cycle 1(1): loaded http://localhost:52403/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52403/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:05:21 INFO - PROCESS | 11211 | RSS: Main: 212398080 12:05:21 INFO - PROCESS | 11211 | 12:05:23 INFO - PROCESS | 11211 | Cycle 1(1): loaded http://localhost:52403/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52403/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:05:24 INFO - PROCESS | 11211 | RSS: Main: 217128960 12:05:24 INFO - PROCESS | 11211 | 12:05:26 INFO - PROCESS | 11211 | Cycle 1(1): loaded http://localhost:52403/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52403/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:05:27 INFO - PROCESS | 11211 | RSS: Main: 223141888 12:05:27 INFO - PROCESS | 11211 | 12:05:29 INFO - PROCESS | 11211 | Cycle 1(1): loaded http://localhost:52403/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52403/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:05:30 INFO - PROCESS | 11211 | RSS: Main: 222887936 12:05:30 INFO - PROCESS | 11211 | 12:05:32 INFO - PROCESS | 11211 | Cycle 1(1): loaded http://localhost:52403/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52403/tests/kraken/driver.html?testName=ai-astar) 12:05:32 INFO - PROCESS | 11211 | RSS: Main: 265052160 12:05:32 INFO - PROCESS | 11211 | 12:05:32 INFO - PROCESS | 11211 | __start_tp_report 12:05:32 INFO - PROCESS | 11211 | _x_x_mozilla_page_load 12:05:32 INFO - PROCESS | 11211 | _x_x_mozilla_page_load_details 12:05:32 INFO - PROCESS | 11211 | |i|pagename|runs| 12:05:32 INFO - PROCESS | 11211 | |0;ai-astar;110;107;110;110;111;111;110;112;111;110 12:05:32 INFO - PROCESS | 11211 | |1;audio-beat-detection;159;123;128;189;132;128;151;124;185;125 12:05:32 INFO - PROCESS | 11211 | |2;audio-dft;160;161;161;161;161;159;159;161;162;161 12:05:32 INFO - PROCESS | 11211 | |3;audio-fft;75;75;76;127;76;77;75;75;111;74 12:05:32 INFO - PROCESS | 11211 | |4;audio-oscillator;85;85;117;86;85;86;112;84;86;118 12:05:32 INFO - PROCESS | 11211 | |5;imaging-gaussian-blur;116;117;116;116;117;117;117;117;117;116 12:05:32 INFO - PROCESS | 11211 | |6;imaging-darkroom;147;146;145;147;147;146;147;148;146;145 12:05:32 INFO - PROCESS | 11211 | |7;imaging-desaturate;95;94;95;95;95;95;94;95;96;95 12:05:32 INFO - PROCESS | 11211 | |8;json-parse-financial;55;53;54;54;54;53;54;54;54;53 12:05:32 INFO - PROCESS | 11211 | |9;json-stringify-tinderbox;61;62;62;62;62;62;61;62;62;61 12:05:32 INFO - PROCESS | 11211 | |10;stanford-crypto-aes;81;80;77;85;79;79;81;80;118;86 12:05:32 INFO - PROCESS | 11211 | |11;stanford-crypto-ccm;122;120;128;128;125;120;119;120;135;122 12:05:32 INFO - PROCESS | 11211 | |12;stanford-crypto-pbkdf2;161;163;162;166;164;160;165;159;156;159 12:05:32 INFO - PROCESS | 11211 | |13;stanford-crypto-sha256-iterative;64;63;65;63;63;62;63;63;65;64 12:05:32 INFO - PROCESS | 11211 | __end_tp_report 12:05:32 INFO - PROCESS | 11211 | __start_cc_report 12:05:32 INFO - PROCESS | 11211 | _x_x_mozilla_cycle_collect,1603 12:05:32 INFO - PROCESS | 11211 | __end_cc_report 12:05:32 INFO - PROCESS | 11211 | __startTimestamp1465239932370__endTimestamp 12:05:32 INFO - PROCESS | 11211 | 12:05:32 INFO - PROCESS | 11211 | ------- Summary: start ------- 12:05:32 INFO - PROCESS | 11211 | Number of tests: 14 12:05:32 INFO - PROCESS | 11211 | 12:05:32 INFO - PROCESS | 11211 | [#0] ai-astar Cycles:10 Average:110.20 Median:110.50 stddev:1.32 (1.2%) stddev-sans-first:1.39 12:05:32 INFO - PROCESS | 11211 | Values: 110.0 107.0 110.0 110.0 111.0 111.0 110.0 112.0 111.0 110.0 12:05:32 INFO - PROCESS | 11211 | 12:05:32 INFO - PROCESS | 11211 | [#1] audio-beat-detection Cycles:10 Average:144.40 Median:141.50 stddev:25.47 (18.0%) stddev-sans-first:26.46 12:05:32 INFO - PROCESS | 11211 | Values: 159.0 123.0 128.0 189.0 132.0 128.0 151.0 124.0 185.0 125.0 12:05:32 INFO - PROCESS | 11211 | 12:05:32 INFO - PROCESS | 11211 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 12:05:32 INFO - PROCESS | 11211 | Values: 160.0 161.0 161.0 161.0 161.0 159.0 159.0 161.0 162.0 161.0 12:05:32 INFO - PROCESS | 11211 | 12:05:32 INFO - PROCESS | 11211 | [#3] audio-fft Cycles:10 Average:84.10 Median:75.00 stddev:18.79 (25.1%) stddev-sans-first:19.64 12:05:32 INFO - PROCESS | 11211 | Values: 75.0 75.0 76.0 127.0 76.0 77.0 75.0 75.0 111.0 74.0 12:05:32 INFO - PROCESS | 11211 | 12:05:32 INFO - PROCESS | 11211 | [#4] audio-oscillator Cycles:10 Average:94.40 Median:85.00 stddev:14.77 (17.4%) stddev-sans-first:15.27 12:05:32 INFO - PROCESS | 11211 | Values: 85.0 85.0 117.0 86.0 85.0 86.0 112.0 84.0 86.0 118.0 12:05:32 INFO - PROCESS | 11211 | 12:05:32 INFO - PROCESS | 11211 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 12:05:32 INFO - PROCESS | 11211 | Values: 116.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 12:05:32 INFO - PROCESS | 11211 | 12:05:32 INFO - PROCESS | 11211 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:147.00 stddev:0.97 (0.7%) stddev-sans-first:1.00 12:05:32 INFO - PROCESS | 11211 | Values: 147.0 146.0 145.0 147.0 147.0 146.0 147.0 148.0 146.0 145.0 12:05:32 INFO - PROCESS | 11211 | 12:05:32 INFO - PROCESS | 11211 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 12:05:32 INFO - PROCESS | 11211 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 94.0 95.0 96.0 95.0 12:05:32 INFO - PROCESS | 11211 | 12:05:32 INFO - PROCESS | 11211 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:0.63 (1.2%) stddev-sans-first:0.50 12:05:32 INFO - PROCESS | 11211 | Values: 55.0 53.0 54.0 54.0 54.0 53.0 54.0 54.0 54.0 53.0 12:05:32 INFO - PROCESS | 11211 | 12:05:32 INFO - PROCESS | 11211 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:62.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 12:05:32 INFO - PROCESS | 11211 | Values: 61.0 62.0 62.0 62.0 62.0 62.0 61.0 62.0 62.0 61.0 12:05:32 INFO - PROCESS | 11211 | 12:05:32 INFO - PROCESS | 11211 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:80.50 stddev:12.05 (15.0%) stddev-sans-first:12.71 12:05:32 INFO - PROCESS | 11211 | Values: 81.0 80.0 77.0 85.0 79.0 79.0 81.0 80.0 118.0 86.0 12:05:32 INFO - PROCESS | 11211 | 12:05:32 INFO - PROCESS | 11211 | [#11] stanford-crypto-ccm Cycles:10 Average:123.90 Median:123.50 stddev:5.11 (4.1%) stddev-sans-first:5.37 12:05:32 INFO - PROCESS | 11211 | Values: 122.0 120.0 128.0 128.0 125.0 120.0 119.0 120.0 135.0 122.0 12:05:32 INFO - PROCESS | 11211 | 12:05:32 INFO - PROCESS | 11211 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.50 Median:162.50 stddev:3.10 (1.9%) stddev-sans-first:3.28 12:05:32 INFO - PROCESS | 11211 | Values: 161.0 163.0 162.0 166.0 164.0 160.0 165.0 159.0 156.0 159.0 12:05:32 INFO - PROCESS | 11211 | 12:05:32 INFO - PROCESS | 11211 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:63.50 stddev:0.97 (1.5%) stddev-sans-first:1.01 12:05:32 INFO - PROCESS | 11211 | Values: 64.0 63.0 65.0 63.0 63.0 62.0 63.0 63.0 65.0 64.0 12:05:32 INFO - PROCESS | 11211 | -------- Summary: end -------- 12:05:32 INFO - PROCESS | 11211 | 12:05:33 INFO - TEST-INFO | 11211: exit 0 12:05:33 INFO - TEST-OK | kraken | took 61188ms 12:05:33 INFO - SUITE-END | took 1174s 12:05:33 INFO - Completed test suite (00:19:34) 12:05:33 INFO - javascript benchmark 12:05:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3136.85884135214, 3139.2465808206025, 3157.226479512519, 3175.8570864311105, 3199.2641692410743, 5295.920561191585, 5371.167469042305, 5405.513503784664, 5498.312710911141, 5505.697186654733, 5468.863278418042, 5490.478404551571, 5504.587155963299, 5508.366537848138, 5544.0, 4916.926246106311, 4921.212605983034, 5012.298278241049, 5029.5221953914315, 5174.456682048387, 5064.215046667772, 5099.209622508499, 5128.230765385203, 5140.074786538422, 5142.460041695625, 4878.560929516343, 4938.456769755324, 4947.307376967227, 4970.900581988358, 5019.196928491442, 4939.160342741707, 4944.629152813553, 5026.145555255579, 5032.446430892635, 5048.192289233742, 4848.127337079324, 4961.603071754251, 4973.701577905337, 4998.200287953946, 5028.472010438888, 5339.5728341732565, 5429.53848922842, 5437.619366644337, 5520.475554822286, 5530.695811730353, 5953.58324917256, 5963.314218864799, 5968.253968253968, 5973.0144526153135, 5982.282126144847, 5722.856928576777, 5797.4782269595935, 5931.199288096138, 5936.0, 5953.047512398039, 5391.703456309901, 5536.2249285100115, 5546.417626149277, 5551.028570000234, 5557.499825015768, 6048.455638992512, 6061.212042434456, 6080.8783824324155, 6081.422264884829, 6085.6348619083, 5617.0, 5716.114002329646, 5749.13762935563, 5822.155787410802, 5825.2135961644635, 5895.41045895407, 5932.3177834548715, 5938.703064846827, 5957.106434034929, 5960.1059841023325, 5822.0, 5842.2405087338375, 5844.386339434383, 5860.443257890493, 5872.677002764804, 5584.888302233932, 5717.799877004285, 5722.284714410699, 5770.942290577041, 5860.589758716934, 4399.406080179135, 4399.626031787334, 4401.361802538614, 4413.624841888475, 4430.977845110819, 3926.6466018058513, 3926.7447615904875, 3948.1906209227614, 3963.4451176835264, 3974.066094467798, 5355.303810504687, 5405.297311349499, 5495.807646732345, 5537.723113844291, 5547.55619550435, 5987.790427335022, 6000.369961154103, 6005.819825405245, 6009.399060093956, 6036.215292012011, 5583.74873130702, 5592.664440133605, 5596.804111856066, 5599.412061733541, 5602.775888964396, 4942.085714142823, 5059.418166910852, 5104.2088476286235, 5112.463191364927, 5176.068307704574, 6156.876862462816, 6163.876722465615, 6170.691465426711, 6173.351798061229, 6175.505959523227, 5956.136360227742, 5994.340622531431, 5996.280446346466, 5996.910046349221, 5997.0404735242155, 5865.736041878211, 6023.277206735044, 6025.728842202024, 6077.118817771487, 6108.08378743192, 5809.0, 5825.650460972355, 5850.297964244318, 5853.09277062056, 5857.26784151981, 5577.0, 5898.262717160355, 5939.376365481735, 5951.672658003851, 5962.880742385041, 5725.370209276893, 5765.250517432707, 5769.336526299529, 5801.912971305518, 5819.15622234782, 5776.797812076726, 5799.768009279582, 5802.303723553201, 5809.593328466966, 5810.070388737781, 5470.863228419162, 5602.411746766694, 5701.287339082614, 5702.515286200553, 5717.113847353667, 5789.0, 5862.589618726648, 5886.205362276038, 5893.970530147321, 5894.38108998549, 5694.231278777312, 5703.62926409782, 5705.857353566028, 5705.971470142788, 5735.340435849931], "value": 5422.937973276531, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.3761100400565, 595.7736060297086, 608.7838817219886, 619.3527763487156, 640.4876099120702, 33442.16394590133, 36100.0, 43586.91032724179, 44716.3292550612, 44750.7762461188, 46405.53594464054, 46841.0, 46889.29666055003, 46914.29628555566, 46968.0, 8637.438566493189, 8820.338474614398, 8824.779380515474, 8826.293896488298, 8828.558572071403, 8599.140085991414, 8772.429792063496, 8775.561221938877, 8777.912220877804, 8780.121987801233, 8756.124387561256, 8821.735347939572, 8833.867491987625, 8841.160089791492, 8843.11568843117, 8776.912230877673, 8831.867521987175, 8834.911650883474, 8838.072002439747, 8838.779030524256, 8649.610767515476, 8742.912570874274, 8759.781005474913, 8763.649454021832, 8769.561521923943, 43031.139377212596, 43274.350884736756, 43454.34818477726, 43478.565214348084, 43482.565174348165, 3439.914002149941, 3538.716902647782, 3654.3239500692193, 3848.826802793881, 4263.87208383749, 32228.0, 32678.836605816818, 32902.34195316104, 32989.03701061644, 32991.83504082464, 4244.936325955113, 4292.635126014261, 4387.473503179607, 4407.735535867858, 4502.099580083996, 374359.0, 374899.0, 375721.0, 376918.99999999726, 377786.0, 59137.0, 59293.0, 59435.10847337294, 59499.70250148721, 59552.404475955555, 63503.6824815873, 63565.68217158884, 63744.681276594245, 63796.0, 63839.0, 16254.0, 16419.753703694456, 16455.753163702553, 16459.753103703453, 16467.176641168135, 13363.665908352175, 13448.193108413527, 13477.258750768802, 13485.123466974615, 13496.122752021283, 16036.358545658042, 17304.307827687004, 17334.913325433292, 17356.739648905277, 17516.824831751775, 5829.854253643608, 6356.523260755462, 6718.193816741925, 6968.407685346802, 6974.825629359307, 1007.4056306779036, 1132.6375559820779, 1140.7091191746051, 1196.9646255988507, 1201.5133870782347, 33754.831225843714, 33853.83073084619, 33864.49203261953, 33869.49195762065, 33888.49167262493, 1164.525383559935, 1171.9062475001979, 1186.7092562322287, 1248.719038216394, 1256.4220458588968, 17163.534725861446, 17381.391651292142, 17438.215280312415, 17518.562035948948, 17667.38164164248, 552315.0, 552854.0, 553322.0, 553427.0, 556513.0, 59161.11258331128, 59193.70403147957, 59257.40742592605, 59312.0, 59324.40675593275, 1227.821965814952, 1286.9806952895715, 1338.8326459192601, 1342.2483409290828, 1382.9170249785045, 32262.0, 35072.47391289082, 35109.0, 35149.47275790814, 35183.49804915703, 51665.0, 51972.480275196765, 52290.47709522856, 52377.214341785664, 52420.47579524156, 396638.0, 400420.0, 400967.0, 402107.0, 402292.0, 41372.793136034124, 42509.36235956401, 43019.56980430156, 43314.78342608267, 43492.782536087114, 49465.25802113043, 50119.0, 50428.0, 50730.0, 51189.0, 41984.94508331922, 42298.36552451777, 42916.785416073966, 42932.35601466043, 43017.354739679555, 42235.95075620086, 42311.3653295207, 42634.51721083841, 42716.57283427126, 42829.0, 42261.84875780603, 42581.57418425776, 42676.0, 43126.568734312255, 43446.78276608597, 36869.81565092158, 37539.62460375361, 37815.43276850794, 38173.61826381701, 38529.614703853724, 28723.856380717963, 28932.27669308284, 28978.27554311159, 29165.625156226735, 29326.0], "value": 20679.533459125818, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.35879531422347, 370.53497860185473, 384.85567912032985, 398.3805182940528, 406.36606893246517, 17786.110694465275, 19633.705494417576, 19842.0, 19970.301039463604, 20030.899845500753, 18361.173747181376, 18553.81446185541, 18805.24779008838, 18943.62112757744, 18987.715184272212, 5568.972155139219, 5620.887582248352, 5756.740946657411, 5760.2511673482595, 5804.680742559158, 5509.862253443676, 5624.634398764088, 5636.830895073154, 5662.094064949609, 5684.289463817023, 5586.55307575395, 5622.128570071645, 5628.04323265046, 5630.915536266939, 5702.372738998707, 5670.319561652587, 5697.943020569783, 5698.116791897262, 5699.088145896637, 5701.629394089392, 4958.677685950402, 5051.823186188466, 5089.821856235051, 5142.948570514322, 5148.227765835155, 22446.438839028993, 22454.55090898189, 22561.887190564106, 23133.652995205084, 23141.768582314297, 2135.4981579328846, 2305.7117860267467, 2310.0413328468835, 2927.2681829542616, 3075.246564591667, 10268.332558383756, 11471.713207169803, 12956.963442924638, 14081.436742530286, 14689.192094434802, 1929.729837822706, 1971.7338159348449, 2024.3522072936667, 2050.794920507952, 2159.341400872733, 82617.0, 85254.0, 86251.0, 87041.56479217627, 90499.0, 9129.269658427309, 9486.0, 9726.659566915265, 9747.658831940847, 10022.444276709393, 13081.672958176121, 13113.737725245443, 13146.60560183196, 13172.628926793077, 13246.602601921957, 7508.324250817343, 7803.531788092619, 7826.0608726952, 7957.880631790527, 7986.480878742863, 7776.844463110706, 7906.841863162819, 7953.2842044216295, 8019.679212831538, 8058.597070146469, 4047.2714911315657, 4066.898327541776, 4145.067359844011, 4156.480439945007, 4202.810873510699, 1831.6336732653256, 1901.5341241395947, 1903.3747992378653, 1924.807519248064, 1958.8824670519814, 914.3873604684877, 1064.3667018124204, 1120.7478317378689, 1121.0079080014084, 1127.2785417332914, 19015.0, 19345.90327048356, 19782.60434791325, 19809.702854457195, 19891.204351826054, 996.566493575297, 1024.8667673202585, 1027.5889644142403, 1061.6231237910586, 1068.316277582348, 10776.730581735363, 11206.719832004264, 11246.66260012201, 11255.099592032782, 11284.605038823765, 477858.0, 480778.0, 481127.0, 485942.0, 515619.0, 56738.0, 71314.93027604486, 86141.0, 86645.566772167, 87151.0, 1013.8834034086027, 1021.6373187518473, 1026.1329176845554, 1028.4395004722444, 1032.02989190161, 17420.82579174192, 17553.59143532927, 17800.287988480315, 17825.46523604294, 17898.10509474547, 39166.41250381304, 39418.40872386974, 40296.597034029284, 40658.1868362637, 40964.79517602393, 52841.735791320796, 53732.19401709056, 54022.459775401745, 54334.72832635811, 54601.72699136479, 8710.956445217733, 8800.735977920416, 8894.200841612303, 9066.456012639263, 9149.588268528065, 12667.30329831868, 13519.324033798468, 13556.661083472993, 13721.382537786023, 13758.587242382344, 11832.408379580815, 11885.108616853944, 11889.346085965355, 11916.344601047025, 11919.523219071487, 10125.0, 10571.154307655523, 11464.082873369944, 11598.130140239347, 11735.706607334885, 12206.694832629255, 12207.0, 12353.505859765508, 12408.689782755504, 12752.298623575793, 7551.773446796605, 7791.142974272712, 8521.105283945097, 8707.825843482968, 9059.954700226457, 11746.941265293619, 12036.879631203576, 12041.0, 12120.393980301125, 12324.81512777327], "value": 9153.58537826456, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1321.4912258780366, 1474.8230212374513, 1530.1507663246898, 1662.7090259204645, 1800.1539276540022, 8631.30949524038, 8992.955035224815, 9015.639374425024, 9196.540172991357, 9237.584308706108, 8848.823023539526, 9079.500627465486, 9087.182153606174, 9099.0, 9105.089491050892, 2065.607534568427, 2301.7122859642545, 2330.1727886600265, 2359.9174028908906, 2375.8455700379504, 2406.338256979327, 2414.7223069346987, 2419.5402873454077, 2421.4672771990136, 2422.2612103308484, 2337.684412604302, 2372.3120295114395, 2379.6668466414717, 2385.427497400629, 2386.081358676913, 2011.4669612552684, 2216.8448208625405, 2277.225743247304, 2290.2900100968754, 2294.655801629752, 2307.180950762472, 2341.285907798121, 2344.4959333743154, 2353.5645905507536, 2355.1168311883043, 8761.34289928258, 8794.076621954731, 8826.0, 8836.072212417732, 8841.823163536694, 5216.478352164791, 5341.813036543741, 5348.224507446437, 5356.9732151339385, 5359.035373632744, 3319.9834000830083, 3380.3915295246848, 3532.646735326447, 3557.768745031565, 3562.4834399012257, 1161.285809227319, 1195.1335281920624, 1241.1312081542956, 1244.7261602447447, 2092.4559614500185, 12213.816792748115, 12699.365031748375, 12710.42803073864, 12713.300768457731, 12727.0, 4742.264948932852, 4746.833860814855, 4785.612172469945, 4809.735464549483, 4825.613950883921, 10868.239223254297, 10936.781264374667, 10944.56221751137, 10950.780984380268, 10951.069159121405, 5416.891662166813, 5419.241306217133, 5431.8098866539485, 5436.184572314184, 5437.864053398617, 4303.505096913895, 4792.880177995508, 4942.9752851236235, 4945.530174633404, 5028.120078986163, 4035.597674603816, 4096.8566100186945, 4204.264253755642, 4211.241976444208, 4217.810198541073, 1281.9935900320625, 1317.6244770240435, 1319.960401187966, 1331.081553727944, 1340.5643165971098, 960.577345967772, 986.0780170540568, 995.2983146881431, 999.7550600102876, 1015.0762805846645, 5935.792247271324, 6154.1999540059505, 6196.287426945869, 6245.0, 6375.904361434582, 967.1489089601106, 979.0796651147898, 991.0981007283337, 1000.3297790480395, 1025.1747343388645, 4229.577042295808, 4336.479622445327, 4345.717528360647, 4350.8042138103865, 4368.563143685606, 10902.236843420884, 11233.55065797359, 11242.213045086928, 11266.267692599955, 11271.211015229019, 10645.627403041011, 11101.222914395914, 11119.332840029625, 11444.14168937333, 11448.828267575993, 8213.548254845922, 8387.496750195009, 8420.621072051772, 8425.620847061897, 8430.494170349799, 6020.90968635462, 6363.809085727436, 6399.232092148972, 6470.450011749054, 6481.287058423664, 9943.751406214902, 10348.120409764953, 10550.997655222742, 10623.468826558486, 10634.89365106339, 10431.061204491632, 10652.8934710655, 10701.143908487147, 10794.56821727122, 10796.622118225825, 7003.824904377431, 7384.298491643285, 7794.0, 7960.402969777174, 8083.797905052421, 8927.732168034969, 8964.731058068268, 9026.18764311215, 9031.548422578977, 9047.411918225294, 7816.765497035098, 8010.198980101944, 8094.392920530866, 8197.508149511048, 8201.0, 7846.960765196366, 7928.127905930228, 7966.880496792669, 8014.438989270695, 8032.076311224284, 6884.793456196322, 6937.89593156093, 6953.026576279426, 7017.298270172942, 7017.649117544001, 5022.372203474566, 5078.7206703631655, 5102.285680004728, 5105.8723531912, 5130.256112863689, 5240.842774716612, 5390.272313237662, 5398.325209348832, 5441.428649991693, 5515.779368825202], "value": 4786.180202167716, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.3798782313604, 332.95338652588634, 337.6960735338195, 339.2959608811715, 342.7275316123681, 5148.8415106601, 5273.789048438058, 5312.389075256347, 5353.9196912046355, 5362.356517217934, 5278.973605131969, 5342.652727572705, 5354.518093371596, 5367.221752845835, 5373.0, 4169.124483858378, 4170.874873753793, 4175.895602609936, 4199.433076534675, 4218.671118597647, 3951.6245956634216, 4010.9799451002705, 4177.979110104445, 4188.141431006651, 4218.135282267143, 4148.854790082348, 4172.853950111731, 4200.306949353353, 4212.304969679999, 4212.410262563244, 4152.335626299778, 4157.750534967911, 4158.376243563474, 4163.188178305231, 4164.5210800758, 3642.852501462031, 3676.8863011932453, 3734.8132593370224, 3750.906227344311, 3754.155315054118, 5086.516780905808, 5092.872678183038, 5112.948870511284, 5137.537621614073, 5138.768755406016, 4729.834455794031, 4730.408698912636, 4765.523447655241, 4776.498467660915, 4799.13615549201, 5334.679919204821, 5463.371712253102, 5493.285872836545, 5540.750666220029, 5568.192612071227, 3997.2405243003736, 4003.11931375097, 4008.318585840385, 4035.757854528738, 4052.3516237401873, 5785.595008349417, 5832.737526811304, 5854.76580936762, 5884.176215329857, 5904.5276377890095, 3898.142408670088, 3993.2612466693754, 4027.2549578328103, 4055.106586695618, 4129.525104613008, 4023.8189281482405, 4055.797210139481, 4072.124493233969, 4090.5500394957126, 4091.0590564170407, 4667.836625718083, 4684.461286951976, 4707.364505791675, 4708.788104535304, 4712.50518695532, 5340.439253878365, 5503.257060296809, 5558.916616250759, 5639.2668953035845, 5639.295088113986, 1339.2968691437075, 1382.7165431086603, 1399.8940836739066, 1403.4736973634888, 1406.21252098825, 866.6273502394031, 888.4629590807939, 892.4734406700078, 896.2068569316202, 909.8126944337571, 4761.40482439695, 4780.330753694486, 4795.520447955247, 4812.711237325701, 4821.445533763592, 5117.720569857535, 5124.795673016838, 5127.179651255781, 5140.460251673595, 5154.510321519525, 4799.0, 4802.591779698695, 4807.519248075165, 4823.831165909176, 5051.292819005343, 3043.893463728759, 3062.433449811792, 3081.2450949517065, 3104.549840273193, 3107.9378412431624, 5943.375945525744, 5958.463738263577, 5964.582479226499, 5973.820785376446, 6015.939840601625, 5619.43805619443, 5845.386234445407, 5909.556783241188, 5938.782549577326, 5945.40545945402, 5879.235699359056, 5904.1734157218025, 5907.316414821841, 5908.084246941645, 5910.763569457174, 5498.120300751861, 5714.885702286014, 5723.8855222896145, 5755.510781583613, 5755.913661295168, 5656.85857853557, 5688.971555142363, 5695.772169113189, 5711.657300561979, 5717.199592057199, 5927.229460170322, 5943.108533719977, 5946.0, 5956.463918247378, 5981.700914954148, 3940.8226629801156, 4062.471878655756, 4078.775667338325, 4081.89795255121, 4100.507939047334, 5505.311836020497, 5732.742026608896, 5752.453516915886, 5768.451997060272, 5826.242588463472, 5485.341758988947, 5607.233721377753, 5607.355154157324, 5634.295713035871, 5645.548356131581, 5609.429359779268, 5620.606557540933, 5682.8579285516535, 5684.2947115864245, 5690.231818704422, 5312.867178320418, 5508.173773933942, 5510.173473978935, 5584.888302234014, 5614.831555053355, 5631.155326701028, 5635.309407177912, 5637.125066216341, 5647.237622920853, 5651.0, 5523.779048838162, 5530.198121272312, 5533.972330138324, 5547.362053363753, 5565.916511252415], "value": 4219.236551472519, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [801.2948605227401, 820.5733018830205, 824.2664029014175, 863.248973393148, 864.2696921101671, 14787.186704731235, 15973.840261597366, 16039.0, 16054.678906421865, 16087.517374478784, 14356.856431435683, 15157.105361829772, 15161.924190379033, 15179.089254644728, 15181.0891346519, 687.0450074396592, 806.6894245715413, 814.1532805881891, 822.0628483528782, 826.962786674601, 808.4340961327065, 808.6765293882436, 810.2828996338225, 810.9148539403366, 811.059171361221, 865.0786911938765, 866.1208872993885, 866.3891956170916, 866.5797088412115, 866.9293422623056, 710.5203987308546, 723.8660847743184, 725.6698202317932, 833.7873842170269, 858.1161403754144, 625.2434554189437, 626.573929727785, 627.1721327847243, 627.3318915355133, 627.5293529852611, 14885.33016014282, 14886.181260030695, 14946.850531494763, 14980.625484362869, 14996.700065998728, 13952.93023534886, 14351.928240358835, 14555.490557830424, 14588.781168282485, 14648.853511464855, 12640.873591264153, 12671.619851404472, 12733.87266127336, 12954.352282385844, 12962.935185324108, 4319.805608747614, 4384.671149663756, 4401.537838526972, 4443.733375997451, 4485.618722408599, 80841.59579202125, 83021.16978830195, 83979.5801020991, 84794.0, 85304.46955304543, 11376.203665743318, 11425.714357140972, 11552.480138393625, 11573.594924177612, 11573.652790416301, 19561.315353962542, 20408.183672653224, 22276.331710048726, 22335.441613959458, 22397.0, 8416.579171041423, 8485.490870547786, 8547.35894807892, 8596.140385961355, 8819.867701984474, 4814.494478079751, 5000.6249531284575, 5001.699898006132, 5032.421271553818, 5200.7139607321205, 3493.7205023598053, 3692.593814680383, 3698.7041036716996, 3720.981395093007, 3726.832292546842, 665.70043480434, 670.6412069542869, 678.4368973751774, 678.5589366911547, 694.8089275449291, 634.6953462338104, 667.2526770017514, 757.7756645473476, 761.9847603048019, 762.0931092000612, 9824.312298139062, 10327.9483602583, 10337.9483102584, 10355.223358248162, 10356.792864142826, 648.4455790299321, 716.2658275267892, 750.2272659160964, 770.603139383218, 799.436397339874, 4854.344663470457, 4989.499204333973, 5008.574271186917, 5013.523715247045, 5066.544011038951, 68561.3143868565, 93879.53060234655, 111024.4448777751, 115184.42407787907, 116947.41526292314, 95817.0, 99694.5015274919, 101019.49490252501, 101113.0, 102143.0, 86512.13487865166, 87063.56468217618, 87281.99999999873, 87606.12393876107, 87658.0, 9422.0, 9449.43303401798, 9532.0, 9546.52267386614, 9603.567839447382, 52320.21519677284, 52434.0, 52834.73582632062, 53404.1989370152, 54354.18468723052, 46302.30546541872, 65282.347176529525, 66242.33757662361, 75275.62362188155, 78678.0, 13447.798283025566, 13607.523736669169, 13613.591592252249, 13813.378397972316, 14269.143851368952, 14643.26783660834, 15270.0, 15278.0, 15407.76888346698, 16056.91971540135, 14389.934341364873, 14434.350454229794, 14620.707585848011, 14872.330745116713, 15253.847461525243, 14252.928735356258, 14268.363416435719, 14361.425542978164, 14363.425462981364, 14942.327595258022, 13907.721845563234, 14032.508862189774, 14083.647908801951, 14147.504837330644, 14464.204468753898, 10755.731106722395, 11202.94398528002, 11336.773264534828, 11467.827982580102, 11748.412579370826, 11416.429178540873, 11520.366379849189, 11578.826317605075, 11714.88285117138, 11774.882251177378], "value": 7729.983706732841, "unit": "score"}], "name": "dromaeo_css", "value": 7370.022607922647, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 107.0, 110.0, 110.0, 111.0, 111.0, 110.0, 112.0, 111.0, 110.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 123.0, 128.0, 189.0, 132.0, 128.0, 151.0, 124.0, 185.0, 125.0], "value": 144.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 161.0, 161.0, 159.0, 159.0, 161.0, 162.0, 161.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 127.0, 76.0, 77.0, 75.0, 75.0, 111.0, 74.0], "value": 84.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 117.0, 86.0, 85.0, 86.0, 112.0, 84.0, 86.0, 118.0], "value": 94.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 145.0, 147.0, 147.0, 146.0, 147.0, 148.0, 146.0, 145.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 96.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 54.0, 54.0, 54.0, 53.0, 54.0, 54.0, 54.0, 53.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 62.0, 62.0, 62.0, 61.0, 62.0, 62.0, 61.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 77.0, 85.0, 79.0, 79.0, 81.0, 80.0, 118.0, 86.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 120.0, 128.0, 128.0, 125.0, 120.0, 119.0, 120.0, 135.0, 122.0], "value": 123.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 162.0, 166.0, 164.0, 160.0, 165.0, 159.0, 156.0, 159.0], "value": 161.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 65.0, 63.0, 63.0, 62.0, 63.0, 63.0, 65.0, 64.0], "value": 63.5, "unit": "score"}], "name": "kraken", "value": 1500.6, "alertThreshold": 2.0}]} 12:05:33 INFO - Return code: 0 12:05:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:05:33 ERROR - # TBPL SUCCESS # 12:05:33 INFO - Running post-action listener: _resource_record_post_action 12:05:33 INFO - ##### 12:05:33 INFO - ##### Finished run-tests step (success) 12:05:33 INFO - ##### 12:05:33 INFO - Running post-run listener: _resource_record_post_run 12:05:33 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 143360; Write bytes: 304488448; Read time: 176; Write time: 180688 12:05:33 INFO - TinderboxPrint: CPU usage
13.1% 12:05:33 INFO - TinderboxPrint: I/O read bytes / time
143,360 / 176 12:05:33 INFO - TinderboxPrint: I/O write bytes / time
304,488,448 / 180,688 12:05:33 INFO - TinderboxPrint: CPU idle
8,262.2 (86.8%) 12:05:33 INFO - TinderboxPrint: CPU user
1,209.0 (12.7%) 12:05:33 INFO - TinderboxPrint: Swap in / out
0 / 0 12:05:33 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 16027648; Read time: 0; Write time: 3716 12:05:33 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 143360; Write bytes: 287977472; Read time: 176; Write time: 176892 12:05:34 INFO - Running post-run listener: _upload_blobber_files 12:05:34 INFO - Blob upload gear active. 12:05:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:05:34 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 12:05:34 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:05:34 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:05:34 INFO - (blobuploader) - INFO - Open directory for files ... 12:05:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:05:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:05:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:05:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:05:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:05:39 INFO - (blobuploader) - INFO - Done attempting. 12:05:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:05:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:05:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:05:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:05:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:05:40 INFO - (blobuploader) - INFO - Done attempting. 12:05:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:05:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:05:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:05:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:05:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:05:40 INFO - (blobuploader) - INFO - Done attempting. 12:05:40 INFO - (blobuploader) - INFO - Iteration through files over. 12:05:40 INFO - Return code: 0 12:05:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:05:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:05:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7de6fcaf255f6e891c197f314f292b13049559195d318a98ee89b67f7fd4acc12d9d979730abb94159ebfcc157984fea2e4d7bcb3e33cf0a3378cbff6f42e513", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/82316546fe23e156a1c4824b7ddd4da7e44d2a9ee630e1fb1cd8e8607a83c4df3f123b2867161704915f8229472733625dc3f906eb6c14de982b5fd4310a45df", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/619509053de927751b253a562de3b494bc58348cdbc05055acd58b8a6875c41ab3dff53f6a0d65aad3f671e543390b1b0cc053e779a29f770a739063c18851ea"} 12:05:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:05:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:05:40 INFO - Contents: 12:05:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7de6fcaf255f6e891c197f314f292b13049559195d318a98ee89b67f7fd4acc12d9d979730abb94159ebfcc157984fea2e4d7bcb3e33cf0a3378cbff6f42e513", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/82316546fe23e156a1c4824b7ddd4da7e44d2a9ee630e1fb1cd8e8607a83c4df3f123b2867161704915f8229472733625dc3f906eb6c14de982b5fd4310a45df", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/619509053de927751b253a562de3b494bc58348cdbc05055acd58b8a6875c41ab3dff53f6a0d65aad3f671e543390b1b0cc053e779a29f770a739063c18851ea"} 12:05:40 INFO - Running post-run listener: copy_logs_to_upload_dir 12:05:40 INFO - Copying logs to upload dir... 12:05:40 INFO - mkdir: /builds/slave/test/build/upload/logs 12:05:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1363.214892 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 43 secs) (at 2016-06-06 12:05:40.887251) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 12:05:40.891112) ========= 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=8887e36bb8e381bfd44124ac000001a8-1465238576.52688-459128812 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/sha512/7de6fcaf255f6e891c197f314f292b13049559195d318a98ee89b67f7fd4acc12d9d979730abb94159ebfcc157984fea2e4d7bcb3e33cf0a3378cbff6f42e513", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/82316546fe23e156a1c4824b7ddd4da7e44d2a9ee630e1fb1cd8e8607a83c4df3f123b2867161704915f8229472733625dc3f906eb6c14de982b5fd4310a45df", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/619509053de927751b253a562de3b494bc58348cdbc05055acd58b8a6875c41ab3dff53f6a0d65aad3f671e543390b1b0cc053e779a29f770a739063c18851ea"} build_url:https://queue.taskcluster.net/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011434 build_url: 'https://queue.taskcluster.net/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7de6fcaf255f6e891c197f314f292b13049559195d318a98ee89b67f7fd4acc12d9d979730abb94159ebfcc157984fea2e4d7bcb3e33cf0a3378cbff6f42e513", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/82316546fe23e156a1c4824b7ddd4da7e44d2a9ee630e1fb1cd8e8607a83c4df3f123b2867161704915f8229472733625dc3f906eb6c14de982b5fd4310a45df", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/619509053de927751b253a562de3b494bc58348cdbc05055acd58b8a6875c41ab3dff53f6a0d65aad3f671e543390b1b0cc053e779a29f770a739063c18851ea"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 12:05:40.920133) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 12:05:40.920843) ========= 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=8887e36bb8e381bfd44124ac000001a8-1465238576.52688-459128812 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004509 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 12:05:41.001795) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 12:05:41.002147) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 12:05:41.002464) ========= ========= Total master_lag: 0.19 =========