builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-011 starttime: 1466893577.21 results: success (0) buildid: 20160625144323 builduid: 2acc665ab6fb4a9eaa038736efb257e4 revision: afb7cb42a98a66de401af5bcf7de03733f2784cd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-25 15:26:17.205987) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-25 15:26:17.209455) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-25 15:26:17.209729) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-25 15:26:17.254267) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-25 15:26:17.254538) ========= 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=5cf47e208febbcd81da23b2e0000026f-1466893251.605493-755333358 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-25 15:26:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 90.2M=0s 2016-06-25 15:26:17 (90.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109520 ========= master_lag: 1.58 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-25 15:26:18.940219) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 15:26:18.940507) ========= 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=5cf47e208febbcd81da23b2e0000026f-1466893251.605493-755333358 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022603 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 15:26:19.012684) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 15:26:19.013024) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev afb7cb42a98a66de401af5bcf7de03733f2784cd --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 afb7cb42a98a66de401af5bcf7de03733f2784cd --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=5cf47e208febbcd81da23b2e0000026f-1466893251.605493-755333358 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-25 15:26:19,346 truncating revision to first 12 chars 2016-06-25 15:26:19,346 Setting DEBUG logging. 2016-06-25 15:26:19,346 attempt 1/10 2016-06-25 15:26:19,346 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/afb7cb42a98a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-25 15:26:19,691 unpacking tar archive at: fx-team-afb7cb42a98a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.689781 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 15:26:19.744791) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-25 15:26:19.745069) ========= script_repo_revision: afb7cb42a98a66de401af5bcf7de03733f2784cd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-25 15:26:19.745433) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-25 15:26:19.745736) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-25 15:26:19.756578) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-06-25 15:26:19.756876) ========= /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=5cf47e208febbcd81da23b2e0000026f-1466893251.605493-755333358 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:26:20 INFO - MultiFileLogger online at 20160625 15:26:20 in /builds/slave/test 15:26:20 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 15:26:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:26:20 INFO - {'append_to_log': False, 15:26:20 INFO - 'base_work_dir': '/builds/slave/test', 15:26:20 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:26:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:26:20 INFO - 'branch': 'Fx-Team-Non-PGO', 15:26:20 INFO - 'buildbot_json_path': 'buildprops.json', 15:26:20 INFO - 'config_files': ('talos/linux_config.py',), 15:26:20 INFO - 'default_actions': ('clobber', 15:26:20 INFO - 'read-buildbot-config', 15:26:20 INFO - 'download-and-extract', 15:26:20 INFO - 'populate-webroot', 15:26:20 INFO - 'create-virtualenv', 15:26:20 INFO - 'install', 15:26:20 INFO - 'run-tests'), 15:26:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:26:20 INFO - 'download_minidump_stackwalk': True, 15:26:20 INFO - 'download_symbols': 'ondemand', 15:26:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:26:20 INFO - 'tooltool.py': '/tools/tooltool.py', 15:26:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:26:20 INFO - '/tools/misc-python/virtualenv.py')}, 15:26:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:26:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:26:20 INFO - 'installer_path': 'installer.exe', 15:26:20 INFO - 'log_level': 'info', 15:26:20 INFO - 'log_name': 'talos', 15:26:20 INFO - 'log_to_console': True, 15:26:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:26:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:26:20 INFO - 'opt_config_files': (), 15:26:20 INFO - 'pip_index': False, 15:26:20 INFO - 'sps_profile': False, 15:26:20 INFO - 'sps_profile_interval': 0, 15:26:20 INFO - 'suite': 'dromaeojs', 15:26:20 INFO - 'system_bits': '32', 15:26:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:26:20 INFO - 'title': 'talos-linux64-ix-011', 15:26:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:26:20 INFO - 'use_talos_json': True, 15:26:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:26:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:26:20 INFO - 'work_dir': 'build'} 15:26:20 INFO - ##### 15:26:20 INFO - ##### Running clobber step. 15:26:20 INFO - ##### 15:26:20 INFO - Running pre-action listener: _resource_record_pre_action 15:26:20 INFO - Running main action method: clobber 15:26:20 INFO - rmtree: /builds/slave/test/build 15:26:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:26:20 INFO - Running post-action listener: _resource_record_post_action 15:26:20 INFO - ##### 15:26:20 INFO - ##### Finished clobber step (success) 15:26:20 INFO - ##### 15:26:20 INFO - ##### 15:26:20 INFO - ##### Running read-buildbot-config step. 15:26:20 INFO - ##### 15:26:20 INFO - Running pre-action listener: _resource_record_pre_action 15:26:20 INFO - Running main action method: read_buildbot_config 15:26:20 INFO - Using buildbot properties: 15:26:20 INFO - { 15:26:20 INFO - "project": "", 15:26:20 INFO - "product": "firefox", 15:26:20 INFO - "script_repo_revision": "production", 15:26:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:26:20 INFO - "repository": "", 15:26:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 15:26:20 INFO - "buildid": "20160625144323", 15:26:20 INFO - "pgo_build": "False", 15:26:20 INFO - "basedir": "/builds/slave/test", 15:26:20 INFO - "buildnumber": 3118, 15:26:20 INFO - "slavename": "talos-linux64-ix-011", 15:26:20 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:26:20 INFO - "platform": "ubuntu64_hw", 15:26:20 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:26:20 INFO - "branch": "fx-team", 15:26:20 INFO - "repo_path": "integration/fx-team", 15:26:20 INFO - "revision": "afb7cb42a98a66de401af5bcf7de03733f2784cd", 15:26:20 INFO - "stage_platform": "linux64", 15:26:20 INFO - "builduid": "2acc665ab6fb4a9eaa038736efb257e4", 15:26:20 INFO - "slavebuilddir": "test" 15:26:20 INFO - } 15:26:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/Vens87spTlKWbAsul_A8xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 15:26:20 INFO - Running post-action listener: _resource_record_post_action 15:26:20 INFO - ##### 15:26:20 INFO - ##### Finished read-buildbot-config step (success) 15:26:20 INFO - ##### 15:26:20 INFO - ##### 15:26:20 INFO - ##### Running download-and-extract step. 15:26:20 INFO - ##### 15:26:20 INFO - Running pre-action listener: _resource_record_pre_action 15:26:20 INFO - Running main action method: download_and_extract 15:26:20 INFO - mkdir: /builds/slave/test/build/tests 15:26:20 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')]} 15:26:20 INFO - https://queue.taskcluster.net/v1/task/Vens87spTlKWbAsul_A8xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:26:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vens87spTlKWbAsul_A8xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:26:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vens87spTlKWbAsul_A8xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:26:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vens87spTlKWbAsul_A8xQ/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 15:26:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vens87spTlKWbAsul_A8xQ/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 15:26:25 INFO - Downloaded 1361 bytes. 15:26:25 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:26:25 INFO - Using the following test package requirements: 15:26:25 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:26:25 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:26:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:26:25 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:26:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:26:25 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:26:25 INFO - u'jsshell-linux-x86_64.zip'], 15:26:25 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:26:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:26:25 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:26:25 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:26:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:26:25 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:26:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:26:25 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:26:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:26:25 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:26:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:26:25 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:26:25 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')]} 15:26:25 INFO - https://queue.taskcluster.net/v1/task/Vens87spTlKWbAsul_A8xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:26:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vens87spTlKWbAsul_A8xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:26:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vens87spTlKWbAsul_A8xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:26:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vens87spTlKWbAsul_A8xQ/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 15:26:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vens87spTlKWbAsul_A8xQ/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 15:26:27 INFO - Downloaded 22713106 bytes. 15:26:27 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'] 15:26:27 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 15:26:28 INFO - Return code: 0 15:26:28 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 15:26:28 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')]} 15:26:28 INFO - https://queue.taskcluster.net/v1/task/Vens87spTlKWbAsul_A8xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:26:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vens87spTlKWbAsul_A8xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:26:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vens87spTlKWbAsul_A8xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:26:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vens87spTlKWbAsul_A8xQ/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 15:26:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vens87spTlKWbAsul_A8xQ/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 15:26:41 INFO - Downloaded 22713106 bytes. 15:26:41 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'] 15:26:41 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 15:26:42 INFO - Return code: 0 15:26:42 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')]} 15:26:42 INFO - https://queue.taskcluster.net/v1/task/Vens87spTlKWbAsul_A8xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:26:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vens87spTlKWbAsul_A8xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:26:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vens87spTlKWbAsul_A8xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:26:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vens87spTlKWbAsul_A8xQ/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 15:26:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vens87spTlKWbAsul_A8xQ/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 15:26:44 INFO - Downloaded 14405188 bytes. 15:26:44 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'] 15:26:44 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 15:26:44 INFO - Return code: 0 15:26:44 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')]} 15:26:44 INFO - https://queue.taskcluster.net/v1/task/Vens87spTlKWbAsul_A8xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:26:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vens87spTlKWbAsul_A8xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:26:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vens87spTlKWbAsul_A8xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:26:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vens87spTlKWbAsul_A8xQ/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 15:26:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vens87spTlKWbAsul_A8xQ/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 15:26:45 INFO - Downloaded 56272542 bytes. 15:26:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Vens87spTlKWbAsul_A8xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:26:45 INFO - mkdir: /builds/slave/test/properties 15:26:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:26:45 INFO - Writing to file /builds/slave/test/properties/build_url 15:26:45 INFO - Contents: 15:26:45 INFO - build_url:https://queue.taskcluster.net/v1/task/Vens87spTlKWbAsul_A8xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:26:46 INFO - Running post-action listener: _resource_record_post_action 15:26:46 INFO - Running post-action listener: set_extra_try_arguments 15:26:46 INFO - ##### 15:26:46 INFO - ##### Finished download-and-extract step (success) 15:26:46 INFO - ##### 15:26:46 INFO - ##### 15:26:46 INFO - ##### Running populate-webroot step. 15:26:46 INFO - ##### 15:26:46 INFO - Running pre-action listener: _resource_record_pre_action 15:26:46 INFO - Running main action method: populate_webroot 15:26:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:26:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:26:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:26:46 INFO - '--tppagecycles', 15:26:46 INFO - '7'], 15:26:46 INFO - 'tests': ['tsvgm']}}, 15:26:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:26:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:26:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:26:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:26:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:26:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:26:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:46 INFO - 'talos_options': ['--disable-e10s'], 15:26:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:26:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:26:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:46 INFO - 'talos_options': ['--disable-e10s'], 15:26:46 INFO - 'tests': ['damp', 'tps']}, 15:26:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:46 INFO - 'tests': ['damp', 'tps']}, 15:26:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:26:46 INFO - 'tests': ['dromaeo_dom']}, 15:26:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:26:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:26:46 INFO - 'tests': ['basic_compositor_video']}, 15:26:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:26:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:26:46 INFO - 'tests': ['a11yr', 15:26:46 INFO - 'ts_paint', 15:26:46 INFO - 'tpaint', 15:26:46 INFO - 'sessionrestore', 15:26:46 INFO - 'sessionrestore_no_auto_restore', 15:26:46 INFO - 'tabpaint']}, 15:26:46 INFO - 'other-e10s': {'tests': ['a11yr', 15:26:46 INFO - 'ts_paint', 15:26:46 INFO - 'tpaint', 15:26:46 INFO - 'sessionrestore', 15:26:46 INFO - 'sessionrestore_no_auto_restore', 15:26:46 INFO - 'tabpaint']}, 15:26:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:26:46 INFO - 'ts_paint', 15:26:46 INFO - 'tpaint', 15:26:46 INFO - 'sessionrestore', 15:26:46 INFO - 'sessionrestore_no_auto_restore', 15:26:46 INFO - 'tabpaint']}, 15:26:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:26:46 INFO - 'ts_paint', 15:26:46 INFO - 'tpaint', 15:26:46 INFO - 'sessionrestore', 15:26:46 INFO - 'sessionrestore_no_auto_restore', 15:26:46 INFO - 'tabpaint']}, 15:26:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:26:46 INFO - 'tests': ['a11yr', 15:26:46 INFO - 'ts_paint', 15:26:46 INFO - 'tpaint', 15:26:46 INFO - 'sessionrestore', 15:26:46 INFO - 'sessionrestore_no_auto_restore', 15:26:46 INFO - 'tabpaint']}, 15:26:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:26:46 INFO - 'tests': ['a11yr', 15:26:46 INFO - 'ts_paint', 15:26:46 INFO - 'tpaint', 15:26:46 INFO - 'sessionrestore', 15:26:46 INFO - 'sessionrestore_no_auto_restore', 15:26:46 INFO - 'tabpaint']}, 15:26:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:26:46 INFO - 'tests': ['tsvgx', 15:26:46 INFO - 'tsvgr_opacity', 15:26:46 INFO - 'tart', 15:26:46 INFO - 'tscrollx', 15:26:46 INFO - 'cart']}, 15:26:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:26:46 INFO - 'tsvgr_opacity', 15:26:46 INFO - 'tart', 15:26:46 INFO - 'tscrollx', 15:26:46 INFO - 'cart']}, 15:26:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:46 INFO - 'talos_options': ['--disable-e10s'], 15:26:46 INFO - 'tests': ['tp5o']}, 15:26:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:46 INFO - 'tests': ['tp5o']}, 15:26:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:46 INFO - 'talos_options': ['--disable-e10s', 15:26:46 INFO - '--xperf_path', 15:26:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:26:46 INFO - 'tests': ['tp5n']}, 15:26:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:46 INFO - 'talos_options': ['--xperf_path', 15:26:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:26:46 INFO - 'tests': ['tp5n']}}, 15:26:46 INFO - 'talos.zip': {'path': '', 15:26:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:26:46 INFO - Running post-action listener: _resource_record_post_action 15:26:46 INFO - ##### 15:26:46 INFO - ##### Finished populate-webroot step (success) 15:26:46 INFO - ##### 15:26:46 INFO - ##### 15:26:46 INFO - ##### Running create-virtualenv step. 15:26:46 INFO - ##### 15:26:46 INFO - Running pre-action listener: _resource_record_pre_action 15:26:46 INFO - Running main action method: create_virtualenv 15:26:46 INFO - Creating virtualenv /builds/slave/test/build/venv 15:26:46 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 15:26:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:26:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:26:46 INFO - Using real prefix '/usr' 15:26:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:26:47 INFO - Installing distribute.............................................................................................................................................................................................done. 15:26:49 INFO - Installing pip.................done. 15:26:49 INFO - Return code: 0 15:26:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:26: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')]} 15:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26: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')]} 15:26:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96909f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a07350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a961c0>, '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 0x2a970c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a97550>, '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': '5cf47e208febbcd81da23b2e0000026f-1466893251.605493-755333358', '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 15:26: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', 'pip>=1.5'] in /builds/slave/test/build 15:26: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 pip>=1.5 15:26:49 INFO - Using env: {'DISPLAY': ':0', 15:26:49 INFO - 'HOME': '/home/cltbld', 15:26:49 INFO - 'LANG': 'en_US.UTF-8', 15:26:49 INFO - 'LANGUAGE': 'en_US:en', 15:26:49 INFO - 'LOGNAME': 'cltbld', 15:26:49 INFO - 'MAIL': '/var/mail/cltbld', 15:26:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:49 INFO - 'MOZ_NO_REMOTE': '1', 15:26:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:26:49 INFO - 'NO_EM_RESTART': '1', 15:26:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:26:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:49 INFO - 'PWD': '/builds/slave/test', 15:26:49 INFO - 'SHELL': '/bin/bash', 15:26:49 INFO - 'SHLVL': '1', 15:26:49 INFO - 'TERM': 'linux', 15:26:49 INFO - 'TMOUT': '86400', 15:26:49 INFO - 'USER': 'cltbld', 15:26:49 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1466893251.605493-755333358', 15:26:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:49 INFO - '_': '/tools/buildbot/bin/python'} 15:26:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26: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 15:26:49 INFO - Cleaning up... 15:26:49 INFO - Return code: 0 15:26:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:26: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')]} 15:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26: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')]} 15:26:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26: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 0x7f96909f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a07350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a961c0>, '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 0x2a970c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a97550>, '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': '5cf47e208febbcd81da23b2e0000026f-1466893251.605493-755333358', '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 15:26: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 15:26: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 15:26:49 INFO - Using env: {'DISPLAY': ':0', 15:26:49 INFO - 'HOME': '/home/cltbld', 15:26:49 INFO - 'LANG': 'en_US.UTF-8', 15:26:49 INFO - 'LANGUAGE': 'en_US:en', 15:26:49 INFO - 'LOGNAME': 'cltbld', 15:26:49 INFO - 'MAIL': '/var/mail/cltbld', 15:26:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:49 INFO - 'MOZ_NO_REMOTE': '1', 15:26:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:26:49 INFO - 'NO_EM_RESTART': '1', 15:26:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:26:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:49 INFO - 'PWD': '/builds/slave/test', 15:26:49 INFO - 'SHELL': '/bin/bash', 15:26:49 INFO - 'SHLVL': '1', 15:26:49 INFO - 'TERM': 'linux', 15:26:49 INFO - 'TMOUT': '86400', 15:26:49 INFO - 'USER': 'cltbld', 15:26:49 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1466893251.605493-755333358', 15:26:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:49 INFO - '_': '/tools/buildbot/bin/python'} 15:26:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:49 INFO - Downloading/unpacking psutil>=3.1.1 15:26: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 15:26: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 15:26: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 15:26: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 15:26: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 15:26: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 15:26:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:26:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:26:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:26:51 INFO - Installing collected packages: psutil 15:26:51 INFO - Running setup.py install for psutil 15:26:51 INFO - building 'psutil._psutil_linux' extension 15:26: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 15:26:51 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 15:26:51 INFO - building 'psutil._psutil_posix' extension 15:26:51 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 15:26:52 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 15:26:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:26:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:26:52 INFO - Successfully installed psutil 15:26:52 INFO - Cleaning up... 15:26:52 INFO - Return code: 0 15:26:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:26:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:52 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 0x7f96909f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a07350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a961c0>, '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 0x2a970c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a97550>, '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': '5cf47e208febbcd81da23b2e0000026f-1466893251.605493-755333358', '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 15:26:52 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 15:26:52 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 15:26:52 INFO - Using env: {'DISPLAY': ':0', 15:26:52 INFO - 'HOME': '/home/cltbld', 15:26:52 INFO - 'LANG': 'en_US.UTF-8', 15:26:52 INFO - 'LANGUAGE': 'en_US:en', 15:26:52 INFO - 'LOGNAME': 'cltbld', 15:26:52 INFO - 'MAIL': '/var/mail/cltbld', 15:26:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:52 INFO - 'MOZ_NO_REMOTE': '1', 15:26:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:26:52 INFO - 'NO_EM_RESTART': '1', 15:26:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:26:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:52 INFO - 'PWD': '/builds/slave/test', 15:26:52 INFO - 'SHELL': '/bin/bash', 15:26:52 INFO - 'SHLVL': '1', 15:26:52 INFO - 'TERM': 'linux', 15:26:52 INFO - 'TMOUT': '86400', 15:26:52 INFO - 'USER': 'cltbld', 15:26:52 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1466893251.605493-755333358', 15:26:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:52 INFO - '_': '/tools/buildbot/bin/python'} 15:26:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:26:52 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 15:26:52 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 15:26:52 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 15:26:52 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 15:26:52 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 15:26:52 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 15:26:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:26:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:26:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:26:54 INFO - Installing collected packages: mozsystemmonitor 15:26:54 INFO - Running setup.py install for mozsystemmonitor 15:26:54 INFO - Successfully installed mozsystemmonitor 15:26:54 INFO - Cleaning up... 15:26:54 INFO - Return code: 0 15:26:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:26: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')]} 15:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26: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')]} 15:26:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26: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', '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 0x7f96909f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a07350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a961c0>, '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 0x2a970c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a97550>, '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': '5cf47e208febbcd81da23b2e0000026f-1466893251.605493-755333358', '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 15:26: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:26: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 jsonschema==2.5.1 15:26:54 INFO - Using env: {'DISPLAY': ':0', 15:26:54 INFO - 'HOME': '/home/cltbld', 15:26:54 INFO - 'LANG': 'en_US.UTF-8', 15:26:54 INFO - 'LANGUAGE': 'en_US:en', 15:26:54 INFO - 'LOGNAME': 'cltbld', 15:26:54 INFO - 'MAIL': '/var/mail/cltbld', 15:26:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:54 INFO - 'MOZ_NO_REMOTE': '1', 15:26:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:26:54 INFO - 'NO_EM_RESTART': '1', 15:26:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:54 INFO - 'PWD': '/builds/slave/test', 15:26:54 INFO - 'SHELL': '/bin/bash', 15:26:54 INFO - 'SHLVL': '1', 15:26:54 INFO - 'TERM': 'linux', 15:26:54 INFO - 'TMOUT': '86400', 15:26:54 INFO - 'USER': 'cltbld', 15:26:54 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1466893251.605493-755333358', 15:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:54 INFO - '_': '/tools/buildbot/bin/python'} 15:26:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:54 INFO - Downloading/unpacking jsonschema==2.5.1 15:26: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 15:26: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 15:26: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 15:26: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 15:26: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 15:26: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 15:26:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:26:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:26: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 15:26: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 15:26: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 15:26: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 15:26: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 15:26: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 15:26:56 INFO - Downloading functools32-3.2.3-2.tar.gz 15:26:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:26:56 INFO - warning: no files found matching '*.txt' 15:26:56 INFO - no previously-included directories found matching 'build' 15:26:56 INFO - no previously-included directories found matching 'dist' 15:26:56 INFO - no previously-included directories found matching '.git*' 15:26:56 INFO - Installing collected packages: jsonschema, functools32 15:26:56 INFO - Running setup.py install for functools32 15:26:57 INFO - warning: no files found matching '*.txt' 15:26:57 INFO - no previously-included directories found matching 'build' 15:26:57 INFO - no previously-included directories found matching 'dist' 15:26:57 INFO - no previously-included directories found matching '.git*' 15:26:57 INFO - Successfully installed jsonschema functools32 15:26:57 INFO - Cleaning up... 15:26:57 INFO - Return code: 0 15:26:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:26:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:57 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 0x7f96909f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a07350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a961c0>, '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 0x2a970c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a97550>, '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': '5cf47e208febbcd81da23b2e0000026f-1466893251.605493-755333358', '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 15:26:57 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 15:26:57 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 15:26:57 INFO - Using env: {'DISPLAY': ':0', 15:26:57 INFO - 'HOME': '/home/cltbld', 15:26:57 INFO - 'LANG': 'en_US.UTF-8', 15:26:57 INFO - 'LANGUAGE': 'en_US:en', 15:26:57 INFO - 'LOGNAME': 'cltbld', 15:26:57 INFO - 'MAIL': '/var/mail/cltbld', 15:26:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:57 INFO - 'MOZ_NO_REMOTE': '1', 15:26:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:26:57 INFO - 'NO_EM_RESTART': '1', 15:26:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:26:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:57 INFO - 'PWD': '/builds/slave/test', 15:26:57 INFO - 'SHELL': '/bin/bash', 15:26:57 INFO - 'SHLVL': '1', 15:26:57 INFO - 'TERM': 'linux', 15:26:57 INFO - 'TMOUT': '86400', 15:26:57 INFO - 'USER': 'cltbld', 15:26:57 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1466893251.605493-755333358', 15:26:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:57 INFO - '_': '/tools/buildbot/bin/python'} 15:26:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:57 INFO - Downloading/unpacking blobuploader==1.2.4 15:26:57 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 15:26:57 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 15:26:57 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 15:26:57 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 15:26:57 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 15:26:57 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 15:26:59 INFO - Downloading blobuploader-1.2.4.tar.gz 15:26:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:26:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:26: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 15:26: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 15:26: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 15:26: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 15:26: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 15:26: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 15:26:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:26:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:26: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 15:26: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 15:26: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 15:26: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 15:26: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 15:26: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 15:26:59 INFO - Downloading docopt-0.6.1.tar.gz 15:26:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:26:59 INFO - Installing collected packages: blobuploader, requests, docopt 15:26:59 INFO - Running setup.py install for blobuploader 15:27:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:27:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:27:00 INFO - Running setup.py install for requests 15:27:00 INFO - Running setup.py install for docopt 15:27:00 INFO - Successfully installed blobuploader requests docopt 15:27:00 INFO - Cleaning up... 15:27:00 INFO - Return code: 0 15:27:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:27:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:27:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:00 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 0x7f96909f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a07350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a961c0>, '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 0x2a970c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a97550>, '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': '5cf47e208febbcd81da23b2e0000026f-1466893251.605493-755333358', '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 15:27:00 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 15:27:00 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 15:27:00 INFO - Using env: {'DISPLAY': ':0', 15:27:00 INFO - 'HOME': '/home/cltbld', 15:27:00 INFO - 'LANG': 'en_US.UTF-8', 15:27:00 INFO - 'LANGUAGE': 'en_US:en', 15:27:00 INFO - 'LOGNAME': 'cltbld', 15:27:00 INFO - 'MAIL': '/var/mail/cltbld', 15:27:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:00 INFO - 'MOZ_NO_REMOTE': '1', 15:27:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:27:00 INFO - 'NO_EM_RESTART': '1', 15:27:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:27:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:00 INFO - 'PWD': '/builds/slave/test', 15:27:00 INFO - 'SHELL': '/bin/bash', 15:27:00 INFO - 'SHLVL': '1', 15:27:00 INFO - 'TERM': 'linux', 15:27:00 INFO - 'TMOUT': '86400', 15:27:00 INFO - 'USER': 'cltbld', 15:27:00 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1466893251.605493-755333358', 15:27:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:00 INFO - '_': '/tools/buildbot/bin/python'} 15:27:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:27:00 INFO - Running setup.py (path:/tmp/pip-J69yW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:27:00 INFO - Running setup.py (path:/tmp/pip-CQt1ky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:27:00 INFO - Running setup.py (path:/tmp/pip-qLTyLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:27:01 INFO - Running setup.py (path:/tmp/pip-h2UrOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:27:01 INFO - Running setup.py (path:/tmp/pip-FN8LEn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:27:01 INFO - Running setup.py (path:/tmp/pip-EL80bP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:27:01 INFO - Running setup.py (path:/tmp/pip-OZVDF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:27:01 INFO - Running setup.py (path:/tmp/pip-DcBr9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:27:01 INFO - Running setup.py (path:/tmp/pip-j7uAEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:27:01 INFO - Running setup.py (path:/tmp/pip-LBO3L5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:27:01 INFO - Running setup.py (path:/tmp/pip-BGZu_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:27:01 INFO - Running setup.py (path:/tmp/pip-lhRKX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:27:01 INFO - Running setup.py (path:/tmp/pip-Gz8z0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:27:01 INFO - Running setup.py (path:/tmp/pip-ZD6mWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:27:01 INFO - Running setup.py (path:/tmp/pip-nnHZAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:27:01 INFO - Running setup.py (path:/tmp/pip-bnCbV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:27:01 INFO - Running setup.py (path:/tmp/pip-xcpBbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:27:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:27:01 INFO - Running setup.py install for manifestparser 15:27:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:27:02 INFO - Running setup.py install for mozcrash 15:27:02 INFO - Running setup.py install for mozdebug 15:27:02 INFO - Running setup.py install for mozdevice 15:27:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:27:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:27:02 INFO - Running setup.py install for mozfile 15:27:02 INFO - Running setup.py install for mozhttpd 15:27:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:27:02 INFO - Running setup.py install for mozinfo 15:27:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:27:02 INFO - Running setup.py install for mozInstall 15:27:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:27:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:27:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:27:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:27:02 INFO - Running setup.py install for mozleak 15:27:02 INFO - Running setup.py install for mozlog 15:27:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:27:03 INFO - Running setup.py install for moznetwork 15:27:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:27:03 INFO - Running setup.py install for mozprocess 15:27:03 INFO - Running setup.py install for mozprofile 15:27:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:27:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:27:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:27:03 INFO - Running setup.py install for mozrunner 15:27:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:27:03 INFO - Running setup.py install for mozscreenshot 15:27:03 INFO - Running setup.py install for moztest 15:27:03 INFO - Running setup.py install for mozversion 15:27:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:27:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:27:03 INFO - Cleaning up... 15:27:03 INFO - Return code: 0 15:27:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:27:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:27:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:03 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 0x7f96909f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a07350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a961c0>, '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 0x2a970c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a97550>, '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': '5cf47e208febbcd81da23b2e0000026f-1466893251.605493-755333358', '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 15:27:03 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 15:27:03 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 15:27:03 INFO - Using env: {'DISPLAY': ':0', 15:27:03 INFO - 'HOME': '/home/cltbld', 15:27:03 INFO - 'LANG': 'en_US.UTF-8', 15:27:03 INFO - 'LANGUAGE': 'en_US:en', 15:27:03 INFO - 'LOGNAME': 'cltbld', 15:27:03 INFO - 'MAIL': '/var/mail/cltbld', 15:27:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:03 INFO - 'MOZ_NO_REMOTE': '1', 15:27:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:27:03 INFO - 'NO_EM_RESTART': '1', 15:27:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:27:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:03 INFO - 'PWD': '/builds/slave/test', 15:27:03 INFO - 'SHELL': '/bin/bash', 15:27:03 INFO - 'SHLVL': '1', 15:27:03 INFO - 'TERM': 'linux', 15:27:03 INFO - 'TMOUT': '86400', 15:27:03 INFO - 'USER': 'cltbld', 15:27:03 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1466893251.605493-755333358', 15:27:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:03 INFO - '_': '/tools/buildbot/bin/python'} 15:27:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:27:04 INFO - Running setup.py (path:/tmp/pip-79EgpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:27:04 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)) 15:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:27:04 INFO - Running setup.py (path:/tmp/pip-wupiNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:27:04 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)) 15:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:27:04 INFO - Running setup.py (path:/tmp/pip-uZIQx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:27:04 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)) 15:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:27:04 INFO - Running setup.py (path:/tmp/pip-oatdha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:27:04 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)) 15:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:27:04 INFO - Running setup.py (path:/tmp/pip-903wkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:27:04 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)) 15:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:27:04 INFO - Running setup.py (path:/tmp/pip-ibwIz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:27:04 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)) 15:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:27:04 INFO - Running setup.py (path:/tmp/pip-ilKOHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:27:04 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)) 15:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:27:04 INFO - Running setup.py (path:/tmp/pip-fzWwIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:27:04 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)) 15:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:27:04 INFO - Running setup.py (path:/tmp/pip-RjkBSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:27:04 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)) 15:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:27:04 INFO - Running setup.py (path:/tmp/pip-gylxFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:27:04 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)) 15:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:27:04 INFO - Running setup.py (path:/tmp/pip-xBxfoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:27:04 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)) 15:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:27:04 INFO - Running setup.py (path:/tmp/pip-6pGAgB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:27:04 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)) 15:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:27:04 INFO - Running setup.py (path:/tmp/pip-8HDBPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:27:04 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)) 15:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:27:04 INFO - Running setup.py (path:/tmp/pip-Yh1gu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:27:05 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)) 15:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:27:05 INFO - Running setup.py (path:/tmp/pip-vxvwZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:27:05 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)) 15:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:27:05 INFO - Running setup.py (path:/tmp/pip-HatSxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:27:05 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)) 15:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:27:05 INFO - Running setup.py (path:/tmp/pip-Io7SWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:27:05 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)) 15:27:05 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)) 15:27:05 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)) 15:27:05 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)) 15:27:05 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)) 15:27:05 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)) 15:27:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:27:05 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 15:27:05 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 15:27:05 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 15:27:05 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 15:27:05 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 15:27:05 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 15:27:07 INFO - Downloading blessings-1.6.tar.gz 15:27:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:27:07 INFO - Installing collected packages: blessings 15:27:07 INFO - Running setup.py install for blessings 15:27:07 INFO - Successfully installed blessings 15:27:07 INFO - Cleaning up... 15:27:07 INFO - Return code: 0 15:27:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:27:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:27:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:27:07 INFO - Reading from file tmpfile_stdout 15:27:07 INFO - Current package versions: 15:27:07 INFO - argparse == 1.2.1 15:27:07 INFO - blessings == 1.6 15:27:07 INFO - blobuploader == 1.2.4 15:27:07 INFO - docopt == 0.6.1 15:27:07 INFO - functools32 == 3.2.3-2 15:27:07 INFO - jsonschema == 2.5.1 15:27:07 INFO - manifestparser == 1.1 15:27:07 INFO - mozInstall == 1.12 15:27:07 INFO - mozcrash == 0.17 15:27:07 INFO - mozdebug == 0.1 15:27:07 INFO - mozdevice == 0.48 15:27:07 INFO - mozfile == 1.2 15:27:07 INFO - mozhttpd == 0.7 15:27:07 INFO - mozinfo == 0.9 15:27:07 INFO - mozleak == 0.1 15:27:07 INFO - mozlog == 3.2 15:27:07 INFO - moznetwork == 0.27 15:27:07 INFO - mozprocess == 0.22 15:27:07 INFO - mozprofile == 0.28 15:27:07 INFO - mozrunner == 6.11 15:27:07 INFO - mozscreenshot == 0.1 15:27:07 INFO - mozsystemmonitor == 0.3 15:27:07 INFO - moztest == 0.7 15:27:07 INFO - mozversion == 1.4 15:27:07 INFO - psutil == 3.1.1 15:27:07 INFO - requests == 1.2.3 15:27:07 INFO - wsgiref == 0.1.2 15:27:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:27:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:27:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:27:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:07 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 0x7f96909f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a07350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a961c0>, '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 0x2a970c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a97550>, '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': '5cf47e208febbcd81da23b2e0000026f-1466893251.605493-755333358', '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 15:27:07 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 15:27:07 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 15:27:07 INFO - Using env: {'DISPLAY': ':0', 15:27:07 INFO - 'HOME': '/home/cltbld', 15:27:07 INFO - 'LANG': 'en_US.UTF-8', 15:27:07 INFO - 'LANGUAGE': 'en_US:en', 15:27:07 INFO - 'LOGNAME': 'cltbld', 15:27:07 INFO - 'MAIL': '/var/mail/cltbld', 15:27:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:07 INFO - 'MOZ_NO_REMOTE': '1', 15:27:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:27:07 INFO - 'NO_EM_RESTART': '1', 15:27:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:27:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:07 INFO - 'PWD': '/builds/slave/test', 15:27:07 INFO - 'SHELL': '/bin/bash', 15:27:07 INFO - 'SHLVL': '1', 15:27:07 INFO - 'TERM': 'linux', 15:27:07 INFO - 'TMOUT': '86400', 15:27:07 INFO - 'USER': 'cltbld', 15:27:07 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1466893251.605493-755333358', 15:27:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:07 INFO - '_': '/tools/buildbot/bin/python'} 15:27:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:07 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)) 15:27:07 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)) 15:27:07 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)) 15:27:07 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)) 15:27:07 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)) 15:27:07 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)) 15:27:07 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)) 15:27:07 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)) 15:27:07 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)) 15:27:07 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)) 15:27:07 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)) 15:27:07 INFO - Cleaning up... 15:27:07 INFO - Return code: 0 15:27:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:27:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:27:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:27:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96909f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a07350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a961c0>, '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 0x2a970c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a97550>, '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': '5cf47e208febbcd81da23b2e0000026f-1466893251.605493-755333358', '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 15:27:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:27:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:27:07 INFO - Using env: {'DISPLAY': ':0', 15:27:07 INFO - 'HOME': '/home/cltbld', 15:27:07 INFO - 'LANG': 'en_US.UTF-8', 15:27:07 INFO - 'LANGUAGE': 'en_US:en', 15:27:07 INFO - 'LOGNAME': 'cltbld', 15:27:07 INFO - 'MAIL': '/var/mail/cltbld', 15:27:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:07 INFO - 'MOZ_NO_REMOTE': '1', 15:27:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:27:07 INFO - 'NO_EM_RESTART': '1', 15:27:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:27:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:07 INFO - 'PWD': '/builds/slave/test', 15:27:07 INFO - 'SHELL': '/bin/bash', 15:27:07 INFO - 'SHLVL': '1', 15:27:07 INFO - 'TERM': 'linux', 15:27:07 INFO - 'TMOUT': '86400', 15:27:07 INFO - 'USER': 'cltbld', 15:27:07 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1466893251.605493-755333358', 15:27:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:07 INFO - '_': '/tools/buildbot/bin/python'} 15:27:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:27:08 INFO - Cleaning up... 15:27:08 INFO - Return code: 0 15:27:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:27:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:27:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96909f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a07350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a961c0>, '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 0x2a970c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a97550>, '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': '5cf47e208febbcd81da23b2e0000026f-1466893251.605493-755333358', '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 15:27:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 15:27:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:27:08 INFO - Using env: {'DISPLAY': ':0', 15:27:08 INFO - 'HOME': '/home/cltbld', 15:27:08 INFO - 'LANG': 'en_US.UTF-8', 15:27:08 INFO - 'LANGUAGE': 'en_US:en', 15:27:08 INFO - 'LOGNAME': 'cltbld', 15:27:08 INFO - 'MAIL': '/var/mail/cltbld', 15:27:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:08 INFO - 'MOZ_NO_REMOTE': '1', 15:27:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:27:08 INFO - 'NO_EM_RESTART': '1', 15:27:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:27:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:08 INFO - 'PWD': '/builds/slave/test', 15:27:08 INFO - 'SHELL': '/bin/bash', 15:27:08 INFO - 'SHLVL': '1', 15:27:08 INFO - 'TERM': 'linux', 15:27:08 INFO - 'TMOUT': '86400', 15:27:08 INFO - 'USER': 'cltbld', 15:27:08 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1466893251.605493-755333358', 15:27:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:08 INFO - '_': '/tools/buildbot/bin/python'} 15:27:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:08 INFO - Downloading/unpacking flake8 15:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:27:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:27:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:27:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:27:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:27:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:27:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:27:10 INFO - no previously-included directories found matching 'docs/_build' 15:27:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:27:10 INFO - Running setup.py install for pep8 15:27:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:27:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:27:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:27:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:27:11 INFO - no previously-included directories found matching 'docs/_build' 15:27:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:27:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:27:11 INFO - Cleaning up... 15:27:11 INFO - Return code: 0 15:27:11 INFO - Running post-action listener: _resource_record_post_action 15:27:11 INFO - Running post-action listener: _start_resource_monitoring 15:27:11 INFO - Starting resource monitoring. 15:27:11 INFO - ##### 15:27:11 INFO - ##### Finished create-virtualenv step (success) 15:27:11 INFO - ##### 15:27:11 INFO - ##### 15:27:11 INFO - ##### Running install step. 15:27:11 INFO - ##### 15:27:11 INFO - Running pre-action listener: _resource_record_pre_action 15:27:11 INFO - Running main action method: install 15:27:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:27:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:27:11 INFO - Reading from file tmpfile_stdout 15:27:11 INFO - Detecting whether we're running mozinstall >=1.0... 15:27:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:27:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:27:11 INFO - Reading from file tmpfile_stdout 15:27:11 INFO - Output received: 15:27:11 INFO - Usage: mozinstall [options] installer 15:27:11 INFO - Options: 15:27:11 INFO - -h, --help show this help message and exit 15:27:11 INFO - -d DEST, --destination=DEST 15:27:11 INFO - Directory to install application into. [default: 15:27:11 INFO - "/builds/slave/test"] 15:27:11 INFO - --app=APP Application being installed. [default: firefox] 15:27:11 INFO - mkdir: /builds/slave/test/build/application 15:27:11 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'] 15:27:11 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 15:27:27 INFO - Reading from file tmpfile_stdout 15:27:27 INFO - Output received: 15:27:27 INFO - /builds/slave/test/build/application/firefox/firefox 15:27:27 INFO - Running post-action listener: _resource_record_post_action 15:27:27 INFO - ##### 15:27:27 INFO - ##### Finished install step (success) 15:27:27 INFO - ##### 15:27:27 INFO - ##### 15:27:27 INFO - ##### Running run-tests step. 15:27:27 INFO - ##### 15:27:27 INFO - Running pre-action listener: _resource_record_pre_action 15:27:27 INFO - Running main action method: run_tests 15:27:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:27:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:27:27 INFO - Python 2.7.3 15:27:27 INFO - Return code: 0 15:27:27 INFO - grabbing minidump binary from tooltool 15:27:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:27:27 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 0x2a961c0>, '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 0x2a970c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a97550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:27:27 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 15:27:27 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 15:27:27 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 15:27:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:27:27 INFO - Return code: 0 15:27:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:27:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:27:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:27:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:27:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:27:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:27:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:27:28 INFO - Return code: 0 15:27:28 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/Vens87spTlKWbAsul_A8xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 15:27:28 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/Vens87spTlKWbAsul_A8xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 15:27:28 INFO - Using env: {'DISPLAY': ':0', 15:27:28 INFO - 'HOME': '/home/cltbld', 15:27:28 INFO - 'LANG': 'en_US.UTF-8', 15:27:28 INFO - 'LANGUAGE': 'en_US:en', 15:27:28 INFO - 'LOGNAME': 'cltbld', 15:27:28 INFO - 'MAIL': '/var/mail/cltbld', 15:27:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:27:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:27:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:28 INFO - 'MOZ_NO_REMOTE': '1', 15:27:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:27:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:27:28 INFO - 'NO_EM_RESTART': '1', 15:27:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:27:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:28 INFO - 'PWD': '/builds/slave/test', 15:27:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:27:28 INFO - 'SHELL': '/bin/bash', 15:27:28 INFO - 'SHLVL': '1', 15:27:28 INFO - 'TERM': 'linux', 15:27:28 INFO - 'TMOUT': '86400', 15:27:28 INFO - 'USER': 'cltbld', 15:27:28 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1466893251.605493-755333358', 15:27:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:28 INFO - '_': '/tools/buildbot/bin/python'} 15:27:28 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/Vens87spTlKWbAsul_A8xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 15:27:28 INFO - mozversion application_buildid: 20160625144323 15:27:28 INFO - mozversion application_changeset: afb7cb42a98a66de401af5bcf7de03733f2784cd 15:27:28 INFO - mozversion application_display_name: Nightly 15:27:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:27:28 INFO - mozversion application_name: Firefox 15:27:28 INFO - mozversion application_remotingname: firefox 15:27:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:27:28 INFO - mozversion application_vendor: Mozilla 15:27:28 INFO - mozversion application_version: 50.0a1 15:27:28 INFO - mozversion platform_buildid: 20160625144323 15:27:28 INFO - mozversion platform_changeset: afb7cb42a98a66de401af5bcf7de03733f2784cd 15:27:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:27:28 INFO - mozversion platform_version: 50.0a1 15:27:28 INFO - using testdate: 1466893648 15:27:28 INFO - actual date: 1466893648 15:27:28 INFO - starting webserver on 'localhost:54044' 15:27:28 INFO - SUITE-START | Running 2 tests 15:27:28 INFO - TEST-START | dromaeo_css 15:27:28 INFO - operating with platform_type : linux_ 15:27:28 INFO - Initialising browser for dromaeo_css test... 15:27:28 INFO - TEST-INFO | started process 17317 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeVs9iT/profile http://localhost:54044/getInfo.html) 15:27:33 INFO - PROCESS | 17317 | __metrics Screen width/height:1600/1200 15:27:33 INFO - PROCESS | 17317 | colorDepth:24 15:27:33 INFO - PROCESS | 17317 | Browser inner width/height: 1024/697 15:27:33 INFO - PROCESS | 17317 | __metrics 15:27:35 INFO - PROCESS | 17317 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:27:35 INFO - PROCESS | 17317 | console.error: PushService: 15:27:35 INFO - PROCESS | 17317 | stateChangeProcessEnqueue: Error transitioning state 15:27:35 INFO - PROCESS | 17317 | UnknownError 15:27:36 INFO - TEST-INFO | 17317: exit 0 15:27:36 INFO - Browser initialized. 15:27:36 INFO - Running cycle 1/1 for dromaeo_css test... 15:27:36 INFO - TEST-INFO | started process 17400 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeVs9iT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:27:48 INFO - PROCESS | 17400 | RSS: Main: 175726592 15:27:48 INFO - PROCESS | 17400 | 15:28:39 INFO - PROCESS | 17400 | 1466893719455 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:30:52 INFO - PROCESS | 17400 | Cycle 1(1): loaded http://localhost:54044/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54044/tests/dromaeo/cssquery-ext.html) 15:30:53 INFO - PROCESS | 17400 | RSS: Main: 262750208 15:30:53 INFO - PROCESS | 17400 | 15:33:56 INFO - PROCESS | 17400 | Cycle 1(1): loaded http://localhost:54044/tests/dromaeo/cssquery-ext.html (next: http://localhost:54044/tests/dromaeo/cssquery-jquery.html) 15:33:57 INFO - PROCESS | 17400 | RSS: Main: 258965504 15:33:57 INFO - PROCESS | 17400 | 15:36:59 INFO - PROCESS | 17400 | Cycle 1(1): loaded http://localhost:54044/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54044/tests/dromaeo/cssquery-mootools.html) 15:36:59 INFO - PROCESS | 17400 | RSS: Main: 259543040 15:36:59 INFO - PROCESS | 17400 | 15:40:02 INFO - PROCESS | 17400 | Cycle 1(1): loaded http://localhost:54044/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54044/tests/dromaeo/cssquery-prototype.html) 15:40:02 INFO - PROCESS | 17400 | RSS: Main: 250155008 15:40:02 INFO - PROCESS | 17400 | 15:43:05 INFO - PROCESS | 17400 | Cycle 1(1): loaded http://localhost:54044/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54044/tests/dromaeo/cssquery-yui.html) 15:43:06 INFO - PROCESS | 17400 | RSS: Main: 229208064 15:43:06 INFO - PROCESS | 17400 | 15:46:09 INFO - PROCESS | 17400 | Cycle 1(1): loaded http://localhost:54044/tests/dromaeo/cssquery-yui.html (next: http://localhost:54044/tests/dromaeo/cssquery-dojo.html) 15:46:09 INFO - PROCESS | 17400 | RSS: Main: 290115584 15:46:09 INFO - PROCESS | 17400 | 15:46:09 INFO - PROCESS | 17400 | __start_tp_report 15:46:09 INFO - PROCESS | 17400 | _x_x_mozilla_page_load 15:46:09 INFO - PROCESS | 17400 | _x_x_mozilla_page_load_details 15:46:09 INFO - PROCESS | 17400 | |i|pagename|runs| 15:46:09 INFO - PROCESS | 17400 | |0;dojo.html;2609.7259787722287;2633.3943193065606;2660.4147087640713;2667.6131960865673;2676.571748520237;4705.129551033061;4767.952320476794;4778.546038126373;4851.902961940759;4899.289603007562;4743.075100355432;4786.904261914759;4788.497207793183;4850.2482115272105;4858.125537403266;4252.277112890816;4411.823527058922;4489.887752806173;4547.272436410175;4581.748003859786;4479.686421950465;4520.2315606347;4532.864014079566;4537.3874526938935;4573.611243044345;4348.586884246008;4383.912321753547;4398.7580683062415;4413.271810151321;4445.244308467568;4373.059792144704;4402.251617225047;4452.577005184502;4456.064226512404;4463.352813841975;4423.1153769246275;4440.977795111004;4450.154470650598;4480.775961201927;4486.214912390318;4669.486356500816;4774.546418090311;4900.754962251873;4909.239067944474;4915.9508404916205;5176.818811341623;5208.687478751249;5211.817586384458;5217.165253559412;5240.659357141773;5087.9061001884775;5224.477552244745;5255.579553635738;5285.814996475105;5286;4812.06164797861;4867.26990951353;4875.439324477659;4876.317315575822;4889.535494128052;5448.482394172547;5453.018456677757;5454.10007348791;5461.918071228934;5466.753996070186;4855.247436647325;5043.84868453947;5173.896522069537;5202.375714914235;5203.973980130075;5199.220116982483;5217.973910130425;5238.292830467838;5241.292425522582;5289.312389389432;5159.2003239497935;5171.97414012935;5174.120399532088;5174.275601415805;5223.347081614798;4952.331435256195;5031.52200540948;5077.213031980049;5156.458571849977;5173.896522069537;4341.978290108529;4355.216061109031;4360.062586543845;4400.757958312323;4405.647548196137;3773.8867833965023;3802.3916173412676;3807.695384369244;3841.673457756066;3843.404272337792;4397.648188144941;4443.488998765119;4458.888527786831;4494.865154045384;4498.212812757754;5152.613553983466;5178.378594568676;5179.404368497596;5187.170052791611;5227.790888364499;4503.504614492404;4507.166174257773;4508.797104130322;4547.317902314613;4549.294859296814;4522.5025247222775;4563.771811409416;4564.657650676212;4579.084183163381;4642.535746425398;4888.92666609994;4890.731009794496;4904.901901962012;4919.139150648693;4928.852134435972;5202.167653175474;5205.115130427912;5208.114620514446;5246.344206974129;5250.26496290512;4703.082898834695;4776.474587795409;4827.758612069312;4838.298446725275;4856.757162141949;5046.621503387334;5058.54473097423;5060.139776237975;5067.721275329893;5120.641555091257;5027.120253955616;5164.070467315919;5184.170532714747;5186;5190.091733946469;4934.5312195341385;5017.67385119966;5019.64862459639;5020.146575082172;5039.420466646236;5036;5043.798248070036;5046.268291097696;5054.469280725618;5097.413797413345;4855.271709243641;4930.359053323045;4956.801727930842;4965.577925876341;5017.724025178651;5076.746162691925;5091.4144873338555;5107.642465027412;5118.462561431145;5162.767675454688;5002.699838009731;5017.523335283142;5017.874553136055;5020.899582008413;5064.6961182327705 15:46:09 INFO - PROCESS | 17400 | |1;ext.html;541.9772728345695;577.4283459375218;579.3424463234234;588.7497813429292;593.3828818029249;27613.72386276139;39512;40565.39151912724;40576.79711601445;40651.390229146586;41206.79396603013;41686.7915660422;41787;41797.37303940443;41804.37293440593;7580.658870350848;7687.615619219045;7851.411144164182;10192.133668638175;10514.631987880426;9928.702138935843;10030.39817610942;10038.899611003906;10039.397636141819;10040.89959100407;10044.799104017915;10101.393916365041;10104.89895101047;10107.646232381869;10114;7577.924220757777;9813.067758562926;10087.89912100877;10088.192944564491;10413.53139108742;9993.900060999369;10063.597456101747;10064.345817521838;10069;10070.89929100707;37719.811400943094;38083.4287485688;38167.23665526674;38178.42732359017;38233.235335293415;2889.436559870826;2904.346522032547;3041.17888170195;3105.1771280610656;3376.8986930391884;28852.134435966953;29167.70832291671;29344.853275733698;29986.100416987527;30034.69965300341;3450.3271861986923;3481.3211423772373;3508.947365789515;3518.2084031093054;3557.2529768748595;270754.6462267676;404457;411479;416943;419029;55622;55934;56351;56381.71809140928;56422.99999999918;28759.5686064705;28795;29043.7095629041;59246.70376648089;59791.402085979455;12323.69190770238;13814.930925345308;14009.439622415193;14078.507252246121;14099;10289.176865850714;10516.421596812248;10538.051575358102;10805.351678899291;10807.08139808125;18202.271909123752;18224.36214732478;18232.45302640923;18242.087895605167;18378.081095945417;6854.34883686049;6879.862402751917;7026.1217347831525;7152.392046676091;7178.497505174692;803.7950322667682;814.9714759983373;845.4842546046906;920.8710780490736;1024.6260115058099;27418.725812742017;28231.294217644725;28363;28431.43137137287;28724.42551148965;944.6740874398322;949.5632009275672;951.2342564235719;976.3556053004983;979.2704435195825;14473.493427729978;14887;14913.254337283093;15101.244937753068;15417.383304667912;393624;398089;399824;400315;405181;50322.74838625784;50913.49086509088;50970;51075.23387149196;51293.7435312821;1065.8081545321916;1166.8191430328482;1188.7563049574817;1214.8238505416841;1224.210384302138;28451.43097138087;29770.702292977658;29843;29956.850215748782;30375;42209;42513.36229956491;42840.35739463848;42962.35556466593;42968;321914;327639.2562334653;327643;327709;328178;22263.554728905656;24113.879430603436;24865.87567062153;24961;26290.21129366122;41963;42044.36933445939;42060.57939420567;42957.355639664805;43011.78494107509;35945.64054359423;36340.09149771277;36860;36871.44692829663;37323.62676373201;35589.28821423609;36319.455208172425;36337.454938176474;36464.453033203994;36910.26179476449;35270.64729352674;35785.46321805227;36091.639083608825;36397.636023639425;36717;31685.20786980344;32854;33203.335933280716;33261.833690831394;33329.66670333266;24940.75059249384;25126.748732512442;25749.227523174333;25944.221673349828;26405.603915940894 15:46:09 INFO - PROCESS | 17400 | |2;jquery.html;373.2795704290719;381.5497712699015;382.6231162305129;388.3204392313451;394.2765026176965;16454.588635284108;17227;17367.739483907735;17567.209475573596;17573.121343932784;15757.55757857531;15827.287772050257;16411.507654770376;16596.66806663866;16617.83382166178;4560.635149188065;4734.479207287196;4786.593139583139;4787.8563643090765;4792.376990991166;3528.629493903129;5274.208868669692;5561.304836895388;5562.8609284768;5580.497755202031;5421.241026256307;5552.0839061555;5559.360673522557;5560.388357280696;5571.470710282517;5376.220448035033;5547.084731019377;5549.001179787637;5550.77796888124;5550.888982220333;3389.1357703785625;3587.6950459211;3588.3002814451193;3619.366610843092;5029.572486338666;11486.540538378455;11761.235519691192;11900.642980710592;11910.702232444171;11912.106592005634;1831.7985021647607;1909.1282670799249;1937.5543624966197;1938.5638231397822;2251.6397376419695;8765.167309105625;8956.910430895738;9015.729528114101;9025.41334813235;9512.048795120501;1689.915504224784;1740.321274702867;1753.824617538236;1766.1345940489196;1781.4210381625894;64656.353436465506;65407.34592654108;65503.67248163729;65849.3415065848;67507.32492675059;9953.153981911619;10111.39331640104;10140.949295253477;10431.947840260902;10506.579736810594;13988.58034258974;14020.509282175075;14112.364943577564;14121.293935303194;14123.576292711236;6977.686004129826;7206.171290301682;7220.3140701633265;7236.710531578783;7289.198188199294;6525.053867189231;6605.8348541285895;6713.2279787824045;6727.024581435664;6818.2159051708695;4431.512533621299;4443.666724995638;4526.207913615104;4576.061907308994;4588.609968152745;1659.5270347950775;1663.875209359303;1783.7681101456728;1808.9276428942694;1871.5257870728067;804.7625950344545;843.7384410832539;860.5525126933959;913.584319134792;945.9621615135455;15548.378064877505;16198.595035124215;16953.576160596083;16954.660906781795;17285.91357043207;847.4872702015192;853.8249658819927;898.2903506230135;900.9234215091791;931.902150274225;8791.340649451316;9561.760955976017;9617.855732164024;9631.518424078768;9695.806083878282;357940;360328;360817;367443;372561;74020;75188;76450.61774691091;76523.61738191273;77155.61422192852;883.7481317824389;889.6574818694849;897.8024834536392;912.1653686876434;916.9495677737789;14768.187749673441;14807.703845922806;14906.77639835425;15117.848821512083;15135.545933622008;32641;33433.16417089592;35764.82117589395;35813;36662.90011299666;49219;49244.75377623089;49452;49479.75260123676;50090.49909501004;7571.3564347031115;7716.2669546393;7789.5715735635085;7916.4062695299235;7923.84152316962;11294.152938529807;11839.467223975114;11935.104867134825;11963.940180299043;12092.214006089576;9994.750131246778;10049;10067.446290454096;10345.37927724339;10499.842502362319;5602.747876345656;10432.217583681102;10601.41692206936;10750.73123171927;10760.784784304427;10275.7431064224;10465.215108866712;10646.361218326925;10897.237193396702;10915.39965301916;7830.09953855314;7858.685652574061;7885.487443316166;7931.361499084045;8004.599770011592;8077.27304542594;9554.52227388614;10639.202059845387;10652.73368165771;10654 15:46:09 INFO - PROCESS | 17400 | |3;mootools.html;1223.0949097667717;1381.2886363522787;1390.4229744655966;1470.595586213791;1672.1054235983743;6869.175698916125;7794.727184548535;8040.758777236692;8047.91952080479;8285.42002059856;7968.322692571124;8127.3091787198155;8130.593470326489;8131.756047318575;8150.103488616248;2125.6705210692367;2148.8495805293637;2154.429076294783;2155.3103007037753;2170.3488953313945;2109.4726318420394;2144.5818065477238;2174.1629472653062;2180.1715348167672;2180.9127634894585;2100.390886642872;2112.3768488295914;2119.480727221825;2126.479012641897;2141.4432247615578;2074.6576814825535;2084.291340944079;2090.1639344262267;2093.005822234434;2097.4651463876767;1989.1247850945538;2044.1005957378707;2045.2432599938118;2046.3451695457459;2049.6822992436196;7919.445638805286;8111.188881111901;8137.389695772841;8185.427020108595;8186.345092392594;4613.354130421743;4761.8095276188915;4769.499202583714;4772.188727916263;4779.545943135397;2781.5410457274525;2886.797924145311;2945.7348838604416;2975.1372102090368;2982.701729827;892.6429428228696;903.5121034641352;912.7124955639019;922.2207234886511;934.8317302885478;11261.493232804543;11332.263402878787;11366.545338186463;11373.033292170176;11403.942980285046;4043.2722110020477;4140.979295103505;4249.87250382489;4254.595813397722;4254.829806807755;8796.516191609395;8919.464832110094;8927.24118449926;8929.374943753875;8929.910700893039;4469.642428605704;4546;4550.431196100488;4552.0668263006;4553.658475614342;3720.8697695580527;4215.59951804578;4225.091605304874;4292.89267768302;4361.411209486742;3452.4130897747445;3466.168119651316;3546.858125674944;3566.8038257896064;3572.231970126383;1039.8180318444242;1047.4239168457318;1049.6431213387484;1050.1231471721046;1052.8420736889527;782.2763943352377;838.8406202821444;856.9657213711382;876.3952872517942;881.0176653031823;5189.948100519022;5358.27663265462;5404.297441332602;5441.374241962146;5443.673379597237;402.55115546165814;409.8626959968444;412.36289932055047;413.1736526946108;415.2297488159481;3579.480975258573;3658.359787037258;3669.229461813049;3701.4262789267705;3734.8319325630414;9621.663241786504;10193.082622563856;10200.846987295197;10205.183585313158;10268.075873171301;9969.900300997042;10113.494325283706;10183.592656293666;10184.898151018395;10187.898121018696;7259.709611615476;7364.631768411558;7386;7386.667599957907;7449.85100297991;5115.667481613683;5182.53357197854;5225.843224703265;5332.733363331896;5335.786568537215;9132.49771262587;9163.129502697233;9185.081491850762;9361.578728957349;9419.62321507132;9478.099580539838;9579.808403832023;9595.808083838145;9644.180244679;9672.806543869225;5838.2702162229725;6249.96875015622;6384.521160912857;6585.078089067631;6659.866802664016;7611.733589324347;7632.923670763444;7669.693212271447;7690.307872291521;7697.576633285223;6536;6683.264840867403;6753.594784312957;6783.491238157257;6896.4827637926355;6613.305602911817;6632.602043877383;6640.169978752656;6715.966420167868;6801.081853949851;6303.905441418291;6350.428461438492;6390.360963903572;6403.263624683034;6403.583767055313;4563.977180114078;4698;4734.05318936221;4803.1114243864995;4847.054824309226;4546.818127274872;4617.676762626584;4662.976685116552;4793.592544633745;4809.855704328876 15:46:09 INFO - PROCESS | 17400 | |4;prototype.html;298.50150249084027;304.62987470223675;306.4147478316415;310.36685162268975;313.8415100374311;4967.428745694247;4969.2049272116465;4985.651004429691;5003.099442100421;5020.322256495372;4926.137925862978;4928.285398617199;4943.480934501879;4947.950520494794;4948.777305021274;3697.7966211858406;3755.793431361274;3768.4158955361827;3855.4795102661064;3903.941440878389;3779;3824.2160357126722;3826.9043273918096;3885.708571857108;3907.2966865964113;3687.2072504411544;3815.866444674437;3844.8462061517507;3850.306944749944;3854.961450385488;3574.660407261306;3768.020314718179;3778.4332350147424;3801.4107813288983;3872.283627528916;3422.7946323220685;3424.760266781326;3425.3320602482527;3426.674465925733;3429.537012503305;4771.308160316735;4775.4241100436775;4812.205986012304;4825.348577941968;4831.05794370098;4206.831726730927;4413.16149931512;4415.337699345092;4418.64650827933;4429.247028005247;5095.655998240776;5129.307328581596;5132.897342053176;5146.228065790124;5164.406093299243;3782.981085094557;3793.6016718244737;3797.063497616208;3797.905052373713;3810.90472738181;5188;5409.9459005409835;5432.266644003049;5448.673079615236;5479.863003424946;3841.9231615367535;3848.8652897148463;3872.9419058714143;3873.922521549553;3897.629725176104;3935.2326296372507;3944.7179666608467;3950.8617198398492;3953.8616148435244;3957.1689945111275;4326.178026175016;4421.292593185075;4451.643868490513;4471.575200355961;4472.418585583853;5030.2957585938;5086.456771614193;5098.413682426494;5111.309973153651;5120.564751996122;1330.4944121233868;1353.1610401551102;1353.5939218234687;1355.9254241016642;1367.3710093357167;842.6349314111179;883.2713011765319;886.2776836877924;890.9465432073966;892.790194304338;4343.5656434356315;4488.663350248745;4635.58279754817;4648.256278995412;4666.183417901853;5326.387465441447;5327.493888080626;5358.142697168434;5365.946340536622;5379.354477462652;4574.794134263966;4598.448186217675;4645.535446455395;4672.135654903854;4684.5549672781035;2634.5916382960672;2783.707710690389;2810.4800611886867;2810.592464092736;2826.547752359613;4969.35398398206;4983.825566105169;4989.650724449326;4991.777014631366;5017.7491125443585;5274.815381461707;5423.538999185034;5424.783008679688;5434.972825135849;5441;5004.749762511859;5006.724630145304;5048.545630893237;5068.873278168076;5075.593952483792;5290.338707661543;5311.309529761261;5318.202269659582;5331.413544510023;5342.171963345688;4927.778249978831;5128.0000399921655;5204.193350030751;5214.504622060898;5222.164453687392;5016.896282817775;5034.370703662043;5046.798128074983;5049.570786483043;5067.695938243717;3390.8474118664226;3471.2016236265295;3481.321142377313;3496.8950931472095;3501.2997400520508;4568.474625417986;4767.189577771718;4779.665423420466;4795.681187673417;4798.928016079692;4570.840020599396;4608.976955115337;4620.19812273207;4643.976780116078;4654.48800631937;4638.814447422065;4645.5354464553275;4694.3427920090535;4712.50518695532;4740.762961851825;4209.463545805697;4502.729836209838;4503.581371867851;4541.774530480107;4577.237763461025;4666.533346665306;4927.852164435073;5089.974550127374;5142.922856157086;5148.742562871917;4995.900081998267;4999.500049994971;5024.271480635361;5066.797328106834;5078 15:46:09 INFO - PROCESS | 17400 | |5;yui.html;605.2848311652228;653.2683394598051;661.8047675935599;682.6889585510276;719.1837264704559;12571.24572525648;12950.48198072076;12990.870091299095;13020.804687929665;13033.674158146052;12002.079147549506;12040.397980101005;12820.230786152837;13191.14257573257;13289.667758306046;629.3234772619452;772.3010675338827;787.9960600196991;801.6673080671515;805.0741647105846;792.5522080024797;810.0643756461296;810.116972499975;811.0956283743642;811.2536466450879;845.4800297816829;849.3884403229696;849.9915000849974;849.9957500212521;850.1413572291999;652.1359199061263;803.4978138663336;831.0442990560842;848.707196017373;848.7750746052301;614.5544480251826;615.230961298377;615.5014438304987;615.5106690181317;615.6060121522229;12695.301758403284;12738.554150604685;12789.680257993532;12825.35873206336;12830.294333811637;12154.392280385946;12777.23336599807;13144.14563053408;13198.60404187876;13267.800982985264;9892.060254275832;10078.445685487368;10270.327001214504;10509.789804203872;11070.225084244106;4107;4157.189348077126;4212.599803018708;4219.535851056381;4350.58669426404;50477.74761126208;52417;52613;57464.71267643677;57884;10574.365538067741;10575.576976920991;10717.303375280582;10879.075278601249;11153.49809258569;18650.067496625114;18759.062046897874;18766.061696915098;18801.15394807237;18813.341533046278;6725.8654826903185;6798.592084474947;6864.107666003388;6879.724811007603;7004.439644828503;3591.4612808078996;3643.6720695137565;3761.8307176177136;3828.272628200689;3870.7096967727534;2692.9326766830986;2808.1575527341715;2822.181567345488;2823.647044119485;2835.517961946433;478.2348242811474;487.01622722101155;490.17650347416685;491.071874157842;539.323149447441;478.7295178224292;484.7673116903906;528.9365276166884;580.2659635561018;615.0134472393605;8207.589620518951;8250.339972802161;8453.746387608258;8594.441361311494;8871.157240062184;575.9827205183851;590.0559105431362;611.3519669150714;613.1936503497886;629.9118123462719;4042.171354872244;4155.729877557949;4161.667066634662;4284.186004659105;4333.609975102256;93254;99372;100422;101060.49469752604;105182.4740876306;88825.55587222023;89474.55262723645;91381;92050;92142;54026.72986635042;66868.66565667141;71962.28037719765;74518.99999999891;76343;7906.486078404885;8004.679812807655;8005.1594582568;8207.343412527103;8443.704470343508;32260.516092259106;33793.49309760405;45001.77499112483;45653.315200272686;46697.863235044795;56727;63368.683156583924;63688;65405.672971634835;65703.34296656972;11771.23486973344;11975;12024.278543287432;12186.390680465764;12523.499060037497;12812.487500499876;12954;13015.544455943997;13210.669733256746;13731.725365492834;8635.395522313378;11219.326840389604;11421.885781142082;11499.712507187387;11798.941005294919;11563.42182890869;11872.109591780823;12057.51769929193;12100.636980890587;13218.206907585576;12019.123141289341;12307.247013264485;12318.42822486432;12564.308963007123;12725.829560147271;9476.573554190216;9869;9875.358101723365;10046.899531004596;10377.377357358582;9023.548822558714;9077.954610226907;9443.362134348656;9542.42745435276;9578.377405468622 15:46:09 INFO - PROCESS | 17400 | __end_tp_report 15:46:09 INFO - PROCESS | 17400 | __start_cc_report 15:46:09 INFO - PROCESS | 17400 | _x_x_mozilla_cycle_collect,897 15:46:09 INFO - PROCESS | 17400 | __end_cc_report 15:46:09 INFO - PROCESS | 17400 | __startTimestamp1466894769396__endTimestamp 15:46:09 INFO - PROCESS | 17400 | 15:46:09 INFO - PROCESS | 17400 | ------- Summary: start ------- 15:46:09 INFO - PROCESS | 17400 | Number of tests: 6 15:46:09 INFO - PROCESS | 17400 | 15:46:09 INFO - PROCESS | 17400 | [#0] dojo.html Cycles:165 Average:4785.82 Median:4904.90 stddev:518.32 (10.6%) stddev-sans-first:491.00 15:46:09 INFO - PROCESS | 17400 | Values: 2609.7 2633.4 2660.4 2667.6 2676.6 4705.1 4768.0 4778.5 4851.9 4899.3 4743.1 4786.9 4788.5 4850.2 4858.1 4252.3 4411.8 4489.9 4547.3 4581.7 4479.7 4520.2 4532.9 4537.4 4573.6 4348.6 4383.9 4398.8 4413.3 4445.2 4373.1 4402.3 4452.6 4456.1 4463.4 4423.1 4441.0 4450.2 4480.8 4486.2 4669.5 4774.5 4900.8 4909.2 4916.0 5176.8 5208.7 5211.8 5217.2 5240.7 5087.9 5224.5 5255.6 5285.8 5286.0 4812.1 4867.3 4875.4 4876.3 4889.5 5448.5 5453.0 5454.1 5461.9 5466.8 4855.2 5043.8 5173.9 5202.4 5204.0 5199.2 5218.0 5238.3 5241.3 5289.3 5159.2 5172.0 5174.1 5174.3 5223.3 4952.3 5031.5 5077.2 5156.5 5173.9 4342.0 4355.2 4360.1 4400.8 4405.6 3773.9 3802.4 3807.7 3841.7 3843.4 4397.6 4443.5 4458.9 4494.9 4498.2 5152.6 5178.4 5179.4 5187.2 5227.8 4503.5 4507.2 4508.8 4547.3 4549.3 4522.5 4563.8 4564.7 4579.1 4642.5 4888.9 4890.7 4904.9 4919.1 4928.9 5202.2 5205.1 5208.1 5246.3 5250.3 4703.1 4776.5 4827.8 4838.3 4856.8 5046.6 5058.5 5060.1 5067.7 5120.6 5027.1 5164.1 5184.2 5186.0 5190.1 4934.5 5017.7 5019.6 5020.1 5039.4 5036.0 5043.8 5046.3 5054.5 5097.4 4855.3 4930.4 4956.8 4965.6 5017.7 5076.7 5091.4 5107.6 5118.5 5162.8 5002.7 5017.5 5017.9 5020.9 5064.7 15:46:09 INFO - PROCESS | 17400 | 15:46:09 INFO - PROCESS | 17400 | [#1] ext.html Cycles:180 Average:51776.87 Median:3495.13 stddev:98454.59 (2816.9%) stddev-sans-first:98655.63 15:46:09 INFO - PROCESS | 17400 | Values: 542.0 577.4 579.3 588.7 593.4 27613.7 39512.0 40565.4 40576.8 40651.4 41206.8 41686.8 41787.0 41797.4 41804.4 7580.7 7687.6 7851.4 10192.1 10514.6 9928.7 10030.4 10038.9 10039.4 10040.9 10044.8 10101.4 10104.9 10107.6 10114.0 7577.9 9813.1 10087.9 10088.2 10413.5 9993.9 10063.6 10064.3 10069.0 10070.9 37719.8 38083.4 38167.2 38178.4 38233.2 2889.4 2904.3 3041.2 3105.2 3376.9 28852.1 29167.7 29344.9 29986.1 30034.7 3450.3 3481.3 3508.9 3518.2 3557.3 270754.6 404457.0 411479.0 416943.0 419029.0 55622.0 55934.0 56351.0 56381.7 56423.0 28759.6 28795.0 29043.7 59246.7 59791.4 12323.7 13814.9 14009.4 14078.5 14099.0 10289.2 10516.4 10538.1 10805.4 10807.1 18202.3 18224.4 18232.5 18242.1 18378.1 6854.3 6879.9 7026.1 7152.4 7178.5 803.8 815.0 845.5 920.9 1024.6 27418.7 28231.3 28363.0 28431.4 28724.4 944.7 949.6 951.2 976.4 979.3 14473.5 14887.0 14913.3 15101.2 15417.4 393624.0 398089.0 399824.0 400315.0 405181.0 50322.7 50913.5 50970.0 51075.2 51293.7 1065.8 1166.8 1188.8 1214.8 1224.2 28451.4 29770.7 29843.0 29956.9 30375.0 42209.0 42513.4 42840.4 42962.4 42968.0 321914.0 327639.3 327643.0 327709.0 328178.0 22263.6 24113.9 24865.9 24961.0 26290.2 41963.0 42044.4 42060.6 42957.4 43011.8 35945.6 36340.1 36860.0 36871.4 37323.6 35589.3 36319.5 36337.5 36464.5 36910.3 35270.6 35785.5 36091.6 36397.6 36717.0 31685.2 32854.0 33203.3 33261.8 33329.7 24940.8 25126.7 25749.2 25944.2 26405.6 15:46:09 INFO - PROCESS | 17400 | 15:46:09 INFO - PROCESS | 17400 | [#2] jquery.html Cycles:180 Average:23026.87 Median:4437.59 stddev:60181.75 (1356.2%) stddev-sans-first:60326.54 15:46:09 INFO - PROCESS | 17400 | Values: 373.3 381.5 382.6 388.3 394.3 16454.6 17227.0 17367.7 17567.2 17573.1 15757.6 15827.3 16411.5 16596.7 16617.8 4560.6 4734.5 4786.6 4787.9 4792.4 3528.6 5274.2 5561.3 5562.9 5580.5 5421.2 5552.1 5559.4 5560.4 5571.5 5376.2 5547.1 5549.0 5550.8 5550.9 3389.1 3587.7 3588.3 3619.4 5029.6 11486.5 11761.2 11900.6 11910.7 11912.1 1831.8 1909.1 1937.6 1938.6 2251.6 8765.2 8956.9 9015.7 9025.4 9512.0 1689.9 1740.3 1753.8 1766.1 1781.4 64656.4 65407.3 65503.7 65849.3 67507.3 9953.2 10111.4 10140.9 10431.9 10506.6 13988.6 14020.5 14112.4 14121.3 14123.6 6977.7 7206.2 7220.3 7236.7 7289.2 6525.1 6605.8 6713.2 6727.0 6818.2 4431.5 4443.7 4526.2 4576.1 4588.6 1659.5 1663.9 1783.8 1808.9 1871.5 804.8 843.7 860.6 913.6 946.0 15548.4 16198.6 16953.6 16954.7 17285.9 847.5 853.8 898.3 900.9 931.9 8791.3 9561.8 9617.9 9631.5 9695.8 357940.0 360328.0 360817.0 367443.0 372561.0 74020.0 75188.0 76450.6 76523.6 77155.6 883.7 889.7 897.8 912.2 916.9 14768.2 14807.7 14906.8 15117.8 15135.5 32641.0 33433.2 35764.8 35813.0 36662.9 49219.0 49244.8 49452.0 49479.8 50090.5 7571.4 7716.3 7789.6 7916.4 7923.8 11294.2 11839.5 11935.1 11963.9 12092.2 9994.8 10049.0 10067.4 10345.4 10499.8 5602.7 10432.2 10601.4 10750.7 10760.8 10275.7 10465.2 10646.4 10897.2 10915.4 7830.1 7858.7 7885.5 7931.4 8004.6 8077.3 9554.5 10639.2 10652.7 10654.0 15:46:09 INFO - PROCESS | 17400 | 15:46:09 INFO - PROCESS | 17400 | [#3] mootools.html Cycles:180 Average:5206.70 Median:4765.65 stddev:3040.03 (63.8%) stddev-sans-first:3033.82 15:46:09 INFO - PROCESS | 17400 | Values: 1223.1 1381.3 1390.4 1470.6 1672.1 6869.2 7794.7 8040.8 8047.9 8285.4 7968.3 8127.3 8130.6 8131.8 8150.1 2125.7 2148.8 2154.4 2155.3 2170.3 2109.5 2144.6 2174.2 2180.2 2180.9 2100.4 2112.4 2119.5 2126.5 2141.4 2074.7 2084.3 2090.2 2093.0 2097.5 1989.1 2044.1 2045.2 2046.3 2049.7 7919.4 8111.2 8137.4 8185.4 8186.3 4613.4 4761.8 4769.5 4772.2 4779.5 2781.5 2886.8 2945.7 2975.1 2982.7 892.6 903.5 912.7 922.2 934.8 11261.5 11332.3 11366.5 11373.0 11403.9 4043.3 4141.0 4249.9 4254.6 4254.8 8796.5 8919.5 8927.2 8929.4 8929.9 4469.6 4546.0 4550.4 4552.1 4553.7 3720.9 4215.6 4225.1 4292.9 4361.4 3452.4 3466.2 3546.9 3566.8 3572.2 1039.8 1047.4 1049.6 1050.1 1052.8 782.3 838.8 857.0 876.4 881.0 5189.9 5358.3 5404.3 5441.4 5443.7 402.6 409.9 412.4 413.2 415.2 3579.5 3658.4 3669.2 3701.4 3734.8 9621.7 10193.1 10200.8 10205.2 10268.1 9969.9 10113.5 10183.6 10184.9 10187.9 7259.7 7364.6 7386.0 7386.7 7449.9 5115.7 5182.5 5225.8 5332.7 5335.8 9132.5 9163.1 9185.1 9361.6 9419.6 9478.1 9579.8 9595.8 9644.2 9672.8 5838.3 6250.0 6384.5 6585.1 6659.9 7611.7 7632.9 7669.7 7690.3 7697.6 6536.0 6683.3 6753.6 6783.5 6896.5 6613.3 6632.6 6640.2 6716.0 6801.1 6303.9 6350.4 6390.4 6403.3 6403.6 4564.0 4698.0 4734.1 4803.1 4847.1 4546.8 4617.7 4663.0 4793.6 4809.9 15:46:09 INFO - PROCESS | 17400 | 15:46:09 INFO - PROCESS | 17400 | [#4] prototype.html Cycles:180 Average:4227.71 Median:4666.36 stddev:1212.39 (26.0%) stddev-sans-first:1179.38 15:46:09 INFO - PROCESS | 17400 | Values: 298.5 304.6 306.4 310.4 313.8 4967.4 4969.2 4985.7 5003.1 5020.3 4926.1 4928.3 4943.5 4948.0 4948.8 3697.8 3755.8 3768.4 3855.5 3903.9 3779.0 3824.2 3826.9 3885.7 3907.3 3687.2 3815.9 3844.8 3850.3 3855.0 3574.7 3768.0 3778.4 3801.4 3872.3 3422.8 3424.8 3425.3 3426.7 3429.5 4771.3 4775.4 4812.2 4825.3 4831.1 4206.8 4413.2 4415.3 4418.6 4429.2 5095.7 5129.3 5132.9 5146.2 5164.4 3783.0 3793.6 3797.1 3797.9 3810.9 5188.0 5409.9 5432.3 5448.7 5479.9 3841.9 3848.9 3872.9 3873.9 3897.6 3935.2 3944.7 3950.9 3953.9 3957.2 4326.2 4421.3 4451.6 4471.6 4472.4 5030.3 5086.5 5098.4 5111.3 5120.6 1330.5 1353.2 1353.6 1355.9 1367.4 842.6 883.3 886.3 890.9 892.8 4343.6 4488.7 4635.6 4648.3 4666.2 5326.4 5327.5 5358.1 5365.9 5379.4 4574.8 4598.4 4645.5 4672.1 4684.6 2634.6 2783.7 2810.5 2810.6 2826.5 4969.4 4983.8 4989.7 4991.8 5017.7 5274.8 5423.5 5424.8 5435.0 5441.0 5004.7 5006.7 5048.5 5068.9 5075.6 5290.3 5311.3 5318.2 5331.4 5342.2 4927.8 5128.0 5204.2 5214.5 5222.2 5016.9 5034.4 5046.8 5049.6 5067.7 3390.8 3471.2 3481.3 3496.9 3501.3 4568.5 4767.2 4779.7 4795.7 4798.9 4570.8 4609.0 4620.2 4644.0 4654.5 4638.8 4645.5 4694.3 4712.5 4740.8 4209.5 4502.7 4503.6 4541.8 4577.2 4666.5 4927.9 5090.0 5142.9 5148.7 4995.9 4999.5 5024.3 5066.8 5078.0 15:46:09 INFO - PROCESS | 17400 | 15:46:09 INFO - PROCESS | 17400 | [#5] yui.html Cycles:180 Average:17579.41 Median:485.89 stddev:25299.72 (5206.9%) stddev-sans-first:25338.59 15:46:09 INFO - PROCESS | 17400 | Values: 605.3 653.3 661.8 682.7 719.2 12571.2 12950.5 12990.9 13020.8 13033.7 12002.1 12040.4 12820.2 13191.1 13289.7 629.3 772.3 788.0 801.7 805.1 792.6 810.1 810.1 811.1 811.3 845.5 849.4 850.0 850.0 850.1 652.1 803.5 831.0 848.7 848.8 614.6 615.2 615.5 615.5 615.6 12695.3 12738.6 12789.7 12825.4 12830.3 12154.4 12777.2 13144.1 13198.6 13267.8 9892.1 10078.4 10270.3 10509.8 11070.2 4107.0 4157.2 4212.6 4219.5 4350.6 50477.7 52417.0 52613.0 57464.7 57884.0 10574.4 10575.6 10717.3 10879.1 11153.5 18650.1 18759.1 18766.1 18801.2 18813.3 6725.9 6798.6 6864.1 6879.7 7004.4 3591.5 3643.7 3761.8 3828.3 3870.7 2692.9 2808.2 2822.2 2823.6 2835.5 478.2 487.0 490.2 491.1 539.3 478.7 484.8 528.9 580.3 615.0 8207.6 8250.3 8453.7 8594.4 8871.2 576.0 590.1 611.4 613.2 629.9 4042.2 4155.7 4161.7 4284.2 4333.6 93254.0 99372.0 100422.0 101060.5 105182.5 88825.6 89474.6 91381.0 92050.0 92142.0 54026.7 66868.7 71962.3 74519.0 76343.0 7906.5 8004.7 8005.2 8207.3 8443.7 32260.5 33793.5 45001.8 45653.3 46697.9 56727.0 63368.7 63688.0 65405.7 65703.3 11771.2 11975.0 12024.3 12186.4 12523.5 12812.5 12954.0 13015.5 13210.7 13731.7 8635.4 11219.3 11421.9 11499.7 11798.9 11563.4 11872.1 12057.5 12100.6 13218.2 12019.1 12307.2 12318.4 12564.3 12725.8 9476.6 9869.0 9875.4 10046.9 10377.4 9023.5 9078.0 9443.4 9542.4 9578.4 15:46:09 INFO - PROCESS | 17400 | -------- Summary: end -------- 15:46:09 INFO - PROCESS | 17400 | 15:46:10 INFO - TEST-INFO | 17400: exit 0 15:46:10 INFO - TEST-OK | dromaeo_css | took 1121491ms 15:46:10 INFO - TEST-START | kraken 15:46:10 INFO - operating with platform_type : linux_ 15:46:10 INFO - Initialising browser for kraken test... 15:46:10 INFO - TEST-INFO | started process 17582 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqcxT4U/profile http://localhost:54044/getInfo.html) 15:46:15 INFO - PROCESS | 17582 | __metrics Screen width/height:1600/1200 15:46:15 INFO - PROCESS | 17582 | colorDepth:24 15:46:15 INFO - PROCESS | 17582 | Browser inner width/height: 1024/697 15:46:15 INFO - PROCESS | 17582 | __metrics 15:46:16 INFO - PROCESS | 17582 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:46:17 INFO - TEST-INFO | 17582: exit 0 15:46:17 INFO - Browser initialized. 15:46:17 INFO - Running cycle 1/1 for kraken test... 15:46:17 INFO - TEST-INFO | started process 17664 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqcxT4U/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:46:30 INFO - PROCESS | 17664 | RSS: Main: 175587328 15:46:30 INFO - PROCESS | 17664 | 15:46:32 INFO - PROCESS | 17664 | Cycle 1(1): loaded http://localhost:54044/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54044/tests/kraken/driver.html?testName=audio-beat-detection) 15:46:33 INFO - PROCESS | 17664 | RSS: Main: 233103360 15:46:33 INFO - PROCESS | 17664 | 15:46:36 INFO - PROCESS | 17664 | Cycle 1(1): loaded http://localhost:54044/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54044/tests/kraken/driver.html?testName=audio-dft) 15:46:37 INFO - PROCESS | 17664 | RSS: Main: 220016640 15:46:37 INFO - PROCESS | 17664 | 15:46:40 INFO - PROCESS | 17664 | Cycle 1(1): loaded http://localhost:54044/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54044/tests/kraken/driver.html?testName=audio-fft) 15:46:40 INFO - PROCESS | 17664 | RSS: Main: 287997952 15:46:40 INFO - PROCESS | 17664 | 15:46:43 INFO - PROCESS | 17664 | Cycle 1(1): loaded http://localhost:54044/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54044/tests/kraken/driver.html?testName=audio-oscillator) 15:46:43 INFO - PROCESS | 17664 | RSS: Main: 198987776 15:46:43 INFO - PROCESS | 17664 | 15:46:45 INFO - PROCESS | 17664 | Cycle 1(1): loaded http://localhost:54044/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54044/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:46:46 INFO - PROCESS | 17664 | RSS: Main: 203055104 15:46:46 INFO - PROCESS | 17664 | 15:46:49 INFO - PROCESS | 17664 | Cycle 1(1): loaded http://localhost:54044/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54044/tests/kraken/driver.html?testName=imaging-darkroom) 15:46:50 INFO - PROCESS | 17664 | RSS: Main: 238403584 15:46:50 INFO - PROCESS | 17664 | 15:46:53 INFO - PROCESS | 17664 | Cycle 1(1): loaded http://localhost:54044/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54044/tests/kraken/driver.html?testName=imaging-desaturate) 15:46:54 INFO - PROCESS | 17664 | RSS: Main: 239120384 15:46:54 INFO - PROCESS | 17664 | 15:46:57 INFO - PROCESS | 17664 | Cycle 1(1): loaded http://localhost:54044/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54044/tests/kraken/driver.html?testName=json-parse-financial) 15:46:57 INFO - PROCESS | 17664 | RSS: Main: 239218688 15:46:57 INFO - PROCESS | 17664 | 15:46:59 INFO - PROCESS | 17664 | Cycle 1(1): loaded http://localhost:54044/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54044/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:47:00 INFO - PROCESS | 17664 | RSS: Main: 225746944 15:47:00 INFO - PROCESS | 17664 | 15:47:01 INFO - PROCESS | 17664 | Cycle 1(1): loaded http://localhost:54044/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54044/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:47:02 INFO - PROCESS | 17664 | RSS: Main: 230965248 15:47:02 INFO - PROCESS | 17664 | 15:47:04 INFO - PROCESS | 17664 | Cycle 1(1): loaded http://localhost:54044/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54044/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:47:05 INFO - PROCESS | 17664 | RSS: Main: 236777472 15:47:05 INFO - PROCESS | 17664 | 15:47:08 INFO - PROCESS | 17664 | Cycle 1(1): loaded http://localhost:54044/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54044/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:47:08 INFO - PROCESS | 17664 | RSS: Main: 240435200 15:47:08 INFO - PROCESS | 17664 | 15:47:11 INFO - PROCESS | 17664 | Cycle 1(1): loaded http://localhost:54044/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54044/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:47:12 INFO - PROCESS | 17664 | RSS: Main: 239779840 15:47:12 INFO - PROCESS | 17664 | 15:47:14 INFO - PROCESS | 17664 | Cycle 1(1): loaded http://localhost:54044/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54044/tests/kraken/driver.html?testName=ai-astar) 15:47:14 INFO - PROCESS | 17664 | RSS: Main: 281853952 15:47:14 INFO - PROCESS | 17664 | 15:47:14 INFO - PROCESS | 17664 | __start_tp_report 15:47:14 INFO - PROCESS | 17664 | _x_x_mozilla_page_load 15:47:14 INFO - PROCESS | 17664 | _x_x_mozilla_page_load_details 15:47:14 INFO - PROCESS | 17664 | |i|pagename|runs| 15:47:14 INFO - PROCESS | 17664 | |0;ai-astar;104;115;112;111;113;112;112;113;112;113 15:47:14 INFO - PROCESS | 17664 | |1;audio-beat-detection;155;131;131;186;134;139;159;139;186;135 15:47:14 INFO - PROCESS | 17664 | |2;audio-dft;163;162;161;163;162;163;162;162;160;160 15:47:14 INFO - PROCESS | 17664 | |3;audio-fft;77;75;77;110;75;76;76;75;99;76 15:47:14 INFO - PROCESS | 17664 | |4;audio-oscillator;85;87;110;86;87;87;132;86;86;128 15:47:14 INFO - PROCESS | 17664 | |5;imaging-gaussian-blur;117;117;116;117;117;118;117;117;117;116 15:47:14 INFO - PROCESS | 17664 | |6;imaging-darkroom;145;146;145;146;145;145;146;146;145;146 15:47:14 INFO - PROCESS | 17664 | |7;imaging-desaturate;95;94;96;96;95;95;95;95;94;94 15:47:14 INFO - PROCESS | 17664 | |8;json-parse-financial;65;64;63;63;65;64;65;65;64;63 15:47:14 INFO - PROCESS | 17664 | |9;json-stringify-tinderbox;64;64;63;63;65;65;64;64;65;64 15:47:14 INFO - PROCESS | 17664 | |10;stanford-crypto-aes;84;82;87;85;80;83;83;83;92;82 15:47:14 INFO - PROCESS | 17664 | |11;stanford-crypto-ccm;131;140;138;130;128;130;127;145;133;141 15:47:14 INFO - PROCESS | 17664 | |12;stanford-crypto-pbkdf2;170;174;169;173;170;174;166;167;168;169 15:47:14 INFO - PROCESS | 17664 | |13;stanford-crypto-sha256-iterative;67;67;67;69;67;67;66;67;66;67 15:47:14 INFO - PROCESS | 17664 | __end_tp_report 15:47:14 INFO - PROCESS | 17664 | __start_cc_report 15:47:14 INFO - PROCESS | 17664 | _x_x_mozilla_cycle_collect,1904 15:47:14 INFO - PROCESS | 17664 | __end_cc_report 15:47:14 INFO - PROCESS | 17664 | __startTimestamp1466894834312__endTimestamp 15:47:14 INFO - PROCESS | 17664 | 15:47:14 INFO - PROCESS | 17664 | ------- Summary: start ------- 15:47:14 INFO - PROCESS | 17664 | Number of tests: 14 15:47:14 INFO - PROCESS | 17664 | 15:47:14 INFO - PROCESS | 17664 | [#0] ai-astar Cycles:10 Average:111.70 Median:112.50 stddev:2.91 (2.6%) stddev-sans-first:1.13 15:47:14 INFO - PROCESS | 17664 | Values: 104.0 115.0 112.0 111.0 113.0 112.0 112.0 113.0 112.0 113.0 15:47:14 INFO - PROCESS | 17664 | 15:47:14 INFO - PROCESS | 17664 | [#1] audio-beat-detection Cycles:10 Average:149.50 Median:147.00 stddev:21.45 (14.6%) stddev-sans-first:22.66 15:47:14 INFO - PROCESS | 17664 | Values: 155.0 131.0 131.0 186.0 134.0 139.0 159.0 139.0 186.0 135.0 15:47:14 INFO - PROCESS | 17664 | 15:47:14 INFO - PROCESS | 17664 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.14 (0.7%) stddev-sans-first:1.12 15:47:14 INFO - PROCESS | 17664 | Values: 163.0 162.0 161.0 163.0 162.0 163.0 162.0 162.0 160.0 160.0 15:47:14 INFO - PROCESS | 17664 | 15:47:14 INFO - PROCESS | 17664 | [#3] audio-fft Cycles:10 Average:81.60 Median:76.00 stddev:12.37 (16.3%) stddev-sans-first:13.00 15:47:14 INFO - PROCESS | 17664 | Values: 77.0 75.0 77.0 110.0 75.0 76.0 76.0 75.0 99.0 76.0 15:47:14 INFO - PROCESS | 17664 | 15:47:14 INFO - PROCESS | 17664 | [#4] audio-oscillator Cycles:10 Average:97.40 Median:86.00 stddev:18.74 (21.8%) stddev-sans-first:19.33 15:47:14 INFO - PROCESS | 17664 | Values: 85.0 87.0 110.0 86.0 87.0 87.0 132.0 86.0 86.0 128.0 15:47:14 INFO - PROCESS | 17664 | 15:47:14 INFO - PROCESS | 17664 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 15:47:14 INFO - PROCESS | 17664 | Values: 117.0 117.0 116.0 117.0 117.0 118.0 117.0 117.0 117.0 116.0 15:47:14 INFO - PROCESS | 17664 | 15:47:14 INFO - PROCESS | 17664 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 15:47:14 INFO - PROCESS | 17664 | Values: 145.0 146.0 145.0 146.0 145.0 145.0 146.0 146.0 145.0 146.0 15:47:14 INFO - PROCESS | 17664 | 15:47:14 INFO - PROCESS | 17664 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 15:47:14 INFO - PROCESS | 17664 | Values: 95.0 94.0 96.0 96.0 95.0 95.0 95.0 95.0 94.0 94.0 15:47:14 INFO - PROCESS | 17664 | 15:47:14 INFO - PROCESS | 17664 | [#8] json-parse-financial Cycles:10 Average:64.10 Median:64.50 stddev:0.88 (1.4%) stddev-sans-first:0.87 15:47:14 INFO - PROCESS | 17664 | Values: 65.0 64.0 63.0 63.0 65.0 64.0 65.0 65.0 64.0 63.0 15:47:14 INFO - PROCESS | 17664 | 15:47:14 INFO - PROCESS | 17664 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 15:47:14 INFO - PROCESS | 17664 | Values: 64.0 64.0 63.0 63.0 65.0 65.0 64.0 64.0 65.0 64.0 15:47:14 INFO - PROCESS | 17664 | 15:47:14 INFO - PROCESS | 17664 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:83.50 stddev:3.35 (4.0%) stddev-sans-first:3.55 15:47:14 INFO - PROCESS | 17664 | Values: 84.0 82.0 87.0 85.0 80.0 83.0 83.0 83.0 92.0 82.0 15:47:14 INFO - PROCESS | 17664 | 15:47:14 INFO - PROCESS | 17664 | [#11] stanford-crypto-ccm Cycles:10 Average:134.30 Median:135.50 stddev:6.22 (4.6%) stddev-sans-first:6.48 15:47:14 INFO - PROCESS | 17664 | Values: 131.0 140.0 138.0 130.0 128.0 130.0 127.0 145.0 133.0 141.0 15:47:14 INFO - PROCESS | 17664 | 15:47:14 INFO - PROCESS | 17664 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.00 Median:170.00 stddev:2.83 (1.7%) stddev-sans-first:3.00 15:47:14 INFO - PROCESS | 17664 | Values: 170.0 174.0 169.0 173.0 170.0 174.0 166.0 167.0 168.0 169.0 15:47:14 INFO - PROCESS | 17664 | 15:47:14 INFO - PROCESS | 17664 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 15:47:14 INFO - PROCESS | 17664 | Values: 67.0 67.0 67.0 69.0 67.0 67.0 66.0 67.0 66.0 67.0 15:47:14 INFO - PROCESS | 17664 | -------- Summary: end -------- 15:47:14 INFO - PROCESS | 17664 | 15:47:15 INFO - TEST-INFO | 17664: exit 0 15:47:15 INFO - TEST-OK | kraken | took 65241ms 15:47:15 INFO - SUITE-END | took 1186s 15:47:15 INFO - Completed test suite (00:19:47) 15:47:15 INFO - javascript benchmark 15:47:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2609.7259787722287, 2633.3943193065606, 2660.4147087640713, 2667.6131960865673, 2676.571748520237, 4705.129551033061, 4767.952320476794, 4778.546038126373, 4851.902961940759, 4899.289603007562, 4743.075100355432, 4786.904261914759, 4788.497207793183, 4850.2482115272105, 4858.125537403266, 4252.277112890816, 4411.823527058922, 4489.887752806173, 4547.272436410175, 4581.748003859786, 4479.686421950465, 4520.2315606347, 4532.864014079566, 4537.3874526938935, 4573.611243044345, 4348.586884246008, 4383.912321753547, 4398.7580683062415, 4413.271810151321, 4445.244308467568, 4373.059792144704, 4402.251617225047, 4452.577005184502, 4456.064226512404, 4463.352813841975, 4423.1153769246275, 4440.977795111004, 4450.154470650598, 4480.775961201927, 4486.214912390318, 4669.486356500816, 4774.546418090311, 4900.754962251873, 4909.239067944474, 4915.9508404916205, 5176.818811341623, 5208.687478751249, 5211.817586384458, 5217.165253559412, 5240.659357141773, 5087.9061001884775, 5224.477552244745, 5255.579553635738, 5285.814996475105, 5286.0, 4812.06164797861, 4867.26990951353, 4875.439324477659, 4876.317315575822, 4889.535494128052, 5448.482394172547, 5453.018456677757, 5454.10007348791, 5461.918071228934, 5466.753996070186, 4855.247436647325, 5043.84868453947, 5173.896522069537, 5202.375714914235, 5203.973980130075, 5199.220116982483, 5217.973910130425, 5238.292830467838, 5241.292425522582, 5289.312389389432, 5159.2003239497935, 5171.97414012935, 5174.120399532088, 5174.275601415805, 5223.347081614798, 4952.331435256195, 5031.52200540948, 5077.213031980049, 5156.458571849977, 5173.896522069537, 4341.978290108529, 4355.216061109031, 4360.062586543845, 4400.757958312323, 4405.647548196137, 3773.8867833965023, 3802.3916173412676, 3807.695384369244, 3841.673457756066, 3843.404272337792, 4397.648188144941, 4443.488998765119, 4458.888527786831, 4494.865154045384, 4498.212812757754, 5152.613553983466, 5178.378594568676, 5179.404368497596, 5187.170052791611, 5227.790888364499, 4503.504614492404, 4507.166174257773, 4508.797104130322, 4547.317902314613, 4549.294859296814, 4522.5025247222775, 4563.771811409416, 4564.657650676212, 4579.084183163381, 4642.535746425398, 4888.92666609994, 4890.731009794496, 4904.901901962012, 4919.139150648693, 4928.852134435972, 5202.167653175474, 5205.115130427912, 5208.114620514446, 5246.344206974129, 5250.26496290512, 4703.082898834695, 4776.474587795409, 4827.758612069312, 4838.298446725275, 4856.757162141949, 5046.621503387334, 5058.54473097423, 5060.139776237975, 5067.721275329893, 5120.641555091257, 5027.120253955616, 5164.070467315919, 5184.170532714747, 5186.0, 5190.091733946469, 4934.5312195341385, 5017.67385119966, 5019.64862459639, 5020.146575082172, 5039.420466646236, 5036.0, 5043.798248070036, 5046.268291097696, 5054.469280725618, 5097.413797413345, 4855.271709243641, 4930.359053323045, 4956.801727930842, 4965.577925876341, 5017.724025178651, 5076.746162691925, 5091.4144873338555, 5107.642465027412, 5118.462561431145, 5162.767675454688, 5002.699838009731, 5017.523335283142, 5017.874553136055, 5020.899582008413, 5064.6961182327705], "value": 4751.529996496138, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.9772728345695, 577.4283459375218, 579.3424463234234, 588.7497813429292, 593.3828818029249, 27613.72386276139, 39512.0, 40565.39151912724, 40576.79711601445, 40651.390229146586, 41206.79396603013, 41686.7915660422, 41787.0, 41797.37303940443, 41804.37293440593, 7580.658870350848, 7687.615619219045, 7851.411144164182, 10192.133668638175, 10514.631987880426, 9928.702138935843, 10030.39817610942, 10038.899611003906, 10039.397636141819, 10040.89959100407, 10044.799104017915, 10101.393916365041, 10104.89895101047, 10107.646232381869, 10114.0, 7577.924220757777, 9813.067758562926, 10087.89912100877, 10088.192944564491, 10413.53139108742, 9993.900060999369, 10063.597456101747, 10064.345817521838, 10069.0, 10070.89929100707, 37719.811400943094, 38083.4287485688, 38167.23665526674, 38178.42732359017, 38233.235335293415, 2889.436559870826, 2904.346522032547, 3041.17888170195, 3105.1771280610656, 3376.8986930391884, 28852.134435966953, 29167.70832291671, 29344.853275733698, 29986.100416987527, 30034.69965300341, 3450.3271861986923, 3481.3211423772373, 3508.947365789515, 3518.2084031093054, 3557.2529768748595, 270754.6462267676, 404457.0, 411479.0, 416943.0, 419029.0, 55622.0, 55934.0, 56351.0, 56381.71809140928, 56422.99999999918, 28759.5686064705, 28795.0, 29043.7095629041, 59246.70376648089, 59791.402085979455, 12323.69190770238, 13814.930925345308, 14009.439622415193, 14078.507252246121, 14099.0, 10289.176865850714, 10516.421596812248, 10538.051575358102, 10805.351678899291, 10807.08139808125, 18202.271909123752, 18224.36214732478, 18232.45302640923, 18242.087895605167, 18378.081095945417, 6854.34883686049, 6879.862402751917, 7026.1217347831525, 7152.392046676091, 7178.497505174692, 803.7950322667682, 814.9714759983373, 845.4842546046906, 920.8710780490736, 1024.6260115058099, 27418.725812742017, 28231.294217644725, 28363.0, 28431.43137137287, 28724.42551148965, 944.6740874398322, 949.5632009275672, 951.2342564235719, 976.3556053004983, 979.2704435195825, 14473.493427729978, 14887.0, 14913.254337283093, 15101.244937753068, 15417.383304667912, 393624.0, 398089.0, 399824.0, 400315.0, 405181.0, 50322.74838625784, 50913.49086509088, 50970.0, 51075.23387149196, 51293.7435312821, 1065.8081545321916, 1166.8191430328482, 1188.7563049574817, 1214.8238505416841, 1224.210384302138, 28451.43097138087, 29770.702292977658, 29843.0, 29956.850215748782, 30375.0, 42209.0, 42513.36229956491, 42840.35739463848, 42962.35556466593, 42968.0, 321914.0, 327639.2562334653, 327643.0, 327709.0, 328178.0, 22263.554728905656, 24113.879430603436, 24865.87567062153, 24961.0, 26290.21129366122, 41963.0, 42044.36933445939, 42060.57939420567, 42957.355639664805, 43011.78494107509, 35945.64054359423, 36340.09149771277, 36860.0, 36871.44692829663, 37323.62676373201, 35589.28821423609, 36319.455208172425, 36337.454938176474, 36464.453033203994, 36910.26179476449, 35270.64729352674, 35785.46321805227, 36091.639083608825, 36397.636023639425, 36717.0, 31685.20786980344, 32854.0, 33203.335933280716, 33261.833690831394, 33329.66670333266, 24940.75059249384, 25126.748732512442, 25749.227523174333, 25944.221673349828, 26405.603915940894], "value": 18197.0814167719, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.2795704290719, 381.5497712699015, 382.6231162305129, 388.3204392313451, 394.2765026176965, 16454.588635284108, 17227.0, 17367.739483907735, 17567.209475573596, 17573.121343932784, 15757.55757857531, 15827.287772050257, 16411.507654770376, 16596.66806663866, 16617.83382166178, 4560.635149188065, 4734.479207287196, 4786.593139583139, 4787.8563643090765, 4792.376990991166, 3528.629493903129, 5274.208868669692, 5561.304836895388, 5562.8609284768, 5580.497755202031, 5421.241026256307, 5552.0839061555, 5559.360673522557, 5560.388357280696, 5571.470710282517, 5376.220448035033, 5547.084731019377, 5549.001179787637, 5550.77796888124, 5550.888982220333, 3389.1357703785625, 3587.6950459211, 3588.3002814451193, 3619.366610843092, 5029.572486338666, 11486.540538378455, 11761.235519691192, 11900.642980710592, 11910.702232444171, 11912.106592005634, 1831.7985021647607, 1909.1282670799249, 1937.5543624966197, 1938.5638231397822, 2251.6397376419695, 8765.167309105625, 8956.910430895738, 9015.729528114101, 9025.41334813235, 9512.048795120501, 1689.915504224784, 1740.321274702867, 1753.824617538236, 1766.1345940489196, 1781.4210381625894, 64656.353436465506, 65407.34592654108, 65503.67248163729, 65849.3415065848, 67507.32492675059, 9953.153981911619, 10111.39331640104, 10140.949295253477, 10431.947840260902, 10506.579736810594, 13988.58034258974, 14020.509282175075, 14112.364943577564, 14121.293935303194, 14123.576292711236, 6977.686004129826, 7206.171290301682, 7220.3140701633265, 7236.710531578783, 7289.198188199294, 6525.053867189231, 6605.8348541285895, 6713.2279787824045, 6727.024581435664, 6818.2159051708695, 4431.512533621299, 4443.666724995638, 4526.207913615104, 4576.061907308994, 4588.609968152745, 1659.5270347950775, 1663.875209359303, 1783.7681101456728, 1808.9276428942694, 1871.5257870728067, 804.7625950344545, 843.7384410832539, 860.5525126933959, 913.584319134792, 945.9621615135455, 15548.378064877505, 16198.595035124215, 16953.576160596083, 16954.660906781795, 17285.91357043207, 847.4872702015192, 853.8249658819927, 898.2903506230135, 900.9234215091791, 931.902150274225, 8791.340649451316, 9561.760955976017, 9617.855732164024, 9631.518424078768, 9695.806083878282, 357940.0, 360328.0, 360817.0, 367443.0, 372561.0, 74020.0, 75188.0, 76450.61774691091, 76523.61738191273, 77155.61422192852, 883.7481317824389, 889.6574818694849, 897.8024834536392, 912.1653686876434, 916.9495677737789, 14768.187749673441, 14807.703845922806, 14906.77639835425, 15117.848821512083, 15135.545933622008, 32641.0, 33433.16417089592, 35764.82117589395, 35813.0, 36662.90011299666, 49219.0, 49244.75377623089, 49452.0, 49479.75260123676, 50090.49909501004, 7571.3564347031115, 7716.2669546393, 7789.5715735635085, 7916.4062695299235, 7923.84152316962, 11294.152938529807, 11839.467223975114, 11935.104867134825, 11963.940180299043, 12092.214006089576, 9994.750131246778, 10049.0, 10067.446290454096, 10345.37927724339, 10499.842502362319, 5602.747876345656, 10432.217583681102, 10601.41692206936, 10750.73123171927, 10760.784784304427, 10275.7431064224, 10465.215108866712, 10646.361218326925, 10897.237193396702, 10915.39965301916, 7830.09953855314, 7858.685652574061, 7885.487443316166, 7931.361499084045, 8004.599770011592, 8077.27304542594, 9554.52227388614, 10639.202059845387, 10652.73368165771, 10654.0], "value": 7931.676615733807, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1223.0949097667717, 1381.2886363522787, 1390.4229744655966, 1470.595586213791, 1672.1054235983743, 6869.175698916125, 7794.727184548535, 8040.758777236692, 8047.91952080479, 8285.42002059856, 7968.322692571124, 8127.3091787198155, 8130.593470326489, 8131.756047318575, 8150.103488616248, 2125.6705210692367, 2148.8495805293637, 2154.429076294783, 2155.3103007037753, 2170.3488953313945, 2109.4726318420394, 2144.5818065477238, 2174.1629472653062, 2180.1715348167672, 2180.9127634894585, 2100.390886642872, 2112.3768488295914, 2119.480727221825, 2126.479012641897, 2141.4432247615578, 2074.6576814825535, 2084.291340944079, 2090.1639344262267, 2093.005822234434, 2097.4651463876767, 1989.1247850945538, 2044.1005957378707, 2045.2432599938118, 2046.3451695457459, 2049.6822992436196, 7919.445638805286, 8111.188881111901, 8137.389695772841, 8185.427020108595, 8186.345092392594, 4613.354130421743, 4761.8095276188915, 4769.499202583714, 4772.188727916263, 4779.545943135397, 2781.5410457274525, 2886.797924145311, 2945.7348838604416, 2975.1372102090368, 2982.701729827, 892.6429428228696, 903.5121034641352, 912.7124955639019, 922.2207234886511, 934.8317302885478, 11261.493232804543, 11332.263402878787, 11366.545338186463, 11373.033292170176, 11403.942980285046, 4043.2722110020477, 4140.979295103505, 4249.87250382489, 4254.595813397722, 4254.829806807755, 8796.516191609395, 8919.464832110094, 8927.24118449926, 8929.374943753875, 8929.910700893039, 4469.642428605704, 4546.0, 4550.431196100488, 4552.0668263006, 4553.658475614342, 3720.8697695580527, 4215.59951804578, 4225.091605304874, 4292.89267768302, 4361.411209486742, 3452.4130897747445, 3466.168119651316, 3546.858125674944, 3566.8038257896064, 3572.231970126383, 1039.8180318444242, 1047.4239168457318, 1049.6431213387484, 1050.1231471721046, 1052.8420736889527, 782.2763943352377, 838.8406202821444, 856.9657213711382, 876.3952872517942, 881.0176653031823, 5189.948100519022, 5358.27663265462, 5404.297441332602, 5441.374241962146, 5443.673379597237, 402.55115546165814, 409.8626959968444, 412.36289932055047, 413.1736526946108, 415.2297488159481, 3579.480975258573, 3658.359787037258, 3669.229461813049, 3701.4262789267705, 3734.8319325630414, 9621.663241786504, 10193.082622563856, 10200.846987295197, 10205.183585313158, 10268.075873171301, 9969.900300997042, 10113.494325283706, 10183.592656293666, 10184.898151018395, 10187.898121018696, 7259.709611615476, 7364.631768411558, 7386.0, 7386.667599957907, 7449.85100297991, 5115.667481613683, 5182.53357197854, 5225.843224703265, 5332.733363331896, 5335.786568537215, 9132.49771262587, 9163.129502697233, 9185.081491850762, 9361.578728957349, 9419.62321507132, 9478.099580539838, 9579.808403832023, 9595.808083838145, 9644.180244679, 9672.806543869225, 5838.2702162229725, 6249.96875015622, 6384.521160912857, 6585.078089067631, 6659.866802664016, 7611.733589324347, 7632.923670763444, 7669.693212271447, 7690.307872291521, 7697.576633285223, 6536.0, 6683.264840867403, 6753.594784312957, 6783.491238157257, 6896.4827637926355, 6613.305602911817, 6632.602043877383, 6640.169978752656, 6715.966420167868, 6801.081853949851, 6303.905441418291, 6350.428461438492, 6390.360963903572, 6403.263624683034, 6403.583767055313, 4563.977180114078, 4698.0, 4734.05318936221, 4803.1114243864995, 4847.054824309226, 4546.818127274872, 4617.676762626584, 4662.976685116552, 4793.592544633745, 4809.855704328876], "value": 4065.3201577425402, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.50150249084027, 304.62987470223675, 306.4147478316415, 310.36685162268975, 313.8415100374311, 4967.428745694247, 4969.2049272116465, 4985.651004429691, 5003.099442100421, 5020.322256495372, 4926.137925862978, 4928.285398617199, 4943.480934501879, 4947.950520494794, 4948.777305021274, 3697.7966211858406, 3755.793431361274, 3768.4158955361827, 3855.4795102661064, 3903.941440878389, 3779.0, 3824.2160357126722, 3826.9043273918096, 3885.708571857108, 3907.2966865964113, 3687.2072504411544, 3815.866444674437, 3844.8462061517507, 3850.306944749944, 3854.961450385488, 3574.660407261306, 3768.020314718179, 3778.4332350147424, 3801.4107813288983, 3872.283627528916, 3422.7946323220685, 3424.760266781326, 3425.3320602482527, 3426.674465925733, 3429.537012503305, 4771.308160316735, 4775.4241100436775, 4812.205986012304, 4825.348577941968, 4831.05794370098, 4206.831726730927, 4413.16149931512, 4415.337699345092, 4418.64650827933, 4429.247028005247, 5095.655998240776, 5129.307328581596, 5132.897342053176, 5146.228065790124, 5164.406093299243, 3782.981085094557, 3793.6016718244737, 3797.063497616208, 3797.905052373713, 3810.90472738181, 5188.0, 5409.9459005409835, 5432.266644003049, 5448.673079615236, 5479.863003424946, 3841.9231615367535, 3848.8652897148463, 3872.9419058714143, 3873.922521549553, 3897.629725176104, 3935.2326296372507, 3944.7179666608467, 3950.8617198398492, 3953.8616148435244, 3957.1689945111275, 4326.178026175016, 4421.292593185075, 4451.643868490513, 4471.575200355961, 4472.418585583853, 5030.2957585938, 5086.456771614193, 5098.413682426494, 5111.309973153651, 5120.564751996122, 1330.4944121233868, 1353.1610401551102, 1353.5939218234687, 1355.9254241016642, 1367.3710093357167, 842.6349314111179, 883.2713011765319, 886.2776836877924, 890.9465432073966, 892.790194304338, 4343.5656434356315, 4488.663350248745, 4635.58279754817, 4648.256278995412, 4666.183417901853, 5326.387465441447, 5327.493888080626, 5358.142697168434, 5365.946340536622, 5379.354477462652, 4574.794134263966, 4598.448186217675, 4645.535446455395, 4672.135654903854, 4684.5549672781035, 2634.5916382960672, 2783.707710690389, 2810.4800611886867, 2810.592464092736, 2826.547752359613, 4969.35398398206, 4983.825566105169, 4989.650724449326, 4991.777014631366, 5017.7491125443585, 5274.815381461707, 5423.538999185034, 5424.783008679688, 5434.972825135849, 5441.0, 5004.749762511859, 5006.724630145304, 5048.545630893237, 5068.873278168076, 5075.593952483792, 5290.338707661543, 5311.309529761261, 5318.202269659582, 5331.413544510023, 5342.171963345688, 4927.778249978831, 5128.0000399921655, 5204.193350030751, 5214.504622060898, 5222.164453687392, 5016.896282817775, 5034.370703662043, 5046.798128074983, 5049.570786483043, 5067.695938243717, 3390.8474118664226, 3471.2016236265295, 3481.321142377313, 3496.8950931472095, 3501.2997400520508, 4568.474625417986, 4767.189577771718, 4779.665423420466, 4795.681187673417, 4798.928016079692, 4570.840020599396, 4608.976955115337, 4620.19812273207, 4643.976780116078, 4654.48800631937, 4638.814447422065, 4645.5354464553275, 4694.3427920090535, 4712.50518695532, 4740.762961851825, 4209.463545805697, 4502.729836209838, 4503.581371867851, 4541.774530480107, 4577.237763461025, 4666.533346665306, 4927.852164435073, 5089.974550127374, 5142.922856157086, 5148.742562871917, 4995.900081998267, 4999.500049994971, 5024.271480635361, 5066.797328106834, 5078.0], "value": 3846.263093968881, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.2848311652228, 653.2683394598051, 661.8047675935599, 682.6889585510276, 719.1837264704559, 12571.24572525648, 12950.48198072076, 12990.870091299095, 13020.804687929665, 13033.674158146052, 12002.079147549506, 12040.397980101005, 12820.230786152837, 13191.14257573257, 13289.667758306046, 629.3234772619452, 772.3010675338827, 787.9960600196991, 801.6673080671515, 805.0741647105846, 792.5522080024797, 810.0643756461296, 810.116972499975, 811.0956283743642, 811.2536466450879, 845.4800297816829, 849.3884403229696, 849.9915000849974, 849.9957500212521, 850.1413572291999, 652.1359199061263, 803.4978138663336, 831.0442990560842, 848.707196017373, 848.7750746052301, 614.5544480251826, 615.230961298377, 615.5014438304987, 615.5106690181317, 615.6060121522229, 12695.301758403284, 12738.554150604685, 12789.680257993532, 12825.35873206336, 12830.294333811637, 12154.392280385946, 12777.23336599807, 13144.14563053408, 13198.60404187876, 13267.800982985264, 9892.060254275832, 10078.445685487368, 10270.327001214504, 10509.789804203872, 11070.225084244106, 4107.0, 4157.189348077126, 4212.599803018708, 4219.535851056381, 4350.58669426404, 50477.74761126208, 52417.0, 52613.0, 57464.71267643677, 57884.0, 10574.365538067741, 10575.576976920991, 10717.303375280582, 10879.075278601249, 11153.49809258569, 18650.067496625114, 18759.062046897874, 18766.061696915098, 18801.15394807237, 18813.341533046278, 6725.8654826903185, 6798.592084474947, 6864.107666003388, 6879.724811007603, 7004.439644828503, 3591.4612808078996, 3643.6720695137565, 3761.8307176177136, 3828.272628200689, 3870.7096967727534, 2692.9326766830986, 2808.1575527341715, 2822.181567345488, 2823.647044119485, 2835.517961946433, 478.2348242811474, 487.01622722101155, 490.17650347416685, 491.071874157842, 539.323149447441, 478.7295178224292, 484.7673116903906, 528.9365276166884, 580.2659635561018, 615.0134472393605, 8207.589620518951, 8250.339972802161, 8453.746387608258, 8594.441361311494, 8871.157240062184, 575.9827205183851, 590.0559105431362, 611.3519669150714, 613.1936503497886, 629.9118123462719, 4042.171354872244, 4155.729877557949, 4161.667066634662, 4284.186004659105, 4333.609975102256, 93254.0, 99372.0, 100422.0, 101060.49469752604, 105182.4740876306, 88825.55587222023, 89474.55262723645, 91381.0, 92050.0, 92142.0, 54026.72986635042, 66868.66565667141, 71962.28037719765, 74518.99999999891, 76343.0, 7906.486078404885, 8004.679812807655, 8005.1594582568, 8207.343412527103, 8443.704470343508, 32260.516092259106, 33793.49309760405, 45001.77499112483, 45653.315200272686, 46697.863235044795, 56727.0, 63368.683156583924, 63688.0, 65405.672971634835, 65703.34296656972, 11771.23486973344, 11975.0, 12024.278543287432, 12186.390680465764, 12523.499060037497, 12812.487500499876, 12954.0, 13015.544455943997, 13210.669733256746, 13731.725365492834, 8635.395522313378, 11219.326840389604, 11421.885781142082, 11499.712507187387, 11798.941005294919, 11563.42182890869, 11872.109591780823, 12057.51769929193, 12100.636980890587, 13218.206907585576, 12019.123141289341, 12307.247013264485, 12318.42822486432, 12564.308963007123, 12725.829560147271, 9476.573554190216, 9869.0, 9875.358101723365, 10046.899531004596, 10377.377357358582, 9023.548822558714, 9077.954610226907, 9443.362134348656, 9542.42745435276, 9578.377405468622], "value": 6579.628816330121, "unit": "score"}], "name": "dromaeo_css", "value": 6428.322021417505, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 112.0, 111.0, 113.0, 112.0, 112.0, 113.0, 112.0, 113.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 131.0, 131.0, 186.0, 134.0, 139.0, 159.0, 139.0, 186.0, 135.0], "value": 149.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 161.0, 163.0, 162.0, 163.0, 162.0, 162.0, 160.0, 160.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 77.0, 110.0, 75.0, 76.0, 76.0, 75.0, 99.0, 76.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 110.0, 86.0, 87.0, 87.0, 132.0, 86.0, 86.0, 128.0], "value": 97.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 63.0, 63.0, 65.0, 64.0, 65.0, 65.0, 64.0, 63.0], "value": 64.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 63.0, 65.0, 65.0, 64.0, 64.0, 65.0, 64.0], "value": 64.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 87.0, 85.0, 80.0, 83.0, 83.0, 83.0, 92.0, 82.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 140.0, 138.0, 130.0, 128.0, 130.0, 127.0, 145.0, 133.0, 141.0], "value": 134.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 174.0, 169.0, 173.0, 170.0, 174.0, 166.0, 167.0, 168.0, 169.0], "value": 170.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 69.0, 67.0, 67.0, 66.0, 67.0, 66.0, 67.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1542.8999999999999, "alertThreshold": 2.0}]} 15:47:16 INFO - Return code: 0 15:47:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:47:16 INFO - # TBPL SUCCESS # 15:47:16 INFO - Running post-action listener: _resource_record_post_action 15:47:16 INFO - ##### 15:47:16 INFO - ##### Finished run-tests step (success) 15:47:16 INFO - ##### 15:47:16 INFO - Running post-run listener: _resource_record_post_run 15:47:16 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 541937664; Read time: 12; Write time: 1044768 15:47:16 INFO - TinderboxPrint: CPU usage
13.2% 15:47:16 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 15:47:16 INFO - TinderboxPrint: I/O write bytes / time
541,937,664 / 1,044,768 15:47:16 INFO - TinderboxPrint: CPU idle
8,334.6 (86.7%) 15:47:16 INFO - TinderboxPrint: CPU user
1,218.1 (12.7%) 15:47:16 INFO - TinderboxPrint: Swap in / out
0 / 0 15:47:16 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 246362112; Read time: 0; Write time: 507240 15:47:16 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295575552; Read time: 12; Write time: 537528 15:47:16 INFO - Running post-run listener: _upload_blobber_files 15:47:16 INFO - Blob upload gear active. 15:47:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:47:16 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:47:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:47:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:47:17 INFO - (blobuploader) - INFO - Open directory for files ... 15:47:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:47:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:47:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:47:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:47:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:47:18 INFO - (blobuploader) - INFO - Done attempting. 15:47:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:47:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:47:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:47:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:47:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:47:18 INFO - (blobuploader) - INFO - Done attempting. 15:47:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:47:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:47:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:47:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:47:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:47:22 INFO - (blobuploader) - INFO - Done attempting. 15:47:22 INFO - (blobuploader) - INFO - Iteration through files over. 15:47:22 INFO - Return code: 0 15:47:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:47:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:47:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f0cda18fc95ef4ced89f51b561b340a7872fea4e6a87a30cc4fc82a556fe77f4bd72a284ce933adfba1336308b3dd96ba76ef6b19ad5404ef4c894fb4f6ec060", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ae59cc2fd57fb00cde7c713a8feaaf77559dd93460232779fb8041f031190633de065b24e9a041e14de541d02af93acda87295f508093902e52f0345fe739bc8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f6889e202bb7492cde8379d6cd30ae06a88bda21d56d5a1726f9683776b485eaccab3c24a6f358ded4af91d3fd99afd68fd6a4669f77b92585db241df94a62ac"} 15:47:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:47:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:47:22 INFO - Contents: 15:47:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f0cda18fc95ef4ced89f51b561b340a7872fea4e6a87a30cc4fc82a556fe77f4bd72a284ce933adfba1336308b3dd96ba76ef6b19ad5404ef4c894fb4f6ec060", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ae59cc2fd57fb00cde7c713a8feaaf77559dd93460232779fb8041f031190633de065b24e9a041e14de541d02af93acda87295f508093902e52f0345fe739bc8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f6889e202bb7492cde8379d6cd30ae06a88bda21d56d5a1726f9683776b485eaccab3c24a6f358ded4af91d3fd99afd68fd6a4669f77b92585db241df94a62ac"} 15:47:22 INFO - Running post-run listener: copy_logs_to_upload_dir 15:47:22 INFO - Copying logs to upload dir... 15:47:22 INFO - mkdir: /builds/slave/test/build/upload/logs 15:47:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.303667 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-06-25 15:47:22.092564) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-25 15:47:22.096748) ========= 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=5cf47e208febbcd81da23b2e0000026f-1466893251.605493-755333358 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/f0cda18fc95ef4ced89f51b561b340a7872fea4e6a87a30cc4fc82a556fe77f4bd72a284ce933adfba1336308b3dd96ba76ef6b19ad5404ef4c894fb4f6ec060", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ae59cc2fd57fb00cde7c713a8feaaf77559dd93460232779fb8041f031190633de065b24e9a041e14de541d02af93acda87295f508093902e52f0345fe739bc8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f6889e202bb7492cde8379d6cd30ae06a88bda21d56d5a1726f9683776b485eaccab3c24a6f358ded4af91d3fd99afd68fd6a4669f77b92585db241df94a62ac"} build_url:https://queue.taskcluster.net/v1/task/Vens87spTlKWbAsul_A8xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011276 build_url: 'https://queue.taskcluster.net/v1/task/Vens87spTlKWbAsul_A8xQ/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/f0cda18fc95ef4ced89f51b561b340a7872fea4e6a87a30cc4fc82a556fe77f4bd72a284ce933adfba1336308b3dd96ba76ef6b19ad5404ef4c894fb4f6ec060", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ae59cc2fd57fb00cde7c713a8feaaf77559dd93460232779fb8041f031190633de065b24e9a041e14de541d02af93acda87295f508093902e52f0345fe739bc8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f6889e202bb7492cde8379d6cd30ae06a88bda21d56d5a1726f9683776b485eaccab3c24a6f358ded4af91d3fd99afd68fd6a4669f77b92585db241df94a62ac"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-25 15:47:22.128306) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 15:47:22.128858) ========= 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=5cf47e208febbcd81da23b2e0000026f-1466893251.605493-755333358 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004481 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 15:47:22.210022) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-25 15:47:22.210369) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-25 15:47:22.210667) ========= ========= Total master_lag: 1.80 =========