builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-067 starttime: 1465902999.16 results: success (0) buildid: 20160614032225 builduid: bdfbdc2fcdd94a05a3c6f70515c75558 revision: 846fcdf259a5c0fdce3a4b2661feb516ed63ad67 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-14 04:16:39.159823) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-14 04:16:39.160232) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-14 04:16:39.160552) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-14 04:16:39.201121) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 04:16:39.201416) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1465901886.373116-1203290557 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-14 04:16:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-06-14 04:16:41 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.073710 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 04:16:39.290652) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 04:16:39.290977) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1465901886.373116-1203290557 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023121 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 04:16:39.340107) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-14 04:16:39.340449) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 846fcdf259a5c0fdce3a4b2661feb516ed63ad67 --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 846fcdf259a5c0fdce3a4b2661feb516ed63ad67 --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=e0e61f6f900f4dc42e3e8956000001ad-1465901886.373116-1203290557 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-14 04:16:42,069 truncating revision to first 12 chars 2016-06-14 04:16:42,069 Setting DEBUG logging. 2016-06-14 04:16:42,069 attempt 1/10 2016-06-14 04:16:42,069 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/846fcdf259a5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-14 04:16:42,749 unpacking tar archive at: fx-team-846fcdf259a5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.026947 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-14 04:16:40.380742) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-14 04:16:40.381041) ========= script_repo_revision: 846fcdf259a5c0fdce3a4b2661feb516ed63ad67 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-14 04:16:40.381427) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-14 04:16:40.381709) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-14 04:16:40.392167) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-14 04:16:40.392437) ========= /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=e0e61f6f900f4dc42e3e8956000001ad-1465901886.373116-1203290557 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:16:43 INFO - MultiFileLogger online at 20160614 04:16:43 in /builds/slave/test 04:16:43 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 04:16:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:16:43 INFO - {'append_to_log': False, 04:16:43 INFO - 'base_work_dir': '/builds/slave/test', 04:16:43 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:16:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:16:43 INFO - 'branch': 'Fx-Team-Non-PGO', 04:16:43 INFO - 'buildbot_json_path': 'buildprops.json', 04:16:43 INFO - 'config_files': ('talos/linux_config.py',), 04:16:43 INFO - 'default_actions': ('clobber', 04:16:43 INFO - 'read-buildbot-config', 04:16:43 INFO - 'download-and-extract', 04:16:43 INFO - 'populate-webroot', 04:16:43 INFO - 'create-virtualenv', 04:16:43 INFO - 'install', 04:16:43 INFO - 'run-tests'), 04:16:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:16:43 INFO - 'download_minidump_stackwalk': True, 04:16:43 INFO - 'download_symbols': 'ondemand', 04:16:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:16:43 INFO - 'tooltool.py': '/tools/tooltool.py', 04:16:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:16:43 INFO - '/tools/misc-python/virtualenv.py')}, 04:16:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:16:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:16:43 INFO - 'installer_path': 'installer.exe', 04:16:43 INFO - 'log_level': 'info', 04:16:43 INFO - 'log_name': 'talos', 04:16:43 INFO - 'log_to_console': True, 04:16:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:16:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:16:43 INFO - 'opt_config_files': (), 04:16:43 INFO - 'pip_index': False, 04:16:43 INFO - 'sps_profile': False, 04:16:43 INFO - 'sps_profile_interval': 0, 04:16:43 INFO - 'suite': 'dromaeojs', 04:16:43 INFO - 'system_bits': '32', 04:16:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:16:43 INFO - 'title': 'talos-linux64-ix-067', 04:16:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:16:43 INFO - 'use_talos_json': True, 04:16:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:16:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:16:43 INFO - 'work_dir': 'build'} 04:16:43 INFO - ##### 04:16:43 INFO - ##### Running clobber step. 04:16:43 INFO - ##### 04:16:43 INFO - Running pre-action listener: _resource_record_pre_action 04:16:43 INFO - Running main action method: clobber 04:16:43 INFO - rmtree: /builds/slave/test/build 04:16:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:16:44 INFO - Running post-action listener: _resource_record_post_action 04:16:44 INFO - ##### 04:16:44 INFO - ##### Finished clobber step (success) 04:16:44 INFO - ##### 04:16:44 INFO - ##### 04:16:44 INFO - ##### Running read-buildbot-config step. 04:16:44 INFO - ##### 04:16:44 INFO - Running pre-action listener: _resource_record_pre_action 04:16:44 INFO - Running main action method: read_buildbot_config 04:16:44 INFO - Using buildbot properties: 04:16:44 INFO - { 04:16:44 INFO - "project": "", 04:16:44 INFO - "product": "firefox", 04:16:44 INFO - "script_repo_revision": "production", 04:16:44 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:16:44 INFO - "repository": "", 04:16:44 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:16:44 INFO - "buildid": "20160614032225", 04:16:44 INFO - "pgo_build": "False", 04:16:44 INFO - "basedir": "/builds/slave/test", 04:16:44 INFO - "buildnumber": 3086, 04:16:44 INFO - "slavename": "talos-linux64-ix-067", 04:16:44 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:16:44 INFO - "platform": "ubuntu64_hw", 04:16:44 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:16:44 INFO - "branch": "fx-team", 04:16:44 INFO - "repo_path": "integration/fx-team", 04:16:44 INFO - "revision": "846fcdf259a5c0fdce3a4b2661feb516ed63ad67", 04:16:44 INFO - "stage_platform": "linux64", 04:16:44 INFO - "builduid": "bdfbdc2fcdd94a05a3c6f70515c75558", 04:16:44 INFO - "slavebuilddir": "test" 04:16:44 INFO - } 04:16:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/H30P2BUrTQGbZFm86zVoPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:16:44 INFO - Running post-action listener: _resource_record_post_action 04:16:44 INFO - ##### 04:16:44 INFO - ##### Finished read-buildbot-config step (success) 04:16:44 INFO - ##### 04:16:44 INFO - ##### 04:16:44 INFO - ##### Running download-and-extract step. 04:16:44 INFO - ##### 04:16:44 INFO - Running pre-action listener: _resource_record_pre_action 04:16:44 INFO - Running main action method: download_and_extract 04:16:44 INFO - mkdir: /builds/slave/test/build/tests 04:16: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')]} 04:16:44 INFO - https://queue.taskcluster.net/v1/task/H30P2BUrTQGbZFm86zVoPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:16:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H30P2BUrTQGbZFm86zVoPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:16:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H30P2BUrTQGbZFm86zVoPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:16:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H30P2BUrTQGbZFm86zVoPA/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 04:16:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H30P2BUrTQGbZFm86zVoPA/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 04:16:47 INFO - Downloaded 1361 bytes. 04:16:47 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:16:47 INFO - Using the following test package requirements: 04:16:47 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:16:47 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:16:47 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:16:47 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:47 INFO - u'jsshell-linux-x86_64.zip'], 04:16:47 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:16:47 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:16:47 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:16:47 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:16:47 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:16:47 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:16:47 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:16:47 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')]} 04:16:47 INFO - https://queue.taskcluster.net/v1/task/H30P2BUrTQGbZFm86zVoPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:16:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H30P2BUrTQGbZFm86zVoPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:16:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H30P2BUrTQGbZFm86zVoPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:16:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H30P2BUrTQGbZFm86zVoPA/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 04:16:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H30P2BUrTQGbZFm86zVoPA/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 04:16:48 INFO - Downloaded 22653673 bytes. 04:16:48 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'] 04:16:48 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 04:16:50 INFO - Return code: 0 04:16:50 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 04:16:50 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')]} 04:16:50 INFO - https://queue.taskcluster.net/v1/task/H30P2BUrTQGbZFm86zVoPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:16:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H30P2BUrTQGbZFm86zVoPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:16:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H30P2BUrTQGbZFm86zVoPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:16:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H30P2BUrTQGbZFm86zVoPA/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 04:16:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H30P2BUrTQGbZFm86zVoPA/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 04:16:51 INFO - Downloaded 22653673 bytes. 04:16:51 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'] 04:16:51 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 04:16:53 INFO - Return code: 0 04:16:53 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')]} 04:16:53 INFO - https://queue.taskcluster.net/v1/task/H30P2BUrTQGbZFm86zVoPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:16:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H30P2BUrTQGbZFm86zVoPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:16:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H30P2BUrTQGbZFm86zVoPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:16:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H30P2BUrTQGbZFm86zVoPA/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 04:16:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H30P2BUrTQGbZFm86zVoPA/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 04:16:55 INFO - Downloaded 14405384 bytes. 04:16:55 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'] 04:16:55 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 04:16:55 INFO - Return code: 0 04:16:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:55 INFO - https://queue.taskcluster.net/v1/task/H30P2BUrTQGbZFm86zVoPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:16:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H30P2BUrTQGbZFm86zVoPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:16:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H30P2BUrTQGbZFm86zVoPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:16:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H30P2BUrTQGbZFm86zVoPA/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 04:16:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H30P2BUrTQGbZFm86zVoPA/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 04:16:58 INFO - Downloaded 55395141 bytes. 04:16:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H30P2BUrTQGbZFm86zVoPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:16:58 INFO - mkdir: /builds/slave/test/properties 04:16:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:16:58 INFO - Writing to file /builds/slave/test/properties/build_url 04:16:58 INFO - Contents: 04:16:58 INFO - build_url:https://queue.taskcluster.net/v1/task/H30P2BUrTQGbZFm86zVoPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:16:59 INFO - Running post-action listener: _resource_record_post_action 04:16:59 INFO - Running post-action listener: set_extra_try_arguments 04:16:59 INFO - ##### 04:16:59 INFO - ##### Finished download-and-extract step (success) 04:16:59 INFO - ##### 04:16:59 INFO - ##### 04:16:59 INFO - ##### Running populate-webroot step. 04:16:59 INFO - ##### 04:16:59 INFO - Running pre-action listener: _resource_record_pre_action 04:16:59 INFO - Running main action method: populate_webroot 04:16:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:16:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:16:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:16:59 INFO - '--tppagecycles', 04:16:59 INFO - '7'], 04:16:59 INFO - 'tests': ['tsvgm']}}, 04:16:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:16:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:16:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:16:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:16:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:16:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:16:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:59 INFO - 'talos_options': ['--disable-e10s'], 04:16:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:16:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:16:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:59 INFO - 'talos_options': ['--disable-e10s'], 04:16:59 INFO - 'tests': ['damp', 'tps']}, 04:16:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:59 INFO - 'tests': ['damp', 'tps']}, 04:16:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:16:59 INFO - 'tests': ['dromaeo_dom']}, 04:16:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:16:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:16:59 INFO - 'tests': ['basic_compositor_video']}, 04:16:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:16:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:16:59 INFO - 'tests': ['a11yr', 04:16:59 INFO - 'ts_paint', 04:16:59 INFO - 'tpaint', 04:16:59 INFO - 'sessionrestore', 04:16:59 INFO - 'sessionrestore_no_auto_restore', 04:16:59 INFO - 'tabpaint']}, 04:16:59 INFO - 'other-e10s': {'tests': ['a11yr', 04:16:59 INFO - 'ts_paint', 04:16:59 INFO - 'tpaint', 04:16:59 INFO - 'sessionrestore', 04:16:59 INFO - 'sessionrestore_no_auto_restore', 04:16:59 INFO - 'tabpaint']}, 04:16:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:16:59 INFO - 'ts_paint', 04:16:59 INFO - 'tpaint', 04:16:59 INFO - 'sessionrestore', 04:16:59 INFO - 'sessionrestore_no_auto_restore', 04:16:59 INFO - 'tabpaint']}, 04:16:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:16:59 INFO - 'ts_paint', 04:16:59 INFO - 'tpaint', 04:16:59 INFO - 'sessionrestore', 04:16:59 INFO - 'sessionrestore_no_auto_restore', 04:16:59 INFO - 'tabpaint']}, 04:16:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:16:59 INFO - 'tests': ['a11yr', 04:16:59 INFO - 'ts_paint', 04:16:59 INFO - 'tpaint', 04:16:59 INFO - 'sessionrestore', 04:16:59 INFO - 'sessionrestore_no_auto_restore', 04:16:59 INFO - 'tabpaint']}, 04:16:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:16:59 INFO - 'tests': ['a11yr', 04:16:59 INFO - 'ts_paint', 04:16:59 INFO - 'tpaint', 04:16:59 INFO - 'sessionrestore', 04:16:59 INFO - 'sessionrestore_no_auto_restore', 04:16:59 INFO - 'tabpaint']}, 04:16:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:16:59 INFO - 'tests': ['tsvgx', 04:16:59 INFO - 'tsvgr_opacity', 04:16:59 INFO - 'tart', 04:16:59 INFO - 'tscrollx', 04:16:59 INFO - 'cart']}, 04:16:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:16:59 INFO - 'tsvgr_opacity', 04:16:59 INFO - 'tart', 04:16:59 INFO - 'tscrollx', 04:16:59 INFO - 'cart']}, 04:16:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:59 INFO - 'talos_options': ['--disable-e10s'], 04:16:59 INFO - 'tests': ['tp5o']}, 04:16:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:59 INFO - 'tests': ['tp5o']}, 04:16:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:59 INFO - 'talos_options': ['--disable-e10s', 04:16:59 INFO - '--xperf_path', 04:16:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:16:59 INFO - 'tests': ['tp5n']}, 04:16:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:59 INFO - 'talos_options': ['--xperf_path', 04:16:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:16:59 INFO - 'tests': ['tp5n']}}, 04:16:59 INFO - 'talos.zip': {'path': '', 04:16:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:16:59 INFO - Running post-action listener: _resource_record_post_action 04:16:59 INFO - ##### 04:16:59 INFO - ##### Finished populate-webroot step (success) 04:16:59 INFO - ##### 04:16:59 INFO - ##### 04:16:59 INFO - ##### Running create-virtualenv step. 04:16:59 INFO - ##### 04:16:59 INFO - Running pre-action listener: _resource_record_pre_action 04:16:59 INFO - Running main action method: create_virtualenv 04:16:59 INFO - Creating virtualenv /builds/slave/test/build/venv 04:16:59 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 04:16:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:16:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:16:59 INFO - Using real prefix '/usr' 04:16:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:17:00 INFO - Installing distribute.............................................................................................................................................................................................done. 04:17:02 INFO - Installing pip.................done. 04:17:02 INFO - Return code: 0 04:17:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:02 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 0x7f184aa1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf361c0>, '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 0xf370c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf37550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465901886.373116-1203290557', '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 04:17:02 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 04:17:02 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 04:17:02 INFO - Using env: {'DISPLAY': ':0', 04:17:02 INFO - 'HOME': '/home/cltbld', 04:17:02 INFO - 'LANG': 'en_US.UTF-8', 04:17:02 INFO - 'LANGUAGE': 'en_US:en', 04:17:02 INFO - 'LOGNAME': 'cltbld', 04:17:02 INFO - 'MAIL': '/var/mail/cltbld', 04:17:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:02 INFO - 'MOZ_NO_REMOTE': '1', 04:17:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:02 INFO - 'NO_EM_RESTART': '1', 04:17:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:02 INFO - 'PWD': '/builds/slave/test', 04:17:02 INFO - 'SHELL': '/bin/bash', 04:17:02 INFO - 'SHLVL': '1', 04:17:02 INFO - 'TERM': 'linux', 04:17:02 INFO - 'TMOUT': '86400', 04:17:02 INFO - 'USER': 'cltbld', 04:17:02 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465901886.373116-1203290557', 04:17:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:02 INFO - '_': '/tools/buildbot/bin/python'} 04:17:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:02 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 04:17:02 INFO - Cleaning up... 04:17:02 INFO - Return code: 0 04:17:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:02 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 0x7f184aa1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf361c0>, '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 0xf370c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf37550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465901886.373116-1203290557', '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 04:17:02 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 04:17:02 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 04:17:02 INFO - Using env: {'DISPLAY': ':0', 04:17:02 INFO - 'HOME': '/home/cltbld', 04:17:02 INFO - 'LANG': 'en_US.UTF-8', 04:17:02 INFO - 'LANGUAGE': 'en_US:en', 04:17:02 INFO - 'LOGNAME': 'cltbld', 04:17:02 INFO - 'MAIL': '/var/mail/cltbld', 04:17:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:02 INFO - 'MOZ_NO_REMOTE': '1', 04:17:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:02 INFO - 'NO_EM_RESTART': '1', 04:17:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:02 INFO - 'PWD': '/builds/slave/test', 04:17:02 INFO - 'SHELL': '/bin/bash', 04:17:02 INFO - 'SHLVL': '1', 04:17:02 INFO - 'TERM': 'linux', 04:17:02 INFO - 'TMOUT': '86400', 04:17:02 INFO - 'USER': 'cltbld', 04:17:02 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465901886.373116-1203290557', 04:17:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:02 INFO - '_': '/tools/buildbot/bin/python'} 04:17:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:02 INFO - Downloading/unpacking psutil>=3.1.1 04:17:02 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 04:17:02 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 04:17:02 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 04:17:02 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 04:17:02 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 04:17:02 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 04:17:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:17:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:17:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:17:04 INFO - Installing collected packages: psutil 04:17:04 INFO - Running setup.py install for psutil 04:17:04 INFO - building 'psutil._psutil_linux' extension 04:17:04 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 04:17:04 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 04:17:04 INFO - building 'psutil._psutil_posix' extension 04:17:04 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 04:17:04 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 04:17:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:17:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:17:04 INFO - Successfully installed psutil 04:17:04 INFO - Cleaning up... 04:17:05 INFO - Return code: 0 04:17:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:05 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 0x7f184aa1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf361c0>, '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 0xf370c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf37550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465901886.373116-1203290557', '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 04:17:05 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 04:17:05 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 04:17:05 INFO - Using env: {'DISPLAY': ':0', 04:17:05 INFO - 'HOME': '/home/cltbld', 04:17:05 INFO - 'LANG': 'en_US.UTF-8', 04:17:05 INFO - 'LANGUAGE': 'en_US:en', 04:17:05 INFO - 'LOGNAME': 'cltbld', 04:17:05 INFO - 'MAIL': '/var/mail/cltbld', 04:17:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:05 INFO - 'MOZ_NO_REMOTE': '1', 04:17:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:05 INFO - 'NO_EM_RESTART': '1', 04:17:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:05 INFO - 'PWD': '/builds/slave/test', 04:17:05 INFO - 'SHELL': '/bin/bash', 04:17:05 INFO - 'SHLVL': '1', 04:17:05 INFO - 'TERM': 'linux', 04:17:05 INFO - 'TMOUT': '86400', 04:17:05 INFO - 'USER': 'cltbld', 04:17:05 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465901886.373116-1203290557', 04:17:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:05 INFO - '_': '/tools/buildbot/bin/python'} 04:17:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:17: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 04:17: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 04:17: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 04:17: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 04:17: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 04:17: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 04:17:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:17:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:17:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:17:07 INFO - Installing collected packages: mozsystemmonitor 04:17:07 INFO - Running setup.py install for mozsystemmonitor 04:17:07 INFO - Successfully installed mozsystemmonitor 04:17:07 INFO - Cleaning up... 04:17:07 INFO - Return code: 0 04:17:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:17: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')]} 04:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17: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')]} 04:17:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f184aa1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf361c0>, '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 0xf370c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf37550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465901886.373116-1203290557', '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 04:17: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==2.5.1'] in /builds/slave/test/build 04:17: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==2.5.1 04:17:07 INFO - Using env: {'DISPLAY': ':0', 04:17:07 INFO - 'HOME': '/home/cltbld', 04:17:07 INFO - 'LANG': 'en_US.UTF-8', 04:17:07 INFO - 'LANGUAGE': 'en_US:en', 04:17:07 INFO - 'LOGNAME': 'cltbld', 04:17:07 INFO - 'MAIL': '/var/mail/cltbld', 04:17:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:07 INFO - 'MOZ_NO_REMOTE': '1', 04:17:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:07 INFO - 'NO_EM_RESTART': '1', 04:17:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:07 INFO - 'PWD': '/builds/slave/test', 04:17:07 INFO - 'SHELL': '/bin/bash', 04:17:07 INFO - 'SHLVL': '1', 04:17:07 INFO - 'TERM': 'linux', 04:17:07 INFO - 'TMOUT': '86400', 04:17:07 INFO - 'USER': 'cltbld', 04:17:07 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465901886.373116-1203290557', 04:17:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:07 INFO - '_': '/tools/buildbot/bin/python'} 04:17:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:07 INFO - Downloading/unpacking jsonschema==2.5.1 04:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:17:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:17:09 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 04:17:09 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 04:17:09 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 04:17:09 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 04:17:09 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 04:17:09 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 04:17:09 INFO - Downloading functools32-3.2.3-2.tar.gz 04:17:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:17:09 INFO - warning: no files found matching '*.txt' 04:17:09 INFO - no previously-included directories found matching 'build' 04:17:09 INFO - no previously-included directories found matching 'dist' 04:17:09 INFO - no previously-included directories found matching '.git*' 04:17:09 INFO - Installing collected packages: jsonschema, functools32 04:17:09 INFO - Running setup.py install for functools32 04:17:10 INFO - warning: no files found matching '*.txt' 04:17:10 INFO - no previously-included directories found matching 'build' 04:17:10 INFO - no previously-included directories found matching 'dist' 04:17:10 INFO - no previously-included directories found matching '.git*' 04:17:10 INFO - Successfully installed jsonschema functools32 04:17:10 INFO - Cleaning up... 04:17:10 INFO - Return code: 0 04:17:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:17:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f184aa1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf361c0>, '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 0xf370c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf37550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465901886.373116-1203290557', '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 04:17:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:17:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:17:10 INFO - Using env: {'DISPLAY': ':0', 04:17:10 INFO - 'HOME': '/home/cltbld', 04:17:10 INFO - 'LANG': 'en_US.UTF-8', 04:17:10 INFO - 'LANGUAGE': 'en_US:en', 04:17:10 INFO - 'LOGNAME': 'cltbld', 04:17:10 INFO - 'MAIL': '/var/mail/cltbld', 04:17:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:10 INFO - 'MOZ_NO_REMOTE': '1', 04:17:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:10 INFO - 'NO_EM_RESTART': '1', 04:17:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:10 INFO - 'PWD': '/builds/slave/test', 04:17:10 INFO - 'SHELL': '/bin/bash', 04:17:10 INFO - 'SHLVL': '1', 04:17:10 INFO - 'TERM': 'linux', 04:17:10 INFO - 'TMOUT': '86400', 04:17:10 INFO - 'USER': 'cltbld', 04:17:10 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465901886.373116-1203290557', 04:17:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:10 INFO - '_': '/tools/buildbot/bin/python'} 04:17:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:10 INFO - Downloading/unpacking blobuploader==1.2.4 04:17: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 04:17: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 04:17: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 04:17: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 04:17: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 04:17: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 04:17:12 INFO - Downloading blobuploader-1.2.4.tar.gz 04:17:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:17:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:17:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:12 INFO - Downloading docopt-0.6.1.tar.gz 04:17:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:17:13 INFO - Installing collected packages: blobuploader, requests, docopt 04:17:13 INFO - Running setup.py install for blobuploader 04:17:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:17:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:17:13 INFO - Running setup.py install for requests 04:17:13 INFO - Running setup.py install for docopt 04:17:13 INFO - Successfully installed blobuploader requests docopt 04:17:13 INFO - Cleaning up... 04:17:13 INFO - Return code: 0 04:17:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:17:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:13 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 0x7f184aa1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf361c0>, '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 0xf370c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf37550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465901886.373116-1203290557', '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 04:17:13 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 04:17:13 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 04:17:13 INFO - Using env: {'DISPLAY': ':0', 04:17:13 INFO - 'HOME': '/home/cltbld', 04:17:13 INFO - 'LANG': 'en_US.UTF-8', 04:17:13 INFO - 'LANGUAGE': 'en_US:en', 04:17:13 INFO - 'LOGNAME': 'cltbld', 04:17:13 INFO - 'MAIL': '/var/mail/cltbld', 04:17:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:13 INFO - 'MOZ_NO_REMOTE': '1', 04:17:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:13 INFO - 'NO_EM_RESTART': '1', 04:17:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:13 INFO - 'PWD': '/builds/slave/test', 04:17:13 INFO - 'SHELL': '/bin/bash', 04:17:13 INFO - 'SHLVL': '1', 04:17:13 INFO - 'TERM': 'linux', 04:17:13 INFO - 'TMOUT': '86400', 04:17:13 INFO - 'USER': 'cltbld', 04:17:13 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465901886.373116-1203290557', 04:17:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:13 INFO - '_': '/tools/buildbot/bin/python'} 04:17:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:17:13 INFO - Running setup.py (path:/tmp/pip-PifLpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:17:13 INFO - Running setup.py (path:/tmp/pip-9R06B_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:17:13 INFO - Running setup.py (path:/tmp/pip-METESV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:17:14 INFO - Running setup.py (path:/tmp/pip-QLdThn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:17:14 INFO - Running setup.py (path:/tmp/pip-N7l9f0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:17:14 INFO - Running setup.py (path:/tmp/pip-3yosj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:17:14 INFO - Running setup.py (path:/tmp/pip-kRFhpQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:17:14 INFO - Running setup.py (path:/tmp/pip-nc5G55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:17:14 INFO - Running setup.py (path:/tmp/pip-Gcs2KN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:17:14 INFO - Running setup.py (path:/tmp/pip-2RvIKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:17:14 INFO - Running setup.py (path:/tmp/pip-450z93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:17:14 INFO - Running setup.py (path:/tmp/pip-WeDjhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:17:14 INFO - Running setup.py (path:/tmp/pip-_IwdKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:17:14 INFO - Running setup.py (path:/tmp/pip-34RX3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:17:14 INFO - Running setup.py (path:/tmp/pip-eD7bsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:17:14 INFO - Running setup.py (path:/tmp/pip-fUJj5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:17:15 INFO - Running setup.py (path:/tmp/pip-Qx9vLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:17:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:17:15 INFO - Running setup.py install for manifestparser 04:17:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:17:15 INFO - Running setup.py install for mozcrash 04:17:15 INFO - Running setup.py install for mozdebug 04:17:15 INFO - Running setup.py install for mozdevice 04:17:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:17:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:17:15 INFO - Running setup.py install for mozfile 04:17:15 INFO - Running setup.py install for mozhttpd 04:17:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:17:15 INFO - Running setup.py install for mozinfo 04:17:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:17:15 INFO - Running setup.py install for mozInstall 04:17:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:17:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:17:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:17:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:17:15 INFO - Running setup.py install for mozleak 04:17:15 INFO - Running setup.py install for mozlog 04:17:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:17:16 INFO - Running setup.py install for moznetwork 04:17:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:17:16 INFO - Running setup.py install for mozprocess 04:17:16 INFO - Running setup.py install for mozprofile 04:17:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:17:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:17:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:17:16 INFO - Running setup.py install for mozrunner 04:17:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:17:16 INFO - Running setup.py install for mozscreenshot 04:17:16 INFO - Running setup.py install for moztest 04:17:16 INFO - Running setup.py install for mozversion 04:17:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:17:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:17:16 INFO - Cleaning up... 04:17:16 INFO - Return code: 0 04:17:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:17:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:16 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 0x7f184aa1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf361c0>, '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 0xf370c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf37550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465901886.373116-1203290557', '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 04:17:16 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 04:17:16 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 04:17:16 INFO - Using env: {'DISPLAY': ':0', 04:17:16 INFO - 'HOME': '/home/cltbld', 04:17:16 INFO - 'LANG': 'en_US.UTF-8', 04:17:16 INFO - 'LANGUAGE': 'en_US:en', 04:17:16 INFO - 'LOGNAME': 'cltbld', 04:17:16 INFO - 'MAIL': '/var/mail/cltbld', 04:17:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:16 INFO - 'MOZ_NO_REMOTE': '1', 04:17:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:16 INFO - 'NO_EM_RESTART': '1', 04:17:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:16 INFO - 'PWD': '/builds/slave/test', 04:17:16 INFO - 'SHELL': '/bin/bash', 04:17:16 INFO - 'SHLVL': '1', 04:17:16 INFO - 'TERM': 'linux', 04:17:16 INFO - 'TMOUT': '86400', 04:17:16 INFO - 'USER': 'cltbld', 04:17:16 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465901886.373116-1203290557', 04:17:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:16 INFO - '_': '/tools/buildbot/bin/python'} 04:17:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:17:17 INFO - Running setup.py (path:/tmp/pip-luc9qz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:17:17 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)) 04:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:17:17 INFO - Running setup.py (path:/tmp/pip-1yr_39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:17:17 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)) 04:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:17:17 INFO - Running setup.py (path:/tmp/pip-mZOgkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:17:17 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)) 04:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:17:17 INFO - Running setup.py (path:/tmp/pip-jRAVTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:17:17 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)) 04:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:17:17 INFO - Running setup.py (path:/tmp/pip-zlUoVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:17:17 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)) 04:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:17:17 INFO - Running setup.py (path:/tmp/pip-qCsUur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:17:17 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)) 04:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:17:17 INFO - Running setup.py (path:/tmp/pip-kjACWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:17:17 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)) 04:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:17:17 INFO - Running setup.py (path:/tmp/pip-oypuq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:17:17 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)) 04:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:17:17 INFO - Running setup.py (path:/tmp/pip-VUEhl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:17:17 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)) 04:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:17:17 INFO - Running setup.py (path:/tmp/pip-QWp1pA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:17:17 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)) 04:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:17:17 INFO - Running setup.py (path:/tmp/pip-qadyZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:17:17 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)) 04:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:17:17 INFO - Running setup.py (path:/tmp/pip-1MJVhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:17:18 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)) 04:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:17:18 INFO - Running setup.py (path:/tmp/pip-yhKMlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:17:18 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)) 04:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:17:18 INFO - Running setup.py (path:/tmp/pip-5Vakq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:17:18 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)) 04:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:17:18 INFO - Running setup.py (path:/tmp/pip-mSGzRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:17:18 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)) 04:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:17:18 INFO - Running setup.py (path:/tmp/pip-qwLruc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:17:18 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)) 04:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:17:18 INFO - Running setup.py (path:/tmp/pip-WkhSa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:17:18 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)) 04:17:18 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)) 04:17:18 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)) 04:17:18 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)) 04:17:18 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)) 04:17:18 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)) 04:17:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:20 INFO - Downloading blessings-1.6.tar.gz 04:17:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:17:20 INFO - Installing collected packages: blessings 04:17:20 INFO - Running setup.py install for blessings 04:17:20 INFO - Successfully installed blessings 04:17:20 INFO - Cleaning up... 04:17:20 INFO - Return code: 0 04:17:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:17:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:17:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:17:20 INFO - Reading from file tmpfile_stdout 04:17:20 INFO - Current package versions: 04:17:20 INFO - argparse == 1.2.1 04:17:20 INFO - blessings == 1.6 04:17:20 INFO - blobuploader == 1.2.4 04:17:20 INFO - docopt == 0.6.1 04:17:20 INFO - functools32 == 3.2.3-2 04:17:20 INFO - jsonschema == 2.5.1 04:17:20 INFO - manifestparser == 1.1 04:17:20 INFO - mozInstall == 1.12 04:17:20 INFO - mozcrash == 0.17 04:17:20 INFO - mozdebug == 0.1 04:17:20 INFO - mozdevice == 0.48 04:17:20 INFO - mozfile == 1.2 04:17:20 INFO - mozhttpd == 0.7 04:17:20 INFO - mozinfo == 0.9 04:17:20 INFO - mozleak == 0.1 04:17:20 INFO - mozlog == 3.2 04:17:20 INFO - moznetwork == 0.27 04:17:20 INFO - mozprocess == 0.22 04:17:20 INFO - mozprofile == 0.28 04:17:20 INFO - mozrunner == 6.11 04:17:20 INFO - mozscreenshot == 0.1 04:17:20 INFO - mozsystemmonitor == 0.3 04:17:20 INFO - moztest == 0.7 04:17:20 INFO - mozversion == 1.4 04:17:20 INFO - psutil == 3.1.1 04:17:20 INFO - requests == 1.2.3 04:17:20 INFO - wsgiref == 0.1.2 04:17:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:17: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')]} 04:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17: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')]} 04:17:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:20 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 0x7f184aa1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf361c0>, '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 0xf370c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf37550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465901886.373116-1203290557', '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 04:17:20 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 04:17:20 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 04:17:20 INFO - Using env: {'DISPLAY': ':0', 04:17:20 INFO - 'HOME': '/home/cltbld', 04:17:20 INFO - 'LANG': 'en_US.UTF-8', 04:17:20 INFO - 'LANGUAGE': 'en_US:en', 04:17:20 INFO - 'LOGNAME': 'cltbld', 04:17:20 INFO - 'MAIL': '/var/mail/cltbld', 04:17:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:20 INFO - 'MOZ_NO_REMOTE': '1', 04:17:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:20 INFO - 'NO_EM_RESTART': '1', 04:17:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:20 INFO - 'PWD': '/builds/slave/test', 04:17:20 INFO - 'SHELL': '/bin/bash', 04:17:20 INFO - 'SHLVL': '1', 04:17:20 INFO - 'TERM': 'linux', 04:17:20 INFO - 'TMOUT': '86400', 04:17:20 INFO - 'USER': 'cltbld', 04:17:20 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465901886.373116-1203290557', 04:17:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:20 INFO - '_': '/tools/buildbot/bin/python'} 04:17:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:20 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)) 04:17:20 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)) 04:17:20 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)) 04:17:20 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)) 04:17:20 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)) 04:17:20 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)) 04:17:20 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)) 04:17:20 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)) 04:17:20 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)) 04:17:20 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)) 04:17:20 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)) 04:17:20 INFO - Cleaning up... 04:17:20 INFO - Return code: 0 04:17:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:17: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')]} 04:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17: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')]} 04:17:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:20 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 0x7f184aa1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf361c0>, '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 0xf370c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf37550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465901886.373116-1203290557', '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 04:17:20 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 04:17:20 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 04:17:20 INFO - Using env: {'DISPLAY': ':0', 04:17:20 INFO - 'HOME': '/home/cltbld', 04:17:20 INFO - 'LANG': 'en_US.UTF-8', 04:17:20 INFO - 'LANGUAGE': 'en_US:en', 04:17:20 INFO - 'LOGNAME': 'cltbld', 04:17:20 INFO - 'MAIL': '/var/mail/cltbld', 04:17:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:20 INFO - 'MOZ_NO_REMOTE': '1', 04:17:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:20 INFO - 'NO_EM_RESTART': '1', 04:17:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:20 INFO - 'PWD': '/builds/slave/test', 04:17:20 INFO - 'SHELL': '/bin/bash', 04:17:20 INFO - 'SHLVL': '1', 04:17:20 INFO - 'TERM': 'linux', 04:17:20 INFO - 'TMOUT': '86400', 04:17:20 INFO - 'USER': 'cltbld', 04:17:20 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465901886.373116-1203290557', 04:17:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:20 INFO - '_': '/tools/buildbot/bin/python'} 04:17:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:17:21 INFO - Cleaning up... 04:17:21 INFO - Return code: 0 04:17:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:17:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f184aa1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf361c0>, '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 0xf370c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf37550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465901886.373116-1203290557', '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 04:17:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:17:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:17:21 INFO - Using env: {'DISPLAY': ':0', 04:17:21 INFO - 'HOME': '/home/cltbld', 04:17:21 INFO - 'LANG': 'en_US.UTF-8', 04:17:21 INFO - 'LANGUAGE': 'en_US:en', 04:17:21 INFO - 'LOGNAME': 'cltbld', 04:17:21 INFO - 'MAIL': '/var/mail/cltbld', 04:17:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:21 INFO - 'MOZ_NO_REMOTE': '1', 04:17:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:21 INFO - 'NO_EM_RESTART': '1', 04:17:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:21 INFO - 'PWD': '/builds/slave/test', 04:17:21 INFO - 'SHELL': '/bin/bash', 04:17:21 INFO - 'SHLVL': '1', 04:17:21 INFO - 'TERM': 'linux', 04:17:21 INFO - 'TMOUT': '86400', 04:17:21 INFO - 'USER': 'cltbld', 04:17:21 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465901886.373116-1203290557', 04:17:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:21 INFO - '_': '/tools/buildbot/bin/python'} 04:17:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:21 INFO - Downloading/unpacking flake8 04:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:17:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:17:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:17:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:17:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:17:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:17:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:17:23 INFO - no previously-included directories found matching 'docs/_build' 04:17:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:17:24 INFO - Running setup.py install for pep8 04:17:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:17:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:17:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:17:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:17:24 INFO - no previously-included directories found matching 'docs/_build' 04:17:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:17:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:17:24 INFO - Cleaning up... 04:17:24 INFO - Return code: 0 04:17:24 INFO - Running post-action listener: _resource_record_post_action 04:17:24 INFO - Running post-action listener: _start_resource_monitoring 04:17:24 INFO - Starting resource monitoring. 04:17:24 INFO - ##### 04:17:24 INFO - ##### Finished create-virtualenv step (success) 04:17:24 INFO - ##### 04:17:24 INFO - ##### 04:17:24 INFO - ##### Running install step. 04:17:24 INFO - ##### 04:17:24 INFO - Running pre-action listener: _resource_record_pre_action 04:17:24 INFO - Running main action method: install 04:17:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:17:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:17:24 INFO - Reading from file tmpfile_stdout 04:17:24 INFO - Detecting whether we're running mozinstall >=1.0... 04:17:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:17:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:17:24 INFO - Reading from file tmpfile_stdout 04:17:24 INFO - Output received: 04:17:24 INFO - Usage: mozinstall [options] installer 04:17:24 INFO - Options: 04:17:24 INFO - -h, --help show this help message and exit 04:17:24 INFO - -d DEST, --destination=DEST 04:17:24 INFO - Directory to install application into. [default: 04:17:24 INFO - "/builds/slave/test"] 04:17:24 INFO - --app=APP Application being installed. [default: firefox] 04:17:24 INFO - mkdir: /builds/slave/test/build/application 04:17:24 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'] 04:17:24 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 04:17:40 INFO - Reading from file tmpfile_stdout 04:17:40 INFO - Output received: 04:17:40 INFO - /builds/slave/test/build/application/firefox/firefox 04:17:40 INFO - Running post-action listener: _resource_record_post_action 04:17:40 INFO - ##### 04:17:40 INFO - ##### Finished install step (success) 04:17:40 INFO - ##### 04:17:40 INFO - ##### 04:17:40 INFO - ##### Running run-tests step. 04:17:40 INFO - ##### 04:17:40 INFO - Running pre-action listener: _resource_record_pre_action 04:17:40 INFO - Running main action method: run_tests 04:17:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:17:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:17:40 INFO - Python 2.7.3 04:17:40 INFO - Return code: 0 04:17:40 INFO - grabbing minidump binary from tooltool 04:17:40 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')]} 04:17:40 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 0xf361c0>, '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 0xf370c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf37550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:17:40 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 04:17:40 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 04:17:40 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 04:17:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:17:40 INFO - Return code: 0 04:17:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:17:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:17:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:17:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:17:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:17:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:17:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:17:41 INFO - Return code: 0 04:17:41 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/H30P2BUrTQGbZFm86zVoPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 04:17:41 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/H30P2BUrTQGbZFm86zVoPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 04:17:41 INFO - Using env: {'DISPLAY': ':0', 04:17:41 INFO - 'HOME': '/home/cltbld', 04:17:41 INFO - 'LANG': 'en_US.UTF-8', 04:17:41 INFO - 'LANGUAGE': 'en_US:en', 04:17:41 INFO - 'LOGNAME': 'cltbld', 04:17:41 INFO - 'MAIL': '/var/mail/cltbld', 04:17:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:17:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:41 INFO - 'MOZ_NO_REMOTE': '1', 04:17:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:17:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:41 INFO - 'NO_EM_RESTART': '1', 04:17:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:41 INFO - 'PWD': '/builds/slave/test', 04:17:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:17:41 INFO - 'SHELL': '/bin/bash', 04:17:41 INFO - 'SHLVL': '1', 04:17:41 INFO - 'TERM': 'linux', 04:17:41 INFO - 'TMOUT': '86400', 04:17:41 INFO - 'USER': 'cltbld', 04:17:41 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465901886.373116-1203290557', 04:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:41 INFO - '_': '/tools/buildbot/bin/python'} 04:17:41 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/H30P2BUrTQGbZFm86zVoPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 04:17:41 INFO - mozversion application_buildid: 20160614032225 04:17:41 INFO - mozversion application_changeset: 846fcdf259a5c0fdce3a4b2661feb516ed63ad67 04:17:41 INFO - mozversion application_display_name: Nightly 04:17:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:17:41 INFO - mozversion application_name: Firefox 04:17:41 INFO - mozversion application_remotingname: firefox 04:17:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:17:41 INFO - mozversion application_vendor: Mozilla 04:17:41 INFO - mozversion application_version: 50.0a1 04:17:41 INFO - mozversion platform_buildid: 20160614032225 04:17:41 INFO - mozversion platform_changeset: 846fcdf259a5c0fdce3a4b2661feb516ed63ad67 04:17:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:17:41 INFO - mozversion platform_version: 50.0a1 04:17:41 INFO - using testdate: 1465903061 04:17:41 INFO - actual date: 1465903061 04:17:41 INFO - starting webserver on 'localhost:36549' 04:17:41 INFO - SUITE-START | Running 2 tests 04:17:41 INFO - TEST-START | dromaeo_css 04:17:41 INFO - operating with platform_type : linux_ 04:17:41 INFO - Initialising browser for dromaeo_css test... 04:17:41 INFO - TEST-INFO | started process 8616 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKXPnYg/profile http://localhost:36549/getInfo.html) 04:17:45 INFO - PROCESS | 8616 | __metrics Screen width/height:1600/1200 04:17:45 INFO - PROCESS | 8616 | colorDepth:24 04:17:45 INFO - PROCESS | 8616 | Browser inner width/height: 1024/697 04:17:45 INFO - PROCESS | 8616 | __metrics 04:17:46 INFO - PROCESS | 8616 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:17:46 INFO - PROCESS | 8616 | console.error: PushService: 04:17:46 INFO - PROCESS | 8616 | stateChangeProcessEnqueue: Error transitioning state 04:17:46 INFO - PROCESS | 8616 | UnknownError 04:17:47 INFO - TEST-INFO | 8616: exit 0 04:17:47 INFO - Browser initialized. 04:17:47 INFO - Running cycle 1/1 for dromaeo_css test... 04:17:47 INFO - TEST-INFO | started process 8701 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKXPnYg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:17:59 INFO - PROCESS | 8701 | RSS: Main: 175550464 04:17:59 INFO - PROCESS | 8701 | 04:18:51 INFO - PROCESS | 8701 | 1465903131507 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] 04:21:02 INFO - PROCESS | 8701 | Cycle 1(1): loaded http://localhost:36549/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36549/tests/dromaeo/cssquery-ext.html) 04:21:04 INFO - PROCESS | 8701 | RSS: Main: 292917248 04:21:04 INFO - PROCESS | 8701 | 04:24:06 INFO - PROCESS | 8701 | Cycle 1(1): loaded http://localhost:36549/tests/dromaeo/cssquery-ext.html (next: http://localhost:36549/tests/dromaeo/cssquery-jquery.html) 04:24:07 INFO - PROCESS | 8701 | RSS: Main: 248729600 04:24:07 INFO - PROCESS | 8701 | 04:27:09 INFO - PROCESS | 8701 | Cycle 1(1): loaded http://localhost:36549/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36549/tests/dromaeo/cssquery-mootools.html) 04:27:10 INFO - PROCESS | 8701 | RSS: Main: 258699264 04:27:10 INFO - PROCESS | 8701 | 04:30:12 INFO - PROCESS | 8701 | Cycle 1(1): loaded http://localhost:36549/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36549/tests/dromaeo/cssquery-prototype.html) 04:30:13 INFO - PROCESS | 8701 | RSS: Main: 254312448 04:30:13 INFO - PROCESS | 8701 | 04:33:16 INFO - PROCESS | 8701 | Cycle 1(1): loaded http://localhost:36549/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36549/tests/dromaeo/cssquery-yui.html) 04:33:16 INFO - PROCESS | 8701 | RSS: Main: 239095808 04:33:16 INFO - PROCESS | 8701 | 04:36:19 INFO - PROCESS | 8701 | Cycle 1(1): loaded http://localhost:36549/tests/dromaeo/cssquery-yui.html (next: http://localhost:36549/tests/dromaeo/cssquery-dojo.html) 04:36:19 INFO - PROCESS | 8701 | RSS: Main: 298934272 04:36:19 INFO - PROCESS | 8701 | 04:36:19 INFO - PROCESS | 8701 | __start_tp_report 04:36:19 INFO - PROCESS | 8701 | _x_x_mozilla_page_load 04:36:19 INFO - PROCESS | 8701 | _x_x_mozilla_page_load_details 04:36:19 INFO - PROCESS | 8701 | |i|pagename|runs| 04:36:19 INFO - PROCESS | 8701 | |0;dojo.html;2641.2868525498116;2668.4129491511862;2695.433958868636;2699.2172270041688;2701;4521.977390113045;4577.702449340799;4770.7376094314795;4838.371011768465;4897.461279259279;4628.884277893055;4652.651051171168;4729.8817529561775;4813.061453016663;4856.077345304389;4370.584794444539;4383.035732138925;4399.076193999264;4465.68740188187;4537.137943790669;4417.624501917341;4494.730316181023;4534.954650453503;4551.408316918796;4560.156371071346;4259.318509038539;4462.308342206963;4491.056878055612;4512.864614061567;4519.683622146451;4253.787310634456;4311.784410779448;4331.263685173528;4356.237658409797;4399.846005389796;4289.849855255083;4357.891052723676;4381.255186618282;4422.823087076513;4422.911541769179;4604.88487787808;4766.142094423002;4780.450248221429;4803.135435621587;4808.35087263222;5065.974670126662;5144.3312369392115;5148.6910785353;5208.583313334962;5212.270282160501;5180.067587834188;5192;5213.322268105122;5225.555827754645;5234.895302093937;4597.793099310539;4760.64295177863;4816.807327706888;4857.635677324215;4864.221724524059;5204.193350030751;5261.3686357637325;5270.209468579744;5276.63063585553;5282.392524859691;5012.774425150877;5051;5058.089543882136;5061.114304996611;5065.493450654905;4899.436564795023;5103.209002604603;5107.029664363759;5107.157319042391;5151.639385242997;5123.769430375642;5148.099082660594;5148.922766158511;5150;5187.377514698185;5110.182370820725;5120.206368012964;5120.974395128001;5123.231515272739;5173.301604283449;4188.85339013133;4233.682473814415;4234.661227101825;4264.573542645772;4351.695381323277;3750.5874353821605;3760.52993375828;3761.1725420407465;3774.245150969817;3814.1036856338737;4387.5393083726385;4388.8902777430185;4391.494978077498;4417.757023363746;4433.490148632948;4945.826896058621;4991.875203119951;5089.567386772092;5113.079645663816;5182.031781671107;4407.074514351958;4425.424694789721;4428.778561071998;4450.421445212167;4457.108578284357;4614.215583350839;4625.629949604024;4626.1210370029585;4627.606653434428;4673.299005149255;4652.464966528757;4712.128256272601;4737.336772851872;4756.7145971241835;4832.734199619054;5074;5089.618278629192;5098.617603679813;5100.948990510047;5148.176291793295;4774.069056533943;4777.904441911072;4780.498047704941;4784.378030855966;4789.928151077667;4881.048195601824;5026.673266237683;5066.240063990431;5067.341245638044;5108.744562771921;5141.511556402136;5165.354330708661;5174.14626586609;5175.9741201293755;5215.113430716711;4780.569748722632;5016.097102521581;5020.548150666457;5030.773615187252;5031.798728050983;4921.753912304442;4937.975310123426;4961.181405068123;4971.105201063699;5010.599152067899;4844.975775121102;4859.659823812299;4897.216445368724;4900.166971614905;4912.7543622818;4855.854324370274;4954.133026720381;5025.497450255091;5063.822766203165;5079.339685840965;4905.337779399735;4915.066137433876;4920.21276595743;4986.102501549756;4987.326710893983 04:36:19 INFO - PROCESS | 8701 | |1;ext.html;530.8737720658838;579.5392662833048;585.4701495146894;587.2336600736038;591.7396345607931;25934.48131037378;39472.40791388128;40464.19071618566;40504.189916201656;40531;39897.60102398975;40167.79916100423;40294.39558406626;40296.19407611846;40304.395434068436;7464.813379665525;7929.207079292053;8067.112617612058;8069.1527389624125;10180.23648226386;9909.454979976135;10329.741756456111;10336.5348559315;10337.896621033806;10339.069483746462;10361.844572331422;10413.687589372332;10418.895811041906;10427.635032773855;10430.37417754937;7536.698532058738;7686.846263074764;7692.807679807994;10227.284090113695;10304.38173709576;9939.105480506789;10322.948385258102;10334;10338;10340.638077667321;38486.80756596227;38885.41671874924;38893.61106388956;38921.805390973146;38960.61039389626;3084.6915308469197;3308.7849289796327;3413.6586341365914;3515.2969406118623;3606.386914224588;29322.343687310084;29621.01030907414;30071.09786706402;30915.22711932197;31029.379412411625;3544.946825797615;3553.3070308748684;3584;3628.3650361186687;3655.817209139559;243711;243850;244043;244414;245595;32190.19524511906;50881.23678144831;50989.74505127525;51077;51133.48866511287;33652.831735841166;33996.49005264923;34051.829740851135;34066;34079.488807667905;11860.406979650983;11872.347020913932;11910.940445297718;11911.880881191251;11912.702182445508;9666.903330966601;10294.227932904912;10521.789564208673;10553.947230263799;10771.676849694522;7838.372930165573;7856.371490280764;7863.37093032556;7930.206979302024;7944.364450843918;3079.214800225973;3091.7681173912047;3107.7979931304394;3140.3876244132175;3174.2699179188917;871.9825603487894;874.5452364770284;881.2157180109707;895.9328050396247;900.8603666431713;26465.338366540604;26978.5953210702;27245.182644520697;27369.589456158174;27482;908.4367692030983;958.152035448633;961.024560071528;991.5240684471349;1018.3228153277987;14325.13497300544;14717.55847324582;14760.860900757401;14869.18219497938;14912.925435372754;317683;321589;321651;322320;325585;45608.087838243715;46159.76920115378;46521.76739116283;46559.06881862412;46642.30036549454;1060.5545670818428;1067.3489171605315;1172.3903570143648;1187.5962172861268;1201.2312120243053;28091.859540702164;28583.14250572486;29050.854745726137;29199;29472.705272947853;40869.18261634691;41162;41340.48605868535;41453.1709365817;41616;287336;288484;288563;288819;289148;22475.21336753206;25009.624855627542;25316.493670126125;25749.871250643628;25853.612195816702;41064.58935410727;41283.38074928938;41861;42209;43285;34897.82551087228;35472.645273546936;36119;36149.27701446009;36156.27687446184;35545.82227088848;35952.28095438129;36010.27979440344;36450.27099457943;36750.44874326834;35048;35873.28253434865;35950.28099438049;36172;36259.27481450409;29986.550201746555;32084.67915320817;32339.838300808344;32346.514802278456;32445.351092977537;24518.754812451647;24743.133990310253;24759.752402475744;25190.74809251884;25392.238232853044 04:36:19 INFO - PROCESS | 8701 | |2;jquery.html;365.1856360316493;367.8546973945292;371.9442083687447;385.7781775479098;387.1946351588696;15815.762763558556;16165.272562734675;17026.233819478122;17028.659426811457;17072.914635426838;15769.60575985601;16319.184040797973;16705.248263828125;16729.581760455996;16730.079845608485;4874.65877388583;5078.111330517145;5117.820876269331;5126.615503837227;5126.948730512684;3714.53568303962;3843.1545060086737;4980.8505744827535;5654.943450565483;5952.19645347879;5985.5810093293485;5986.431289027557;6005.669688167149;6015.488683461911;6022.96988515059;5601.915971260414;5900.350961394243;5902.380250073724;5906.763729450817;5914.142449344842;3371.9157021074425;4866.951330486685;5164.354455693038;5169.793208271664;5209.2446595243855;19510.80489195104;19788.604227915363;19795.703064454046;20755.481112972146;20804.791952080588;1910.1786231920269;2054.0448691358442;2056.8148866601928;2155.3426205007468;2563.192594332798;13018.739625207443;13053.216806991515;13213.33933303331;13236.735265294641;13623.25072121033;1792.1576858876308;1858.4145994011978;1892.3187652445108;1924.7209154672494;1947.0334961688795;65319.346806532274;65441.672791636214;65821;65964.67017664929;67471.66264168697;9826.508674566387;9919.355241909252;9996.200303975664;10062.144717698931;10067.899321006842;13409;13637.795433068512;13643.044986851024;13670.726585468235;13674.31628418575;7049.647517624098;7113.5376200547835;7128;7201.279872012757;7211.963940180265;6715.4627629790475;6828.965855170792;6873.65963637096;6959.6868140933775;6978.197507286625;4298.527162012176;4329.307310830315;4335.566443355639;4349.891252718708;4434;1655.809581898073;1709.4102534625783;1747.8077411484726;1792.2024699008816;1813.8458231050245;783.925527074927;793.2543409195338;798.4929569723267;817.8773184022325;822.5434883639638;15403.92298038525;15603.141827199614;15759.212039397984;15787;15920.840791592167;783.7766236622535;811.3671336357651;835.4193835284419;862.017300277684;870.5473153959905;8596.52719100443;8660.740177794676;8702;8754.51850148248;9018.09819018093;403952;407550;408689;408748;409188;47270.5272947273;54641.453585463634;72059.91910121353;75917;78225;885.685581618542;915.8122584870085;934.2992755433424;949.0793929887998;952.8660893536808;13742;13820.861791381958;13981.161130332213;14024.789628155382;14235.145891246559;34184.82907585446;35532.64467355293;35674.28651427009;35809;36682.8165859169;52221.477785221665;52673.736631318134;52721;53000;53258;6581.506387021088;6934.16789985205;6954.8956765647545;6967.7212911485;7110.3600675939415;9149.405288656217;11126;11276.492557834754;11399.20205585601;12333.506659733868;9899.455529945923;9988.60045598168;10015.749606259902;10346.637867674595;10638.14894808429;9092.181703646704;9117.452952822852;9400.764980875532;9620.37467564606;10198.43908585035;10048.748781280234;10205.438700871226;10397;10426;10729.195310351912;6898.758543450955;6937.375636192767;7017.298270172942;7022.824429389306;7039.718411263492;9561.665341713007;9995.750106247402;10256.58973641046;10310.896891030994;10555.239151504387 04:36:19 INFO - PROCESS | 8701 | |3;mootools.html;1225.6078055022397;1360.31984007996;1425.6435891027243;1466.5527014260647;1677.3542186258294;6943;7727.034120734908;7949.92050079499;7958.24396682315;8166.59167041647;7851.5681637509915;8029.2773650371455;8036.799080022988;8049.35605151588;8050.315723163523;1914.8659593828438;2127.936161915145;2181.6727490876337;2199.0214354612203;2214.889255537225;2319.9420014499606;2342.2387723989773;2346.307839187435;2347.4131467133216;2347.85912845229;2213.6236839737285;2224.1992882562263;2246.8314876384256;2248.921287754929;2248.9887550562225;1869.1028306412998;2088.905999230038;2178.4227179797367;2184;2235.2400183937457;2246.7753224677563;2273.1362082408746;2273.34073118797;2274.601944659678;2276.282970864189;7997.36021118315;8076.4750291230885;8087.636056377418;8092.635831387602;8097.473664211808;4628.421447319085;4737.218358970766;4744.715317080986;4752.310914917318;4753.287006948951;2893.6961619029908;3009.5554134015574;3121.406932682783;3123.3909387669414;3138.168385377877;946.5078159357165;949.9905000949971;968.8110818390417;971.1162841813986;971.5142428785607;10963.83554246687;10977.560897564088;10980;10981.835272470918;10997.780044399147;4158.6673066154635;4291.184674911757;4309;4318.395424640553;4372.40972468719;9131.81736365269;9172.31207659415;9195.95402022999;9196.310276729271;9201.263898888206;4670.929936050962;4675.368825208621;4679.649026322972;4680.789364478606;4680.81276748933;3781.697464202857;4106.445629839993;4211.136716973013;4222.345536441856;4259.424977628042;3674.889753307405;3714.182879766447;3745.1198968242443;3788.242351529705;3835.386338185877;1188.6552899659002;1221.883921027501;1224.3510939202238;1239.2712166527645;1249.2067537113999;758.8634045871686;840.5797101449275;847.9321654267644;852.8763329317214;872.1895426456197;5185.896282074337;5335.786568537215;5491.203775452537;5506.03644362235;5577.609567330329;423.544689458833;424.11360257062273;427.45712944560853;433.2504766753534;438.54391432909415;3561.3233485637647;3598.226381328027;3618.457231415309;3621.113234235841;3643.7267204959203;9521;9945.701628951143;9948;9963.103320701026;9963.80072398548;9770.902290977;9846.769153855768;9851.50742462874;9855.950720246354;9862.45756483386;7401.629918504053;7481.738139165103;7506.361959233526;7510.324070833652;7517.285857843496;5158.406783219828;5249.448807875271;5258.290130832289;5306.442823503477;5373.7850485980125;9001.909980900107;9012.684556040507;9016;9083.409578377385;9154.588043537924;8693.869591956;9023.819523609622;9048.864267036131;9285.257179425495;9292;6112.72492737819;6285.120083188449;6287.96856015717;6664.233613134357;6828.317168283132;7187.604681742554;7255.818604534928;7258.673359698721;7493.363064139609;7498;6721.428678562182;6824.317568243335;6841.076454678555;6866.313368663094;6947.687354068978;6635.601863888182;6690.83272918181;6744.62904540255;6790.219124800514;6804.795856124324;6180.938190618036;6625.966870165618;6630.071789949508;6685.331466853276;6694.966525167343;4708.176069187947;4724.4094488188975;4784.210605250095;4835.29888166221;4874.610031197567;4825.131476334293;4890.606177239612;4942.308076869169;4971.1797553403285;5027.296178534935 04:36:19 INFO - PROCESS | 8701 | |4;prototype.html;296.28151732049776;300.84957521239375;306.9600951876256;310.0234262074464;313.60015979625973;4661.533846615337;4819.614430845532;4866.270059491074;4894.388201474816;4898.951010489894;4676.7193968361835;4820;4824.396950381202;4831.782569784359;4835.114305420889;3855;3863.5750067492695;3868.845246190149;3869;3892.8637497687587;3676.411774116142;3691.6308369163003;3799.3731034379293;3873.2253549290112;3880.20455806559;3816.160444702161;3830.9042273943237;3836.3478208704587;3837.5586807517216;3845.615438456146;3818.16000479894;3823.235352929425;3835.712321575893;3836.9424458632866;3877.1082650990147;3425.5889293284717;3451.706604938583;3452.188735647121;3459.705924996378;3465.358908601917;4592.6555508337005;4714.787834547454;4716.726483849376;4737.834175803865;4749.287606858964;4318.805653745589;4336.609705126553;4347.456567929009;4351.108022855307;4366.934495982563;5039.672421292605;5041.798328066873;5042.924356134661;5046.924296135561;5069.315642388267;3615.566132064143;3719.6652301292743;3725.9441108383126;3731.7014638828828;3734.290484807878;5247.055530004598;5286.8633243852755;5300.973495132538;5312.1766126250495;5336.4129945705945;3798.9362978366103;3820.166320166336;3825.1967086911504;3829.942550861739;3831.9616803832164;3758.680512156497;3865.8453661853773;3884.533855937249;3894.4353068804867;3896.980515097463;4270.594293542109;4313.223619748475;4329.458817647794;4348.891277718019;4356.3683265926265;5005.924911126336;5024.120778863684;5035.79856805731;5051.292819005343;5094.439611642716;1264.5510843650557;1297.2605614799663;1304.6542666193466;1305.2560040776666;1308.587794844621;828.7058094376409;919.5448153430357;929.7494869400646;931.9114684104999;935.6351023100996;4451.910961780746;4474.843380481732;4487.640988720895;4492.483364413069;4501.662375321864;5176.136590827299;5176.559992400613;5205.765740541685;5222.817201397933;5254.0805359062015;4266.5467356270265;4420.67914344965;4430.335449682573;4460.8661740147845;4466.196084704784;2737.178846346128;2758.8620568971473;2766.837928070215;2771.80597358187;2775.3755405033708;4865;4871.902561948741;4883.3651625288485;4887.926681099786;4905.656604037683;5148.510891465305;5206.7350702444555;5304.92042619361;5306.363236411578;5316.73416329182;4889.315495830587;4898.730569818623;4900.142475066849;4945.7527123644395;4948.430930442901;5235.633505654568;5248.265242866079;5249.790008399774;5252.7898884045735;5270.235815806764;4855.684380515255;5092.210707340369;5145.691258524501;5193.61047921415;5196.79136367035;4933.802647894187;4954.30639710448;4955.454899961073;4985.651004429655;4990.451050384528;3738.495303134151;3748.9128152835374;3769.3403654360927;3780.7542509736777;3786.905327366838;5033.6476446648385;5170.97414512925;5335.519803217574;5366.7316634167355;5380.412778230353;5058.5466048966955;5164.7934082636275;5169.612279079009;5181.455947125498;5194.74026298676;5129.948700512947;5135.435102138837;5135.589152867837;5146.819861304836;5152.742362881766;4732.716037037789;5002.199648056294;5030.195168772979;5034.421041580119;5038.949610503994;5135.124330375002;5164.070467315919;5170.1727723565555;5191.558717509054;5218.530332270114;5045.697258164522;5070.6928347601015;5099.311592934906;5104.2343648453025;5111.846644600668 04:36:19 INFO - PROCESS | 8701 | |5;yui.html;647.1069923505564;651.4853265919924;707.19026714412;732.8277854704144;751.5603372027362;12653.30406827624;13024.739505209915;13153.27656978867;13357.198568085909;13469.461221551152;13053.869461305385;13069.542566010192;13171.538996135137;13193.736125277514;13196.406161722722;626.1296797451546;770.4183341577116;771.5717776633966;792.7978365516814;800.8118092248317;784.2392878907451;803.1927912448011;803.6865622407266;803.8834369016519;804.6218277409608;844.8690452979798;845.5898889038812;852.2415050604935;852.3181454836138;852.5694524265238;651.4430162211288;806.8305655812286;819.213554987213;843.0810416645854;843.6751850537526;609.8079105081885;611.7369531101624;612.13077430049;612.2102487790745;612.259166408646;12397.132200745951;12424.37878106091;12432.191907525981;12435.813462797974;12484.937575312066;12492.375381230902;13023.348832558335;13078.215307081606;13174.86825131746;13187.274699891503;10934.398608076554;11167.329960202333;11221.438928053647;11272.267302625303;11321.716957076056;4136;4227.915441691149;4229.154169166149;4234.872953811359;4282.293421585435;56956.71521642407;57921.42078579203;58201.41798582002;58235.41764582342;60219.69890150521;10280.126189273846;10296.22778291631;10411.843822342671;10782.568697252022;10794.352338859693;17184.570385740208;17714.379996700052;18788.248470061317;18830.52923676919;18848.717269240973;7046.718131274692;7048.083749112685;7115.324044215791;7153.6780844862105;7208.783736487913;3759.191773768653;3809.904752381213;3904.2972264992572;3930.8231129599235;3997.32045552251;2987.4174535965276;3037.0585118612858;3059.6481404638307;3090.3201295714907;3091.4435401627475;512.2086376548242;523.2778765303856;532.305341529308;532.6404676843193;542.500899172762;419.6999145610903;465.80458057723985;469.84495116611436;541.53157518746;562.7327019665707;7461.626918654046;7510.436717246119;7650.273224043707;7763.9223607764325;8000.4399692021;524.5279248676222;532.8321578702696;541.5559241421996;554.9417311182268;556.2879514221722;3480.5127282180515;3511.3152935177395;3521.964780352215;3600.945985810215;3605.513255710498;90151;91963;92904.53547732218;93986.53006734923;94612;79567.60216198998;82085.17914820895;82503.17496824954;83193.58403207945;84324.57837710895;44690.106197876514;44866;51993.74003130036;69694;72000;7022.929770702432;7064.611446370293;7139.964300178466;7212.170600381023;7266.455015873725;41845.79077104717;43145.13709725725;43396.783016084715;43412;43428.348574770775;36512.14765334464;38147;40916.590834092465;63177;63925;9615.01209451104;9745;9823.607055717692;9890.109890109925;10001.399916005063;11219.55121795119;11370.602028928948;11562.653120406401;11570.132240082195;11654.30074195551;9618.134367906921;9639.614415423304;9729.173020293072;9904.702858913955;9970.102690757867;9464.668736594185;9677.467739274407;9915.900840991499;9938.900610994087;10506.106980906708;8877.866831997397;9090.909090909006;9379.296552758435;9750.853737193806;10040.748981275527;7870.29167374939;7919.128866004899;8104.068032176139;9031.232345250728;9080.455172689659;8205.138460461565;8383.287420569077;8409.20112589303;8509.321420549502;8734.737957861274 04:36:19 INFO - PROCESS | 8701 | __end_tp_report 04:36:19 INFO - PROCESS | 8701 | __start_cc_report 04:36:19 INFO - PROCESS | 8701 | _x_x_mozilla_cycle_collect,1055 04:36:19 INFO - PROCESS | 8701 | __end_cc_report 04:36:19 INFO - PROCESS | 8701 | __startTimestamp1465904179964__endTimestamp 04:36:19 INFO - PROCESS | 8701 | 04:36:19 INFO - PROCESS | 8701 | ------- Summary: start ------- 04:36:19 INFO - PROCESS | 8701 | Number of tests: 6 04:36:19 INFO - PROCESS | 8701 | 04:36:19 INFO - PROCESS | 8701 | [#0] dojo.html Cycles:165 Average:4725.55 Median:4844.98 stddev:500.37 (10.3%) stddev-sans-first:474.44 04:36:19 INFO - PROCESS | 8701 | Values: 2641.3 2668.4 2695.4 2699.2 2701.0 4522.0 4577.7 4770.7 4838.4 4897.5 4628.9 4652.7 4729.9 4813.1 4856.1 4370.6 4383.0 4399.1 4465.7 4537.1 4417.6 4494.7 4535.0 4551.4 4560.2 4259.3 4462.3 4491.1 4512.9 4519.7 4253.8 4311.8 4331.3 4356.2 4399.8 4289.8 4357.9 4381.3 4422.8 4422.9 4604.9 4766.1 4780.5 4803.1 4808.4 5066.0 5144.3 5148.7 5208.6 5212.3 5180.1 5192.0 5213.3 5225.6 5234.9 4597.8 4760.6 4816.8 4857.6 4864.2 5204.2 5261.4 5270.2 5276.6 5282.4 5012.8 5051.0 5058.1 5061.1 5065.5 4899.4 5103.2 5107.0 5107.2 5151.6 5123.8 5148.1 5148.9 5150.0 5187.4 5110.2 5120.2 5121.0 5123.2 5173.3 4188.9 4233.7 4234.7 4264.6 4351.7 3750.6 3760.5 3761.2 3774.2 3814.1 4387.5 4388.9 4391.5 4417.8 4433.5 4945.8 4991.9 5089.6 5113.1 5182.0 4407.1 4425.4 4428.8 4450.4 4457.1 4614.2 4625.6 4626.1 4627.6 4673.3 4652.5 4712.1 4737.3 4756.7 4832.7 5074.0 5089.6 5098.6 5100.9 5148.2 4774.1 4777.9 4780.5 4784.4 4789.9 4881.0 5026.7 5066.2 5067.3 5108.7 5141.5 5165.4 5174.1 5176.0 5215.1 4780.6 5016.1 5020.5 5030.8 5031.8 4921.8 4938.0 4961.2 4971.1 5010.6 4845.0 4859.7 4897.2 4900.2 4912.8 4855.9 4954.1 5025.5 5063.8 5079.3 4905.3 4915.1 4920.2 4986.1 4987.3 04:36:19 INFO - PROCESS | 8701 | 04:36:19 INFO - PROCESS | 8701 | [#1] ext.html Cycles:180 Average:43437.91 Median:33824.66 stddev:75073.17 (221.9%) stddev-sans-first:75214.65 04:36:19 INFO - PROCESS | 8701 | Values: 530.9 579.5 585.5 587.2 591.7 25934.5 39472.4 40464.2 40504.2 40531.0 39897.6 40167.8 40294.4 40296.2 40304.4 7464.8 7929.2 8067.1 8069.2 10180.2 9909.5 10329.7 10336.5 10337.9 10339.1 10361.8 10413.7 10418.9 10427.6 10430.4 7536.7 7686.8 7692.8 10227.3 10304.4 9939.1 10322.9 10334.0 10338.0 10340.6 38486.8 38885.4 38893.6 38921.8 38960.6 3084.7 3308.8 3413.7 3515.3 3606.4 29322.3 29621.0 30071.1 30915.2 31029.4 3544.9 3553.3 3584.0 3628.4 3655.8 243711.0 243850.0 244043.0 244414.0 245595.0 32190.2 50881.2 50989.7 51077.0 51133.5 33652.8 33996.5 34051.8 34066.0 34079.5 11860.4 11872.3 11910.9 11911.9 11912.7 9666.9 10294.2 10521.8 10553.9 10771.7 7838.4 7856.4 7863.4 7930.2 7944.4 3079.2 3091.8 3107.8 3140.4 3174.3 872.0 874.5 881.2 895.9 900.9 26465.3 26978.6 27245.2 27369.6 27482.0 908.4 958.2 961.0 991.5 1018.3 14325.1 14717.6 14760.9 14869.2 14912.9 317683.0 321589.0 321651.0 322320.0 325585.0 45608.1 46159.8 46521.8 46559.1 46642.3 1060.6 1067.3 1172.4 1187.6 1201.2 28091.9 28583.1 29050.9 29199.0 29472.7 40869.2 41162.0 41340.5 41453.2 41616.0 287336.0 288484.0 288563.0 288819.0 289148.0 22475.2 25009.6 25316.5 25749.9 25853.6 41064.6 41283.4 41861.0 42209.0 43285.0 34897.8 35472.6 36119.0 36149.3 36156.3 35545.8 35952.3 36010.3 36450.3 36750.4 35048.0 35873.3 35950.3 36172.0 36259.3 29986.6 32084.7 32339.8 32346.5 32445.4 24518.8 24743.1 24759.8 25190.7 25392.2 04:36:19 INFO - PROCESS | 8701 | 04:36:19 INFO - PROCESS | 8701 | [#2] jquery.html Cycles:180 Average:24297.34 Median:25852.26 stddev:66978.94 (259.1%) stddev-sans-first:67142.73 04:36:19 INFO - PROCESS | 8701 | Values: 365.2 367.9 371.9 385.8 387.2 15815.8 16165.3 17026.2 17028.7 17072.9 15769.6 16319.2 16705.2 16729.6 16730.1 4874.7 5078.1 5117.8 5126.6 5126.9 3714.5 3843.2 4980.9 5654.9 5952.2 5985.6 5986.4 6005.7 6015.5 6023.0 5601.9 5900.4 5902.4 5906.8 5914.1 3371.9 4867.0 5164.4 5169.8 5209.2 19510.8 19788.6 19795.7 20755.5 20804.8 1910.2 2054.0 2056.8 2155.3 2563.2 13018.7 13053.2 13213.3 13236.7 13623.3 1792.2 1858.4 1892.3 1924.7 1947.0 65319.3 65441.7 65821.0 65964.7 67471.7 9826.5 9919.4 9996.2 10062.1 10067.9 13409.0 13637.8 13643.0 13670.7 13674.3 7049.6 7113.5 7128.0 7201.3 7212.0 6715.5 6829.0 6873.7 6959.7 6978.2 4298.5 4329.3 4335.6 4349.9 4434.0 1655.8 1709.4 1747.8 1792.2 1813.8 783.9 793.3 798.5 817.9 822.5 15403.9 15603.1 15759.2 15787.0 15920.8 783.8 811.4 835.4 862.0 870.5 8596.5 8660.7 8702.0 8754.5 9018.1 403952.0 407550.0 408689.0 408748.0 409188.0 47270.5 54641.5 72059.9 75917.0 78225.0 885.7 915.8 934.3 949.1 952.9 13742.0 13820.9 13981.2 14024.8 14235.1 34184.8 35532.6 35674.3 35809.0 36682.8 52221.5 52673.7 52721.0 53000.0 53258.0 6581.5 6934.2 6954.9 6967.7 7110.4 9149.4 11126.0 11276.5 11399.2 12333.5 9899.5 9988.6 10015.7 10346.6 10638.1 9092.2 9117.5 9400.8 9620.4 10198.4 10048.7 10205.4 10397.0 10426.0 10729.2 6898.8 6937.4 7017.3 7022.8 7039.7 9561.7 9995.8 10256.6 10310.9 10555.2 04:36:19 INFO - PROCESS | 8701 | 04:36:19 INFO - PROCESS | 8701 | [#3] mootools.html Cycles:180 Average:5216.70 Median:5172.15 stddev:2942.91 (56.9%) stddev-sans-first:2935.88 04:36:19 INFO - PROCESS | 8701 | Values: 1225.6 1360.3 1425.6 1466.6 1677.4 6943.0 7727.0 7949.9 7958.2 8166.6 7851.6 8029.3 8036.8 8049.4 8050.3 1914.9 2127.9 2181.7 2199.0 2214.9 2319.9 2342.2 2346.3 2347.4 2347.9 2213.6 2224.2 2246.8 2248.9 2249.0 1869.1 2088.9 2178.4 2184.0 2235.2 2246.8 2273.1 2273.3 2274.6 2276.3 7997.4 8076.5 8087.6 8092.6 8097.5 4628.4 4737.2 4744.7 4752.3 4753.3 2893.7 3009.6 3121.4 3123.4 3138.2 946.5 950.0 968.8 971.1 971.5 10963.8 10977.6 10980.0 10981.8 10997.8 4158.7 4291.2 4309.0 4318.4 4372.4 9131.8 9172.3 9196.0 9196.3 9201.3 4670.9 4675.4 4679.6 4680.8 4680.8 3781.7 4106.4 4211.1 4222.3 4259.4 3674.9 3714.2 3745.1 3788.2 3835.4 1188.7 1221.9 1224.4 1239.3 1249.2 758.9 840.6 847.9 852.9 872.2 5185.9 5335.8 5491.2 5506.0 5577.6 423.5 424.1 427.5 433.3 438.5 3561.3 3598.2 3618.5 3621.1 3643.7 9521.0 9945.7 9948.0 9963.1 9963.8 9770.9 9846.8 9851.5 9856.0 9862.5 7401.6 7481.7 7506.4 7510.3 7517.3 5158.4 5249.4 5258.3 5306.4 5373.8 9001.9 9012.7 9016.0 9083.4 9154.6 8693.9 9023.8 9048.9 9285.3 9292.0 6112.7 6285.1 6288.0 6664.2 6828.3 7187.6 7255.8 7258.7 7493.4 7498.0 6721.4 6824.3 6841.1 6866.3 6947.7 6635.6 6690.8 6744.6 6790.2 6804.8 6180.9 6626.0 6630.1 6685.3 6695.0 4708.2 4724.4 4784.2 4835.3 4874.6 4825.1 4890.6 4942.3 4971.2 5027.3 04:36:19 INFO - PROCESS | 8701 | 04:36:19 INFO - PROCESS | 8701 | [#4] prototype.html Cycles:180 Average:4245.30 Median:4828.09 stddev:1216.27 (25.2%) stddev-sans-first:1183.02 04:36:19 INFO - PROCESS | 8701 | Values: 296.3 300.8 307.0 310.0 313.6 4661.5 4819.6 4866.3 4894.4 4899.0 4676.7 4820.0 4824.4 4831.8 4835.1 3855.0 3863.6 3868.8 3869.0 3892.9 3676.4 3691.6 3799.4 3873.2 3880.2 3816.2 3830.9 3836.3 3837.6 3845.6 3818.2 3823.2 3835.7 3836.9 3877.1 3425.6 3451.7 3452.2 3459.7 3465.4 4592.7 4714.8 4716.7 4737.8 4749.3 4318.8 4336.6 4347.5 4351.1 4366.9 5039.7 5041.8 5042.9 5046.9 5069.3 3615.6 3719.7 3725.9 3731.7 3734.3 5247.1 5286.9 5301.0 5312.2 5336.4 3798.9 3820.2 3825.2 3829.9 3832.0 3758.7 3865.8 3884.5 3894.4 3897.0 4270.6 4313.2 4329.5 4348.9 4356.4 5005.9 5024.1 5035.8 5051.3 5094.4 1264.6 1297.3 1304.7 1305.3 1308.6 828.7 919.5 929.7 931.9 935.6 4451.9 4474.8 4487.6 4492.5 4501.7 5176.1 5176.6 5205.8 5222.8 5254.1 4266.5 4420.7 4430.3 4460.9 4466.2 2737.2 2758.9 2766.8 2771.8 2775.4 4865.0 4871.9 4883.4 4887.9 4905.7 5148.5 5206.7 5304.9 5306.4 5316.7 4889.3 4898.7 4900.1 4945.8 4948.4 5235.6 5248.3 5249.8 5252.8 5270.2 4855.7 5092.2 5145.7 5193.6 5196.8 4933.8 4954.3 4955.5 4985.7 4990.5 3738.5 3748.9 3769.3 3780.8 3786.9 5033.6 5171.0 5335.5 5366.7 5380.4 5058.5 5164.8 5169.6 5181.5 5194.7 5129.9 5135.4 5135.6 5146.8 5152.7 4732.7 5002.2 5030.2 5034.4 5038.9 5135.1 5164.1 5170.2 5191.6 5218.5 5045.7 5070.7 5099.3 5104.2 5111.8 04:36:19 INFO - PROCESS | 8701 | 04:36:19 INFO - PROCESS | 8701 | [#5] yui.html Cycles:180 Average:16199.99 Median:58061.42 stddev:23133.23 (39.8%) stddev-sans-first:23168.64 04:36:19 INFO - PROCESS | 8701 | Values: 647.1 651.5 707.2 732.8 751.6 12653.3 13024.7 13153.3 13357.2 13469.5 13053.9 13069.5 13171.5 13193.7 13196.4 626.1 770.4 771.6 792.8 800.8 784.2 803.2 803.7 803.9 804.6 844.9 845.6 852.2 852.3 852.6 651.4 806.8 819.2 843.1 843.7 609.8 611.7 612.1 612.2 612.3 12397.1 12424.4 12432.2 12435.8 12484.9 12492.4 13023.3 13078.2 13174.9 13187.3 10934.4 11167.3 11221.4 11272.3 11321.7 4136.0 4227.9 4229.2 4234.9 4282.3 56956.7 57921.4 58201.4 58235.4 60219.7 10280.1 10296.2 10411.8 10782.6 10794.4 17184.6 17714.4 18788.2 18830.5 18848.7 7046.7 7048.1 7115.3 7153.7 7208.8 3759.2 3809.9 3904.3 3930.8 3997.3 2987.4 3037.1 3059.6 3090.3 3091.4 512.2 523.3 532.3 532.6 542.5 419.7 465.8 469.8 541.5 562.7 7461.6 7510.4 7650.3 7763.9 8000.4 524.5 532.8 541.6 554.9 556.3 3480.5 3511.3 3522.0 3600.9 3605.5 90151.0 91963.0 92904.5 93986.5 94612.0 79567.6 82085.2 82503.2 83193.6 84324.6 44690.1 44866.0 51993.7 69694.0 72000.0 7022.9 7064.6 7140.0 7212.2 7266.5 41845.8 43145.1 43396.8 43412.0 43428.3 36512.1 38147.0 40916.6 63177.0 63925.0 9615.0 9745.0 9823.6 9890.1 10001.4 11219.6 11370.6 11562.7 11570.1 11654.3 9618.1 9639.6 9729.2 9904.7 9970.1 9464.7 9677.5 9915.9 9938.9 10506.1 8877.9 9090.9 9379.3 9750.9 10040.7 7870.3 7919.1 8104.1 9031.2 9080.5 8205.1 8383.3 8409.2 8509.3 8734.7 04:36:19 INFO - PROCESS | 8701 | -------- Summary: end -------- 04:36:19 INFO - PROCESS | 8701 | 04:36:20 INFO - TEST-INFO | 8701: exit 0 04:36:20 INFO - TEST-OK | dromaeo_css | took 1119008ms 04:36:20 INFO - TEST-START | kraken 04:36:20 INFO - operating with platform_type : linux_ 04:36:20 INFO - Initialising browser for kraken test... 04:36:20 INFO - TEST-INFO | started process 8882 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAa1vha/profile http://localhost:36549/getInfo.html) 04:36:24 INFO - PROCESS | 8882 | __metrics Screen width/height:1600/1200 04:36:24 INFO - PROCESS | 8882 | colorDepth:24 04:36:24 INFO - PROCESS | 8882 | Browser inner width/height: 1024/697 04:36:24 INFO - PROCESS | 8882 | __metrics 04:36:25 INFO - PROCESS | 8882 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:36:25 INFO - PROCESS | 8882 | console.error: PushService: 04:36:25 INFO - PROCESS | 8882 | stateChangeProcessEnqueue: Error transitioning state 04:36:25 INFO - PROCESS | 8882 | UnknownError 04:36:26 INFO - TEST-INFO | 8882: exit 0 04:36:26 INFO - Browser initialized. 04:36:26 INFO - Running cycle 1/1 for kraken test... 04:36:26 INFO - TEST-INFO | started process 8961 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAa1vha/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:36:38 INFO - PROCESS | 8961 | RSS: Main: 175464448 04:36:38 INFO - PROCESS | 8961 | 04:36:40 INFO - PROCESS | 8961 | Cycle 1(1): loaded http://localhost:36549/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36549/tests/kraken/driver.html?testName=audio-beat-detection) 04:36:41 INFO - PROCESS | 8961 | RSS: Main: 233955328 04:36:41 INFO - PROCESS | 8961 | 04:36:44 INFO - PROCESS | 8961 | Cycle 1(1): loaded http://localhost:36549/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36549/tests/kraken/driver.html?testName=audio-dft) 04:36:45 INFO - PROCESS | 8961 | RSS: Main: 222187520 04:36:45 INFO - PROCESS | 8961 | 04:36:48 INFO - PROCESS | 8961 | Cycle 1(1): loaded http://localhost:36549/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36549/tests/kraken/driver.html?testName=audio-fft) 04:36:49 INFO - PROCESS | 8961 | RSS: Main: 288641024 04:36:49 INFO - PROCESS | 8961 | 04:36:51 INFO - PROCESS | 8961 | Cycle 1(1): loaded http://localhost:36549/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36549/tests/kraken/driver.html?testName=audio-oscillator) 04:36:51 INFO - PROCESS | 8961 | RSS: Main: 198774784 04:36:51 INFO - PROCESS | 8961 | 04:36:54 INFO - PROCESS | 8961 | Cycle 1(1): loaded http://localhost:36549/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36549/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:36:54 INFO - PROCESS | 8961 | RSS: Main: 202416128 04:36:54 INFO - PROCESS | 8961 | 04:36:57 INFO - PROCESS | 8961 | Cycle 1(1): loaded http://localhost:36549/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36549/tests/kraken/driver.html?testName=imaging-darkroom) 04:36:58 INFO - PROCESS | 8961 | RSS: Main: 239026176 04:36:58 INFO - PROCESS | 8961 | 04:37:01 INFO - PROCESS | 8961 | Cycle 1(1): loaded http://localhost:36549/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36549/tests/kraken/driver.html?testName=imaging-desaturate) 04:37:02 INFO - PROCESS | 8961 | RSS: Main: 234631168 04:37:02 INFO - PROCESS | 8961 | 04:37:05 INFO - PROCESS | 8961 | Cycle 1(1): loaded http://localhost:36549/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36549/tests/kraken/driver.html?testName=json-parse-financial) 04:37:06 INFO - PROCESS | 8961 | RSS: Main: 238034944 04:37:06 INFO - PROCESS | 8961 | 04:37:07 INFO - PROCESS | 8961 | Cycle 1(1): loaded http://localhost:36549/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36549/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:37:08 INFO - PROCESS | 8961 | RSS: Main: 226697216 04:37:08 INFO - PROCESS | 8961 | 04:37:10 INFO - PROCESS | 8961 | Cycle 1(1): loaded http://localhost:36549/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36549/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:37:10 INFO - PROCESS | 8961 | RSS: Main: 232579072 04:37:10 INFO - PROCESS | 8961 | 04:37:13 INFO - PROCESS | 8961 | Cycle 1(1): loaded http://localhost:36549/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36549/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:37:13 INFO - PROCESS | 8961 | RSS: Main: 239546368 04:37:13 INFO - PROCESS | 8961 | 04:37:16 INFO - PROCESS | 8961 | Cycle 1(1): loaded http://localhost:36549/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36549/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:37:17 INFO - PROCESS | 8961 | RSS: Main: 242085888 04:37:17 INFO - PROCESS | 8961 | 04:37:20 INFO - PROCESS | 8961 | Cycle 1(1): loaded http://localhost:36549/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36549/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:37:20 INFO - PROCESS | 8961 | RSS: Main: 243347456 04:37:20 INFO - PROCESS | 8961 | 04:37:22 INFO - PROCESS | 8961 | Cycle 1(1): loaded http://localhost:36549/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36549/tests/kraken/driver.html?testName=ai-astar) 04:37:22 INFO - PROCESS | 8961 | RSS: Main: 286355456 04:37:22 INFO - PROCESS | 8961 | 04:37:22 INFO - PROCESS | 8961 | __start_tp_report 04:37:22 INFO - PROCESS | 8961 | _x_x_mozilla_page_load 04:37:22 INFO - PROCESS | 8961 | _x_x_mozilla_page_load_details 04:37:22 INFO - PROCESS | 8961 | |i|pagename|runs| 04:37:22 INFO - PROCESS | 8961 | |0;ai-astar;113;109;114;112;113;113;113;113;112;112 04:37:22 INFO - PROCESS | 8961 | |1;audio-beat-detection;170;129;135;182;140;137;165;133;194;131 04:37:22 INFO - PROCESS | 8961 | |2;audio-dft;163;162;162;163;163;162;161;163;161;162 04:37:22 INFO - PROCESS | 8961 | |3;audio-fft;77;79;77;115;78;77;76;77;102;77 04:37:22 INFO - PROCESS | 8961 | |4;audio-oscillator;86;86;122;86;86;85;114;85;86;131 04:37:22 INFO - PROCESS | 8961 | |5;imaging-gaussian-blur;116;117;117;118;117;117;117;117;117;116 04:37:22 INFO - PROCESS | 8961 | |6;imaging-darkroom;147;146;146;147;147;146;146;147;147;147 04:37:22 INFO - PROCESS | 8961 | |7;imaging-desaturate;95;95;96;95;95;95;95;96;95;94 04:37:22 INFO - PROCESS | 8961 | |8;json-parse-financial;64;64;64;65;65;66;65;64;66;64 04:37:22 INFO - PROCESS | 8961 | |9;json-stringify-tinderbox;66;64;64;65;64;65;65;65;65;65 04:37:22 INFO - PROCESS | 8961 | |10;stanford-crypto-aes;83;83;82;82;83;87;84;84;122;87 04:37:22 INFO - PROCESS | 8961 | |11;stanford-crypto-ccm;137;136;132;130;140;134;131;128;147;136 04:37:22 INFO - PROCESS | 8961 | |12;stanford-crypto-pbkdf2;170;173;169;169;175;167;172;174;172;166 04:37:22 INFO - PROCESS | 8961 | |13;stanford-crypto-sha256-iterative;68;68;70;67;67;67;68;68;69;67 04:37:22 INFO - PROCESS | 8961 | __end_tp_report 04:37:22 INFO - PROCESS | 8961 | __start_cc_report 04:37:22 INFO - PROCESS | 8961 | _x_x_mozilla_cycle_collect,1912 04:37:22 INFO - PROCESS | 8961 | __end_cc_report 04:37:22 INFO - PROCESS | 8961 | __startTimestamp1465904242817__endTimestamp 04:37:22 INFO - PROCESS | 8961 | 04:37:22 INFO - PROCESS | 8961 | ------- Summary: start ------- 04:37:22 INFO - PROCESS | 8961 | Number of tests: 14 04:37:22 INFO - PROCESS | 8961 | 04:37:22 INFO - PROCESS | 8961 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.00 stddev:1.35 (1.2%) stddev-sans-first:1.41 04:37:22 INFO - PROCESS | 8961 | Values: 113.0 109.0 114.0 112.0 113.0 113.0 113.0 113.0 112.0 112.0 04:37:22 INFO - PROCESS | 8961 | 04:37:22 INFO - PROCESS | 8961 | [#1] audio-beat-detection Cycles:10 Average:151.60 Median:152.50 stddev:23.91 (15.7%) stddev-sans-first:24.41 04:37:22 INFO - PROCESS | 8961 | Values: 170.0 129.0 135.0 182.0 140.0 137.0 165.0 133.0 194.0 131.0 04:37:22 INFO - PROCESS | 8961 | 04:37:22 INFO - PROCESS | 8961 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 04:37:22 INFO - PROCESS | 8961 | Values: 163.0 162.0 162.0 163.0 163.0 162.0 161.0 163.0 161.0 162.0 04:37:22 INFO - PROCESS | 8961 | 04:37:22 INFO - PROCESS | 8961 | [#3] audio-fft Cycles:10 Average:83.50 Median:77.00 stddev:13.55 (17.6%) stddev-sans-first:14.17 04:37:22 INFO - PROCESS | 8961 | Values: 77.0 79.0 77.0 115.0 78.0 77.0 76.0 77.0 102.0 77.0 04:37:22 INFO - PROCESS | 8961 | 04:37:22 INFO - PROCESS | 8961 | [#4] audio-oscillator Cycles:10 Average:96.70 Median:86.00 stddev:18.14 (21.1%) stddev-sans-first:18.82 04:37:22 INFO - PROCESS | 8961 | Values: 86.0 86.0 122.0 86.0 86.0 85.0 114.0 85.0 86.0 131.0 04:37:22 INFO - PROCESS | 8961 | 04:37:22 INFO - PROCESS | 8961 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 04:37:22 INFO - PROCESS | 8961 | Values: 116.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 116.0 04:37:22 INFO - PROCESS | 8961 | 04:37:22 INFO - PROCESS | 8961 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:37:22 INFO - PROCESS | 8961 | Values: 147.0 146.0 146.0 147.0 147.0 146.0 146.0 147.0 147.0 147.0 04:37:22 INFO - PROCESS | 8961 | 04:37:22 INFO - PROCESS | 8961 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 04:37:22 INFO - PROCESS | 8961 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 95.0 94.0 04:37:22 INFO - PROCESS | 8961 | 04:37:22 INFO - PROCESS | 8961 | [#8] json-parse-financial Cycles:10 Average:64.70 Median:65.00 stddev:0.82 (1.3%) stddev-sans-first:0.83 04:37:22 INFO - PROCESS | 8961 | Values: 64.0 64.0 64.0 65.0 65.0 66.0 65.0 64.0 66.0 64.0 04:37:22 INFO - PROCESS | 8961 | 04:37:22 INFO - PROCESS | 8961 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.50 04:37:22 INFO - PROCESS | 8961 | Values: 66.0 64.0 64.0 65.0 64.0 65.0 65.0 65.0 65.0 65.0 04:37:22 INFO - PROCESS | 8961 | 04:37:22 INFO - PROCESS | 8961 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:83.50 stddev:12.18 (14.6%) stddev-sans-first:12.80 04:37:22 INFO - PROCESS | 8961 | Values: 83.0 83.0 82.0 82.0 83.0 87.0 84.0 84.0 122.0 87.0 04:37:22 INFO - PROCESS | 8961 | 04:37:22 INFO - PROCESS | 8961 | [#11] stanford-crypto-ccm Cycles:10 Average:135.10 Median:136.00 stddev:5.53 (4.1%) stddev-sans-first:5.82 04:37:22 INFO - PROCESS | 8961 | Values: 137.0 136.0 132.0 130.0 140.0 134.0 131.0 128.0 147.0 136.0 04:37:22 INFO - PROCESS | 8961 | 04:37:22 INFO - PROCESS | 8961 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.70 Median:172.00 stddev:2.98 (1.7%) stddev-sans-first:3.15 04:37:22 INFO - PROCESS | 8961 | Values: 170.0 173.0 169.0 169.0 175.0 167.0 172.0 174.0 172.0 166.0 04:37:22 INFO - PROCESS | 8961 | 04:37:22 INFO - PROCESS | 8961 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:0.99 (1.5%) stddev-sans-first:1.05 04:37:22 INFO - PROCESS | 8961 | Values: 68.0 68.0 70.0 67.0 67.0 67.0 68.0 68.0 69.0 67.0 04:37:22 INFO - PROCESS | 8961 | -------- Summary: end -------- 04:37:22 INFO - PROCESS | 8961 | 04:37:23 INFO - TEST-INFO | 8961: exit 0 04:37:23 INFO - TEST-OK | kraken | took 63131ms 04:37:23 INFO - SUITE-END | took 1182s 04:37:23 INFO - Completed test suite (00:19:42) 04:37:23 INFO - javascript benchmark 04:37:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2641.2868525498116, 2668.4129491511862, 2695.433958868636, 2699.2172270041688, 2701.0, 4521.977390113045, 4577.702449340799, 4770.7376094314795, 4838.371011768465, 4897.461279259279, 4628.884277893055, 4652.651051171168, 4729.8817529561775, 4813.061453016663, 4856.077345304389, 4370.584794444539, 4383.035732138925, 4399.076193999264, 4465.68740188187, 4537.137943790669, 4417.624501917341, 4494.730316181023, 4534.954650453503, 4551.408316918796, 4560.156371071346, 4259.318509038539, 4462.308342206963, 4491.056878055612, 4512.864614061567, 4519.683622146451, 4253.787310634456, 4311.784410779448, 4331.263685173528, 4356.237658409797, 4399.846005389796, 4289.849855255083, 4357.891052723676, 4381.255186618282, 4422.823087076513, 4422.911541769179, 4604.88487787808, 4766.142094423002, 4780.450248221429, 4803.135435621587, 4808.35087263222, 5065.974670126662, 5144.3312369392115, 5148.6910785353, 5208.583313334962, 5212.270282160501, 5180.067587834188, 5192.0, 5213.322268105122, 5225.555827754645, 5234.895302093937, 4597.793099310539, 4760.64295177863, 4816.807327706888, 4857.635677324215, 4864.221724524059, 5204.193350030751, 5261.3686357637325, 5270.209468579744, 5276.63063585553, 5282.392524859691, 5012.774425150877, 5051.0, 5058.089543882136, 5061.114304996611, 5065.493450654905, 4899.436564795023, 5103.209002604603, 5107.029664363759, 5107.157319042391, 5151.639385242997, 5123.769430375642, 5148.099082660594, 5148.922766158511, 5150.0, 5187.377514698185, 5110.182370820725, 5120.206368012964, 5120.974395128001, 5123.231515272739, 5173.301604283449, 4188.85339013133, 4233.682473814415, 4234.661227101825, 4264.573542645772, 4351.695381323277, 3750.5874353821605, 3760.52993375828, 3761.1725420407465, 3774.245150969817, 3814.1036856338737, 4387.5393083726385, 4388.8902777430185, 4391.494978077498, 4417.757023363746, 4433.490148632948, 4945.826896058621, 4991.875203119951, 5089.567386772092, 5113.079645663816, 5182.031781671107, 4407.074514351958, 4425.424694789721, 4428.778561071998, 4450.421445212167, 4457.108578284357, 4614.215583350839, 4625.629949604024, 4626.1210370029585, 4627.606653434428, 4673.299005149255, 4652.464966528757, 4712.128256272601, 4737.336772851872, 4756.7145971241835, 4832.734199619054, 5074.0, 5089.618278629192, 5098.617603679813, 5100.948990510047, 5148.176291793295, 4774.069056533943, 4777.904441911072, 4780.498047704941, 4784.378030855966, 4789.928151077667, 4881.048195601824, 5026.673266237683, 5066.240063990431, 5067.341245638044, 5108.744562771921, 5141.511556402136, 5165.354330708661, 5174.14626586609, 5175.9741201293755, 5215.113430716711, 4780.569748722632, 5016.097102521581, 5020.548150666457, 5030.773615187252, 5031.798728050983, 4921.753912304442, 4937.975310123426, 4961.181405068123, 4971.105201063699, 5010.599152067899, 4844.975775121102, 4859.659823812299, 4897.216445368724, 4900.166971614905, 4912.7543622818, 4855.854324370274, 4954.133026720381, 5025.497450255091, 5063.822766203165, 5079.339685840965, 4905.337779399735, 4915.066137433876, 4920.21276595743, 4986.102501549756, 4987.326710893983], "value": 4693.656941236868, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [530.8737720658838, 579.5392662833048, 585.4701495146894, 587.2336600736038, 591.7396345607931, 25934.48131037378, 39472.40791388128, 40464.19071618566, 40504.189916201656, 40531.0, 39897.60102398975, 40167.79916100423, 40294.39558406626, 40296.19407611846, 40304.395434068436, 7464.813379665525, 7929.207079292053, 8067.112617612058, 8069.1527389624125, 10180.23648226386, 9909.454979976135, 10329.741756456111, 10336.5348559315, 10337.896621033806, 10339.069483746462, 10361.844572331422, 10413.687589372332, 10418.895811041906, 10427.635032773855, 10430.37417754937, 7536.698532058738, 7686.846263074764, 7692.807679807994, 10227.284090113695, 10304.38173709576, 9939.105480506789, 10322.948385258102, 10334.0, 10338.0, 10340.638077667321, 38486.80756596227, 38885.41671874924, 38893.61106388956, 38921.805390973146, 38960.61039389626, 3084.6915308469197, 3308.7849289796327, 3413.6586341365914, 3515.2969406118623, 3606.386914224588, 29322.343687310084, 29621.01030907414, 30071.09786706402, 30915.22711932197, 31029.379412411625, 3544.946825797615, 3553.3070308748684, 3584.0, 3628.3650361186687, 3655.817209139559, 243711.0, 243850.0, 244043.0, 244414.0, 245595.0, 32190.19524511906, 50881.23678144831, 50989.74505127525, 51077.0, 51133.48866511287, 33652.831735841166, 33996.49005264923, 34051.829740851135, 34066.0, 34079.488807667905, 11860.406979650983, 11872.347020913932, 11910.940445297718, 11911.880881191251, 11912.702182445508, 9666.903330966601, 10294.227932904912, 10521.789564208673, 10553.947230263799, 10771.676849694522, 7838.372930165573, 7856.371490280764, 7863.37093032556, 7930.206979302024, 7944.364450843918, 3079.214800225973, 3091.7681173912047, 3107.7979931304394, 3140.3876244132175, 3174.2699179188917, 871.9825603487894, 874.5452364770284, 881.2157180109707, 895.9328050396247, 900.8603666431713, 26465.338366540604, 26978.5953210702, 27245.182644520697, 27369.589456158174, 27482.0, 908.4367692030983, 958.152035448633, 961.024560071528, 991.5240684471349, 1018.3228153277987, 14325.13497300544, 14717.55847324582, 14760.860900757401, 14869.18219497938, 14912.925435372754, 317683.0, 321589.0, 321651.0, 322320.0, 325585.0, 45608.087838243715, 46159.76920115378, 46521.76739116283, 46559.06881862412, 46642.30036549454, 1060.5545670818428, 1067.3489171605315, 1172.3903570143648, 1187.5962172861268, 1201.2312120243053, 28091.859540702164, 28583.14250572486, 29050.854745726137, 29199.0, 29472.705272947853, 40869.18261634691, 41162.0, 41340.48605868535, 41453.1709365817, 41616.0, 287336.0, 288484.0, 288563.0, 288819.0, 289148.0, 22475.21336753206, 25009.624855627542, 25316.493670126125, 25749.871250643628, 25853.612195816702, 41064.58935410727, 41283.38074928938, 41861.0, 42209.0, 43285.0, 34897.82551087228, 35472.645273546936, 36119.0, 36149.27701446009, 36156.27687446184, 35545.82227088848, 35952.28095438129, 36010.27979440344, 36450.27099457943, 36750.44874326834, 35048.0, 35873.28253434865, 35950.28099438049, 36172.0, 36259.27481450409, 29986.550201746555, 32084.67915320817, 32339.838300808344, 32346.514802278456, 32445.351092977537, 24518.754812451647, 24743.133990310253, 24759.752402475744, 25190.74809251884, 25392.238232853044], "value": 16628.30121316166, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.1856360316493, 367.8546973945292, 371.9442083687447, 385.7781775479098, 387.1946351588696, 15815.762763558556, 16165.272562734675, 17026.233819478122, 17028.659426811457, 17072.914635426838, 15769.60575985601, 16319.184040797973, 16705.248263828125, 16729.581760455996, 16730.079845608485, 4874.65877388583, 5078.111330517145, 5117.820876269331, 5126.615503837227, 5126.948730512684, 3714.53568303962, 3843.1545060086737, 4980.8505744827535, 5654.943450565483, 5952.19645347879, 5985.5810093293485, 5986.431289027557, 6005.669688167149, 6015.488683461911, 6022.96988515059, 5601.915971260414, 5900.350961394243, 5902.380250073724, 5906.763729450817, 5914.142449344842, 3371.9157021074425, 4866.951330486685, 5164.354455693038, 5169.793208271664, 5209.2446595243855, 19510.80489195104, 19788.604227915363, 19795.703064454046, 20755.481112972146, 20804.791952080588, 1910.1786231920269, 2054.0448691358442, 2056.8148866601928, 2155.3426205007468, 2563.192594332798, 13018.739625207443, 13053.216806991515, 13213.33933303331, 13236.735265294641, 13623.25072121033, 1792.1576858876308, 1858.4145994011978, 1892.3187652445108, 1924.7209154672494, 1947.0334961688795, 65319.346806532274, 65441.672791636214, 65821.0, 65964.67017664929, 67471.66264168697, 9826.508674566387, 9919.355241909252, 9996.200303975664, 10062.144717698931, 10067.899321006842, 13409.0, 13637.795433068512, 13643.044986851024, 13670.726585468235, 13674.31628418575, 7049.647517624098, 7113.5376200547835, 7128.0, 7201.279872012757, 7211.963940180265, 6715.4627629790475, 6828.965855170792, 6873.65963637096, 6959.6868140933775, 6978.197507286625, 4298.527162012176, 4329.307310830315, 4335.566443355639, 4349.891252718708, 4434.0, 1655.809581898073, 1709.4102534625783, 1747.8077411484726, 1792.2024699008816, 1813.8458231050245, 783.925527074927, 793.2543409195338, 798.4929569723267, 817.8773184022325, 822.5434883639638, 15403.92298038525, 15603.141827199614, 15759.212039397984, 15787.0, 15920.840791592167, 783.7766236622535, 811.3671336357651, 835.4193835284419, 862.017300277684, 870.5473153959905, 8596.52719100443, 8660.740177794676, 8702.0, 8754.51850148248, 9018.09819018093, 403952.0, 407550.0, 408689.0, 408748.0, 409188.0, 47270.5272947273, 54641.453585463634, 72059.91910121353, 75917.0, 78225.0, 885.685581618542, 915.8122584870085, 934.2992755433424, 949.0793929887998, 952.8660893536808, 13742.0, 13820.861791381958, 13981.161130332213, 14024.789628155382, 14235.145891246559, 34184.82907585446, 35532.64467355293, 35674.28651427009, 35809.0, 36682.8165859169, 52221.477785221665, 52673.736631318134, 52721.0, 53000.0, 53258.0, 6581.506387021088, 6934.16789985205, 6954.8956765647545, 6967.7212911485, 7110.3600675939415, 9149.405288656217, 11126.0, 11276.492557834754, 11399.20205585601, 12333.506659733868, 9899.455529945923, 9988.60045598168, 10015.749606259902, 10346.637867674595, 10638.14894808429, 9092.181703646704, 9117.452952822852, 9400.764980875532, 9620.37467564606, 10198.43908585035, 10048.748781280234, 10205.438700871226, 10397.0, 10426.0, 10729.195310351912, 6898.758543450955, 6937.375636192767, 7017.298270172942, 7022.824429389306, 7039.718411263492, 9561.665341713007, 9995.750106247402, 10256.58973641046, 10310.896891030994, 10555.239151504387], "value": 8091.772927248192, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1225.6078055022397, 1360.31984007996, 1425.6435891027243, 1466.5527014260647, 1677.3542186258294, 6943.0, 7727.034120734908, 7949.92050079499, 7958.24396682315, 8166.59167041647, 7851.5681637509915, 8029.2773650371455, 8036.799080022988, 8049.35605151588, 8050.315723163523, 1914.8659593828438, 2127.936161915145, 2181.6727490876337, 2199.0214354612203, 2214.889255537225, 2319.9420014499606, 2342.2387723989773, 2346.307839187435, 2347.4131467133216, 2347.85912845229, 2213.6236839737285, 2224.1992882562263, 2246.8314876384256, 2248.921287754929, 2248.9887550562225, 1869.1028306412998, 2088.905999230038, 2178.4227179797367, 2184.0, 2235.2400183937457, 2246.7753224677563, 2273.1362082408746, 2273.34073118797, 2274.601944659678, 2276.282970864189, 7997.36021118315, 8076.4750291230885, 8087.636056377418, 8092.635831387602, 8097.473664211808, 4628.421447319085, 4737.218358970766, 4744.715317080986, 4752.310914917318, 4753.287006948951, 2893.6961619029908, 3009.5554134015574, 3121.406932682783, 3123.3909387669414, 3138.168385377877, 946.5078159357165, 949.9905000949971, 968.8110818390417, 971.1162841813986, 971.5142428785607, 10963.83554246687, 10977.560897564088, 10980.0, 10981.835272470918, 10997.780044399147, 4158.6673066154635, 4291.184674911757, 4309.0, 4318.395424640553, 4372.40972468719, 9131.81736365269, 9172.31207659415, 9195.95402022999, 9196.310276729271, 9201.263898888206, 4670.929936050962, 4675.368825208621, 4679.649026322972, 4680.789364478606, 4680.81276748933, 3781.697464202857, 4106.445629839993, 4211.136716973013, 4222.345536441856, 4259.424977628042, 3674.889753307405, 3714.182879766447, 3745.1198968242443, 3788.242351529705, 3835.386338185877, 1188.6552899659002, 1221.883921027501, 1224.3510939202238, 1239.2712166527645, 1249.2067537113999, 758.8634045871686, 840.5797101449275, 847.9321654267644, 852.8763329317214, 872.1895426456197, 5185.896282074337, 5335.786568537215, 5491.203775452537, 5506.03644362235, 5577.609567330329, 423.544689458833, 424.11360257062273, 427.45712944560853, 433.2504766753534, 438.54391432909415, 3561.3233485637647, 3598.226381328027, 3618.457231415309, 3621.113234235841, 3643.7267204959203, 9521.0, 9945.701628951143, 9948.0, 9963.103320701026, 9963.80072398548, 9770.902290977, 9846.769153855768, 9851.50742462874, 9855.950720246354, 9862.45756483386, 7401.629918504053, 7481.738139165103, 7506.361959233526, 7510.324070833652, 7517.285857843496, 5158.406783219828, 5249.448807875271, 5258.290130832289, 5306.442823503477, 5373.7850485980125, 9001.909980900107, 9012.684556040507, 9016.0, 9083.409578377385, 9154.588043537924, 8693.869591956, 9023.819523609622, 9048.864267036131, 9285.257179425495, 9292.0, 6112.72492737819, 6285.120083188449, 6287.96856015717, 6664.233613134357, 6828.317168283132, 7187.604681742554, 7255.818604534928, 7258.673359698721, 7493.363064139609, 7498.0, 6721.428678562182, 6824.317568243335, 6841.076454678555, 6866.313368663094, 6947.687354068978, 6635.601863888182, 6690.83272918181, 6744.62904540255, 6790.219124800514, 6804.795856124324, 6180.938190618036, 6625.966870165618, 6630.071789949508, 6685.331466853276, 6694.966525167343, 4708.176069187947, 4724.4094488188975, 4784.210605250095, 4835.29888166221, 4874.610031197567, 4825.131476334293, 4890.606177239612, 4942.308076869169, 4971.1797553403285, 5027.296178534935], "value": 4131.421358266763, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.28151732049776, 300.84957521239375, 306.9600951876256, 310.0234262074464, 313.60015979625973, 4661.533846615337, 4819.614430845532, 4866.270059491074, 4894.388201474816, 4898.951010489894, 4676.7193968361835, 4820.0, 4824.396950381202, 4831.782569784359, 4835.114305420889, 3855.0, 3863.5750067492695, 3868.845246190149, 3869.0, 3892.8637497687587, 3676.411774116142, 3691.6308369163003, 3799.3731034379293, 3873.2253549290112, 3880.20455806559, 3816.160444702161, 3830.9042273943237, 3836.3478208704587, 3837.5586807517216, 3845.615438456146, 3818.16000479894, 3823.235352929425, 3835.712321575893, 3836.9424458632866, 3877.1082650990147, 3425.5889293284717, 3451.706604938583, 3452.188735647121, 3459.705924996378, 3465.358908601917, 4592.6555508337005, 4714.787834547454, 4716.726483849376, 4737.834175803865, 4749.287606858964, 4318.805653745589, 4336.609705126553, 4347.456567929009, 4351.108022855307, 4366.934495982563, 5039.672421292605, 5041.798328066873, 5042.924356134661, 5046.924296135561, 5069.315642388267, 3615.566132064143, 3719.6652301292743, 3725.9441108383126, 3731.7014638828828, 3734.290484807878, 5247.055530004598, 5286.8633243852755, 5300.973495132538, 5312.1766126250495, 5336.4129945705945, 3798.9362978366103, 3820.166320166336, 3825.1967086911504, 3829.942550861739, 3831.9616803832164, 3758.680512156497, 3865.8453661853773, 3884.533855937249, 3894.4353068804867, 3896.980515097463, 4270.594293542109, 4313.223619748475, 4329.458817647794, 4348.891277718019, 4356.3683265926265, 5005.924911126336, 5024.120778863684, 5035.79856805731, 5051.292819005343, 5094.439611642716, 1264.5510843650557, 1297.2605614799663, 1304.6542666193466, 1305.2560040776666, 1308.587794844621, 828.7058094376409, 919.5448153430357, 929.7494869400646, 931.9114684104999, 935.6351023100996, 4451.910961780746, 4474.843380481732, 4487.640988720895, 4492.483364413069, 4501.662375321864, 5176.136590827299, 5176.559992400613, 5205.765740541685, 5222.817201397933, 5254.0805359062015, 4266.5467356270265, 4420.67914344965, 4430.335449682573, 4460.8661740147845, 4466.196084704784, 2737.178846346128, 2758.8620568971473, 2766.837928070215, 2771.80597358187, 2775.3755405033708, 4865.0, 4871.902561948741, 4883.3651625288485, 4887.926681099786, 4905.656604037683, 5148.510891465305, 5206.7350702444555, 5304.92042619361, 5306.363236411578, 5316.73416329182, 4889.315495830587, 4898.730569818623, 4900.142475066849, 4945.7527123644395, 4948.430930442901, 5235.633505654568, 5248.265242866079, 5249.790008399774, 5252.7898884045735, 5270.235815806764, 4855.684380515255, 5092.210707340369, 5145.691258524501, 5193.61047921415, 5196.79136367035, 4933.802647894187, 4954.30639710448, 4955.454899961073, 4985.651004429655, 4990.451050384528, 3738.495303134151, 3748.9128152835374, 3769.3403654360927, 3780.7542509736777, 3786.905327366838, 5033.6476446648385, 5170.97414512925, 5335.519803217574, 5366.7316634167355, 5380.412778230353, 5058.5466048966955, 5164.7934082636275, 5169.612279079009, 5181.455947125498, 5194.74026298676, 5129.948700512947, 5135.435102138837, 5135.589152867837, 5146.819861304836, 5152.742362881766, 4732.716037037789, 5002.199648056294, 5030.195168772979, 5034.421041580119, 5038.949610503994, 5135.124330375002, 5164.070467315919, 5170.1727723565555, 5191.558717509054, 5218.530332270114, 5045.697258164522, 5070.6928347601015, 5099.311592934906, 5104.2343648453025, 5111.846644600668], "value": 3861.0768119557674, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.1069923505564, 651.4853265919924, 707.19026714412, 732.8277854704144, 751.5603372027362, 12653.30406827624, 13024.739505209915, 13153.27656978867, 13357.198568085909, 13469.461221551152, 13053.869461305385, 13069.542566010192, 13171.538996135137, 13193.736125277514, 13196.406161722722, 626.1296797451546, 770.4183341577116, 771.5717776633966, 792.7978365516814, 800.8118092248317, 784.2392878907451, 803.1927912448011, 803.6865622407266, 803.8834369016519, 804.6218277409608, 844.8690452979798, 845.5898889038812, 852.2415050604935, 852.3181454836138, 852.5694524265238, 651.4430162211288, 806.8305655812286, 819.213554987213, 843.0810416645854, 843.6751850537526, 609.8079105081885, 611.7369531101624, 612.13077430049, 612.2102487790745, 612.259166408646, 12397.132200745951, 12424.37878106091, 12432.191907525981, 12435.813462797974, 12484.937575312066, 12492.375381230902, 13023.348832558335, 13078.215307081606, 13174.86825131746, 13187.274699891503, 10934.398608076554, 11167.329960202333, 11221.438928053647, 11272.267302625303, 11321.716957076056, 4136.0, 4227.915441691149, 4229.154169166149, 4234.872953811359, 4282.293421585435, 56956.71521642407, 57921.42078579203, 58201.41798582002, 58235.41764582342, 60219.69890150521, 10280.126189273846, 10296.22778291631, 10411.843822342671, 10782.568697252022, 10794.352338859693, 17184.570385740208, 17714.379996700052, 18788.248470061317, 18830.52923676919, 18848.717269240973, 7046.718131274692, 7048.083749112685, 7115.324044215791, 7153.6780844862105, 7208.783736487913, 3759.191773768653, 3809.904752381213, 3904.2972264992572, 3930.8231129599235, 3997.32045552251, 2987.4174535965276, 3037.0585118612858, 3059.6481404638307, 3090.3201295714907, 3091.4435401627475, 512.2086376548242, 523.2778765303856, 532.305341529308, 532.6404676843193, 542.500899172762, 419.6999145610903, 465.80458057723985, 469.84495116611436, 541.53157518746, 562.7327019665707, 7461.626918654046, 7510.436717246119, 7650.273224043707, 7763.9223607764325, 8000.4399692021, 524.5279248676222, 532.8321578702696, 541.5559241421996, 554.9417311182268, 556.2879514221722, 3480.5127282180515, 3511.3152935177395, 3521.964780352215, 3600.945985810215, 3605.513255710498, 90151.0, 91963.0, 92904.53547732218, 93986.53006734923, 94612.0, 79567.60216198998, 82085.17914820895, 82503.17496824954, 83193.58403207945, 84324.57837710895, 44690.106197876514, 44866.0, 51993.74003130036, 69694.0, 72000.0, 7022.929770702432, 7064.611446370293, 7139.964300178466, 7212.170600381023, 7266.455015873725, 41845.79077104717, 43145.13709725725, 43396.783016084715, 43412.0, 43428.348574770775, 36512.14765334464, 38147.0, 40916.590834092465, 63177.0, 63925.0, 9615.01209451104, 9745.0, 9823.607055717692, 9890.109890109925, 10001.399916005063, 11219.55121795119, 11370.602028928948, 11562.653120406401, 11570.132240082195, 11654.30074195551, 9618.134367906921, 9639.614415423304, 9729.173020293072, 9904.702858913955, 9970.102690757867, 9464.668736594185, 9677.467739274407, 9915.900840991499, 9938.900610994087, 10506.106980906708, 8877.866831997397, 9090.909090909006, 9379.296552758435, 9750.853737193806, 10040.748981275527, 7870.29167374939, 7919.128866004899, 8104.068032176139, 9031.232345250728, 9080.455172689659, 8205.138460461565, 8383.287420569077, 8409.20112589303, 8509.321420549502, 8734.737957861274], "value": 6226.786093816226, "unit": "score"}], "name": "dromaeo_css", "value": 6303.5738282817765, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 109.0, 114.0, 112.0, 113.0, 113.0, 113.0, 113.0, 112.0, 112.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 129.0, 135.0, 182.0, 140.0, 137.0, 165.0, 133.0, 194.0, 131.0], "value": 151.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 163.0, 163.0, 162.0, 161.0, 163.0, 161.0, 162.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 77.0, 115.0, 78.0, 77.0, 76.0, 77.0, 102.0, 77.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 122.0, 86.0, 86.0, 85.0, 114.0, 85.0, 86.0, 131.0], "value": 96.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 147.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 65.0, 65.0, 66.0, 65.0, 64.0, 66.0, 64.0], "value": 64.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 64.0, 65.0, 64.0, 65.0, 65.0, 65.0, 65.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 82.0, 82.0, 83.0, 87.0, 84.0, 84.0, 122.0, 87.0], "value": 87.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 136.0, 132.0, 130.0, 140.0, 134.0, 131.0, 128.0, 147.0, 136.0], "value": 135.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 173.0, 169.0, 169.0, 175.0, 167.0, 172.0, 174.0, 172.0, 166.0], "value": 170.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 70.0, 67.0, 67.0, 67.0, 68.0, 68.0, 69.0, 67.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1555.9, "alertThreshold": 2.0}]} 04:37:24 INFO - Return code: 0 04:37:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:37:24 INFO - # TBPL SUCCESS # 04:37:24 INFO - Running post-action listener: _resource_record_post_action 04:37:24 INFO - ##### 04:37:24 INFO - ##### Finished run-tests step (success) 04:37:24 INFO - ##### 04:37:24 INFO - Running post-run listener: _resource_record_post_run 04:37:24 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 12288; Write bytes: 519061504; Read time: 184; Write time: 387892 04:37:24 INFO - TinderboxPrint: CPU usage
13.1% 04:37:24 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 184 04:37:24 INFO - TinderboxPrint: I/O write bytes / time
519,061,504 / 387,892 04:37:24 INFO - TinderboxPrint: CPU idle
8,311.3 (86.9%) 04:37:24 INFO - TinderboxPrint: CPU user
1,214.1 (12.7%) 04:37:24 INFO - TinderboxPrint: Swap in / out
0 / 0 04:37:24 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 232407040; Read time: 0; Write time: 190124 04:37:24 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 12288; Write bytes: 286654464; Read time: 184; Write time: 197768 04:37:24 INFO - Running post-run listener: _upload_blobber_files 04:37:24 INFO - Blob upload gear active. 04:37:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:37:24 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 04:37:24 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'] 04:37:24 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 04:37:25 INFO - (blobuploader) - INFO - Open directory for files ... 04:37:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:37:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:37:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:37:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:37:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:37:28 INFO - (blobuploader) - INFO - Done attempting. 04:37:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:37:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:37:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:37:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:37:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:37:29 INFO - (blobuploader) - INFO - Done attempting. 04:37:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:37:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:37:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:37:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:37:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:37:30 INFO - (blobuploader) - INFO - Done attempting. 04:37:30 INFO - (blobuploader) - INFO - Iteration through files over. 04:37:30 INFO - Return code: 0 04:37:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:37:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:37:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/95b0c2c82d64cebc68bf7d7e16dacaff10a3be6854423bcdac5328d035c362bafa0e496f55afe48e3fc1c39e912453c7adbf088c4420967b5a7a7343cd9a1712", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/59f4f9823e726743a1d517bc254f5d77ed4347b31bb8085e6189a0a17c68ae62885ab6e63a9ebccc60c70e78eea4009b03aa3f22712deff2587cc4cb86a841eb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8e67548b3d7d4fca67fdb69207e51777fb4a3823009a240aaea90bbbcaf4bf1b09097d12a521f122f962beb80106cda71bbc13fdc231907f7eca4ee9a35949d2"} 04:37:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:37:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:37:30 INFO - Contents: 04:37:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/95b0c2c82d64cebc68bf7d7e16dacaff10a3be6854423bcdac5328d035c362bafa0e496f55afe48e3fc1c39e912453c7adbf088c4420967b5a7a7343cd9a1712", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/59f4f9823e726743a1d517bc254f5d77ed4347b31bb8085e6189a0a17c68ae62885ab6e63a9ebccc60c70e78eea4009b03aa3f22712deff2587cc4cb86a841eb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8e67548b3d7d4fca67fdb69207e51777fb4a3823009a240aaea90bbbcaf4bf1b09097d12a521f122f962beb80106cda71bbc13fdc231907f7eca4ee9a35949d2"} 04:37:30 INFO - Running post-run listener: copy_logs_to_upload_dir 04:37:30 INFO - Copying logs to upload dir... 04:37:30 INFO - mkdir: /builds/slave/test/build/upload/logs 04:37:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.463928 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-14 04:37:27.859261) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-14 04:37:27.862956) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1465901886.373116-1203290557 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/95b0c2c82d64cebc68bf7d7e16dacaff10a3be6854423bcdac5328d035c362bafa0e496f55afe48e3fc1c39e912453c7adbf088c4420967b5a7a7343cd9a1712", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/59f4f9823e726743a1d517bc254f5d77ed4347b31bb8085e6189a0a17c68ae62885ab6e63a9ebccc60c70e78eea4009b03aa3f22712deff2587cc4cb86a841eb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8e67548b3d7d4fca67fdb69207e51777fb4a3823009a240aaea90bbbcaf4bf1b09097d12a521f122f962beb80106cda71bbc13fdc231907f7eca4ee9a35949d2"} build_url:https://queue.taskcluster.net/v1/task/H30P2BUrTQGbZFm86zVoPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011495 build_url: 'https://queue.taskcluster.net/v1/task/H30P2BUrTQGbZFm86zVoPA/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/95b0c2c82d64cebc68bf7d7e16dacaff10a3be6854423bcdac5328d035c362bafa0e496f55afe48e3fc1c39e912453c7adbf088c4420967b5a7a7343cd9a1712", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/59f4f9823e726743a1d517bc254f5d77ed4347b31bb8085e6189a0a17c68ae62885ab6e63a9ebccc60c70e78eea4009b03aa3f22712deff2587cc4cb86a841eb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8e67548b3d7d4fca67fdb69207e51777fb4a3823009a240aaea90bbbcaf4bf1b09097d12a521f122f962beb80106cda71bbc13fdc231907f7eca4ee9a35949d2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-14 04:37:27.892490) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 04:37:27.892838) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1465901886.373116-1203290557 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004541 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 04:37:27.979005) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-14 04:37:27.979733) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-14 04:37:27.980304) ========= ========= Total master_lag: 0.16 =========