builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-003 starttime: 1465600648.98 results: success (0) buildid: 20160610160226 builduid: 4d0fcd2486d24ec2a0961f41b22160ce revision: fb3a694a5c432916d9414b698efe1ffd0d461db1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 16:17:28.976931) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 16:17:28.977423) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 16:17:28.977759) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 16:17:28.998800) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 16:17:28.999140) ========= 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=7de08804244eb36560b44971000001c3-1465600646.535525-1307599401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-10 16:17:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 113M=0s 2016-06-10 16:17:29 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.208048 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 16:17:29.222335) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 16:17:29.222709) ========= 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=7de08804244eb36560b44971000001c3-1465600646.535525-1307599401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018101 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 16:17:29.272644) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 16:17:29.273038) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev fb3a694a5c432916d9414b698efe1ffd0d461db1 --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 fb3a694a5c432916d9414b698efe1ffd0d461db1 --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=7de08804244eb36560b44971000001c3-1465600646.535525-1307599401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-10 16:17:29,322 truncating revision to first 12 chars 2016-06-10 16:17:29,323 Setting DEBUG logging. 2016-06-10 16:17:29,323 attempt 1/10 2016-06-10 16:17:29,323 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/fb3a694a5c43?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-10 16:17:29,642 unpacking tar archive at: fx-team-fb3a694a5c43/testing/mozharness/ program finished with exit code 0 elapsedTime=0.624943 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 16:17:29.912272) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 16:17:29.912799) ========= script_repo_revision: fb3a694a5c432916d9414b698efe1ffd0d461db1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 16:17:29.913305) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 16:17:29.913662) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 16:17:29.925148) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-06-10 16:17:29.925588) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1465600646.535525-1307599401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:17:30 INFO - MultiFileLogger online at 20160610 16:17:30 in /builds/slave/test 16:17:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 16:17:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:17:30 INFO - {'append_to_log': False, 16:17:30 INFO - 'base_work_dir': '/builds/slave/test', 16:17:30 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 16:17:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:17:30 INFO - 'branch': 'Fx-Team-Non-PGO', 16:17:30 INFO - 'buildbot_json_path': 'buildprops.json', 16:17:30 INFO - 'config_files': ('talos/linux_config.py',), 16:17:30 INFO - 'default_actions': ('clobber', 16:17:30 INFO - 'read-buildbot-config', 16:17:30 INFO - 'download-and-extract', 16:17:30 INFO - 'populate-webroot', 16:17:30 INFO - 'create-virtualenv', 16:17:30 INFO - 'install', 16:17:30 INFO - 'run-tests'), 16:17:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:17:30 INFO - 'download_minidump_stackwalk': True, 16:17:30 INFO - 'download_symbols': 'ondemand', 16:17:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:17:30 INFO - 'tooltool.py': '/tools/tooltool.py', 16:17:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:17:30 INFO - '/tools/misc-python/virtualenv.py')}, 16:17:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:17:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:17:30 INFO - 'installer_path': 'installer.exe', 16:17:30 INFO - 'log_level': 'info', 16:17:30 INFO - 'log_name': 'talos', 16:17:30 INFO - 'log_to_console': True, 16:17:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:17:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:17:30 INFO - 'opt_config_files': (), 16:17:30 INFO - 'pip_index': False, 16:17:30 INFO - 'sps_profile': False, 16:17:30 INFO - 'sps_profile_interval': 0, 16:17:30 INFO - 'suite': 'dromaeojs', 16:17:30 INFO - 'system_bits': '32', 16:17:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:17:30 INFO - 'title': 'talos-linux64-ix-003', 16:17:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:17:30 INFO - 'use_talos_json': True, 16:17:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:17:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:17:30 INFO - 'work_dir': 'build'} 16:17:30 INFO - ##### 16:17:30 INFO - ##### Running clobber step. 16:17:30 INFO - ##### 16:17:30 INFO - Running pre-action listener: _resource_record_pre_action 16:17:30 INFO - Running main action method: clobber 16:17:30 INFO - rmtree: /builds/slave/test/build 16:17:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:17:30 INFO - Running post-action listener: _resource_record_post_action 16:17:30 INFO - ##### 16:17:30 INFO - ##### Finished clobber step (success) 16:17:30 INFO - ##### 16:17:30 INFO - ##### 16:17:30 INFO - ##### Running read-buildbot-config step. 16:17:30 INFO - ##### 16:17:30 INFO - Running pre-action listener: _resource_record_pre_action 16:17:30 INFO - Running main action method: read_buildbot_config 16:17:30 INFO - Using buildbot properties: 16:17:30 INFO - { 16:17:30 INFO - "project": "", 16:17:30 INFO - "product": "firefox", 16:17:30 INFO - "script_repo_revision": "production", 16:17:30 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:17:30 INFO - "repository": "", 16:17:30 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 16:17:30 INFO - "buildid": "20160610160226", 16:17:30 INFO - "pgo_build": "False", 16:17:30 INFO - "basedir": "/builds/slave/test", 16:17:30 INFO - "buildnumber": 1847, 16:17:30 INFO - "slavename": "talos-linux64-ix-003", 16:17:30 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:17:30 INFO - "platform": "ubuntu64_hw", 16:17:30 INFO - "scheduler": "tests-fx-team-linux64-talos", 16:17:30 INFO - "branch": "fx-team", 16:17:30 INFO - "repo_path": "integration/fx-team", 16:17:30 INFO - "revision": "fb3a694a5c432916d9414b698efe1ffd0d461db1", 16:17:30 INFO - "stage_platform": "linux64", 16:17:30 INFO - "builduid": "4d0fcd2486d24ec2a0961f41b22160ce", 16:17:30 INFO - "slavebuilddir": "test" 16:17:30 INFO - } 16:17:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 16:17:30 INFO - Running post-action listener: _resource_record_post_action 16:17:30 INFO - ##### 16:17:30 INFO - ##### Finished read-buildbot-config step (success) 16:17:30 INFO - ##### 16:17:30 INFO - ##### 16:17:30 INFO - ##### Running download-and-extract step. 16:17:30 INFO - ##### 16:17:30 INFO - Running pre-action listener: _resource_record_pre_action 16:17:30 INFO - Running main action method: download_and_extract 16:17:30 INFO - mkdir: /builds/slave/test/build/tests 16:17: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')]} 16:17:30 INFO - https://queue.taskcluster.net/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:17:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:17:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:17:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:17:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:17:31 INFO - Downloaded 1361 bytes. 16:17:31 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:17:31 INFO - Using the following test package requirements: 16:17:31 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:17:31 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:17:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:17:31 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:17:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:17:31 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:17:31 INFO - u'jsshell-linux-x86_64.zip'], 16:17:31 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:17:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:17:31 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:17:31 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:17:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:17:31 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:17:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:17:31 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:17:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:17:31 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:17:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:17:31 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:17:31 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')]} 16:17:31 INFO - https://queue.taskcluster.net/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:17:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:17:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:17:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:17:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:17:32 INFO - Downloaded 22891786 bytes. 16:17:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:17:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:17:34 INFO - Return code: 0 16:17:34 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:17:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:34 INFO - https://queue.taskcluster.net/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:17:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:17:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:17:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:17:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:17:35 INFO - Downloaded 22891786 bytes. 16:17:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:17:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:17:37 INFO - Return code: 0 16:17: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')]} 16:17:37 INFO - https://queue.taskcluster.net/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:17:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:17:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:17:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:17:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:17:38 INFO - Downloaded 10833377 bytes. 16:17:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:17:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:17:39 INFO - Return code: 0 16:17:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:39 INFO - https://queue.taskcluster.net/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:17:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:17:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:17:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:17:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:17:43 INFO - Downloaded 55397943 bytes. 16:17:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:17:43 INFO - mkdir: /builds/slave/test/properties 16:17:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:17:43 INFO - Writing to file /builds/slave/test/properties/build_url 16:17:43 INFO - Contents: 16:17:43 INFO - build_url:https://queue.taskcluster.net/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:17:44 INFO - Running post-action listener: _resource_record_post_action 16:17:44 INFO - Running post-action listener: set_extra_try_arguments 16:17:44 INFO - ##### 16:17:44 INFO - ##### Finished download-and-extract step (success) 16:17:44 INFO - ##### 16:17:44 INFO - ##### 16:17:44 INFO - ##### Running populate-webroot step. 16:17:44 INFO - ##### 16:17:44 INFO - Running pre-action listener: _resource_record_pre_action 16:17:44 INFO - Running main action method: populate_webroot 16:17:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:17:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:17:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:17:44 INFO - '--tppagecycles', 16:17:44 INFO - '7'], 16:17:44 INFO - 'tests': ['tsvgm']}}, 16:17:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:17:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:17:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:17:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:17:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:17:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:17:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:17:44 INFO - 'talos_options': ['--disable-e10s'], 16:17:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:17:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:17:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:17:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:17:44 INFO - 'talos_options': ['--disable-e10s'], 16:17:44 INFO - 'tests': ['damp', 'tps']}, 16:17:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:17:44 INFO - 'tests': ['damp', 'tps']}, 16:17:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:17:44 INFO - 'tests': ['dromaeo_dom']}, 16:17:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:17:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:17:44 INFO - 'tests': ['a11yr', 16:17:44 INFO - 'ts_paint', 16:17:44 INFO - 'tpaint', 16:17:44 INFO - 'sessionrestore', 16:17:44 INFO - 'sessionrestore_no_auto_restore', 16:17:44 INFO - 'tabpaint']}, 16:17:44 INFO - 'other-e10s': {'tests': ['a11yr', 16:17:44 INFO - 'ts_paint', 16:17:44 INFO - 'tpaint', 16:17:44 INFO - 'sessionrestore', 16:17:44 INFO - 'sessionrestore_no_auto_restore', 16:17:44 INFO - 'tabpaint']}, 16:17:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:17:44 INFO - 'ts_paint', 16:17:44 INFO - 'tpaint', 16:17:44 INFO - 'sessionrestore', 16:17:44 INFO - 'sessionrestore_no_auto_restore', 16:17:44 INFO - 'tabpaint']}, 16:17:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:17:44 INFO - 'ts_paint', 16:17:44 INFO - 'tpaint', 16:17:44 INFO - 'sessionrestore', 16:17:44 INFO - 'sessionrestore_no_auto_restore', 16:17:44 INFO - 'tabpaint']}, 16:17:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:17:44 INFO - 'tests': ['a11yr', 16:17:44 INFO - 'ts_paint', 16:17:44 INFO - 'tpaint', 16:17:44 INFO - 'sessionrestore', 16:17:44 INFO - 'sessionrestore_no_auto_restore', 16:17:44 INFO - 'tabpaint']}, 16:17:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:17:44 INFO - 'tests': ['a11yr', 16:17:44 INFO - 'ts_paint', 16:17:44 INFO - 'tpaint', 16:17:44 INFO - 'sessionrestore', 16:17:44 INFO - 'sessionrestore_no_auto_restore', 16:17:44 INFO - 'tabpaint']}, 16:17:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:17:44 INFO - 'tests': ['tsvgx', 16:17:44 INFO - 'tsvgr_opacity', 16:17:44 INFO - 'tart', 16:17:44 INFO - 'tscrollx', 16:17:44 INFO - 'cart']}, 16:17:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:17:44 INFO - 'tsvgr_opacity', 16:17:44 INFO - 'tart', 16:17:44 INFO - 'tscrollx', 16:17:44 INFO - 'cart']}, 16:17:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:17:44 INFO - 'talos_options': ['--disable-e10s'], 16:17:44 INFO - 'tests': ['tp5o']}, 16:17:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:17:44 INFO - 'tests': ['tp5o']}, 16:17:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:17:44 INFO - 'talos_options': ['--disable-e10s', 16:17:44 INFO - '--xperf_path', 16:17:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:17:44 INFO - 'tests': ['tp5n']}, 16:17:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:17:44 INFO - 'talos_options': ['--xperf_path', 16:17:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:17:44 INFO - 'tests': ['tp5n']}}, 16:17:44 INFO - 'talos.zip': {'path': '', 16:17:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:17:44 INFO - Running post-action listener: _resource_record_post_action 16:17:44 INFO - ##### 16:17:44 INFO - ##### Finished populate-webroot step (success) 16:17:44 INFO - ##### 16:17:44 INFO - ##### 16:17:44 INFO - ##### Running create-virtualenv step. 16:17:44 INFO - ##### 16:17:44 INFO - Running pre-action listener: _resource_record_pre_action 16:17:44 INFO - Running main action method: create_virtualenv 16:17:44 INFO - Creating virtualenv /builds/slave/test/build/venv 16:17:44 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 16:17:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:17:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:17:46 INFO - Using real prefix '/usr' 16:17:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:17:46 INFO - Installing distribute.............................................................................................................................................................................................done. 16:17:48 INFO - Installing pip.................done. 16:17:48 INFO - Return code: 0 16:17:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:17:48 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')]} 16:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:48 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')]} 16:17:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:48 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 0x7fc3fd449f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x170b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179a1c0>, '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 0x179b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179b550>, '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': '7de08804244eb36560b44971000001c3-1465600646.535525-1307599401', '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 16:17:48 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 16:17:48 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 16:17:48 INFO - Using env: {'DISPLAY': ':0', 16:17:48 INFO - 'HOME': '/home/cltbld', 16:17:48 INFO - 'LANG': 'en_US.UTF-8', 16:17:48 INFO - 'LANGUAGE': 'en_US:en', 16:17:48 INFO - 'LOGNAME': 'cltbld', 16:17:48 INFO - 'MAIL': '/var/mail/cltbld', 16:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:48 INFO - 'MOZ_NO_REMOTE': '1', 16:17:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:48 INFO - 'NO_EM_RESTART': '1', 16:17:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:48 INFO - 'PWD': '/builds/slave/test', 16:17:48 INFO - 'SHELL': '/bin/bash', 16:17:48 INFO - 'SHLVL': '1', 16:17:48 INFO - 'TERM': 'linux', 16:17:48 INFO - 'TMOUT': '86400', 16:17:48 INFO - 'USER': 'cltbld', 16:17:48 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465600646.535525-1307599401', 16:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:48 INFO - '_': '/tools/buildbot/bin/python'} 16:17:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:49 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 16:17:49 INFO - Cleaning up... 16:17:49 INFO - Return code: 0 16:17:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:17:49 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')]} 16:17:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:49 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')]} 16:17:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:49 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 0x7fc3fd449f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x170b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179a1c0>, '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 0x179b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179b550>, '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': '7de08804244eb36560b44971000001c3-1465600646.535525-1307599401', '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 16:17:49 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 16:17:49 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 16:17:49 INFO - Using env: {'DISPLAY': ':0', 16:17:49 INFO - 'HOME': '/home/cltbld', 16:17:49 INFO - 'LANG': 'en_US.UTF-8', 16:17:49 INFO - 'LANGUAGE': 'en_US:en', 16:17:49 INFO - 'LOGNAME': 'cltbld', 16:17:49 INFO - 'MAIL': '/var/mail/cltbld', 16:17:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:49 INFO - 'MOZ_NO_REMOTE': '1', 16:17:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:49 INFO - 'NO_EM_RESTART': '1', 16:17:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:49 INFO - 'PWD': '/builds/slave/test', 16:17:49 INFO - 'SHELL': '/bin/bash', 16:17:49 INFO - 'SHLVL': '1', 16:17:49 INFO - 'TERM': 'linux', 16:17:49 INFO - 'TMOUT': '86400', 16:17:49 INFO - 'USER': 'cltbld', 16:17:49 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465600646.535525-1307599401', 16:17:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:49 INFO - '_': '/tools/buildbot/bin/python'} 16:17:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:49 INFO - Downloading/unpacking psutil>=3.1.1 16:17:49 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 16:17:49 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 16:17:49 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 16:17:49 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 16:17:49 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 16:17:49 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 16:17:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:17:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:17:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:17:51 INFO - Installing collected packages: psutil 16:17:51 INFO - Running setup.py install for psutil 16:17:51 INFO - building 'psutil._psutil_linux' extension 16:17:51 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 16:17:53 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 16:17:53 INFO - building 'psutil._psutil_posix' extension 16:17:53 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 16:17:54 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 16:17:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:17:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:17:54 INFO - Successfully installed psutil 16:17:54 INFO - Cleaning up... 16:17:54 INFO - Return code: 0 16:17:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:54 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 0x7fc3fd449f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x170b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179a1c0>, '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 0x179b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179b550>, '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': '7de08804244eb36560b44971000001c3-1465600646.535525-1307599401', '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 16:17:54 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 16:17:54 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 16:17:54 INFO - Using env: {'DISPLAY': ':0', 16:17:54 INFO - 'HOME': '/home/cltbld', 16:17:54 INFO - 'LANG': 'en_US.UTF-8', 16:17:54 INFO - 'LANGUAGE': 'en_US:en', 16:17:54 INFO - 'LOGNAME': 'cltbld', 16:17:54 INFO - 'MAIL': '/var/mail/cltbld', 16:17:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:54 INFO - 'MOZ_NO_REMOTE': '1', 16:17:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:54 INFO - 'NO_EM_RESTART': '1', 16:17:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:54 INFO - 'PWD': '/builds/slave/test', 16:17:54 INFO - 'SHELL': '/bin/bash', 16:17:54 INFO - 'SHLVL': '1', 16:17:54 INFO - 'TERM': 'linux', 16:17:54 INFO - 'TMOUT': '86400', 16:17:54 INFO - 'USER': 'cltbld', 16:17:54 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465600646.535525-1307599401', 16:17:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:54 INFO - '_': '/tools/buildbot/bin/python'} 16:17:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:17:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:17:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:17:56 INFO - Installing collected packages: mozsystemmonitor 16:17:56 INFO - Running setup.py install for mozsystemmonitor 16:17:56 INFO - Successfully installed mozsystemmonitor 16:17:56 INFO - Cleaning up... 16:17:56 INFO - Return code: 0 16:17:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:17:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:56 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 0x7fc3fd449f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x170b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179a1c0>, '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 0x179b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179b550>, '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': '7de08804244eb36560b44971000001c3-1465600646.535525-1307599401', '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 16:17:56 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 16:17:56 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 16:17:56 INFO - Using env: {'DISPLAY': ':0', 16:17:56 INFO - 'HOME': '/home/cltbld', 16:17:56 INFO - 'LANG': 'en_US.UTF-8', 16:17:56 INFO - 'LANGUAGE': 'en_US:en', 16:17:56 INFO - 'LOGNAME': 'cltbld', 16:17:56 INFO - 'MAIL': '/var/mail/cltbld', 16:17:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:56 INFO - 'MOZ_NO_REMOTE': '1', 16:17:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:56 INFO - 'NO_EM_RESTART': '1', 16:17:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:56 INFO - 'PWD': '/builds/slave/test', 16:17:56 INFO - 'SHELL': '/bin/bash', 16:17:56 INFO - 'SHLVL': '1', 16:17:56 INFO - 'TERM': 'linux', 16:17:56 INFO - 'TMOUT': '86400', 16:17:56 INFO - 'USER': 'cltbld', 16:17:56 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465600646.535525-1307599401', 16:17:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:56 INFO - '_': '/tools/buildbot/bin/python'} 16:17:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:56 INFO - Downloading/unpacking jsonschema==2.5.1 16:17:56 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 16:17:56 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 16:17:56 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 16:17:56 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 16:17:56 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 16:17:56 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 16:17:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:17:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:17:58 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 16:17:58 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 16:17:58 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 16:17:58 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 16:17:58 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 16:17:58 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 16:17:59 INFO - Downloading functools32-3.2.3-2.tar.gz 16:17:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:17:59 INFO - warning: no files found matching '*.txt' 16:17:59 INFO - no previously-included directories found matching 'build' 16:17:59 INFO - no previously-included directories found matching 'dist' 16:17:59 INFO - no previously-included directories found matching '.git*' 16:17:59 INFO - Installing collected packages: jsonschema, functools32 16:17:59 INFO - Running setup.py install for functools32 16:17:59 INFO - warning: no files found matching '*.txt' 16:17:59 INFO - no previously-included directories found matching 'build' 16:17:59 INFO - no previously-included directories found matching 'dist' 16:17:59 INFO - no previously-included directories found matching '.git*' 16:17:59 INFO - Successfully installed jsonschema functools32 16:17:59 INFO - Cleaning up... 16:17:59 INFO - Return code: 0 16:17:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:17: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')]} 16:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17: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')]} 16:17:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:59 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 0x7fc3fd449f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x170b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179a1c0>, '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 0x179b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179b550>, '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': '7de08804244eb36560b44971000001c3-1465600646.535525-1307599401', '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 16:17:59 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 16:17:59 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 16:17:59 INFO - Using env: {'DISPLAY': ':0', 16:17:59 INFO - 'HOME': '/home/cltbld', 16:17:59 INFO - 'LANG': 'en_US.UTF-8', 16:17:59 INFO - 'LANGUAGE': 'en_US:en', 16:17:59 INFO - 'LOGNAME': 'cltbld', 16:17:59 INFO - 'MAIL': '/var/mail/cltbld', 16:17:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:59 INFO - 'MOZ_NO_REMOTE': '1', 16:17:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:59 INFO - 'NO_EM_RESTART': '1', 16:17:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:59 INFO - 'PWD': '/builds/slave/test', 16:17:59 INFO - 'SHELL': '/bin/bash', 16:17:59 INFO - 'SHLVL': '1', 16:17:59 INFO - 'TERM': 'linux', 16:17:59 INFO - 'TMOUT': '86400', 16:17:59 INFO - 'USER': 'cltbld', 16:17:59 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465600646.535525-1307599401', 16:17:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:59 INFO - '_': '/tools/buildbot/bin/python'} 16:17:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:59 INFO - Downloading/unpacking blobuploader==1.2.4 16:17:59 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 16:17:59 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 16:17:59 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 16:17:59 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 16:17:59 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 16:17:59 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 16:18:01 INFO - Downloading blobuploader-1.2.4.tar.gz 16:18:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:18:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:18:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:18:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:18:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:18:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:18:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:18:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:18:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:18:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:18:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:18:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:18:02 INFO - Downloading docopt-0.6.1.tar.gz 16:18:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:18:02 INFO - Installing collected packages: blobuploader, requests, docopt 16:18:02 INFO - Running setup.py install for blobuploader 16:18:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:18:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:18:02 INFO - Running setup.py install for requests 16:18:02 INFO - Running setup.py install for docopt 16:18:02 INFO - Successfully installed blobuploader requests docopt 16:18:02 INFO - Cleaning up... 16:18:02 INFO - Return code: 0 16:18:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:18:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:02 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 0x7fc3fd449f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x170b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179a1c0>, '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 0x179b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179b550>, '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': '7de08804244eb36560b44971000001c3-1465600646.535525-1307599401', '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 16:18:02 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 16:18:02 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 16:18:02 INFO - Using env: {'DISPLAY': ':0', 16:18:02 INFO - 'HOME': '/home/cltbld', 16:18:02 INFO - 'LANG': 'en_US.UTF-8', 16:18:02 INFO - 'LANGUAGE': 'en_US:en', 16:18:02 INFO - 'LOGNAME': 'cltbld', 16:18:02 INFO - 'MAIL': '/var/mail/cltbld', 16:18:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:02 INFO - 'MOZ_NO_REMOTE': '1', 16:18:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:18:02 INFO - 'NO_EM_RESTART': '1', 16:18:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:18:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:02 INFO - 'PWD': '/builds/slave/test', 16:18:02 INFO - 'SHELL': '/bin/bash', 16:18:02 INFO - 'SHLVL': '1', 16:18:02 INFO - 'TERM': 'linux', 16:18:02 INFO - 'TMOUT': '86400', 16:18:02 INFO - 'USER': 'cltbld', 16:18:02 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465600646.535525-1307599401', 16:18:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:02 INFO - '_': '/tools/buildbot/bin/python'} 16:18:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:18:03 INFO - Running setup.py (path:/tmp/pip-wUkLqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:18:03 INFO - Running setup.py (path:/tmp/pip-huzA2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:18:03 INFO - Running setup.py (path:/tmp/pip-itccMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:18:03 INFO - Running setup.py (path:/tmp/pip-a7lvz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:18:03 INFO - Running setup.py (path:/tmp/pip-0Cz2gq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:18:03 INFO - Running setup.py (path:/tmp/pip-U7PM6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:18:03 INFO - Running setup.py (path:/tmp/pip-wz0DdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:18:03 INFO - Running setup.py (path:/tmp/pip-NCM3q0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:18:03 INFO - Running setup.py (path:/tmp/pip-RGOXYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:18:03 INFO - Running setup.py (path:/tmp/pip-0l9Cpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:18:03 INFO - Running setup.py (path:/tmp/pip-3qkzKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:18:03 INFO - Running setup.py (path:/tmp/pip-dWyVWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:18:03 INFO - Running setup.py (path:/tmp/pip-favnD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:18:04 INFO - Running setup.py (path:/tmp/pip-VN2CFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:18:04 INFO - Running setup.py (path:/tmp/pip-DjjoEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:18:04 INFO - Running setup.py (path:/tmp/pip-IYG88c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:18:04 INFO - Running setup.py (path:/tmp/pip-hHJOR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:18:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:18:04 INFO - Running setup.py install for manifestparser 16:18:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:18:04 INFO - Running setup.py install for mozcrash 16:18:04 INFO - Running setup.py install for mozdebug 16:18:04 INFO - Running setup.py install for mozdevice 16:18:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:18:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:18:04 INFO - Running setup.py install for mozfile 16:18:04 INFO - Running setup.py install for mozhttpd 16:18:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:18:04 INFO - Running setup.py install for mozinfo 16:18:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:18:05 INFO - Running setup.py install for mozInstall 16:18:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:18:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:18:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:18:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:18:05 INFO - Running setup.py install for mozleak 16:18:05 INFO - Running setup.py install for mozlog 16:18:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:18:05 INFO - Running setup.py install for moznetwork 16:18:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:18:05 INFO - Running setup.py install for mozprocess 16:18:05 INFO - Running setup.py install for mozprofile 16:18:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:18:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:18:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:18:05 INFO - Running setup.py install for mozrunner 16:18:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:18:05 INFO - Running setup.py install for mozscreenshot 16:18:05 INFO - Running setup.py install for moztest 16:18:05 INFO - Running setup.py install for mozversion 16:18:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:18:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:18:06 INFO - Cleaning up... 16:18:06 INFO - Return code: 0 16:18:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:18:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:06 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 0x7fc3fd449f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x170b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179a1c0>, '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 0x179b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179b550>, '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': '7de08804244eb36560b44971000001c3-1465600646.535525-1307599401', '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 16:18:06 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 16:18:06 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 16:18:06 INFO - Using env: {'DISPLAY': ':0', 16:18:06 INFO - 'HOME': '/home/cltbld', 16:18:06 INFO - 'LANG': 'en_US.UTF-8', 16:18:06 INFO - 'LANGUAGE': 'en_US:en', 16:18:06 INFO - 'LOGNAME': 'cltbld', 16:18:06 INFO - 'MAIL': '/var/mail/cltbld', 16:18:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:06 INFO - 'MOZ_NO_REMOTE': '1', 16:18:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:18:06 INFO - 'NO_EM_RESTART': '1', 16:18:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:18:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:06 INFO - 'PWD': '/builds/slave/test', 16:18:06 INFO - 'SHELL': '/bin/bash', 16:18:06 INFO - 'SHLVL': '1', 16:18:06 INFO - 'TERM': 'linux', 16:18:06 INFO - 'TMOUT': '86400', 16:18:06 INFO - 'USER': 'cltbld', 16:18:06 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465600646.535525-1307599401', 16:18:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:06 INFO - '_': '/tools/buildbot/bin/python'} 16:18:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:18:06 INFO - Running setup.py (path:/tmp/pip-1XqLT2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:18:06 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)) 16:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:18:06 INFO - Running setup.py (path:/tmp/pip-LwVGLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:18:06 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)) 16:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:18:06 INFO - Running setup.py (path:/tmp/pip-Q688Y9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:18:06 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)) 16:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:18:06 INFO - Running setup.py (path:/tmp/pip-0TJrCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:18:06 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)) 16:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:18:06 INFO - Running setup.py (path:/tmp/pip-gW1lpg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:18:06 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)) 16:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:18:06 INFO - Running setup.py (path:/tmp/pip-kRA4jg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:18:06 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)) 16:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:18:06 INFO - Running setup.py (path:/tmp/pip-lvUCay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:18:06 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)) 16:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:18:06 INFO - Running setup.py (path:/tmp/pip-wHXILQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:18:06 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)) 16:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:18:06 INFO - Running setup.py (path:/tmp/pip-IxyDo2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:18:06 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)) 16:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:18:06 INFO - Running setup.py (path:/tmp/pip-9Ctx0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:18:07 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)) 16:18:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:18:07 INFO - Running setup.py (path:/tmp/pip-knav6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:18:07 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)) 16:18:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:18:07 INFO - Running setup.py (path:/tmp/pip-KHRl2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:18:07 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)) 16:18:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:18:07 INFO - Running setup.py (path:/tmp/pip-L1BpvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:18:07 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)) 16:18:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:18:07 INFO - Running setup.py (path:/tmp/pip-ke0piW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:18:07 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)) 16:18:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:18:07 INFO - Running setup.py (path:/tmp/pip-I1a3vw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:18:07 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)) 16:18:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:18:07 INFO - Running setup.py (path:/tmp/pip-6DE8vF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:18:07 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)) 16:18:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:18:07 INFO - Running setup.py (path:/tmp/pip-kj9_bg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:18:07 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)) 16:18:07 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)) 16:18:07 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)) 16:18:07 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)) 16:18:07 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)) 16:18:07 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)) 16:18:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:18:07 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 16:18:07 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 16:18:07 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 16:18:07 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 16:18:07 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 16:18:07 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 16:18:09 INFO - Downloading blessings-1.6.tar.gz 16:18:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:18:09 INFO - Installing collected packages: blessings 16:18:09 INFO - Running setup.py install for blessings 16:18:09 INFO - Successfully installed blessings 16:18:09 INFO - Cleaning up... 16:18:09 INFO - Return code: 0 16:18:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:18:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:18:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:18:09 INFO - Reading from file tmpfile_stdout 16:18:09 INFO - Current package versions: 16:18:09 INFO - argparse == 1.2.1 16:18:09 INFO - blessings == 1.6 16:18:09 INFO - blobuploader == 1.2.4 16:18:09 INFO - docopt == 0.6.1 16:18:09 INFO - functools32 == 3.2.3-2 16:18:09 INFO - jsonschema == 2.5.1 16:18:09 INFO - manifestparser == 1.1 16:18:09 INFO - mozInstall == 1.12 16:18:09 INFO - mozcrash == 0.17 16:18:09 INFO - mozdebug == 0.1 16:18:09 INFO - mozdevice == 0.48 16:18:09 INFO - mozfile == 1.2 16:18:09 INFO - mozhttpd == 0.7 16:18:09 INFO - mozinfo == 0.9 16:18:09 INFO - mozleak == 0.1 16:18:09 INFO - mozlog == 3.2 16:18:09 INFO - moznetwork == 0.27 16:18:09 INFO - mozprocess == 0.22 16:18:09 INFO - mozprofile == 0.28 16:18:09 INFO - mozrunner == 6.11 16:18:09 INFO - mozscreenshot == 0.1 16:18:09 INFO - mozsystemmonitor == 0.3 16:18:09 INFO - moztest == 0.7 16:18:09 INFO - mozversion == 1.4 16:18:09 INFO - psutil == 3.1.1 16:18:09 INFO - requests == 1.2.3 16:18:09 INFO - wsgiref == 0.1.2 16:18:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:18:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:09 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 0x7fc3fd449f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x170b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179a1c0>, '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 0x179b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179b550>, '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': '7de08804244eb36560b44971000001c3-1465600646.535525-1307599401', '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 16:18:09 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 16:18:09 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 16:18:09 INFO - Using env: {'DISPLAY': ':0', 16:18:09 INFO - 'HOME': '/home/cltbld', 16:18:09 INFO - 'LANG': 'en_US.UTF-8', 16:18:09 INFO - 'LANGUAGE': 'en_US:en', 16:18:09 INFO - 'LOGNAME': 'cltbld', 16:18:09 INFO - 'MAIL': '/var/mail/cltbld', 16:18:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:09 INFO - 'MOZ_NO_REMOTE': '1', 16:18:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:18:09 INFO - 'NO_EM_RESTART': '1', 16:18:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:18:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:09 INFO - 'PWD': '/builds/slave/test', 16:18:09 INFO - 'SHELL': '/bin/bash', 16:18:09 INFO - 'SHLVL': '1', 16:18:09 INFO - 'TERM': 'linux', 16:18:09 INFO - 'TMOUT': '86400', 16:18:09 INFO - 'USER': 'cltbld', 16:18:09 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465600646.535525-1307599401', 16:18:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:09 INFO - '_': '/tools/buildbot/bin/python'} 16:18:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:10 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)) 16:18:10 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)) 16:18:10 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)) 16:18:10 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)) 16:18:10 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)) 16:18:10 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)) 16:18:10 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)) 16:18:10 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)) 16:18:10 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)) 16:18:10 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)) 16:18:10 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)) 16:18:10 INFO - Cleaning up... 16:18:10 INFO - Return code: 0 16:18:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:18:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:10 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 0x7fc3fd449f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x170b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179a1c0>, '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 0x179b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179b550>, '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': '7de08804244eb36560b44971000001c3-1465600646.535525-1307599401', '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 16:18:10 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 16:18:10 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 16:18:10 INFO - Using env: {'DISPLAY': ':0', 16:18:10 INFO - 'HOME': '/home/cltbld', 16:18:10 INFO - 'LANG': 'en_US.UTF-8', 16:18:10 INFO - 'LANGUAGE': 'en_US:en', 16:18:10 INFO - 'LOGNAME': 'cltbld', 16:18:10 INFO - 'MAIL': '/var/mail/cltbld', 16:18:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:10 INFO - 'MOZ_NO_REMOTE': '1', 16:18:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:18:10 INFO - 'NO_EM_RESTART': '1', 16:18:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:18:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:10 INFO - 'PWD': '/builds/slave/test', 16:18:10 INFO - 'SHELL': '/bin/bash', 16:18:10 INFO - 'SHLVL': '1', 16:18:10 INFO - 'TERM': 'linux', 16:18:10 INFO - 'TMOUT': '86400', 16:18:10 INFO - 'USER': 'cltbld', 16:18:10 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465600646.535525-1307599401', 16:18:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:10 INFO - '_': '/tools/buildbot/bin/python'} 16:18:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:18:10 INFO - Cleaning up... 16:18:10 INFO - Return code: 0 16:18:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:18:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:10 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 0x7fc3fd449f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x170b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179a1c0>, '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 0x179b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179b550>, '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': '7de08804244eb36560b44971000001c3-1465600646.535525-1307599401', '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 16:18:10 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 16:18:10 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 16:18:10 INFO - Using env: {'DISPLAY': ':0', 16:18:10 INFO - 'HOME': '/home/cltbld', 16:18:10 INFO - 'LANG': 'en_US.UTF-8', 16:18:10 INFO - 'LANGUAGE': 'en_US:en', 16:18:10 INFO - 'LOGNAME': 'cltbld', 16:18:10 INFO - 'MAIL': '/var/mail/cltbld', 16:18:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:10 INFO - 'MOZ_NO_REMOTE': '1', 16:18:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:18:10 INFO - 'NO_EM_RESTART': '1', 16:18:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:18:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:10 INFO - 'PWD': '/builds/slave/test', 16:18:10 INFO - 'SHELL': '/bin/bash', 16:18:10 INFO - 'SHLVL': '1', 16:18:10 INFO - 'TERM': 'linux', 16:18:10 INFO - 'TMOUT': '86400', 16:18:10 INFO - 'USER': 'cltbld', 16:18:10 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465600646.535525-1307599401', 16:18:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:10 INFO - '_': '/tools/buildbot/bin/python'} 16:18:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:10 INFO - Downloading/unpacking flake8 16:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:18:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:18:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:18:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:18:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:18:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:18:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:18:12 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 16:18:12 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 16:18:12 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 16:18:12 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 16:18:12 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 16:18:12 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 16:18:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:18:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:18:12 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 16:18:12 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 16:18:12 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 16:18:12 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 16:18:12 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 16:18:12 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 16:18:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:18:12 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 16:18:12 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 16:18:12 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 16:18:12 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 16:18:12 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 16:18:12 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 16:18:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:18:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:18:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:18:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:18:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:18:13 INFO - no previously-included directories found matching 'docs/_build' 16:18:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:18:13 INFO - Running setup.py install for pep8 16:18:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:18:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:18:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:18:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:18:13 INFO - no previously-included directories found matching 'docs/_build' 16:18:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:18:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:18:13 INFO - Cleaning up... 16:18:13 INFO - Return code: 0 16:18:13 INFO - Running post-action listener: _resource_record_post_action 16:18:13 INFO - Running post-action listener: _start_resource_monitoring 16:18:13 INFO - Starting resource monitoring. 16:18:13 INFO - ##### 16:18:13 INFO - ##### Finished create-virtualenv step (success) 16:18:13 INFO - ##### 16:18:13 INFO - ##### 16:18:13 INFO - ##### Running install step. 16:18:13 INFO - ##### 16:18:13 INFO - Running pre-action listener: _resource_record_pre_action 16:18:13 INFO - Running main action method: install 16:18:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:18:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:18:13 INFO - Reading from file tmpfile_stdout 16:18:13 INFO - Detecting whether we're running mozinstall >=1.0... 16:18:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:18:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:18:13 INFO - Reading from file tmpfile_stdout 16:18:13 INFO - Output received: 16:18:13 INFO - Usage: mozinstall [options] installer 16:18:13 INFO - Options: 16:18:13 INFO - -h, --help show this help message and exit 16:18:13 INFO - -d DEST, --destination=DEST 16:18:13 INFO - Directory to install application into. [default: 16:18:13 INFO - "/builds/slave/test"] 16:18:13 INFO - --app=APP Application being installed. [default: firefox] 16:18:13 INFO - mkdir: /builds/slave/test/build/application 16:18:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:18:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:18:29 INFO - Reading from file tmpfile_stdout 16:18:29 INFO - Output received: 16:18:29 INFO - /builds/slave/test/build/application/firefox/firefox 16:18:29 INFO - Running post-action listener: _resource_record_post_action 16:18:29 INFO - ##### 16:18:29 INFO - ##### Finished install step (success) 16:18:29 INFO - ##### 16:18:29 INFO - ##### 16:18:29 INFO - ##### Running run-tests step. 16:18:29 INFO - ##### 16:18:29 INFO - Running pre-action listener: _resource_record_pre_action 16:18:29 INFO - Running main action method: run_tests 16:18:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:18:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:18:29 INFO - Python 2.7.3 16:18:29 INFO - Return code: 0 16:18:29 INFO - grabbing minidump binary from tooltool 16:18:29 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')]} 16:18:29 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 0x179a1c0>, '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 0x179b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179b550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:18:29 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 16:18:29 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 16:18:29 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 16:18:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:18:29 INFO - Return code: 0 16:18:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:18:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:18:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:18:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:18:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:18:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:18:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:18:30 INFO - Return code: 0 16:18:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 16:18:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 16:18:30 INFO - Using env: {'DISPLAY': ':0', 16:18:30 INFO - 'HOME': '/home/cltbld', 16:18:30 INFO - 'LANG': 'en_US.UTF-8', 16:18:30 INFO - 'LANGUAGE': 'en_US:en', 16:18:30 INFO - 'LOGNAME': 'cltbld', 16:18:30 INFO - 'MAIL': '/var/mail/cltbld', 16:18:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:18:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:18:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:30 INFO - 'MOZ_NO_REMOTE': '1', 16:18:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:18:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:18:30 INFO - 'NO_EM_RESTART': '1', 16:18:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:18:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:30 INFO - 'PWD': '/builds/slave/test', 16:18:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:18:30 INFO - 'SHELL': '/bin/bash', 16:18:30 INFO - 'SHLVL': '1', 16:18:30 INFO - 'TERM': 'linux', 16:18:30 INFO - 'TMOUT': '86400', 16:18:30 INFO - 'USER': 'cltbld', 16:18:30 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465600646.535525-1307599401', 16:18:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:30 INFO - '_': '/tools/buildbot/bin/python'} 16:18:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 16:18:31 INFO - mozversion application_buildid: 20160610160226 16:18:31 INFO - mozversion application_changeset: fb3a694a5c432916d9414b698efe1ffd0d461db1 16:18:31 INFO - mozversion application_display_name: Nightly 16:18:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:18:31 INFO - mozversion application_name: Firefox 16:18:31 INFO - mozversion application_remotingname: firefox 16:18:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:18:31 INFO - mozversion application_vendor: Mozilla 16:18:31 INFO - mozversion application_version: 50.0a1 16:18:31 INFO - mozversion platform_buildid: 20160610160226 16:18:31 INFO - mozversion platform_changeset: fb3a694a5c432916d9414b698efe1ffd0d461db1 16:18:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:18:31 INFO - mozversion platform_version: 50.0a1 16:18:31 INFO - using testdate: 1465600711 16:18:31 INFO - actual date: 1465600711 16:18:31 INFO - starting webserver on 'localhost:57564' 16:18:31 INFO - SUITE-START | Running 2 tests 16:18:31 INFO - TEST-START | dromaeo_css 16:18:31 INFO - operating with platform_type : linux_ 16:18:31 INFO - Initialising browser for dromaeo_css test... 16:18:31 INFO - TEST-INFO | started process 3328 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_331NZ/profile http://localhost:57564/getInfo.html) 16:18:36 INFO - PROCESS | 3328 | __metrics Screen width/height:1600/1200 16:18:36 INFO - PROCESS | 3328 | colorDepth:24 16:18:36 INFO - PROCESS | 3328 | Browser inner width/height: 1024/697 16:18:36 INFO - PROCESS | 3328 | __metrics 16:18:38 INFO - PROCESS | 3328 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:18:38 INFO - PROCESS | 3328 | console.error: PushService: 16:18:38 INFO - PROCESS | 3328 | stateChangeProcessEnqueue: Error transitioning state 16:18:38 INFO - PROCESS | 3328 | UnknownError 16:18:39 INFO - TEST-INFO | 3328: exit 0 16:18:39 INFO - Browser initialized. 16:18:39 INFO - Running cycle 1/1 for dromaeo_css test... 16:18:39 INFO - TEST-INFO | started process 3409 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_331NZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:18:51 INFO - PROCESS | 3409 | RSS: Main: 175493120 16:18:51 INFO - PROCESS | 3409 | 16:19:42 INFO - PROCESS | 3409 | 1465600782164 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] 16:21:55 INFO - PROCESS | 3409 | Cycle 1(1): loaded http://localhost:57564/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57564/tests/dromaeo/cssquery-ext.html) 16:21:56 INFO - PROCESS | 3409 | RSS: Main: 296579072 16:21:56 INFO - PROCESS | 3409 | 16:24:59 INFO - PROCESS | 3409 | Cycle 1(1): loaded http://localhost:57564/tests/dromaeo/cssquery-ext.html (next: http://localhost:57564/tests/dromaeo/cssquery-jquery.html) 16:24:59 INFO - PROCESS | 3409 | RSS: Main: 254976000 16:24:59 INFO - PROCESS | 3409 | 16:28:02 INFO - PROCESS | 3409 | Cycle 1(1): loaded http://localhost:57564/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57564/tests/dromaeo/cssquery-mootools.html) 16:28:02 INFO - PROCESS | 3409 | RSS: Main: 251564032 16:28:02 INFO - PROCESS | 3409 | 16:31:04 INFO - PROCESS | 3409 | Cycle 1(1): loaded http://localhost:57564/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57564/tests/dromaeo/cssquery-prototype.html) 16:31:05 INFO - PROCESS | 3409 | RSS: Main: 251981824 16:31:05 INFO - PROCESS | 3409 | 16:34:08 INFO - PROCESS | 3409 | Cycle 1(1): loaded http://localhost:57564/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57564/tests/dromaeo/cssquery-yui.html) 16:34:09 INFO - PROCESS | 3409 | RSS: Main: 235737088 16:34:09 INFO - PROCESS | 3409 | 16:37:12 INFO - PROCESS | 3409 | Cycle 1(1): loaded http://localhost:57564/tests/dromaeo/cssquery-yui.html (next: http://localhost:57564/tests/dromaeo/cssquery-dojo.html) 16:37:12 INFO - PROCESS | 3409 | RSS: Main: 322650112 16:37:12 INFO - PROCESS | 3409 | 16:37:12 INFO - PROCESS | 3409 | __start_tp_report 16:37:12 INFO - PROCESS | 3409 | _x_x_mozilla_page_load 16:37:12 INFO - PROCESS | 3409 | _x_x_mozilla_page_load_details 16:37:12 INFO - PROCESS | 3409 | |i|pagename|runs| 16:37:12 INFO - PROCESS | 3409 | |0;dojo.html;2617.4241666833295;2630.9473810523778;2657.202839148256;2664.6669166354195;2665.5202063628553;4557.1113632841525;4656.278276867082;4707.388039554858;4774.0929223447565;4814.229723244277;4667.463241727202;4710.08153410086;4712.269598212274;4735.147673418792;4750.90498190036;4277.337012763027;4294.269974104394;4352.173087113454;4384.517703052662;4493.438320209973;4388.626966707834;4414.4040554525045;4434.401355816972;4447.155040542303;4472.619827314666;4193.098483825992;4223.72545784523;4273.423087883127;4313.28830742927;4324.329728892027;4285.485741710983;4294.677899157576;4296.935545966813;4348.456442944632;4350.847720329805;4303.462067241595;4332.826686932519;4335.219660461115;4372.038151606642;4374.8906277343;4601.056783359403;4683.437987441529;4735.337052812609;4745.477997420281;4760.595349395306;5086.237064440326;5106.591472682177;5149;5159.019786240602;5160.380754309469;5160.174372100446;5178.352705911761;5190.429052804188;5191.662541934762;5195.246689230041;4628.213203755369;4725.716457012591;4765.475797662254;4767.094252092092;4847.830325938646;5266.368035835724;5290.550303224192;5300.072487314705;5303.390110137384;5305.257263983045;4803.543663351976;5073.441921388644;5080.288759573663;5086.872828179326;5093.617978651616;4977.9751101244265;5025.221090730869;5026.673266237683;5047.772850221749;5122.257272695513;5003.949960500348;5011.774470148852;5014.09746245672;5015.247712843103;5071.923921141186;4866.78099485524;4991.800327986913;4991.9204474829085;4995;5000.74996250186;4152.1072969311745;4176.624103830609;4203.810828512725;4209.873703788891;4236.385724069993;3692.8707495237536;3707.5736290326417;3708.8331025103935;3745.6628903398823;3745.7939813309986;4387.188370151468;4398.8020539075815;4399.934000989988;4401.273789824707;4442.53353397895;4980.252962055721;5017.397912250481;5027.572656324253;5040.823571174991;5068.518490743447;4359.80380882861;4371.956280437218;4377;4378.387025816388;4422.09347083847;4415.139047885696;4494.977525112354;4495.483019452739;4501.909961800746;4541.455025396907;4715.033418149271;4758.1435341638835;4765.11845308619;4787.928181077356;4790.353302304145;5062.569681577107;5089.898202036013;5090.516400941905;5092.9745351273;5140.537351638371;4599.1721490132095;4691.507391723956;4792.736399497921;4793.808247670054;4850.587700045536;4924.458309586014;4961.875953101201;4965.702057876539;4965.925511117264;4998.500149984972;5047.671901326402;5050.949490505048;5052.393712754493;5056.595472362129;5106.259592359162;4830.806767729251;4864.270359446112;4901.779419926041;4903.41159060915;4966.18058020437;4924.63065270099;4933.136701077369;4938.975305123451;4951;4980.153373926369;4856.271559266138;4902.362692850049;4909.459959404534;4916.975415122902;4919.016196760591;4791;4837.129316722883;4934.654574179773;4980.975095124501;5015.799368025238;4771.594414474808;4838.056578967067;4838.250071238964;4838.685485443435;4861.173600487855 16:37:12 INFO - PROCESS | 3409 | |1;ext.html;550.2828108522673;579.3742757821553;592.1088761414072;592.6207227374484;592.8577141486041;26525.469490610176;39133.80433097834;39773.60226397735;39834;39955.40066898992;40099;40510.79744601273;40539.59460405395;40584.18831623366;40625.79687101568;7446.329830315271;7704.19105993871;7841.451098423113;7841.764747057598;10141.797164056714;9904.25718071144;10295.382277063363;10303.63937262196;10307.226957978144;10309.742256443575;10337.741556461111;10387.324823886423;10395.064444200021;10397.688069357931;10400.063994240516;7583.241675832428;10139.087482126644;10269.845952310721;10488.265821392506;10492.685219443429;9979.051990060932;10303.227257955608;10338.22463315247;10341.63804266847;10350.068493835592;39251.21497570061;39759.80120099381;39805.800970995246;39876.800615997025;39881.202375952606;3017.6680565137817;3088.243380371823;3094.891678791254;3112.1908303840937;3150.9684903150905;29634;29997;30158.69841301581;30318;30396.848015760002;3567.928641427183;3591.8742844000594;3613.8373773180006;3614.8011859347725;3633.7638053526434;169111;169820;169975;170057;170371;56446;56790.43209567934;56817;56881;57162.42837571654;33786;34756.30487390238;34801.30397392038;37078.814605927335;37108.44337334942;15320.15739134336;15452.768208476882;15460.072395656296;15474.226288685746;15479.458218962282;10685.519151638195;11355.205135640426;11517;11571.247868888495;11769.470373833197;19054;19116.426507204807;19153.52116197106;19160.329388471335;19171.712424313646;7260;7435.367993720486;7490.176080631126;7591.127020392615;7658.310752032344;810.2748040503716;889.5774507109201;924.7139508378713;996.6362277768562;1028.3983869436463;27785.444291114065;27835;27862.303442413697;28300.575491367646;28549.28626784347;958.2094771813142;962.9662961796304;963.8939716631165;994.1351024608637;1004.7337455574278;14715.484958026418;14895.180765058027;14916.925415372854;15048.946573739951;15167;396368;399437;400837;402180;402624;50084.49915500799;50566;50614.24078638823;50615.24077138846;50655.49344506581;1088.1784252889017;1138.8804175561613;1139.5555733264034;1177.381874515886;1178.3577950017261;27973.300667483476;28879;28966.420671586027;28990.7100928988;29231.684574194638;41221;41789.164216716104;41789.37315940324;41803.37294940639;41840.1631967365;242559;243461;243893;244572;245039;20441.591168176852;23659;23702.762972370747;24854.50290994206;24876.253712388658;35342.11644708903;37952.81023594975;41318.58681413147;42026.36960445534;42412.575874240865;35679.28641427209;35904.10239744027;35940.82029589835;36097;36801.26397472089;35333;35333.1166720834;35404;35417.64582354143;35432;34627.30745385028;34955.30089398147;35517.46723799093;35578.28843423169;35969.28061438704;31276.218094547818;32190;32488.187795305308;32537.186570334983;32615.836920815244;24685.753142468344;24729.381765456008;24893.128740493994;25040;25153.49693006093 16:37:12 INFO - PROCESS | 3409 | |2;jquery.html;375.46496242853937;377.562028047465;379.671584079771;386.9922601547967;394.0287192071545;16034.51896443107;16720.080395578254;16965.236564354604;16981.999999999985;17633.82366176341;13659.907207423406;14145.080569762958;15102.471413500529;15205.619859503518;15669.45156919508;4611.815527378909;4777.928331075037;4806.735629540374;4816.590589799871;4821.54195351441;3476.461148521983;3689.723270754691;5230.320058392423;5529.142982837647;5533.22534845122;5517.724113794315;5572.888542229173;5575.498205161534;5617.101263797793;5627.662340259577;5432.375276843135;5539.639923404986;5577;5612.298462692163;5623.606347555673;4809.470958194595;5412.107002344608;5434.728263586844;5440.319960004999;5445.292112025451;11905.940470297593;12501.812472812915;12604.180728252633;12607.180533265308;12614.05394595409;1847.1318480314364;1857.4799056264267;1949.9415017549495;1956.1099699636632;1973.447434718281;9249.306302027375;9250.213731832802;9351.043946708256;9509.001554836781;9675.758106047406;1616.531205950273;1660.1367289009768;1674.673438679458;1723.8371078619489;1766.222861940742;40451;41032.589674103176;59615.701921490116;59840.401595983916;66833.66583167102;9358.800681839763;9704.75738106553;9966.700998970042;10003.749906252402;10053.748656283506;13475.730485390237;13711.657208569866;13753.724925501434;13760.105593136414;13783.724325513635;7178.425725941912;7267.236940121317;7427.925720742832;7534.849303013909;7555.09338879338;7029.613371264527;7073.575585464889;7094.858102837914;7220.963895180491;7270.927290727025;4212.789360531961;4229.513605935295;4241.936370954438;4268.914621707549;4326.502452218036;1714.8370904764026;1759.3578343904383;1776.4759395978217;1785.2948085506412;1802.3961972739016;705.3299365602697;807.1283014344612;856.9357298202535;870.2081106193334;875.7460336502343;16084.276207570454;16742;16765.832341676673;16778.74831877523;17237.310507579557;860.1914200651368;870.5995242188665;908.2960705453327;910.153557191818;929.3540989012571;9005.819883602291;9195.586198621078;9205.677801276923;9715.854262186072;10065.647702330383;303919;394314;398176;398582;400142;70640;75478;78938;79471;79730.40539189184;889.8754174415458;890.1009979920327;917.0554329041098;927.1933417926313;958.242988039455;15180.924095379452;15232;15357.539273821803;15571.84428155704;15736.76394854101;35796.284074318886;36354;36524;37520;38065.61934380732;44821.32768008417;46376.768116159205;49610;51274.743626283125;51760.74119629378;7606.04924384452;7612.923870761443;7695.307422332017;7842.803929901798;7946.284834364935;10124.898751012395;11699.23954942926;11783.293002419883;11878.821817672915;11890.762184756084;9500.334976551576;9826.9017309826;9841.95079024629;9894.257930655085;9960.203183745138;10111.3265244938;10247.94876025645;10355.482225888825;10371.27401081917;10485.318454300446;9846.655367062118;9983.450910199717;10052.798944021224;10066.94966525192;10204;7609.88585171234;7647.808804779925;7750.8449831001935;7807.180246074307;7946.1656526066245;8117.8376432472205;9382.67160649374;9630.566624502055;10033.598656053677;10054.396736195851 16:37:12 INFO - PROCESS | 3409 | |3;mootools.html;1214.1136970011885;1389.1387339849296;1412.0962583946275;1488.9255537223144;1666.067002478612;6426.678666066696;7211.891821622673;7459.030326057605;7484.064491938508;7620.809479763008;7337.88993165103;7480.289372509603;7481.812954676136;7485.625718714056;7486.700531978728;1886.9339573114944;1944.7082937559337;1950.2101648832174;2180.9890950545223;2219.1678120704737;1932.690769476884;2143.582001509706;2244.932652020442;2246.6630005499223;2247.763984781599;2183.530540933699;2191.298784388996;2214.302494714168;2215.5679642469727;2221.4002219400754;1866.178881292227;2187.7812218778076;2216.5899308627954;2217.1463986365206;2220.0120946179036;2121.5226574020876;2206.117552978805;2209.5470428562107;2219.223271854854;2222.488827569668;7616.961915190444;7618.352440042603;7624.390048796083;7624.504407213513;7648.42636802242;4664.626829853603;4790.80836766529;4794.400699912511;4800.567948884583;4803.063402636487;2818.6476690413697;2918.7081291870854;2934.2811011302156;2941.794074414792;2999.0552975812766;842.2924743215729;851.5699571716306;887.60057973912;888.0808363343973;898.7887846356101;10247.487625618689;10440.477976101165;10445.11216546587;10456.895431045668;10473.005064518858;4292.163028209532;4314.331278651814;4346.630536404441;4426.800793964279;4433.933490997638;8922.955385223033;8941.508217048126;8948.955255223682;8950.641974320954;8957.28341732673;4560.635149188057;4566.862994110182;4573.062522182944;4574.611158051603;4578.0157266187925;3333.233356328058;3702.648248416396;4167.5832416758685;4374.321980093091;4385.934210986838;3720.088578298334;3806.752561083576;3816.4847745553993;3841.8271177797064;3865.0530619997717;1221.2733423612935;1225.914186006971;1230.7353918907477;1234.950601975929;1258.1696080586769;776.9417293702995;798.3413683710962;799.8240387114826;809.7165991902905;829.1666874790797;4868.342773725572;4877.609791216694;4929.654924155275;4941.604671626261;5000.099982003274;418.39750758907076;418.8701502534224;424.1453471255423;427.3568279739035;441.7813182474696;3277.4264503712234;3451.6893479586956;3458.533098031784;3469.8959031228596;3483.3381657484997;9245.214156796614;9553.713388598353;9592;9611.423314601147;9632.95183524078;9437;9501.524923753785;9506.762330941781;9508.47703376307;9513.286503512127;6821.079154314203;7117.395021423134;7189.6405179740805;7224.74713385029;7259.274072592699;5448.318960129984;5457.563394928476;5478.643888147258;5543.584231182596;5580.190872323409;8483.27892129176;8650.480971141751;8671;8730.519821409884;8740.78148046304;8299.585020749058;8673.783155421164;8687.869681954902;8748.518831464331;8936.41913275635;5963.552733545088;6884.070650462324;7121.82195445118;7138.072050633385;7141.071660684078;7119.359257666835;7167.3549380556;7205.495615306878;7394.704211831467;7399.667014984447;6493.837654058686;6601.966990165019;6617.933820661732;6745.831354215988;6775.593464392152;6509.088727578238;6590;6618.139641846529;6692;6693.062971184136;5846.795362162304;5925.52595792327;5964.896494148423;6040.818775436744;6042.335343112166;4289.957100429081;4307.504636966663;4339.3924850520325;4373.365861950063;4483.394741709827;4117.094239267356;4217.641500472494;4274.145170965757;4335.349697545394;4392.165488557292 16:37:12 INFO - PROCESS | 3409 | |4;prototype.html;295.8136374084328;300.76089508840477;301.62899633450854;302.73964390624076;308.8023664854493;4805.231163013918;4851.417829860413;4852.733099679516;4872.489528246246;4901.33831932689;4736;4781.569658730714;4803.5676789088975;4812.157872372339;4818.638602104838;3565.983694647026;3629.3648611493013;3695.7412981091334;3754.4743735877;3813.008617759375;3724.2737666155112;3763.0968567543728;3770.397581028066;3783.5433358157034;3814.8474061037527;3555.8044307563073;3723.813809309537;3736.1220113273357;3737.8878633641034;3761.153740408414;3638.6361363863666;3763.397856342972;3764.9435258471144;3770.6621894425493;3794.6395092466173;3340.6492318306473;3364.175776934667;3377.8986630401128;3381.2899291148888;3389.74576906733;4684.313647087046;4693.389859318267;4704.858854234344;4717.811287548494;4750.61995040396;4246.214450326699;4340.262155433584;4340.500842403132;4344.652427805768;4378.10248898975;5000.299958005882;5026.145555255579;5029.119904016782;5049.34358533392;5071.391433028023;3698.68561172298;3701.2597480503737;3706.8887933362043;3715.7956312402807;3721.4603882436895;4925.335079764258;5210.843674689728;5257.369115706139;5261.815836445706;5267.341582302174;3627.6553727395853;3649.872254471081;3664.9083772905356;3666.7799932004164;3668.6881615062484;3701.5373078365205;3707.35121353762;3717.553893532793;3720.795356255432;3728.0800387800305;4257;4279.786010699452;4280.16536775332;4291.82832686689;4292.763897985578;4774.570288674036;5021.347224860745;5036.143855544567;5045.445001049881;5071.503906347636;1298.9805152922713;1321.1940716163133;1331.8401791785047;1340.9262490562917;1344.2606566388447;866.358894418126;884.7743825324501;915.9175674189355;934.6635211323918;935.7099299217128;4452.510223875371;4467.173572889026;4469.597736203757;4487.685861989629;4496.370508128799;5118.692878427306;5140.794368225229;5151.6136289778415;5203.479652034766;5214.895702085937;4278.679099067583;4447.221736196153;4467.597916187558;4470.904628366071;4533.886652833706;2781.735735105162;2792.8603569821425;2793.231861238176;2793.483205606969;2798.2304866161967;4905.3132561441425;4940.604751619861;4944.55499005084;4947.565206090194;4973.801047958041;4999.250112483157;5270.947290527046;5277.419483856773;5370.382406023357;5388.91916621251;4853.635977301717;4868.2210846264425;4871.853844384674;4886.657933944661;4915.287283343967;5184.651990482426;5194.065068287745;5201;5209.7395130244095;5223.981323641853;4888.682235654671;5111.821086261963;5128.205128204985;5133.4096578893905;5142.228665700175;4876;4878.219484882402;4898.559129678346;4907.631927605516;4912.828051018198;3699.6115407881784;3705.722070844751;3741.1021354874088;3755.530558680165;3763.0592351912023;4950.480199579137;5195.922061169161;5210.374755029421;5257.973710131425;5298.7350632469;5035.597152227886;5039.72281524505;5052.115879721107;5064.366954130734;5072.923906141485;5042.571381432619;5048;5064.544191022678;5082.567981721595;5085.923711144262;4746.952530474651;4775.976120119516;5001.449840517613;5008.774605142705;5010.974945125251;4925.556699897026;5108.416390918827;5116;5121.615878809179;5130.615203859651;4989.877277612653;5004.924926126038;5006.524380183877;5009.899802004013;5014.498550144956 16:37:12 INFO - PROCESS | 3409 | |5;yui.html;597.6324560395358;647.9384458476443;650.0282078292953;658.3482352471052;722.3715367630163;13022.73954520909;13421.328933553332;13722.862771372284;13732.24472654005;13776.862231377683;12663;12760.617181484547;12775.552855650054;12789.168704034231;12799.808002879941;621.791699780574;758.1281526244835;772.74499415193;779.0301075161432;786.4416264452217;772.8454309138167;783.3459061683473;785.4737325991571;786.657803855322;787.028020394812;835.2691395029349;837.5937670229933;838.8825564420986;838.9580520973957;840.0297656207091;661.4344735251362;806.4072906413782;828.7969447485405;829.7842560934171;831.3100126894662;606.2633899811706;606.3724045612813;606.7057477123592;606.8725567630803;607.007542667737;13162.14446061003;13283.800742988862;13323.800142997863;13333.333333333294;13349.332533373292;12429.192102513307;13000.544980925717;13015.15401498909;13018.479260829556;13024.218546887123;11817.17279790415;11900.523979040829;11909.285442873455;11933.641990740292;12176.086793490524;3221.952865318781;3287.1946373138494;3308.3714094322004;3397.677220664033;4220.894477638053;61503.692481537306;63596.36403635997;64090.359096408436;64576.354236457504;64613.353866461206;10515.60582936834;10555.630552930765;10589.894101059044;10722.410267435365;10876.728081798019;18157.27370905149;18191;18309.267629294944;18945.33691320797;18974.525636859187;6848.931510684929;6983.511154219257;7036.226015138331;7144.9642751785905;7197.100362454693;3793.203427280302;3857.1514266861245;3877.3990031545154;3913.941290880639;3956.347202711578;2767.861606919646;2868.856557172133;2870.641169853768;2871.239121632769;2873.5545990371525;506.6200349737697;528.6854321678595;560.1066299252685;570.9514691251208;575.2665351676562;433.3564656485117;539.6006954853381;546.6993153765413;565.9575531835129;583.2505230778514;7788;7903.9604801976775;7961;8097.716579919675;8126.715564955316;500.63203545394106;566.5156291370901;614.7264467312093;625.8842114208886;634.0267689097213;3622.492851000862;3806.9238615228096;3831.1954489556947;3843.36584463566;3883.1651194992646;59540.40459595435;60046.39953600495;60275;96393;98668;51137.48862511402;52099.47900521022;53723;57903;84536.73194901958;70552.2944770556;70888.64555677291;71096.64451677709;71590.64204679047;72812.90780638295;7199.892001620085;7210.351068403869;7380.852382952418;7395.260473952561;7574.545527268381;42579.7871010643;46089;46827.29759053685;47322.526774731814;48681.756591216814;62465.37534624596;65365.346346535924;65430.34569654243;65477.67261163663;65489.67255163693;9996.250281228791;10080.596776129167;10374.27380083387;11122.221444499131;11272.718182045515;12187.26876387384;12276.44755985965;13050.869491304966;13157.407916643966;13231.27228002469;10890.564377424815;10914.72713182145;11062.778744424906;11172.553097875994;11202.32786032808;10893;10989.890101098887;11117.166212534254;11265.436728163395;11536;11168.66494005181;11430.771384572428;11467.770644586895;11809.645710628694;11839.289642621126;9421.670241541513;9519.572953736511;9962.252831037846;9965.501724913871;10010.149137323118;9305;9678.854817177607;9894.802103957736;9985.151262142508;10115.79768404613 16:37:12 INFO - PROCESS | 3409 | __end_tp_report 16:37:12 INFO - PROCESS | 3409 | __start_cc_report 16:37:12 INFO - PROCESS | 3409 | _x_x_mozilla_cycle_collect,1137 16:37:12 INFO - PROCESS | 3409 | __end_cc_report 16:37:12 INFO - PROCESS | 3409 | __startTimestamp1465601832347__endTimestamp 16:37:12 INFO - PROCESS | 3409 | 16:37:12 INFO - PROCESS | 3409 | ------- Summary: start ------- 16:37:12 INFO - PROCESS | 3409 | Number of tests: 6 16:37:12 INFO - PROCESS | 3409 | 16:37:12 INFO - PROCESS | 3409 | [#0] dojo.html Cycles:165 Average:4673.73 Median:4792.74 stddev:500.22 (10.4%) stddev-sans-first:475.04 16:37:12 INFO - PROCESS | 3409 | Values: 2617.4 2630.9 2657.2 2664.7 2665.5 4557.1 4656.3 4707.4 4774.1 4814.2 4667.5 4710.1 4712.3 4735.1 4750.9 4277.3 4294.3 4352.2 4384.5 4493.4 4388.6 4414.4 4434.4 4447.2 4472.6 4193.1 4223.7 4273.4 4313.3 4324.3 4285.5 4294.7 4296.9 4348.5 4350.8 4303.5 4332.8 4335.2 4372.0 4374.9 4601.1 4683.4 4735.3 4745.5 4760.6 5086.2 5106.6 5149.0 5159.0 5160.4 5160.2 5178.4 5190.4 5191.7 5195.2 4628.2 4725.7 4765.5 4767.1 4847.8 5266.4 5290.6 5300.1 5303.4 5305.3 4803.5 5073.4 5080.3 5086.9 5093.6 4978.0 5025.2 5026.7 5047.8 5122.3 5003.9 5011.8 5014.1 5015.2 5071.9 4866.8 4991.8 4991.9 4995.0 5000.7 4152.1 4176.6 4203.8 4209.9 4236.4 3692.9 3707.6 3708.8 3745.7 3745.8 4387.2 4398.8 4399.9 4401.3 4442.5 4980.3 5017.4 5027.6 5040.8 5068.5 4359.8 4372.0 4377.0 4378.4 4422.1 4415.1 4495.0 4495.5 4501.9 4541.5 4715.0 4758.1 4765.1 4787.9 4790.4 5062.6 5089.9 5090.5 5093.0 5140.5 4599.2 4691.5 4792.7 4793.8 4850.6 4924.5 4961.9 4965.7 4965.9 4998.5 5047.7 5050.9 5052.4 5056.6 5106.3 4830.8 4864.3 4901.8 4903.4 4966.2 4924.6 4933.1 4939.0 4951.0 4980.2 4856.3 4902.4 4909.5 4917.0 4919.0 4791.0 4837.1 4934.7 4981.0 5015.8 4771.6 4838.1 4838.3 4838.7 4861.2 16:37:12 INFO - PROCESS | 3409 | 16:37:12 INFO - PROCESS | 3409 | [#1] ext.html Cycles:180 Average:43266.66 Median:33200.92 stddev:75900.62 (228.6%) stddev-sans-first:76045.78 16:37:12 INFO - PROCESS | 3409 | Values: 550.3 579.4 592.1 592.6 592.9 26525.5 39133.8 39773.6 39834.0 39955.4 40099.0 40510.8 40539.6 40584.2 40625.8 7446.3 7704.2 7841.5 7841.8 10141.8 9904.3 10295.4 10303.6 10307.2 10309.7 10337.7 10387.3 10395.1 10397.7 10400.1 7583.2 10139.1 10269.8 10488.3 10492.7 9979.1 10303.2 10338.2 10341.6 10350.1 39251.2 39759.8 39805.8 39876.8 39881.2 3017.7 3088.2 3094.9 3112.2 3151.0 29634.0 29997.0 30158.7 30318.0 30396.8 3567.9 3591.9 3613.8 3614.8 3633.8 169111.0 169820.0 169975.0 170057.0 170371.0 56446.0 56790.4 56817.0 56881.0 57162.4 33786.0 34756.3 34801.3 37078.8 37108.4 15320.2 15452.8 15460.1 15474.2 15479.5 10685.5 11355.2 11517.0 11571.2 11769.5 19054.0 19116.4 19153.5 19160.3 19171.7 7260.0 7435.4 7490.2 7591.1 7658.3 810.3 889.6 924.7 996.6 1028.4 27785.4 27835.0 27862.3 28300.6 28549.3 958.2 963.0 963.9 994.1 1004.7 14715.5 14895.2 14916.9 15048.9 15167.0 396368.0 399437.0 400837.0 402180.0 402624.0 50084.5 50566.0 50614.2 50615.2 50655.5 1088.2 1138.9 1139.6 1177.4 1178.4 27973.3 28879.0 28966.4 28990.7 29231.7 41221.0 41789.2 41789.4 41803.4 41840.2 242559.0 243461.0 243893.0 244572.0 245039.0 20441.6 23659.0 23702.8 24854.5 24876.3 35342.1 37952.8 41318.6 42026.4 42412.6 35679.3 35904.1 35940.8 36097.0 36801.3 35333.0 35333.1 35404.0 35417.6 35432.0 34627.3 34955.3 35517.5 35578.3 35969.3 31276.2 32190.0 32488.2 32537.2 32615.8 24685.8 24729.4 24893.1 25040.0 25153.5 16:37:12 INFO - PROCESS | 3409 | 16:37:12 INFO - PROCESS | 3409 | [#2] jquery.html Cycles:180 Average:23146.28 Median:4792.33 stddev:62755.46 (1309.5%) stddev-sans-first:62908.22 16:37:12 INFO - PROCESS | 3409 | Values: 375.5 377.6 379.7 387.0 394.0 16034.5 16720.1 16965.2 16982.0 17633.8 13659.9 14145.1 15102.5 15205.6 15669.5 4611.8 4777.9 4806.7 4816.6 4821.5 3476.5 3689.7 5230.3 5529.1 5533.2 5517.7 5572.9 5575.5 5617.1 5627.7 5432.4 5539.6 5577.0 5612.3 5623.6 4809.5 5412.1 5434.7 5440.3 5445.3 11905.9 12501.8 12604.2 12607.2 12614.1 1847.1 1857.5 1949.9 1956.1 1973.4 9249.3 9250.2 9351.0 9509.0 9675.8 1616.5 1660.1 1674.7 1723.8 1766.2 40451.0 41032.6 59615.7 59840.4 66833.7 9358.8 9704.8 9966.7 10003.7 10053.7 13475.7 13711.7 13753.7 13760.1 13783.7 7178.4 7267.2 7427.9 7534.8 7555.1 7029.6 7073.6 7094.9 7221.0 7270.9 4212.8 4229.5 4241.9 4268.9 4326.5 1714.8 1759.4 1776.5 1785.3 1802.4 705.3 807.1 856.9 870.2 875.7 16084.3 16742.0 16765.8 16778.7 17237.3 860.2 870.6 908.3 910.2 929.4 9005.8 9195.6 9205.7 9715.9 10065.6 303919.0 394314.0 398176.0 398582.0 400142.0 70640.0 75478.0 78938.0 79471.0 79730.4 889.9 890.1 917.1 927.2 958.2 15180.9 15232.0 15357.5 15571.8 15736.8 35796.3 36354.0 36524.0 37520.0 38065.6 44821.3 46376.8 49610.0 51274.7 51760.7 7606.0 7612.9 7695.3 7842.8 7946.3 10124.9 11699.2 11783.3 11878.8 11890.8 9500.3 9826.9 9842.0 9894.3 9960.2 10111.3 10247.9 10355.5 10371.3 10485.3 9846.7 9983.5 10052.8 10066.9 10204.0 7609.9 7647.8 7750.8 7807.2 7946.2 8117.8 9382.7 9630.6 10033.6 10054.4 16:37:12 INFO - PROCESS | 3409 | 16:37:12 INFO - PROCESS | 3409 | [#3] mootools.html Cycles:180 Average:5025.16 Median:4872.98 stddev:2819.47 (57.9%) stddev-sans-first:2812.83 16:37:12 INFO - PROCESS | 3409 | Values: 1214.1 1389.1 1412.1 1488.9 1666.1 6426.7 7211.9 7459.0 7484.1 7620.8 7337.9 7480.3 7481.8 7485.6 7486.7 1886.9 1944.7 1950.2 2181.0 2219.2 1932.7 2143.6 2244.9 2246.7 2247.8 2183.5 2191.3 2214.3 2215.6 2221.4 1866.2 2187.8 2216.6 2217.1 2220.0 2121.5 2206.1 2209.5 2219.2 2222.5 7617.0 7618.4 7624.4 7624.5 7648.4 4664.6 4790.8 4794.4 4800.6 4803.1 2818.6 2918.7 2934.3 2941.8 2999.1 842.3 851.6 887.6 888.1 898.8 10247.5 10440.5 10445.1 10456.9 10473.0 4292.2 4314.3 4346.6 4426.8 4433.9 8923.0 8941.5 8949.0 8950.6 8957.3 4560.6 4566.9 4573.1 4574.6 4578.0 3333.2 3702.6 4167.6 4374.3 4385.9 3720.1 3806.8 3816.5 3841.8 3865.1 1221.3 1225.9 1230.7 1235.0 1258.2 776.9 798.3 799.8 809.7 829.2 4868.3 4877.6 4929.7 4941.6 5000.1 418.4 418.9 424.1 427.4 441.8 3277.4 3451.7 3458.5 3469.9 3483.3 9245.2 9553.7 9592.0 9611.4 9633.0 9437.0 9501.5 9506.8 9508.5 9513.3 6821.1 7117.4 7189.6 7224.7 7259.3 5448.3 5457.6 5478.6 5543.6 5580.2 8483.3 8650.5 8671.0 8730.5 8740.8 8299.6 8673.8 8687.9 8748.5 8936.4 5963.6 6884.1 7121.8 7138.1 7141.1 7119.4 7167.4 7205.5 7394.7 7399.7 6493.8 6602.0 6617.9 6745.8 6775.6 6509.1 6590.0 6618.1 6692.0 6693.1 5846.8 5925.5 5964.9 6040.8 6042.3 4290.0 4307.5 4339.4 4373.4 4483.4 4117.1 4217.6 4274.1 4335.3 4392.2 16:37:12 INFO - PROCESS | 3409 | 16:37:12 INFO - PROCESS | 3409 | [#4] prototype.html Cycles:180 Average:4201.04 Median:4804.40 stddev:1207.07 (25.1%) stddev-sans-first:1174.33 16:37:12 INFO - PROCESS | 3409 | Values: 295.8 300.8 301.6 302.7 308.8 4805.2 4851.4 4852.7 4872.5 4901.3 4736.0 4781.6 4803.6 4812.2 4818.6 3566.0 3629.4 3695.7 3754.5 3813.0 3724.3 3763.1 3770.4 3783.5 3814.8 3555.8 3723.8 3736.1 3737.9 3761.2 3638.6 3763.4 3764.9 3770.7 3794.6 3340.6 3364.2 3377.9 3381.3 3389.7 4684.3 4693.4 4704.9 4717.8 4750.6 4246.2 4340.3 4340.5 4344.7 4378.1 5000.3 5026.1 5029.1 5049.3 5071.4 3698.7 3701.3 3706.9 3715.8 3721.5 4925.3 5210.8 5257.4 5261.8 5267.3 3627.7 3649.9 3664.9 3666.8 3668.7 3701.5 3707.4 3717.6 3720.8 3728.1 4257.0 4279.8 4280.2 4291.8 4292.8 4774.6 5021.3 5036.1 5045.4 5071.5 1299.0 1321.2 1331.8 1340.9 1344.3 866.4 884.8 915.9 934.7 935.7 4452.5 4467.2 4469.6 4487.7 4496.4 5118.7 5140.8 5151.6 5203.5 5214.9 4278.7 4447.2 4467.6 4470.9 4533.9 2781.7 2792.9 2793.2 2793.5 2798.2 4905.3 4940.6 4944.6 4947.6 4973.8 4999.3 5270.9 5277.4 5370.4 5388.9 4853.6 4868.2 4871.9 4886.7 4915.3 5184.7 5194.1 5201.0 5209.7 5224.0 4888.7 5111.8 5128.2 5133.4 5142.2 4876.0 4878.2 4898.6 4907.6 4912.8 3699.6 3705.7 3741.1 3755.5 3763.1 4950.5 5195.9 5210.4 5258.0 5298.7 5035.6 5039.7 5052.1 5064.4 5072.9 5042.6 5048.0 5064.5 5082.6 5085.9 4747.0 4776.0 5001.4 5008.8 5011.0 4925.6 5108.4 5116.0 5121.6 5130.6 4989.9 5004.9 5006.5 5009.9 5014.5 16:37:12 INFO - PROCESS | 3409 | 16:37:12 INFO - PROCESS | 3409 | [#5] yui.html Cycles:180 Average:16494.92 Median:26314.08 stddev:22281.95 (84.7%) stddev-sans-first:22312.48 16:37:12 INFO - PROCESS | 3409 | Values: 597.6 647.9 650.0 658.3 722.4 13022.7 13421.3 13722.9 13732.2 13776.9 12663.0 12760.6 12775.6 12789.2 12799.8 621.8 758.1 772.7 779.0 786.4 772.8 783.3 785.5 786.7 787.0 835.3 837.6 838.9 839.0 840.0 661.4 806.4 828.8 829.8 831.3 606.3 606.4 606.7 606.9 607.0 13162.1 13283.8 13323.8 13333.3 13349.3 12429.2 13000.5 13015.2 13018.5 13024.2 11817.2 11900.5 11909.3 11933.6 12176.1 3222.0 3287.2 3308.4 3397.7 4220.9 61503.7 63596.4 64090.4 64576.4 64613.4 10515.6 10555.6 10589.9 10722.4 10876.7 18157.3 18191.0 18309.3 18945.3 18974.5 6848.9 6983.5 7036.2 7145.0 7197.1 3793.2 3857.2 3877.4 3913.9 3956.3 2767.9 2868.9 2870.6 2871.2 2873.6 506.6 528.7 560.1 571.0 575.3 433.4 539.6 546.7 566.0 583.3 7788.0 7904.0 7961.0 8097.7 8126.7 500.6 566.5 614.7 625.9 634.0 3622.5 3806.9 3831.2 3843.4 3883.2 59540.4 60046.4 60275.0 96393.0 98668.0 51137.5 52099.5 53723.0 57903.0 84536.7 70552.3 70888.6 71096.6 71590.6 72812.9 7199.9 7210.4 7380.9 7395.3 7574.5 42579.8 46089.0 46827.3 47322.5 48681.8 62465.4 65365.3 65430.3 65477.7 65489.7 9996.3 10080.6 10374.3 11122.2 11272.7 12187.3 12276.4 13050.9 13157.4 13231.3 10890.6 10914.7 11062.8 11172.6 11202.3 10893.0 10989.9 11117.2 11265.4 11536.0 11168.7 11430.8 11467.8 11809.6 11839.3 9421.7 9519.6 9962.3 9965.5 10010.1 9305.0 9678.9 9894.8 9985.2 10115.8 16:37:12 INFO - PROCESS | 3409 | -------- Summary: end -------- 16:37:12 INFO - PROCESS | 3409 | 16:37:13 INFO - TEST-INFO | 3409: exit 0 16:37:13 INFO - TEST-OK | dromaeo_css | took 1122139ms 16:37:13 INFO - TEST-START | kraken 16:37:13 INFO - operating with platform_type : linux_ 16:37:13 INFO - Initialising browser for kraken test... 16:37:13 INFO - TEST-INFO | started process 3592 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzw2qql/profile http://localhost:57564/getInfo.html) 16:37:17 INFO - PROCESS | 3592 | __metrics Screen width/height:1600/1200 16:37:17 INFO - PROCESS | 3592 | colorDepth:24 16:37:17 INFO - PROCESS | 3592 | Browser inner width/height: 1024/697 16:37:17 INFO - PROCESS | 3592 | __metrics 16:37:18 INFO - PROCESS | 3592 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:37:18 INFO - PROCESS | 3592 | console.error: PushService: 16:37:18 INFO - PROCESS | 3592 | stateChangeProcessEnqueue: Error transitioning state 16:37:18 INFO - PROCESS | 3592 | UnknownError 16:37:19 INFO - TEST-INFO | 3592: exit 0 16:37:19 INFO - Browser initialized. 16:37:19 INFO - Running cycle 1/1 for kraken test... 16:37:19 INFO - TEST-INFO | started process 3672 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzw2qql/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:37:31 INFO - PROCESS | 3672 | RSS: Main: 175558656 16:37:31 INFO - PROCESS | 3672 | 16:37:34 INFO - PROCESS | 3672 | Cycle 1(1): loaded http://localhost:57564/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57564/tests/kraken/driver.html?testName=audio-beat-detection) 16:37:35 INFO - PROCESS | 3672 | RSS: Main: 233791488 16:37:35 INFO - PROCESS | 3672 | 16:37:38 INFO - PROCESS | 3672 | Cycle 1(1): loaded http://localhost:57564/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57564/tests/kraken/driver.html?testName=audio-dft) 16:37:39 INFO - PROCESS | 3672 | RSS: Main: 221839360 16:37:39 INFO - PROCESS | 3672 | 16:37:42 INFO - PROCESS | 3672 | Cycle 1(1): loaded http://localhost:57564/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57564/tests/kraken/driver.html?testName=audio-fft) 16:37:42 INFO - PROCESS | 3672 | RSS: Main: 289583104 16:37:42 INFO - PROCESS | 3672 | 16:37:45 INFO - PROCESS | 3672 | Cycle 1(1): loaded http://localhost:57564/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57564/tests/kraken/driver.html?testName=audio-oscillator) 16:37:45 INFO - PROCESS | 3672 | RSS: Main: 199491584 16:37:45 INFO - PROCESS | 3672 | 16:37:47 INFO - PROCESS | 3672 | Cycle 1(1): loaded http://localhost:57564/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57564/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:37:48 INFO - PROCESS | 3672 | RSS: Main: 202993664 16:37:48 INFO - PROCESS | 3672 | 16:37:51 INFO - PROCESS | 3672 | Cycle 1(1): loaded http://localhost:57564/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57564/tests/kraken/driver.html?testName=imaging-darkroom) 16:37:52 INFO - PROCESS | 3672 | RSS: Main: 238985216 16:37:52 INFO - PROCESS | 3672 | 16:37:55 INFO - PROCESS | 3672 | Cycle 1(1): loaded http://localhost:57564/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57564/tests/kraken/driver.html?testName=imaging-desaturate) 16:37:56 INFO - PROCESS | 3672 | RSS: Main: 235470848 16:37:56 INFO - PROCESS | 3672 | 16:37:59 INFO - PROCESS | 3672 | Cycle 1(1): loaded http://localhost:57564/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57564/tests/kraken/driver.html?testName=json-parse-financial) 16:38:00 INFO - PROCESS | 3672 | RSS: Main: 237740032 16:38:00 INFO - PROCESS | 3672 | 16:38:01 INFO - PROCESS | 3672 | Cycle 1(1): loaded http://localhost:57564/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57564/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:38:02 INFO - PROCESS | 3672 | RSS: Main: 225853440 16:38:02 INFO - PROCESS | 3672 | 16:38:04 INFO - PROCESS | 3672 | Cycle 1(1): loaded http://localhost:57564/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57564/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:38:04 INFO - PROCESS | 3672 | RSS: Main: 229605376 16:38:04 INFO - PROCESS | 3672 | 16:38:07 INFO - PROCESS | 3672 | Cycle 1(1): loaded http://localhost:57564/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57564/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:38:07 INFO - PROCESS | 3672 | RSS: Main: 237838336 16:38:07 INFO - PROCESS | 3672 | 16:38:10 INFO - PROCESS | 3672 | Cycle 1(1): loaded http://localhost:57564/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57564/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:38:11 INFO - PROCESS | 3672 | RSS: Main: 242053120 16:38:11 INFO - PROCESS | 3672 | 16:38:14 INFO - PROCESS | 3672 | Cycle 1(1): loaded http://localhost:57564/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57564/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:38:14 INFO - PROCESS | 3672 | RSS: Main: 239472640 16:38:14 INFO - PROCESS | 3672 | 16:38:16 INFO - PROCESS | 3672 | Cycle 1(1): loaded http://localhost:57564/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57564/tests/kraken/driver.html?testName=ai-astar) 16:38:16 INFO - PROCESS | 3672 | RSS: Main: 282284032 16:38:16 INFO - PROCESS | 3672 | 16:38:16 INFO - PROCESS | 3672 | __start_tp_report 16:38:16 INFO - PROCESS | 3672 | _x_x_mozilla_page_load 16:38:16 INFO - PROCESS | 3672 | _x_x_mozilla_page_load_details 16:38:16 INFO - PROCESS | 3672 | |i|pagename|runs| 16:38:16 INFO - PROCESS | 3672 | |0;ai-astar;115;110;112;116;113;113;113;114;113;114 16:38:16 INFO - PROCESS | 3672 | |1;audio-beat-detection;161;129;134;180;130;157;165;131;200;132 16:38:16 INFO - PROCESS | 3672 | |2;audio-dft;161;162;162;161;161;162;164;162;161;161 16:38:16 INFO - PROCESS | 3672 | |3;audio-fft;74;76;75;102;77;77;75;75;98;75 16:38:16 INFO - PROCESS | 3672 | |4;audio-oscillator;85;85;119;86;86;87;120;85;86;123 16:38:16 INFO - PROCESS | 3672 | |5;imaging-gaussian-blur;117;118;117;117;117;117;117;116;117;117 16:38:16 INFO - PROCESS | 3672 | |6;imaging-darkroom;146;147;146;146;146;146;145;146;148;147 16:38:16 INFO - PROCESS | 3672 | |7;imaging-desaturate;96;95;94;95;95;95;95;95;95;95 16:38:16 INFO - PROCESS | 3672 | |8;json-parse-financial;63;64;63;63;64;71;72;62;62;62 16:38:16 INFO - PROCESS | 3672 | |9;json-stringify-tinderbox;65;65;65;66;65;64;64;65;65;64 16:38:16 INFO - PROCESS | 3672 | |10;stanford-crypto-aes;83;84;83;84;87;84;93;90;118;83 16:38:16 INFO - PROCESS | 3672 | |11;stanford-crypto-ccm;132;134;132;131;145;129;130;130;141;132 16:38:16 INFO - PROCESS | 3672 | |12;stanford-crypto-pbkdf2;173;180;176;178;167;169;167;168;174;173 16:38:16 INFO - PROCESS | 3672 | |13;stanford-crypto-sha256-iterative;70;67;68;68;69;71;68;68;68;66 16:38:16 INFO - PROCESS | 3672 | __end_tp_report 16:38:16 INFO - PROCESS | 3672 | __start_cc_report 16:38:16 INFO - PROCESS | 3672 | _x_x_mozilla_cycle_collect,1893 16:38:16 INFO - PROCESS | 3672 | __end_cc_report 16:38:16 INFO - PROCESS | 3672 | __startTimestamp1465601896655__endTimestamp 16:38:16 INFO - PROCESS | 3672 | 16:38:16 INFO - PROCESS | 3672 | ------- Summary: start ------- 16:38:16 INFO - PROCESS | 3672 | Number of tests: 14 16:38:16 INFO - PROCESS | 3672 | 16:38:16 INFO - PROCESS | 3672 | [#0] ai-astar Cycles:10 Average:113.30 Median:113.50 stddev:1.64 (1.4%) stddev-sans-first:1.62 16:38:16 INFO - PROCESS | 3672 | Values: 115.0 110.0 112.0 116.0 113.0 113.0 113.0 114.0 113.0 114.0 16:38:16 INFO - PROCESS | 3672 | 16:38:16 INFO - PROCESS | 3672 | [#1] audio-beat-detection Cycles:10 Average:151.90 Median:159.00 stddev:24.81 (15.6%) stddev-sans-first:26.10 16:38:16 INFO - PROCESS | 3672 | Values: 161.0 129.0 134.0 180.0 130.0 157.0 165.0 131.0 200.0 132.0 16:38:16 INFO - PROCESS | 3672 | 16:38:16 INFO - PROCESS | 3672 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 16:38:16 INFO - PROCESS | 3672 | Values: 161.0 162.0 162.0 161.0 161.0 162.0 164.0 162.0 161.0 161.0 16:38:16 INFO - PROCESS | 3672 | 16:38:16 INFO - PROCESS | 3672 | [#3] audio-fft Cycles:10 Average:80.40 Median:75.50 stddev:10.42 (13.8%) stddev-sans-first:10.79 16:38:16 INFO - PROCESS | 3672 | Values: 74.0 76.0 75.0 102.0 77.0 77.0 75.0 75.0 98.0 75.0 16:38:16 INFO - PROCESS | 3672 | 16:38:16 INFO - PROCESS | 3672 | [#4] audio-oscillator Cycles:10 Average:96.20 Median:85.50 stddev:16.92 (19.8%) stddev-sans-first:17.46 16:38:16 INFO - PROCESS | 3672 | Values: 85.0 85.0 119.0 86.0 86.0 87.0 120.0 85.0 86.0 123.0 16:38:16 INFO - PROCESS | 3672 | 16:38:16 INFO - PROCESS | 3672 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 16:38:16 INFO - PROCESS | 3672 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 16:38:16 INFO - PROCESS | 3672 | 16:38:16 INFO - PROCESS | 3672 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 16:38:16 INFO - PROCESS | 3672 | Values: 146.0 147.0 146.0 146.0 146.0 146.0 145.0 146.0 148.0 147.0 16:38:16 INFO - PROCESS | 3672 | 16:38:16 INFO - PROCESS | 3672 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 16:38:16 INFO - PROCESS | 3672 | Values: 96.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 16:38:16 INFO - PROCESS | 3672 | 16:38:16 INFO - PROCESS | 3672 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:63.50 stddev:3.72 (5.9%) stddev-sans-first:3.90 16:38:16 INFO - PROCESS | 3672 | Values: 63.0 64.0 63.0 63.0 64.0 71.0 72.0 62.0 62.0 62.0 16:38:16 INFO - PROCESS | 3672 | 16:38:16 INFO - PROCESS | 3672 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 16:38:16 INFO - PROCESS | 3672 | Values: 65.0 65.0 65.0 66.0 65.0 64.0 64.0 65.0 65.0 64.0 16:38:16 INFO - PROCESS | 3672 | 16:38:16 INFO - PROCESS | 3672 | [#10] stanford-crypto-aes Cycles:10 Average:88.90 Median:84.00 stddev:10.77 (12.8%) stddev-sans-first:11.22 16:38:16 INFO - PROCESS | 3672 | Values: 83.0 84.0 83.0 84.0 87.0 84.0 93.0 90.0 118.0 83.0 16:38:16 INFO - PROCESS | 3672 | 16:38:16 INFO - PROCESS | 3672 | [#11] stanford-crypto-ccm Cycles:10 Average:133.60 Median:132.00 stddev:5.23 (4.0%) stddev-sans-first:5.52 16:38:16 INFO - PROCESS | 3672 | Values: 132.0 134.0 132.0 131.0 145.0 129.0 130.0 130.0 141.0 132.0 16:38:16 INFO - PROCESS | 3672 | 16:38:16 INFO - PROCESS | 3672 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.50 Median:173.50 stddev:4.65 (2.7%) stddev-sans-first:4.93 16:38:16 INFO - PROCESS | 3672 | Values: 173.0 180.0 176.0 178.0 167.0 169.0 167.0 168.0 174.0 173.0 16:38:16 INFO - PROCESS | 3672 | 16:38:16 INFO - PROCESS | 3672 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.00 stddev:1.42 (2.1%) stddev-sans-first:1.36 16:38:16 INFO - PROCESS | 3672 | Values: 70.0 67.0 68.0 68.0 69.0 71.0 68.0 68.0 68.0 66.0 16:38:16 INFO - PROCESS | 3672 | -------- Summary: end -------- 16:38:16 INFO - PROCESS | 3672 | 16:38:17 INFO - TEST-INFO | 3672: exit 0 16:38:18 INFO - TEST-OK | kraken | took 64899ms 16:38:18 INFO - SUITE-END | took 1187s 16:38:18 INFO - Completed test suite (00:19:47) 16:38:18 INFO - javascript benchmark 16:38:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2617.4241666833295, 2630.9473810523778, 2657.202839148256, 2664.6669166354195, 2665.5202063628553, 4557.1113632841525, 4656.278276867082, 4707.388039554858, 4774.0929223447565, 4814.229723244277, 4667.463241727202, 4710.08153410086, 4712.269598212274, 4735.147673418792, 4750.90498190036, 4277.337012763027, 4294.269974104394, 4352.173087113454, 4384.517703052662, 4493.438320209973, 4388.626966707834, 4414.4040554525045, 4434.401355816972, 4447.155040542303, 4472.619827314666, 4193.098483825992, 4223.72545784523, 4273.423087883127, 4313.28830742927, 4324.329728892027, 4285.485741710983, 4294.677899157576, 4296.935545966813, 4348.456442944632, 4350.847720329805, 4303.462067241595, 4332.826686932519, 4335.219660461115, 4372.038151606642, 4374.8906277343, 4601.056783359403, 4683.437987441529, 4735.337052812609, 4745.477997420281, 4760.595349395306, 5086.237064440326, 5106.591472682177, 5149.0, 5159.019786240602, 5160.380754309469, 5160.174372100446, 5178.352705911761, 5190.429052804188, 5191.662541934762, 5195.246689230041, 4628.213203755369, 4725.716457012591, 4765.475797662254, 4767.094252092092, 4847.830325938646, 5266.368035835724, 5290.550303224192, 5300.072487314705, 5303.390110137384, 5305.257263983045, 4803.543663351976, 5073.441921388644, 5080.288759573663, 5086.872828179326, 5093.617978651616, 4977.9751101244265, 5025.221090730869, 5026.673266237683, 5047.772850221749, 5122.257272695513, 5003.949960500348, 5011.774470148852, 5014.09746245672, 5015.247712843103, 5071.923921141186, 4866.78099485524, 4991.800327986913, 4991.9204474829085, 4995.0, 5000.74996250186, 4152.1072969311745, 4176.624103830609, 4203.810828512725, 4209.873703788891, 4236.385724069993, 3692.8707495237536, 3707.5736290326417, 3708.8331025103935, 3745.6628903398823, 3745.7939813309986, 4387.188370151468, 4398.8020539075815, 4399.934000989988, 4401.273789824707, 4442.53353397895, 4980.252962055721, 5017.397912250481, 5027.572656324253, 5040.823571174991, 5068.518490743447, 4359.80380882861, 4371.956280437218, 4377.0, 4378.387025816388, 4422.09347083847, 4415.139047885696, 4494.977525112354, 4495.483019452739, 4501.909961800746, 4541.455025396907, 4715.033418149271, 4758.1435341638835, 4765.11845308619, 4787.928181077356, 4790.353302304145, 5062.569681577107, 5089.898202036013, 5090.516400941905, 5092.9745351273, 5140.537351638371, 4599.1721490132095, 4691.507391723956, 4792.736399497921, 4793.808247670054, 4850.587700045536, 4924.458309586014, 4961.875953101201, 4965.702057876539, 4965.925511117264, 4998.500149984972, 5047.671901326402, 5050.949490505048, 5052.393712754493, 5056.595472362129, 5106.259592359162, 4830.806767729251, 4864.270359446112, 4901.779419926041, 4903.41159060915, 4966.18058020437, 4924.63065270099, 4933.136701077369, 4938.975305123451, 4951.0, 4980.153373926369, 4856.271559266138, 4902.362692850049, 4909.459959404534, 4916.975415122902, 4919.016196760591, 4791.0, 4837.129316722883, 4934.654574179773, 4980.975095124501, 5015.799368025238, 4771.594414474808, 4838.056578967067, 4838.250071238964, 4838.685485443435, 4861.173600487855], "value": 4641.432676775927, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.2828108522673, 579.3742757821553, 592.1088761414072, 592.6207227374484, 592.8577141486041, 26525.469490610176, 39133.80433097834, 39773.60226397735, 39834.0, 39955.40066898992, 40099.0, 40510.79744601273, 40539.59460405395, 40584.18831623366, 40625.79687101568, 7446.329830315271, 7704.19105993871, 7841.451098423113, 7841.764747057598, 10141.797164056714, 9904.25718071144, 10295.382277063363, 10303.63937262196, 10307.226957978144, 10309.742256443575, 10337.741556461111, 10387.324823886423, 10395.064444200021, 10397.688069357931, 10400.063994240516, 7583.241675832428, 10139.087482126644, 10269.845952310721, 10488.265821392506, 10492.685219443429, 9979.051990060932, 10303.227257955608, 10338.22463315247, 10341.63804266847, 10350.068493835592, 39251.21497570061, 39759.80120099381, 39805.800970995246, 39876.800615997025, 39881.202375952606, 3017.6680565137817, 3088.243380371823, 3094.891678791254, 3112.1908303840937, 3150.9684903150905, 29634.0, 29997.0, 30158.69841301581, 30318.0, 30396.848015760002, 3567.928641427183, 3591.8742844000594, 3613.8373773180006, 3614.8011859347725, 3633.7638053526434, 169111.0, 169820.0, 169975.0, 170057.0, 170371.0, 56446.0, 56790.43209567934, 56817.0, 56881.0, 57162.42837571654, 33786.0, 34756.30487390238, 34801.30397392038, 37078.814605927335, 37108.44337334942, 15320.15739134336, 15452.768208476882, 15460.072395656296, 15474.226288685746, 15479.458218962282, 10685.519151638195, 11355.205135640426, 11517.0, 11571.247868888495, 11769.470373833197, 19054.0, 19116.426507204807, 19153.52116197106, 19160.329388471335, 19171.712424313646, 7260.0, 7435.367993720486, 7490.176080631126, 7591.127020392615, 7658.310752032344, 810.2748040503716, 889.5774507109201, 924.7139508378713, 996.6362277768562, 1028.3983869436463, 27785.444291114065, 27835.0, 27862.303442413697, 28300.575491367646, 28549.28626784347, 958.2094771813142, 962.9662961796304, 963.8939716631165, 994.1351024608637, 1004.7337455574278, 14715.484958026418, 14895.180765058027, 14916.925415372854, 15048.946573739951, 15167.0, 396368.0, 399437.0, 400837.0, 402180.0, 402624.0, 50084.49915500799, 50566.0, 50614.24078638823, 50615.24077138846, 50655.49344506581, 1088.1784252889017, 1138.8804175561613, 1139.5555733264034, 1177.381874515886, 1178.3577950017261, 27973.300667483476, 28879.0, 28966.420671586027, 28990.7100928988, 29231.684574194638, 41221.0, 41789.164216716104, 41789.37315940324, 41803.37294940639, 41840.1631967365, 242559.0, 243461.0, 243893.0, 244572.0, 245039.0, 20441.591168176852, 23659.0, 23702.762972370747, 24854.50290994206, 24876.253712388658, 35342.11644708903, 37952.81023594975, 41318.58681413147, 42026.36960445534, 42412.575874240865, 35679.28641427209, 35904.10239744027, 35940.82029589835, 36097.0, 36801.26397472089, 35333.0, 35333.1166720834, 35404.0, 35417.64582354143, 35432.0, 34627.30745385028, 34955.30089398147, 35517.46723799093, 35578.28843423169, 35969.28061438704, 31276.218094547818, 32190.0, 32488.187795305308, 32537.186570334983, 32615.836920815244, 24685.753142468344, 24729.381765456008, 24893.128740493994, 25040.0, 25153.49693006093], "value": 17654.16362014518, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.46496242853937, 377.562028047465, 379.671584079771, 386.9922601547967, 394.0287192071545, 16034.51896443107, 16720.080395578254, 16965.236564354604, 16981.999999999985, 17633.82366176341, 13659.907207423406, 14145.080569762958, 15102.471413500529, 15205.619859503518, 15669.45156919508, 4611.815527378909, 4777.928331075037, 4806.735629540374, 4816.590589799871, 4821.54195351441, 3476.461148521983, 3689.723270754691, 5230.320058392423, 5529.142982837647, 5533.22534845122, 5517.724113794315, 5572.888542229173, 5575.498205161534, 5617.101263797793, 5627.662340259577, 5432.375276843135, 5539.639923404986, 5577.0, 5612.298462692163, 5623.606347555673, 4809.470958194595, 5412.107002344608, 5434.728263586844, 5440.319960004999, 5445.292112025451, 11905.940470297593, 12501.812472812915, 12604.180728252633, 12607.180533265308, 12614.05394595409, 1847.1318480314364, 1857.4799056264267, 1949.9415017549495, 1956.1099699636632, 1973.447434718281, 9249.306302027375, 9250.213731832802, 9351.043946708256, 9509.001554836781, 9675.758106047406, 1616.531205950273, 1660.1367289009768, 1674.673438679458, 1723.8371078619489, 1766.222861940742, 40451.0, 41032.589674103176, 59615.701921490116, 59840.401595983916, 66833.66583167102, 9358.800681839763, 9704.75738106553, 9966.700998970042, 10003.749906252402, 10053.748656283506, 13475.730485390237, 13711.657208569866, 13753.724925501434, 13760.105593136414, 13783.724325513635, 7178.425725941912, 7267.236940121317, 7427.925720742832, 7534.849303013909, 7555.09338879338, 7029.613371264527, 7073.575585464889, 7094.858102837914, 7220.963895180491, 7270.927290727025, 4212.789360531961, 4229.513605935295, 4241.936370954438, 4268.914621707549, 4326.502452218036, 1714.8370904764026, 1759.3578343904383, 1776.4759395978217, 1785.2948085506412, 1802.3961972739016, 705.3299365602697, 807.1283014344612, 856.9357298202535, 870.2081106193334, 875.7460336502343, 16084.276207570454, 16742.0, 16765.832341676673, 16778.74831877523, 17237.310507579557, 860.1914200651368, 870.5995242188665, 908.2960705453327, 910.153557191818, 929.3540989012571, 9005.819883602291, 9195.586198621078, 9205.677801276923, 9715.854262186072, 10065.647702330383, 303919.0, 394314.0, 398176.0, 398582.0, 400142.0, 70640.0, 75478.0, 78938.0, 79471.0, 79730.40539189184, 889.8754174415458, 890.1009979920327, 917.0554329041098, 927.1933417926313, 958.242988039455, 15180.924095379452, 15232.0, 15357.539273821803, 15571.84428155704, 15736.76394854101, 35796.284074318886, 36354.0, 36524.0, 37520.0, 38065.61934380732, 44821.32768008417, 46376.768116159205, 49610.0, 51274.743626283125, 51760.74119629378, 7606.04924384452, 7612.923870761443, 7695.307422332017, 7842.803929901798, 7946.284834364935, 10124.898751012395, 11699.23954942926, 11783.293002419883, 11878.821817672915, 11890.762184756084, 9500.334976551576, 9826.9017309826, 9841.95079024629, 9894.257930655085, 9960.203183745138, 10111.3265244938, 10247.94876025645, 10355.482225888825, 10371.27401081917, 10485.318454300446, 9846.655367062118, 9983.450910199717, 10052.798944021224, 10066.94966525192, 10204.0, 7609.88585171234, 7647.808804779925, 7750.8449831001935, 7807.180246074307, 7946.1656526066245, 8117.8376432472205, 9382.67160649374, 9630.566624502055, 10033.598656053677, 10054.396736195851], "value": 7911.160368194612, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1214.1136970011885, 1389.1387339849296, 1412.0962583946275, 1488.9255537223144, 1666.067002478612, 6426.678666066696, 7211.891821622673, 7459.030326057605, 7484.064491938508, 7620.809479763008, 7337.88993165103, 7480.289372509603, 7481.812954676136, 7485.625718714056, 7486.700531978728, 1886.9339573114944, 1944.7082937559337, 1950.2101648832174, 2180.9890950545223, 2219.1678120704737, 1932.690769476884, 2143.582001509706, 2244.932652020442, 2246.6630005499223, 2247.763984781599, 2183.530540933699, 2191.298784388996, 2214.302494714168, 2215.5679642469727, 2221.4002219400754, 1866.178881292227, 2187.7812218778076, 2216.5899308627954, 2217.1463986365206, 2220.0120946179036, 2121.5226574020876, 2206.117552978805, 2209.5470428562107, 2219.223271854854, 2222.488827569668, 7616.961915190444, 7618.352440042603, 7624.390048796083, 7624.504407213513, 7648.42636802242, 4664.626829853603, 4790.80836766529, 4794.400699912511, 4800.567948884583, 4803.063402636487, 2818.6476690413697, 2918.7081291870854, 2934.2811011302156, 2941.794074414792, 2999.0552975812766, 842.2924743215729, 851.5699571716306, 887.60057973912, 888.0808363343973, 898.7887846356101, 10247.487625618689, 10440.477976101165, 10445.11216546587, 10456.895431045668, 10473.005064518858, 4292.163028209532, 4314.331278651814, 4346.630536404441, 4426.800793964279, 4433.933490997638, 8922.955385223033, 8941.508217048126, 8948.955255223682, 8950.641974320954, 8957.28341732673, 4560.635149188057, 4566.862994110182, 4573.062522182944, 4574.611158051603, 4578.0157266187925, 3333.233356328058, 3702.648248416396, 4167.5832416758685, 4374.321980093091, 4385.934210986838, 3720.088578298334, 3806.752561083576, 3816.4847745553993, 3841.8271177797064, 3865.0530619997717, 1221.2733423612935, 1225.914186006971, 1230.7353918907477, 1234.950601975929, 1258.1696080586769, 776.9417293702995, 798.3413683710962, 799.8240387114826, 809.7165991902905, 829.1666874790797, 4868.342773725572, 4877.609791216694, 4929.654924155275, 4941.604671626261, 5000.099982003274, 418.39750758907076, 418.8701502534224, 424.1453471255423, 427.3568279739035, 441.7813182474696, 3277.4264503712234, 3451.6893479586956, 3458.533098031784, 3469.8959031228596, 3483.3381657484997, 9245.214156796614, 9553.713388598353, 9592.0, 9611.423314601147, 9632.95183524078, 9437.0, 9501.524923753785, 9506.762330941781, 9508.47703376307, 9513.286503512127, 6821.079154314203, 7117.395021423134, 7189.6405179740805, 7224.74713385029, 7259.274072592699, 5448.318960129984, 5457.563394928476, 5478.643888147258, 5543.584231182596, 5580.190872323409, 8483.27892129176, 8650.480971141751, 8671.0, 8730.519821409884, 8740.78148046304, 8299.585020749058, 8673.783155421164, 8687.869681954902, 8748.518831464331, 8936.41913275635, 5963.552733545088, 6884.070650462324, 7121.82195445118, 7138.072050633385, 7141.071660684078, 7119.359257666835, 7167.3549380556, 7205.495615306878, 7394.704211831467, 7399.667014984447, 6493.837654058686, 6601.966990165019, 6617.933820661732, 6745.831354215988, 6775.593464392152, 6509.088727578238, 6590.0, 6618.139641846529, 6692.0, 6693.062971184136, 5846.795362162304, 5925.52595792327, 5964.896494148423, 6040.818775436744, 6042.335343112166, 4289.957100429081, 4307.504636966663, 4339.3924850520325, 4373.365861950063, 4483.394741709827, 4117.094239267356, 4217.641500472494, 4274.145170965757, 4335.349697545394, 4392.165488557292], "value": 3989.215326357564, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.8136374084328, 300.76089508840477, 301.62899633450854, 302.73964390624076, 308.8023664854493, 4805.231163013918, 4851.417829860413, 4852.733099679516, 4872.489528246246, 4901.33831932689, 4736.0, 4781.569658730714, 4803.5676789088975, 4812.157872372339, 4818.638602104838, 3565.983694647026, 3629.3648611493013, 3695.7412981091334, 3754.4743735877, 3813.008617759375, 3724.2737666155112, 3763.0968567543728, 3770.397581028066, 3783.5433358157034, 3814.8474061037527, 3555.8044307563073, 3723.813809309537, 3736.1220113273357, 3737.8878633641034, 3761.153740408414, 3638.6361363863666, 3763.397856342972, 3764.9435258471144, 3770.6621894425493, 3794.6395092466173, 3340.6492318306473, 3364.175776934667, 3377.8986630401128, 3381.2899291148888, 3389.74576906733, 4684.313647087046, 4693.389859318267, 4704.858854234344, 4717.811287548494, 4750.61995040396, 4246.214450326699, 4340.262155433584, 4340.500842403132, 4344.652427805768, 4378.10248898975, 5000.299958005882, 5026.145555255579, 5029.119904016782, 5049.34358533392, 5071.391433028023, 3698.68561172298, 3701.2597480503737, 3706.8887933362043, 3715.7956312402807, 3721.4603882436895, 4925.335079764258, 5210.843674689728, 5257.369115706139, 5261.815836445706, 5267.341582302174, 3627.6553727395853, 3649.872254471081, 3664.9083772905356, 3666.7799932004164, 3668.6881615062484, 3701.5373078365205, 3707.35121353762, 3717.553893532793, 3720.795356255432, 3728.0800387800305, 4257.0, 4279.786010699452, 4280.16536775332, 4291.82832686689, 4292.763897985578, 4774.570288674036, 5021.347224860745, 5036.143855544567, 5045.445001049881, 5071.503906347636, 1298.9805152922713, 1321.1940716163133, 1331.8401791785047, 1340.9262490562917, 1344.2606566388447, 866.358894418126, 884.7743825324501, 915.9175674189355, 934.6635211323918, 935.7099299217128, 4452.510223875371, 4467.173572889026, 4469.597736203757, 4487.685861989629, 4496.370508128799, 5118.692878427306, 5140.794368225229, 5151.6136289778415, 5203.479652034766, 5214.895702085937, 4278.679099067583, 4447.221736196153, 4467.597916187558, 4470.904628366071, 4533.886652833706, 2781.735735105162, 2792.8603569821425, 2793.231861238176, 2793.483205606969, 2798.2304866161967, 4905.3132561441425, 4940.604751619861, 4944.55499005084, 4947.565206090194, 4973.801047958041, 4999.250112483157, 5270.947290527046, 5277.419483856773, 5370.382406023357, 5388.91916621251, 4853.635977301717, 4868.2210846264425, 4871.853844384674, 4886.657933944661, 4915.287283343967, 5184.651990482426, 5194.065068287745, 5201.0, 5209.7395130244095, 5223.981323641853, 4888.682235654671, 5111.821086261963, 5128.205128204985, 5133.4096578893905, 5142.228665700175, 4876.0, 4878.219484882402, 4898.559129678346, 4907.631927605516, 4912.828051018198, 3699.6115407881784, 3705.722070844751, 3741.1021354874088, 3755.530558680165, 3763.0592351912023, 4950.480199579137, 5195.922061169161, 5210.374755029421, 5257.973710131425, 5298.7350632469, 5035.597152227886, 5039.72281524505, 5052.115879721107, 5064.366954130734, 5072.923906141485, 5042.571381432619, 5048.0, 5064.544191022678, 5082.567981721595, 5085.923711144262, 4746.952530474651, 4775.976120119516, 5001.449840517613, 5008.774605142705, 5010.974945125251, 4925.556699897026, 5108.416390918827, 5116.0, 5121.615878809179, 5130.615203859651, 4989.877277612653, 5004.924926126038, 5006.524380183877, 5009.899802004013, 5014.498550144956], "value": 3822.3555138453025, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.6324560395358, 647.9384458476443, 650.0282078292953, 658.3482352471052, 722.3715367630163, 13022.73954520909, 13421.328933553332, 13722.862771372284, 13732.24472654005, 13776.862231377683, 12663.0, 12760.617181484547, 12775.552855650054, 12789.168704034231, 12799.808002879941, 621.791699780574, 758.1281526244835, 772.74499415193, 779.0301075161432, 786.4416264452217, 772.8454309138167, 783.3459061683473, 785.4737325991571, 786.657803855322, 787.028020394812, 835.2691395029349, 837.5937670229933, 838.8825564420986, 838.9580520973957, 840.0297656207091, 661.4344735251362, 806.4072906413782, 828.7969447485405, 829.7842560934171, 831.3100126894662, 606.2633899811706, 606.3724045612813, 606.7057477123592, 606.8725567630803, 607.007542667737, 13162.14446061003, 13283.800742988862, 13323.800142997863, 13333.333333333294, 13349.332533373292, 12429.192102513307, 13000.544980925717, 13015.15401498909, 13018.479260829556, 13024.218546887123, 11817.17279790415, 11900.523979040829, 11909.285442873455, 11933.641990740292, 12176.086793490524, 3221.952865318781, 3287.1946373138494, 3308.3714094322004, 3397.677220664033, 4220.894477638053, 61503.692481537306, 63596.36403635997, 64090.359096408436, 64576.354236457504, 64613.353866461206, 10515.60582936834, 10555.630552930765, 10589.894101059044, 10722.410267435365, 10876.728081798019, 18157.27370905149, 18191.0, 18309.267629294944, 18945.33691320797, 18974.525636859187, 6848.931510684929, 6983.511154219257, 7036.226015138331, 7144.9642751785905, 7197.100362454693, 3793.203427280302, 3857.1514266861245, 3877.3990031545154, 3913.941290880639, 3956.347202711578, 2767.861606919646, 2868.856557172133, 2870.641169853768, 2871.239121632769, 2873.5545990371525, 506.6200349737697, 528.6854321678595, 560.1066299252685, 570.9514691251208, 575.2665351676562, 433.3564656485117, 539.6006954853381, 546.6993153765413, 565.9575531835129, 583.2505230778514, 7788.0, 7903.9604801976775, 7961.0, 8097.716579919675, 8126.715564955316, 500.63203545394106, 566.5156291370901, 614.7264467312093, 625.8842114208886, 634.0267689097213, 3622.492851000862, 3806.9238615228096, 3831.1954489556947, 3843.36584463566, 3883.1651194992646, 59540.40459595435, 60046.39953600495, 60275.0, 96393.0, 98668.0, 51137.48862511402, 52099.47900521022, 53723.0, 57903.0, 84536.73194901958, 70552.2944770556, 70888.64555677291, 71096.64451677709, 71590.64204679047, 72812.90780638295, 7199.892001620085, 7210.351068403869, 7380.852382952418, 7395.260473952561, 7574.545527268381, 42579.7871010643, 46089.0, 46827.29759053685, 47322.526774731814, 48681.756591216814, 62465.37534624596, 65365.346346535924, 65430.34569654243, 65477.67261163663, 65489.67255163693, 9996.250281228791, 10080.596776129167, 10374.27380083387, 11122.221444499131, 11272.718182045515, 12187.26876387384, 12276.44755985965, 13050.869491304966, 13157.407916643966, 13231.27228002469, 10890.564377424815, 10914.72713182145, 11062.778744424906, 11172.553097875994, 11202.32786032808, 10893.0, 10989.890101098887, 11117.166212534254, 11265.436728163395, 11536.0, 11168.66494005181, 11430.771384572428, 11467.770644586895, 11809.645710628694, 11839.289642621126, 9421.670241541513, 9519.572953736511, 9962.252831037846, 9965.501724913871, 10010.149137323118, 9305.0, 9678.854817177607, 9894.802103957736, 9985.151262142508, 10115.79768404613], "value": 6433.686053506044, "unit": "score"}], "name": "dromaeo_css", "value": 6317.977418302804, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 110.0, 112.0, 116.0, 113.0, 113.0, 113.0, 114.0, 113.0, 114.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 129.0, 134.0, 180.0, 130.0, 157.0, 165.0, 131.0, 200.0, 132.0], "value": 151.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 161.0, 161.0, 162.0, 164.0, 162.0, 161.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 102.0, 77.0, 77.0, 75.0, 75.0, 98.0, 75.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 119.0, 86.0, 86.0, 87.0, 120.0, 85.0, 86.0, 123.0], "value": 96.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 148.0, 147.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 63.0, 64.0, 71.0, 72.0, 62.0, 62.0, 62.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 66.0, 65.0, 64.0, 64.0, 65.0, 65.0, 64.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 83.0, 84.0, 87.0, 84.0, 93.0, 90.0, 118.0, 83.0], "value": 88.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 134.0, 132.0, 131.0, 145.0, 129.0, 130.0, 130.0, 141.0, 132.0], "value": 133.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 180.0, 176.0, 178.0, 167.0, 169.0, 167.0, 168.0, 174.0, 173.0], "value": 172.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 68.0, 68.0, 69.0, 71.0, 68.0, 68.0, 68.0, 66.0], "value": 68.3, "unit": "score"}], "name": "kraken", "value": 1554.4999999999998, "alertThreshold": 2.0}]} 16:38:18 INFO - Return code: 0 16:38:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:38:18 INFO - # TBPL SUCCESS # 16:38:18 INFO - Running post-action listener: _resource_record_post_action 16:38:18 INFO - ##### 16:38:18 INFO - ##### Finished run-tests step (success) 16:38:18 INFO - ##### 16:38:18 INFO - Running post-run listener: _resource_record_post_run 16:38:18 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 7790592; Write bytes: 400793600; Read time: 944; Write time: 352668 16:38:18 INFO - TinderboxPrint: CPU usage
13.1% 16:38:18 INFO - TinderboxPrint: I/O read bytes / time
7,790,592 / 944 16:38:18 INFO - TinderboxPrint: I/O write bytes / time
400,793,600 / 352,668 16:38:18 INFO - TinderboxPrint: CPU idle
8,344.3 (86.9%) 16:38:18 INFO - TinderboxPrint: CPU user
1,214.8 (12.6%) 16:38:18 INFO - TinderboxPrint: Swap in / out
0 / 0 16:38:18 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 62947328; Read time: 0; Write time: 27112 16:38:18 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 6029312; Write bytes: 337846272; Read time: 900; Write time: 325556 16:38:19 INFO - Running post-run listener: _upload_blobber_files 16:38:19 INFO - Blob upload gear active. 16:38:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:38:19 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 16:38:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:38:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:38:19 INFO - (blobuploader) - INFO - Open directory for files ... 16:38:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:38:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:38:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:38:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:38:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:38:20 INFO - (blobuploader) - INFO - Done attempting. 16:38:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:38:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:38:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:38:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:38:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:38:21 INFO - (blobuploader) - INFO - Done attempting. 16:38:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:38:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:38:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:38:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:38:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:38:25 INFO - (blobuploader) - INFO - Done attempting. 16:38:25 INFO - (blobuploader) - INFO - Iteration through files over. 16:38:25 INFO - Return code: 0 16:38:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:38:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:38:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/69df99e058529a7d0cadb64d91204f7f2d539865c8cf9ff4ee32602ccdebe05ff7d189da0d0291e68b4278301fd9efe5e88c4c2021ac366990d0a7744214860d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d845992a45a363db6061a525778efde49550cc1d5ac93ab854d5d797742295c56bc28bdd9be7bf1623951404c9c7e35847230b560044132b40fb982671665c19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/12eef4d7b64d682d86e186aa9c9dc99d25a798b55872e91c5a5ff3e6cda971b227bc39e344b4e6ef2427bc38bbc7e77eb2c8b40579e3bfeff2a66fd65b7f55f3"} 16:38:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:38:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:38:25 INFO - Contents: 16:38:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/69df99e058529a7d0cadb64d91204f7f2d539865c8cf9ff4ee32602ccdebe05ff7d189da0d0291e68b4278301fd9efe5e88c4c2021ac366990d0a7744214860d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d845992a45a363db6061a525778efde49550cc1d5ac93ab854d5d797742295c56bc28bdd9be7bf1623951404c9c7e35847230b560044132b40fb982671665c19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/12eef4d7b64d682d86e186aa9c9dc99d25a798b55872e91c5a5ff3e6cda971b227bc39e344b4e6ef2427bc38bbc7e77eb2c8b40579e3bfeff2a66fd65b7f55f3"} 16:38:25 INFO - Running post-run listener: copy_logs_to_upload_dir 16:38:25 INFO - Copying logs to upload dir... 16:38:25 INFO - mkdir: /builds/slave/test/build/upload/logs 16:38:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.388795 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-06-10 16:38:25.374103) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 16:38:25.378286) ========= 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=7de08804244eb36560b44971000001c3-1465600646.535525-1307599401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/69df99e058529a7d0cadb64d91204f7f2d539865c8cf9ff4ee32602ccdebe05ff7d189da0d0291e68b4278301fd9efe5e88c4c2021ac366990d0a7744214860d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d845992a45a363db6061a525778efde49550cc1d5ac93ab854d5d797742295c56bc28bdd9be7bf1623951404c9c7e35847230b560044132b40fb982671665c19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/12eef4d7b64d682d86e186aa9c9dc99d25a798b55872e91c5a5ff3e6cda971b227bc39e344b4e6ef2427bc38bbc7e77eb2c8b40579e3bfeff2a66fd65b7f55f3"} build_url:https://queue.taskcluster.net/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011274 build_url: 'https://queue.taskcluster.net/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/69df99e058529a7d0cadb64d91204f7f2d539865c8cf9ff4ee32602ccdebe05ff7d189da0d0291e68b4278301fd9efe5e88c4c2021ac366990d0a7744214860d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d845992a45a363db6061a525778efde49550cc1d5ac93ab854d5d797742295c56bc28bdd9be7bf1623951404c9c7e35847230b560044132b40fb982671665c19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/12eef4d7b64d682d86e186aa9c9dc99d25a798b55872e91c5a5ff3e6cda971b227bc39e344b4e6ef2427bc38bbc7e77eb2c8b40579e3bfeff2a66fd65b7f55f3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 16:38:25.406049) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 16:38:25.406658) ========= 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=7de08804244eb36560b44971000001c3-1465600646.535525-1307599401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004423 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 16:38:25.492570) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 16:38:25.493272) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 16:38:25.493968) ========= ========= Total master_lag: 0.22 =========