builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-056 starttime: 1466595505.68 results: success (0) buildid: 20160622040901 builduid: 0ce7f3fc2c0040e1a52dbbcaa971cec1 revision: e077a9ed54589316850312a6c4460ef15472109d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 04:38:25.678140) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 04:38:25.678665) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 04:38:25.679056) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 04:38:25.738934) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 04:38:25.739272) ========= 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=52faae308a556c440401f8e5000001e8-1466594285.413666-1520447168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-22 04:38:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-06-22 04:38:26 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086836 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 04:38:25.848400) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 04:38:25.848746) ========= 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=52faae308a556c440401f8e5000001e8-1466594285.413666-1520447168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019813 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 04:38:25.900964) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-22 04:38:25.901544) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e077a9ed54589316850312a6c4460ef15472109d --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 e077a9ed54589316850312a6c4460ef15472109d --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=52faae308a556c440401f8e5000001e8-1466594285.413666-1520447168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-22 04:38:26,310 truncating revision to first 12 chars 2016-06-22 04:38:26,311 Setting DEBUG logging. 2016-06-22 04:38:26,311 attempt 1/10 2016-06-22 04:38:26,311 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e077a9ed5458?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-22 04:38:27,474 unpacking tar archive at: fx-team-e077a9ed5458/testing/mozharness/ program finished with exit code 0 elapsedTime=1.508623 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-22 04:38:27.424914) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 04:38:27.425280) ========= script_repo_revision: e077a9ed54589316850312a6c4460ef15472109d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 04:38:27.425768) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 04:38:27.426103) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 04:38:27.435548) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-06-22 04:38:27.435899) ========= /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=52faae308a556c440401f8e5000001e8-1466594285.413666-1520447168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:38:27 INFO - MultiFileLogger online at 20160622 04:38:27 in /builds/slave/test 04:38:27 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:38:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:38:27 INFO - {'append_to_log': False, 04:38:27 INFO - 'base_work_dir': '/builds/slave/test', 04:38:27 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:38:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:38:27 INFO - 'branch': 'Fx-Team-Non-PGO', 04:38:27 INFO - 'buildbot_json_path': 'buildprops.json', 04:38:27 INFO - 'config_files': ('talos/linux_config.py',), 04:38:27 INFO - 'default_actions': ('clobber', 04:38:27 INFO - 'read-buildbot-config', 04:38:27 INFO - 'download-and-extract', 04:38:27 INFO - 'populate-webroot', 04:38:27 INFO - 'create-virtualenv', 04:38:27 INFO - 'install', 04:38:27 INFO - 'run-tests'), 04:38:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:38:27 INFO - 'download_minidump_stackwalk': True, 04:38:27 INFO - 'download_symbols': 'ondemand', 04:38:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:38:27 INFO - 'tooltool.py': '/tools/tooltool.py', 04:38:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:38:27 INFO - '/tools/misc-python/virtualenv.py')}, 04:38:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:38:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:38:27 INFO - 'installer_path': 'installer.exe', 04:38:27 INFO - 'log_level': 'info', 04:38:27 INFO - 'log_name': 'talos', 04:38:27 INFO - 'log_to_console': True, 04:38:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:38:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:38:27 INFO - 'opt_config_files': (), 04:38:27 INFO - 'pip_index': False, 04:38:27 INFO - 'sps_profile': False, 04:38:27 INFO - 'sps_profile_interval': 0, 04:38:27 INFO - 'suite': 'dromaeojs', 04:38:27 INFO - 'system_bits': '32', 04:38:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:38:27 INFO - 'title': 'talos-linux64-ix-056', 04:38:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:38:27 INFO - 'use_talos_json': True, 04:38:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:38:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:38:27 INFO - 'work_dir': 'build'} 04:38:27 INFO - ##### 04:38:27 INFO - ##### Running clobber step. 04:38:27 INFO - ##### 04:38:27 INFO - Running pre-action listener: _resource_record_pre_action 04:38:27 INFO - Running main action method: clobber 04:38:27 INFO - rmtree: /builds/slave/test/build 04:38:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:38:28 INFO - Running post-action listener: _resource_record_post_action 04:38:28 INFO - ##### 04:38:28 INFO - ##### Finished clobber step (success) 04:38:28 INFO - ##### 04:38:28 INFO - ##### 04:38:28 INFO - ##### Running read-buildbot-config step. 04:38:28 INFO - ##### 04:38:28 INFO - Running pre-action listener: _resource_record_pre_action 04:38:28 INFO - Running main action method: read_buildbot_config 04:38:28 INFO - Using buildbot properties: 04:38:28 INFO - { 04:38:28 INFO - "project": "", 04:38:28 INFO - "product": "firefox", 04:38:28 INFO - "script_repo_revision": "production", 04:38:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:38:28 INFO - "repository": "", 04:38:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:38:28 INFO - "buildid": "20160622040901", 04:38:28 INFO - "pgo_build": "False", 04:38:28 INFO - "basedir": "/builds/slave/test", 04:38:28 INFO - "buildnumber": 1876, 04:38:28 INFO - "slavename": "talos-linux64-ix-056", 04:38:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:38:28 INFO - "platform": "ubuntu64_hw", 04:38:28 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:38:28 INFO - "branch": "fx-team", 04:38:28 INFO - "repo_path": "integration/fx-team", 04:38:28 INFO - "revision": "e077a9ed54589316850312a6c4460ef15472109d", 04:38:28 INFO - "stage_platform": "linux64", 04:38:28 INFO - "builduid": "0ce7f3fc2c0040e1a52dbbcaa971cec1", 04:38:28 INFO - "slavebuilddir": "test" 04:38:28 INFO - } 04:38:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/JGVyGV_SQ9OwHj_qt_UU-w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:38:28 INFO - Running post-action listener: _resource_record_post_action 04:38:28 INFO - ##### 04:38:28 INFO - ##### Finished read-buildbot-config step (success) 04:38:28 INFO - ##### 04:38:28 INFO - ##### 04:38:28 INFO - ##### Running download-and-extract step. 04:38:28 INFO - ##### 04:38:28 INFO - Running pre-action listener: _resource_record_pre_action 04:38:28 INFO - Running main action method: download_and_extract 04:38:28 INFO - mkdir: /builds/slave/test/build/tests 04:38:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:28 INFO - https://queue.taskcluster.net/v1/task/JGVyGV_SQ9OwHj_qt_UU-w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:38:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JGVyGV_SQ9OwHj_qt_UU-w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:38:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JGVyGV_SQ9OwHj_qt_UU-w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:38:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JGVyGV_SQ9OwHj_qt_UU-w/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:38:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JGVyGV_SQ9OwHj_qt_UU-w/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:38:30 INFO - Downloaded 1361 bytes. 04:38:30 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:38:30 INFO - Using the following test package requirements: 04:38:30 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:38:30 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:38:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:38:30 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:38:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:38:30 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:38:30 INFO - u'jsshell-linux-x86_64.zip'], 04:38:30 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:38:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:38:30 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:38:30 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:38:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:38:30 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:38:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:38:30 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:38:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:38:30 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:38:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:38:30 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:38:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:30 INFO - https://queue.taskcluster.net/v1/task/JGVyGV_SQ9OwHj_qt_UU-w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:38:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JGVyGV_SQ9OwHj_qt_UU-w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:38:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JGVyGV_SQ9OwHj_qt_UU-w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:38:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JGVyGV_SQ9OwHj_qt_UU-w/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:38:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JGVyGV_SQ9OwHj_qt_UU-w/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:38:34 INFO - Downloaded 22701903 bytes. 04:38:34 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:38:34 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:38:35 INFO - Return code: 0 04:38:35 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:38:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:35 INFO - https://queue.taskcluster.net/v1/task/JGVyGV_SQ9OwHj_qt_UU-w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:38:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JGVyGV_SQ9OwHj_qt_UU-w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:38:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JGVyGV_SQ9OwHj_qt_UU-w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:38:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JGVyGV_SQ9OwHj_qt_UU-w/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:38:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JGVyGV_SQ9OwHj_qt_UU-w/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:38:43 INFO - Downloaded 22701903 bytes. 04:38:43 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:38:43 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:38:45 INFO - Return code: 0 04:38:45 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:38:45 INFO - https://queue.taskcluster.net/v1/task/JGVyGV_SQ9OwHj_qt_UU-w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:38:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JGVyGV_SQ9OwHj_qt_UU-w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:38:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JGVyGV_SQ9OwHj_qt_UU-w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:38:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JGVyGV_SQ9OwHj_qt_UU-w/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:38:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JGVyGV_SQ9OwHj_qt_UU-w/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:38:46 INFO - Downloaded 14405384 bytes. 04:38:46 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:38:46 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:38:46 INFO - Return code: 0 04:38:46 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:38:46 INFO - https://queue.taskcluster.net/v1/task/JGVyGV_SQ9OwHj_qt_UU-w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:38:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JGVyGV_SQ9OwHj_qt_UU-w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:38:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JGVyGV_SQ9OwHj_qt_UU-w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:38:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JGVyGV_SQ9OwHj_qt_UU-w/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:38:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JGVyGV_SQ9OwHj_qt_UU-w/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:38:48 INFO - Downloaded 56245527 bytes. 04:38:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JGVyGV_SQ9OwHj_qt_UU-w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:38:48 INFO - mkdir: /builds/slave/test/properties 04:38:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:38:48 INFO - Writing to file /builds/slave/test/properties/build_url 04:38:48 INFO - Contents: 04:38:48 INFO - build_url:https://queue.taskcluster.net/v1/task/JGVyGV_SQ9OwHj_qt_UU-w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:38:49 INFO - Running post-action listener: _resource_record_post_action 04:38:49 INFO - Running post-action listener: set_extra_try_arguments 04:38:49 INFO - ##### 04:38:49 INFO - ##### Finished download-and-extract step (success) 04:38:49 INFO - ##### 04:38:49 INFO - ##### 04:38:49 INFO - ##### Running populate-webroot step. 04:38:49 INFO - ##### 04:38:49 INFO - Running pre-action listener: _resource_record_pre_action 04:38:49 INFO - Running main action method: populate_webroot 04:38:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:38:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:38:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:38:49 INFO - '--tppagecycles', 04:38:49 INFO - '7'], 04:38:49 INFO - 'tests': ['tsvgm']}}, 04:38:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:38:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:38:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:38:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:38:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:38:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:38:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:38:49 INFO - 'talos_options': ['--disable-e10s'], 04:38:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:38:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:38:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:38:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:38:49 INFO - 'talos_options': ['--disable-e10s'], 04:38:49 INFO - 'tests': ['damp', 'tps']}, 04:38:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:38:49 INFO - 'tests': ['damp', 'tps']}, 04:38:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:38:49 INFO - 'tests': ['dromaeo_dom']}, 04:38:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:38:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:38:49 INFO - 'tests': ['basic_compositor_video']}, 04:38:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:38:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:38:49 INFO - 'tests': ['a11yr', 04:38:49 INFO - 'ts_paint', 04:38:49 INFO - 'tpaint', 04:38:49 INFO - 'sessionrestore', 04:38:49 INFO - 'sessionrestore_no_auto_restore', 04:38:49 INFO - 'tabpaint']}, 04:38:49 INFO - 'other-e10s': {'tests': ['a11yr', 04:38:49 INFO - 'ts_paint', 04:38:49 INFO - 'tpaint', 04:38:49 INFO - 'sessionrestore', 04:38:49 INFO - 'sessionrestore_no_auto_restore', 04:38:49 INFO - 'tabpaint']}, 04:38:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:38:49 INFO - 'ts_paint', 04:38:49 INFO - 'tpaint', 04:38:49 INFO - 'sessionrestore', 04:38:49 INFO - 'sessionrestore_no_auto_restore', 04:38:49 INFO - 'tabpaint']}, 04:38:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:38:49 INFO - 'ts_paint', 04:38:49 INFO - 'tpaint', 04:38:49 INFO - 'sessionrestore', 04:38:49 INFO - 'sessionrestore_no_auto_restore', 04:38:49 INFO - 'tabpaint']}, 04:38:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:38:49 INFO - 'tests': ['a11yr', 04:38:49 INFO - 'ts_paint', 04:38:49 INFO - 'tpaint', 04:38:49 INFO - 'sessionrestore', 04:38:49 INFO - 'sessionrestore_no_auto_restore', 04:38:49 INFO - 'tabpaint']}, 04:38:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:38:49 INFO - 'tests': ['a11yr', 04:38:49 INFO - 'ts_paint', 04:38:49 INFO - 'tpaint', 04:38:49 INFO - 'sessionrestore', 04:38:49 INFO - 'sessionrestore_no_auto_restore', 04:38:49 INFO - 'tabpaint']}, 04:38:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:38:49 INFO - 'tests': ['tsvgx', 04:38:49 INFO - 'tsvgr_opacity', 04:38:49 INFO - 'tart', 04:38:49 INFO - 'tscrollx', 04:38:49 INFO - 'cart']}, 04:38:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:38:49 INFO - 'tsvgr_opacity', 04:38:49 INFO - 'tart', 04:38:49 INFO - 'tscrollx', 04:38:49 INFO - 'cart']}, 04:38:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:38:49 INFO - 'talos_options': ['--disable-e10s'], 04:38:49 INFO - 'tests': ['tp5o']}, 04:38:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:38:49 INFO - 'tests': ['tp5o']}, 04:38:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:38:49 INFO - 'talos_options': ['--disable-e10s', 04:38:49 INFO - '--xperf_path', 04:38:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:38:49 INFO - 'tests': ['tp5n']}, 04:38:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:38:49 INFO - 'talos_options': ['--xperf_path', 04:38:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:38:49 INFO - 'tests': ['tp5n']}}, 04:38:49 INFO - 'talos.zip': {'path': '', 04:38:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:38:49 INFO - Running post-action listener: _resource_record_post_action 04:38:49 INFO - ##### 04:38:49 INFO - ##### Finished populate-webroot step (success) 04:38:49 INFO - ##### 04:38:49 INFO - ##### 04:38:49 INFO - ##### Running create-virtualenv step. 04:38:49 INFO - ##### 04:38:49 INFO - Running pre-action listener: _resource_record_pre_action 04:38:49 INFO - Running main action method: create_virtualenv 04:38:49 INFO - Creating virtualenv /builds/slave/test/build/venv 04:38:49 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:38:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:38:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:38:49 INFO - Using real prefix '/usr' 04:38:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:38:49 INFO - Installing distribute.............................................................................................................................................................................................done. 04:38:51 INFO - Installing pip.................done. 04:38:51 INFO - Return code: 0 04:38:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:38:51 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:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:51 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:38:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:51 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 0x7f49c45c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220a1c0>, '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 0x220b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220b550>, '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': '52faae308a556c440401f8e5000001e8-1466594285.413666-1520447168', '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:38:51 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:38:51 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:38:51 INFO - Using env: {'DISPLAY': ':0', 04:38:51 INFO - 'HOME': '/home/cltbld', 04:38:51 INFO - 'LANG': 'en_US.UTF-8', 04:38:51 INFO - 'LANGUAGE': 'en_US:en', 04:38:51 INFO - 'LOGNAME': 'cltbld', 04:38:51 INFO - 'MAIL': '/var/mail/cltbld', 04:38:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:51 INFO - 'MOZ_NO_REMOTE': '1', 04:38:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:38:51 INFO - 'NO_EM_RESTART': '1', 04:38:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:38:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:51 INFO - 'PWD': '/builds/slave/test', 04:38:51 INFO - 'SHELL': '/bin/bash', 04:38:51 INFO - 'SHLVL': '1', 04:38:51 INFO - 'TERM': 'linux', 04:38:51 INFO - 'TMOUT': '86400', 04:38:51 INFO - 'USER': 'cltbld', 04:38:51 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466594285.413666-1520447168', 04:38:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:51 INFO - '_': '/tools/buildbot/bin/python'} 04:38:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:52 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:38:52 INFO - Cleaning up... 04:38:52 INFO - Return code: 0 04:38:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:38:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f49c45c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220a1c0>, '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 0x220b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220b550>, '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': '52faae308a556c440401f8e5000001e8-1466594285.413666-1520447168', '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:38:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:38:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:38:52 INFO - Using env: {'DISPLAY': ':0', 04:38:52 INFO - 'HOME': '/home/cltbld', 04:38:52 INFO - 'LANG': 'en_US.UTF-8', 04:38:52 INFO - 'LANGUAGE': 'en_US:en', 04:38:52 INFO - 'LOGNAME': 'cltbld', 04:38:52 INFO - 'MAIL': '/var/mail/cltbld', 04:38:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:52 INFO - 'MOZ_NO_REMOTE': '1', 04:38:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:38:52 INFO - 'NO_EM_RESTART': '1', 04:38:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:38:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:52 INFO - 'PWD': '/builds/slave/test', 04:38:52 INFO - 'SHELL': '/bin/bash', 04:38:52 INFO - 'SHLVL': '1', 04:38:52 INFO - 'TERM': 'linux', 04:38:52 INFO - 'TMOUT': '86400', 04:38:52 INFO - 'USER': 'cltbld', 04:38:52 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466594285.413666-1520447168', 04:38:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:52 INFO - '_': '/tools/buildbot/bin/python'} 04:38:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:52 INFO - Downloading/unpacking psutil>=3.1.1 04:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:38:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:38:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:38:54 INFO - Installing collected packages: psutil 04:38:54 INFO - Running setup.py install for psutil 04:38:54 INFO - building 'psutil._psutil_linux' extension 04:38:54 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:38:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:38:54 INFO - building 'psutil._psutil_posix' extension 04:38:54 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:38:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:38:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:38:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:38:54 INFO - Successfully installed psutil 04:38:54 INFO - Cleaning up... 04:38:54 INFO - Return code: 0 04:38:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:38:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f49c45c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220a1c0>, '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 0x220b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220b550>, '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': '52faae308a556c440401f8e5000001e8-1466594285.413666-1520447168', '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:38:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:38:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:38:54 INFO - Using env: {'DISPLAY': ':0', 04:38:54 INFO - 'HOME': '/home/cltbld', 04:38:54 INFO - 'LANG': 'en_US.UTF-8', 04:38:54 INFO - 'LANGUAGE': 'en_US:en', 04:38:54 INFO - 'LOGNAME': 'cltbld', 04:38:54 INFO - 'MAIL': '/var/mail/cltbld', 04:38:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:54 INFO - 'MOZ_NO_REMOTE': '1', 04:38:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:38:54 INFO - 'NO_EM_RESTART': '1', 04:38:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:38:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:54 INFO - 'PWD': '/builds/slave/test', 04:38:54 INFO - 'SHELL': '/bin/bash', 04:38:54 INFO - 'SHLVL': '1', 04:38:54 INFO - 'TERM': 'linux', 04:38:54 INFO - 'TMOUT': '86400', 04:38:54 INFO - 'USER': 'cltbld', 04:38:54 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466594285.413666-1520447168', 04:38:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:54 INFO - '_': '/tools/buildbot/bin/python'} 04:38:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:38:55 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:38:55 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:38:55 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:38:55 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:38:55 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:38:55 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:38:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:38:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:38:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:38:57 INFO - Installing collected packages: mozsystemmonitor 04:38:57 INFO - Running setup.py install for mozsystemmonitor 04:38:57 INFO - Successfully installed mozsystemmonitor 04:38:57 INFO - Cleaning up... 04:38:57 INFO - Return code: 0 04:38:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:38:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f49c45c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220a1c0>, '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 0x220b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220b550>, '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': '52faae308a556c440401f8e5000001e8-1466594285.413666-1520447168', '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:38:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:38:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:38:57 INFO - Using env: {'DISPLAY': ':0', 04:38:57 INFO - 'HOME': '/home/cltbld', 04:38:57 INFO - 'LANG': 'en_US.UTF-8', 04:38:57 INFO - 'LANGUAGE': 'en_US:en', 04:38:57 INFO - 'LOGNAME': 'cltbld', 04:38:57 INFO - 'MAIL': '/var/mail/cltbld', 04:38:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:57 INFO - 'MOZ_NO_REMOTE': '1', 04:38:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:38:57 INFO - 'NO_EM_RESTART': '1', 04:38:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:38:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:57 INFO - 'PWD': '/builds/slave/test', 04:38:57 INFO - 'SHELL': '/bin/bash', 04:38:57 INFO - 'SHLVL': '1', 04:38:57 INFO - 'TERM': 'linux', 04:38:57 INFO - 'TMOUT': '86400', 04:38:57 INFO - 'USER': 'cltbld', 04:38:57 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466594285.413666-1520447168', 04:38:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:57 INFO - '_': '/tools/buildbot/bin/python'} 04:38:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:57 INFO - Downloading/unpacking jsonschema==2.5.1 04:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:38:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:59 INFO - Downloading functools32-3.2.3-2.tar.gz 04:38:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:38:59 INFO - warning: no files found matching '*.txt' 04:38:59 INFO - no previously-included directories found matching 'build' 04:38:59 INFO - no previously-included directories found matching 'dist' 04:38:59 INFO - no previously-included directories found matching '.git*' 04:38:59 INFO - Installing collected packages: jsonschema, functools32 04:38:59 INFO - Running setup.py install for functools32 04:38:59 INFO - warning: no files found matching '*.txt' 04:38:59 INFO - no previously-included directories found matching 'build' 04:38:59 INFO - no previously-included directories found matching 'dist' 04:38:59 INFO - no previously-included directories found matching '.git*' 04:38:59 INFO - Successfully installed jsonschema functools32 04:38:59 INFO - Cleaning up... 04:38:59 INFO - Return code: 0 04:38:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:38:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f49c45c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220a1c0>, '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 0x220b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220b550>, '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': '52faae308a556c440401f8e5000001e8-1466594285.413666-1520447168', '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:38:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:38:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:38:59 INFO - Using env: {'DISPLAY': ':0', 04:38:59 INFO - 'HOME': '/home/cltbld', 04:38:59 INFO - 'LANG': 'en_US.UTF-8', 04:38:59 INFO - 'LANGUAGE': 'en_US:en', 04:38:59 INFO - 'LOGNAME': 'cltbld', 04:38:59 INFO - 'MAIL': '/var/mail/cltbld', 04:38:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:59 INFO - 'MOZ_NO_REMOTE': '1', 04:38:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:38:59 INFO - 'NO_EM_RESTART': '1', 04:38:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:38:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:59 INFO - 'PWD': '/builds/slave/test', 04:38:59 INFO - 'SHELL': '/bin/bash', 04:38:59 INFO - 'SHLVL': '1', 04:38:59 INFO - 'TERM': 'linux', 04:38:59 INFO - 'TMOUT': '86400', 04:38:59 INFO - 'USER': 'cltbld', 04:38:59 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466594285.413666-1520447168', 04:38:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:59 INFO - '_': '/tools/buildbot/bin/python'} 04:38:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:59 INFO - Downloading/unpacking blobuploader==1.2.4 04:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:01 INFO - Downloading blobuploader-1.2.4.tar.gz 04:39:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:39:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:39:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:39: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:39: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:39: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:39: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:39: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:39: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:39:02 INFO - Downloading docopt-0.6.1.tar.gz 04:39:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:39:02 INFO - Installing collected packages: blobuploader, requests, docopt 04:39:02 INFO - Running setup.py install for blobuploader 04:39:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:39:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:39:02 INFO - Running setup.py install for requests 04:39:03 INFO - Running setup.py install for docopt 04:39:03 INFO - Successfully installed blobuploader requests docopt 04:39:03 INFO - Cleaning up... 04:39:03 INFO - Return code: 0 04:39:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:39:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:03 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 0x7f49c45c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220a1c0>, '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 0x220b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220b550>, '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': '52faae308a556c440401f8e5000001e8-1466594285.413666-1520447168', '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:39:03 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:39:03 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:39:03 INFO - Using env: {'DISPLAY': ':0', 04:39:03 INFO - 'HOME': '/home/cltbld', 04:39:03 INFO - 'LANG': 'en_US.UTF-8', 04:39:03 INFO - 'LANGUAGE': 'en_US:en', 04:39:03 INFO - 'LOGNAME': 'cltbld', 04:39:03 INFO - 'MAIL': '/var/mail/cltbld', 04:39:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:03 INFO - 'MOZ_NO_REMOTE': '1', 04:39:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:03 INFO - 'NO_EM_RESTART': '1', 04:39:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:03 INFO - 'PWD': '/builds/slave/test', 04:39:03 INFO - 'SHELL': '/bin/bash', 04:39:03 INFO - 'SHLVL': '1', 04:39:03 INFO - 'TERM': 'linux', 04:39:03 INFO - 'TMOUT': '86400', 04:39:03 INFO - 'USER': 'cltbld', 04:39:03 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466594285.413666-1520447168', 04:39:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:03 INFO - '_': '/tools/buildbot/bin/python'} 04:39:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:39:03 INFO - Running setup.py (path:/tmp/pip-vM3HKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:39:03 INFO - Running setup.py (path:/tmp/pip-me9HHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:39:03 INFO - Running setup.py (path:/tmp/pip-qpN_Qo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:39:03 INFO - Running setup.py (path:/tmp/pip-q9B1zK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:39:03 INFO - Running setup.py (path:/tmp/pip-LbgB9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:39:03 INFO - Running setup.py (path:/tmp/pip-Emv8N5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:39:03 INFO - Running setup.py (path:/tmp/pip-wmesB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:39:03 INFO - Running setup.py (path:/tmp/pip-A73hsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:39:04 INFO - Running setup.py (path:/tmp/pip-UDtigD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:39:04 INFO - Running setup.py (path:/tmp/pip-V1gBv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:39:04 INFO - Running setup.py (path:/tmp/pip-BKb9nH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:39:04 INFO - Running setup.py (path:/tmp/pip-ERgiTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:39:04 INFO - Running setup.py (path:/tmp/pip-jfW0Ci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:39:04 INFO - Running setup.py (path:/tmp/pip-cWCHye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:04 INFO - Running setup.py (path:/tmp/pip-RDmYym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:39:04 INFO - Running setup.py (path:/tmp/pip-ZhVrgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:39:04 INFO - Running setup.py (path:/tmp/pip-saWffB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:39:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:39:04 INFO - Running setup.py install for manifestparser 04:39:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:39:04 INFO - Running setup.py install for mozcrash 04:39:04 INFO - Running setup.py install for mozdebug 04:39:05 INFO - Running setup.py install for mozdevice 04:39:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:39:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:39:05 INFO - Running setup.py install for mozfile 04:39:05 INFO - Running setup.py install for mozhttpd 04:39:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:39:05 INFO - Running setup.py install for mozinfo 04:39:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:39:05 INFO - Running setup.py install for mozInstall 04:39:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:39:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:39:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:39:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:39:05 INFO - Running setup.py install for mozleak 04:39:05 INFO - Running setup.py install for mozlog 04:39:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:39:05 INFO - Running setup.py install for moznetwork 04:39:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:39:05 INFO - Running setup.py install for mozprocess 04:39:05 INFO - Running setup.py install for mozprofile 04:39:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:39:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:39:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:39:06 INFO - Running setup.py install for mozrunner 04:39:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:39:06 INFO - Running setup.py install for mozscreenshot 04:39:06 INFO - Running setup.py install for moztest 04:39:06 INFO - Running setup.py install for mozversion 04:39:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:39:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:39:06 INFO - Cleaning up... 04:39:06 INFO - Return code: 0 04:39:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:39:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f49c45c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220a1c0>, '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 0x220b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220b550>, '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': '52faae308a556c440401f8e5000001e8-1466594285.413666-1520447168', '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:39:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:39:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:39:06 INFO - Using env: {'DISPLAY': ':0', 04:39:06 INFO - 'HOME': '/home/cltbld', 04:39:06 INFO - 'LANG': 'en_US.UTF-8', 04:39:06 INFO - 'LANGUAGE': 'en_US:en', 04:39:06 INFO - 'LOGNAME': 'cltbld', 04:39:06 INFO - 'MAIL': '/var/mail/cltbld', 04:39:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:06 INFO - 'MOZ_NO_REMOTE': '1', 04:39:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:06 INFO - 'NO_EM_RESTART': '1', 04:39:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:06 INFO - 'PWD': '/builds/slave/test', 04:39:06 INFO - 'SHELL': '/bin/bash', 04:39:06 INFO - 'SHLVL': '1', 04:39:06 INFO - 'TERM': 'linux', 04:39:06 INFO - 'TMOUT': '86400', 04:39:06 INFO - 'USER': 'cltbld', 04:39:06 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466594285.413666-1520447168', 04:39:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:06 INFO - '_': '/tools/buildbot/bin/python'} 04:39:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:39:06 INFO - Running setup.py (path:/tmp/pip-hQLr5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:39:06 INFO - Running setup.py (path:/tmp/pip-xKdGwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:39:06 INFO - Running setup.py (path:/tmp/pip-wRwQw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:39:06 INFO - Running setup.py (path:/tmp/pip-08ta68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:39:07 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:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:39:07 INFO - Running setup.py (path:/tmp/pip-Q8P0ZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:39:07 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:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:39:07 INFO - Running setup.py (path:/tmp/pip-EbeSJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:39:07 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:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:39:07 INFO - Running setup.py (path:/tmp/pip-CqCaIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:39:07 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:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:39:07 INFO - Running setup.py (path:/tmp/pip-jkIXtM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:39:07 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:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:39:07 INFO - Running setup.py (path:/tmp/pip-obY24J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:39:07 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:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:39:07 INFO - Running setup.py (path:/tmp/pip-pIORSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:39:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:39:07 INFO - Running setup.py (path:/tmp/pip-vnZy9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:39:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:39:07 INFO - Running setup.py (path:/tmp/pip-0zgeK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:39:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:39:07 INFO - Running setup.py (path:/tmp/pip-2Y39fQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:39:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:39:07 INFO - Running setup.py (path:/tmp/pip-afPe9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:39:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:07 INFO - Running setup.py (path:/tmp/pip-69bmFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:39:07 INFO - Running setup.py (path:/tmp/pip-oUbKjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:39:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:39:07 INFO - Running setup.py (path:/tmp/pip-WPqwIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:39:08 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:39:08 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:39:08 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:39:08 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:39:08 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:39:08 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:39:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:09 INFO - Downloading blessings-1.6.tar.gz 04:39:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:39:09 INFO - Installing collected packages: blessings 04:39:09 INFO - Running setup.py install for blessings 04:39:10 INFO - Successfully installed blessings 04:39:10 INFO - Cleaning up... 04:39:10 INFO - Return code: 0 04:39:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:39:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:39:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:39:10 INFO - Reading from file tmpfile_stdout 04:39:10 INFO - Current package versions: 04:39:10 INFO - argparse == 1.2.1 04:39:10 INFO - blessings == 1.6 04:39:10 INFO - blobuploader == 1.2.4 04:39:10 INFO - docopt == 0.6.1 04:39:10 INFO - functools32 == 3.2.3-2 04:39:10 INFO - jsonschema == 2.5.1 04:39:10 INFO - manifestparser == 1.1 04:39:10 INFO - mozInstall == 1.12 04:39:10 INFO - mozcrash == 0.17 04:39:10 INFO - mozdebug == 0.1 04:39:10 INFO - mozdevice == 0.48 04:39:10 INFO - mozfile == 1.2 04:39:10 INFO - mozhttpd == 0.7 04:39:10 INFO - mozinfo == 0.9 04:39:10 INFO - mozleak == 0.1 04:39:10 INFO - mozlog == 3.2 04:39:10 INFO - moznetwork == 0.27 04:39:10 INFO - mozprocess == 0.22 04:39:10 INFO - mozprofile == 0.28 04:39:10 INFO - mozrunner == 6.11 04:39:10 INFO - mozscreenshot == 0.1 04:39:10 INFO - mozsystemmonitor == 0.3 04:39:10 INFO - moztest == 0.7 04:39:10 INFO - mozversion == 1.4 04:39:10 INFO - psutil == 3.1.1 04:39:10 INFO - requests == 1.2.3 04:39:10 INFO - wsgiref == 0.1.2 04:39:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:39: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:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39: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:39:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:10 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 0x7f49c45c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220a1c0>, '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 0x220b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220b550>, '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': '52faae308a556c440401f8e5000001e8-1466594285.413666-1520447168', '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:39:10 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:39:10 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:39:10 INFO - Using env: {'DISPLAY': ':0', 04:39:10 INFO - 'HOME': '/home/cltbld', 04:39:10 INFO - 'LANG': 'en_US.UTF-8', 04:39:10 INFO - 'LANGUAGE': 'en_US:en', 04:39:10 INFO - 'LOGNAME': 'cltbld', 04:39:10 INFO - 'MAIL': '/var/mail/cltbld', 04:39:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:10 INFO - 'MOZ_NO_REMOTE': '1', 04:39:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:10 INFO - 'NO_EM_RESTART': '1', 04:39:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:10 INFO - 'PWD': '/builds/slave/test', 04:39:10 INFO - 'SHELL': '/bin/bash', 04:39:10 INFO - 'SHLVL': '1', 04:39:10 INFO - 'TERM': 'linux', 04:39:10 INFO - 'TMOUT': '86400', 04:39:10 INFO - 'USER': 'cltbld', 04:39:10 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466594285.413666-1520447168', 04:39:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:10 INFO - '_': '/tools/buildbot/bin/python'} 04:39:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:39:10 INFO - Cleaning up... 04:39:10 INFO - Return code: 0 04:39:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:39: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:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39: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:39:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f49c45c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220a1c0>, '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 0x220b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220b550>, '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': '52faae308a556c440401f8e5000001e8-1466594285.413666-1520447168', '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:39:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:39:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:39:10 INFO - Using env: {'DISPLAY': ':0', 04:39:10 INFO - 'HOME': '/home/cltbld', 04:39:10 INFO - 'LANG': 'en_US.UTF-8', 04:39:10 INFO - 'LANGUAGE': 'en_US:en', 04:39:10 INFO - 'LOGNAME': 'cltbld', 04:39:10 INFO - 'MAIL': '/var/mail/cltbld', 04:39:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:10 INFO - 'MOZ_NO_REMOTE': '1', 04:39:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:10 INFO - 'NO_EM_RESTART': '1', 04:39:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:10 INFO - 'PWD': '/builds/slave/test', 04:39:10 INFO - 'SHELL': '/bin/bash', 04:39:10 INFO - 'SHLVL': '1', 04:39:10 INFO - 'TERM': 'linux', 04:39:10 INFO - 'TMOUT': '86400', 04:39:10 INFO - 'USER': 'cltbld', 04:39:10 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466594285.413666-1520447168', 04:39:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:10 INFO - '_': '/tools/buildbot/bin/python'} 04:39:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:39:10 INFO - Cleaning up... 04:39:10 INFO - Return code: 0 04:39:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:39: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:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39: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:39:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f49c45c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220a1c0>, '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 0x220b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220b550>, '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': '52faae308a556c440401f8e5000001e8-1466594285.413666-1520447168', '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:39:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:39:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:39:10 INFO - Using env: {'DISPLAY': ':0', 04:39:10 INFO - 'HOME': '/home/cltbld', 04:39:10 INFO - 'LANG': 'en_US.UTF-8', 04:39:10 INFO - 'LANGUAGE': 'en_US:en', 04:39:10 INFO - 'LOGNAME': 'cltbld', 04:39:10 INFO - 'MAIL': '/var/mail/cltbld', 04:39:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:10 INFO - 'MOZ_NO_REMOTE': '1', 04:39:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:10 INFO - 'NO_EM_RESTART': '1', 04:39:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:10 INFO - 'PWD': '/builds/slave/test', 04:39:10 INFO - 'SHELL': '/bin/bash', 04:39:10 INFO - 'SHLVL': '1', 04:39:10 INFO - 'TERM': 'linux', 04:39:10 INFO - 'TMOUT': '86400', 04:39:10 INFO - 'USER': 'cltbld', 04:39:10 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466594285.413666-1520447168', 04:39:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:10 INFO - '_': '/tools/buildbot/bin/python'} 04:39:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:11 INFO - Downloading/unpacking flake8 04:39:11 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:39:11 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:39:11 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:39:11 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:39:11 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:39:11 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:39:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:39:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:39: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:39: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:39: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:39: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:39: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:39: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:39:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:39:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:39:13 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:39:13 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:39:13 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:39:13 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:39:13 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:39:13 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:39:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:39:13 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:39:13 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:39:13 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:39:13 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:39:13 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:39:13 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:39:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:39:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:39:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:39:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:39:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:39:13 INFO - no previously-included directories found matching 'docs/_build' 04:39:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:39:13 INFO - Running setup.py install for pep8 04:39:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:39:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:39:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:39:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:39:13 INFO - no previously-included directories found matching 'docs/_build' 04:39:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:39:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:39:13 INFO - Cleaning up... 04:39:13 INFO - Return code: 0 04:39:13 INFO - Running post-action listener: _resource_record_post_action 04:39:13 INFO - Running post-action listener: _start_resource_monitoring 04:39:13 INFO - Starting resource monitoring. 04:39:13 INFO - ##### 04:39:13 INFO - ##### Finished create-virtualenv step (success) 04:39:13 INFO - ##### 04:39:13 INFO - ##### 04:39:13 INFO - ##### Running install step. 04:39:13 INFO - ##### 04:39:13 INFO - Running pre-action listener: _resource_record_pre_action 04:39:13 INFO - Running main action method: install 04:39:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:39:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:39:14 INFO - Reading from file tmpfile_stdout 04:39:14 INFO - Detecting whether we're running mozinstall >=1.0... 04:39:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:39:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:39:14 INFO - Reading from file tmpfile_stdout 04:39:14 INFO - Output received: 04:39:14 INFO - Usage: mozinstall [options] installer 04:39:14 INFO - Options: 04:39:14 INFO - -h, --help show this help message and exit 04:39:14 INFO - -d DEST, --destination=DEST 04:39:14 INFO - Directory to install application into. [default: 04:39:14 INFO - "/builds/slave/test"] 04:39:14 INFO - --app=APP Application being installed. [default: firefox] 04:39:14 INFO - mkdir: /builds/slave/test/build/application 04:39:14 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:39:14 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:39:30 INFO - Reading from file tmpfile_stdout 04:39:30 INFO - Output received: 04:39:30 INFO - /builds/slave/test/build/application/firefox/firefox 04:39:30 INFO - Running post-action listener: _resource_record_post_action 04:39:30 INFO - ##### 04:39:30 INFO - ##### Finished install step (success) 04:39:30 INFO - ##### 04:39:30 INFO - ##### 04:39:30 INFO - ##### Running run-tests step. 04:39:30 INFO - ##### 04:39:30 INFO - Running pre-action listener: _resource_record_pre_action 04:39:30 INFO - Running main action method: run_tests 04:39:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:39:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:39:30 INFO - Python 2.7.3 04:39:30 INFO - Return code: 0 04:39:30 INFO - grabbing minidump binary from tooltool 04:39:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:30 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 0x220a1c0>, '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 0x220b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220b550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:39:30 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:39:30 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:39:30 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:39:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:39:30 INFO - Return code: 0 04:39:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:39:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:39:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:39:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:39:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:39:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:39:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:39:31 INFO - Return code: 0 04:39:31 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/JGVyGV_SQ9OwHj_qt_UU-w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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:39:31 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/JGVyGV_SQ9OwHj_qt_UU-w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --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:39:31 INFO - Using env: {'DISPLAY': ':0', 04:39:31 INFO - 'HOME': '/home/cltbld', 04:39:31 INFO - 'LANG': 'en_US.UTF-8', 04:39:31 INFO - 'LANGUAGE': 'en_US:en', 04:39:31 INFO - 'LOGNAME': 'cltbld', 04:39:31 INFO - 'MAIL': '/var/mail/cltbld', 04:39:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:39:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:39:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:31 INFO - 'MOZ_NO_REMOTE': '1', 04:39:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:39:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:31 INFO - 'NO_EM_RESTART': '1', 04:39:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:31 INFO - 'PWD': '/builds/slave/test', 04:39:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:39:31 INFO - 'SHELL': '/bin/bash', 04:39:31 INFO - 'SHLVL': '1', 04:39:31 INFO - 'TERM': 'linux', 04:39:31 INFO - 'TMOUT': '86400', 04:39:31 INFO - 'USER': 'cltbld', 04:39:31 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466594285.413666-1520447168', 04:39:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:31 INFO - '_': '/tools/buildbot/bin/python'} 04:39:31 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/JGVyGV_SQ9OwHj_qt_UU-w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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:39:31 INFO - mozversion application_buildid: 20160622040901 04:39:31 INFO - mozversion application_changeset: e077a9ed54589316850312a6c4460ef15472109d 04:39:31 INFO - mozversion application_display_name: Nightly 04:39:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:39:31 INFO - mozversion application_name: Firefox 04:39:31 INFO - mozversion application_remotingname: firefox 04:39:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:39:31 INFO - mozversion application_vendor: Mozilla 04:39:31 INFO - mozversion application_version: 50.0a1 04:39:31 INFO - mozversion platform_buildid: 20160622040901 04:39:31 INFO - mozversion platform_changeset: e077a9ed54589316850312a6c4460ef15472109d 04:39:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:39:31 INFO - mozversion platform_version: 50.0a1 04:39:31 INFO - using testdate: 1466595571 04:39:31 INFO - actual date: 1466595571 04:39:31 INFO - starting webserver on 'localhost:34865' 04:39:31 INFO - SUITE-START | Running 2 tests 04:39:31 INFO - TEST-START | dromaeo_css 04:39:31 INFO - operating with platform_type : linux_ 04:39:31 INFO - Initialising browser for dromaeo_css test... 04:39:31 INFO - TEST-INFO | started process 17203 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDupI2s/profile http://localhost:34865/getInfo.html) 04:39:36 INFO - PROCESS | 17203 | __metrics Screen width/height:1600/1200 04:39:36 INFO - PROCESS | 17203 | colorDepth:24 04:39:36 INFO - PROCESS | 17203 | Browser inner width/height: 1024/697 04:39:36 INFO - PROCESS | 17203 | __metrics 04:39:37 INFO - PROCESS | 17203 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:39:37 INFO - PROCESS | 17203 | console.error: PushService: 04:39:37 INFO - PROCESS | 17203 | stateChangeProcessEnqueue: Error transitioning state 04:39:37 INFO - PROCESS | 17203 | UnknownError 04:39:38 INFO - TEST-INFO | 17203: exit 0 04:39:38 INFO - Browser initialized. 04:39:38 INFO - Running cycle 1/1 for dromaeo_css test... 04:39:38 INFO - TEST-INFO | started process 17284 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDupI2s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:39:50 INFO - PROCESS | 17284 | RSS: Main: 175534080 04:39:50 INFO - PROCESS | 17284 | 04:40:41 INFO - PROCESS | 17284 | 1466595641660 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:42:54 INFO - PROCESS | 17284 | Cycle 1(1): loaded http://localhost:34865/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34865/tests/dromaeo/cssquery-ext.html) 04:42:55 INFO - PROCESS | 17284 | RSS: Main: 297070592 04:42:55 INFO - PROCESS | 17284 | 04:45:58 INFO - PROCESS | 17284 | Cycle 1(1): loaded http://localhost:34865/tests/dromaeo/cssquery-ext.html (next: http://localhost:34865/tests/dromaeo/cssquery-jquery.html) 04:45:59 INFO - PROCESS | 17284 | RSS: Main: 255180800 04:45:59 INFO - PROCESS | 17284 | 04:49:01 INFO - PROCESS | 17284 | Cycle 1(1): loaded http://localhost:34865/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34865/tests/dromaeo/cssquery-mootools.html) 04:49:02 INFO - PROCESS | 17284 | RSS: Main: 250630144 04:49:02 INFO - PROCESS | 17284 | 04:52:04 INFO - PROCESS | 17284 | Cycle 1(1): loaded http://localhost:34865/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34865/tests/dromaeo/cssquery-prototype.html) 04:52:04 INFO - PROCESS | 17284 | RSS: Main: 250277888 04:52:04 INFO - PROCESS | 17284 | 04:55:07 INFO - PROCESS | 17284 | Cycle 1(1): loaded http://localhost:34865/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34865/tests/dromaeo/cssquery-yui.html) 04:55:08 INFO - PROCESS | 17284 | RSS: Main: 238477312 04:55:08 INFO - PROCESS | 17284 | 04:58:11 INFO - PROCESS | 17284 | Cycle 1(1): loaded http://localhost:34865/tests/dromaeo/cssquery-yui.html (next: http://localhost:34865/tests/dromaeo/cssquery-dojo.html) 04:58:11 INFO - PROCESS | 17284 | RSS: Main: 324288512 04:58:11 INFO - PROCESS | 17284 | 04:58:11 INFO - PROCESS | 17284 | __start_tp_report 04:58:11 INFO - PROCESS | 17284 | _x_x_mozilla_page_load 04:58:11 INFO - PROCESS | 17284 | _x_x_mozilla_page_load_details 04:58:11 INFO - PROCESS | 17284 | |i|pagename|runs| 04:58:11 INFO - PROCESS | 17284 | |0;dojo.html;2579.9871000644994;2661.587453944639;2687.3281679580105;2690.36776357556;2706.512827691016;4663.370444989925;4738.644601654877;4761.833335833247;4818.566329030386;4908.607311415087;4713.929291060636;4714.5285471452835;4728.598069164125;4736.739479328636;4738;4302.838233676913;4321.330193819963;4394.5385734497895;4428.114377124588;4565.908681826361;4498.1903257413815;4502.369668246448;4519.864404067883;4546;4577.198990176722;4327.199468098412;4359.455068116486;4366.497852746943;4366.956330436718;4409.338599210112;4379.912401751947;4382.868513944587;4386.6929314947965;4388.319810429389;4443.066955939256;4408.801603927831;4412.360207769888;4413.646908247332;4416.602505774464;4445.355423463612;4639.118567472169;4658.767061646904;4776.188048031808;4843.709377437365;4885.316055752198;5200.97399513;5204.98502791952;5227.581793456515;5227.581793456515;5237.450067742909;5229.346331708536;5263.210518422267;5264.394594621629;5265.236540701615;5266.526012658841;4664.55686709762;4787.114383839001;4836.032793441326;4856.1016212000895;4886.1204983103025;5290.603204759658;5302.1781623848365;5323.6273460857365;5363.946360536423;5368.221607866915;5044.697318160922;5065.366829146356;5078.771455284521;5087.186050231945;5090.796368145307;4946.455889852114;5017.749112544431;5077.238414237894;5080.441151473335;5107.387113546324;5031.974840125776;5069.087564238399;5076.340075790124;5078.542931136216;5128.0000399921655;4886.731229782325;5071.847844564669;5083.288339632454;5086.618503612244;5093.083245015932;4311.051568654891;4353.368761529624;4396.208682437192;4398.73607583546;4408.55914408563;3743.5507739071486;3762.209935913434;3764.4917936078277;3800.7339486235696;3807.3146833569667;4354;4354.9782251088545;4357.215701173819;4361.8005048611885;4418.2047231498;4962.15643340633;5083.694978301313;5127.07712611726;5136.1525348317855;5166.2508936204795;4375.431193944767;4379.167958087953;4389.1660584488845;4391.253486907233;4432.268675668543;4449.399331090326;4606.930896036562;4620.19146649335;4629.0973260214605;4670.042641258534;4820.4456487504385;4846.103470857903;4877.073356062337;4883.975580122076;4897.608191344612;5195.6622819516615;5226.555742761908;5227.7714737036;5238.266642670105;5290.232916227049;4642;4807.4471435785335;4850.442199147144;4872.049950259665;4895.608351331956;5059;5092.668976516515;5120.462351453044;5120.641555091108;5176.327077479904;5176.06830770465;5190.299309593308;5196.2465442509865;5198.428172901054;5244.685318880879;4831.227003679394;4864.537868902448;4921.434035085867;5027.924581131213;5053.2420136979745;4925.679830810986;4949.430815456269;4954.157793175241;4962.280469331999;4996.7001979881325;4865.56209941107;4882.048000639841;4927.063857866994;4932.975335123445;4938.506149385033;4826.927596086131;4893.926591101065;4988.4263309719845;4993.400791904995;5032.194848824171;4765.928511072268;4821.662483626113;4831.444383895897;4879.512048795092;4923.359963204761 04:58:11 INFO - PROCESS | 17284 | |1;ext.html;531.3465592422536;583.2039266401364;589.0369246282327;590.1207201270107;601.5368166511785;26445.867770661145;38675;39152.21695566087;39193.60806391935;39466.21067578647;36595.451068234;40328;40469.7976510117;40488.19023619526;40543.18913621726;7456.5898875561825;7596.924030759691;7786.26030527099;7790.688372465094;7791.766247012571;7399.741009064684;9887;10123.392596444237;10132.949335253314;10153.086222240034;9823.65617203398;9914.40513569188;9918.3057185997;10186.28695991281;10217.489125543692;9782.119609235167;9890.554925028391;9895.109440150422;9898.9505052475;9909.851352229722;9823.36148150375;9916.801663966753;9966.352187107816;9986;9993.950030249802;39165.41251881224;39471.40792888109;39559;39580.80209598933;39636;3113.7508999280003;3162.3517178978486;3189.521571764231;3240.675932406764;3325;30397.544036839467;30414.66868742085;30511.23721906948;30766.23084422885;32021.519677204862;3320.6423439358086;3329.20099176196;3356.848941797625;3356.9160770980675;3359.0930448778695;257535;258128;259169.9999999981;259608.10587841197;261009;56624;57891.71054144702;57995.71002145047;58248.4175158243;58261.41738582645;60473;61118;61159.38840611626;61160;61173.69413152906;15463.149526776135;15908.125053122189;15913.920430397773;15924.92037539805;15926.203689815462;10980.121590272758;11907.821382679267;12089.637310880687;12146.75706485883;12252.81620775689;18683.532911677044;18771.34300299483;18849.90575047116;18878.62242755137;18919.81080189208;7101.964490177619;7138.179109402381;7144.714211431588;7153.427725781925;7314.48798584094;790.6442101054548;858.952757598338;897.8563429851192;970.5050424283525;993.1111655068673;27596;27933.580996285073;28135.015274465706;28141.71858281432;28385.71614283872;950.8763860698065;957.3011701457974;969.966051188205;988.7231575158967;1016.537475448669;14362.210078445785;14737.410503579737;14869.959102862696;14941.626459338604;15137;369113;371051;373867;374550;375007;48825.51174488281;49383.25925111126;49435.258471122965;49493.50506494961;49578;1072.8980746829038;1087.5486673030603;1174.7298121431947;1194.9581764638197;1216.5620376664394;24039.51920961606;26778.330541736614;26785;27339.19793270438;27661.58507622347;40784.79607601943;41331.38002929898;41779.58220417757;41841.79079104585;41884;230359;232068;232289;233269;233313;31788.682113178573;37006.25987480181;40210.39684404795;41350.586494135874;41412.585874140874;41449;41519.792401037805;41692.374614380205;42496.57503424926;42508;36413.817930910176;36514.8174259127;36597.81701091584;36824.39964526156;37029.62970370369;35559.82220088883;35642;36038.27923441569;36133.457998129525;37050.81474592718;35037.299254014266;35390.292194156485;35501.644983549835;35581.46627800533;35905;31809;32077.67922320747;32260.677393225767;32556.837215813768;32916.50625240671;24516.87741561281;24730.50538989246;24832.37919052038;25327.87336063308;25379.238622840607 04:58:11 INFO - PROCESS | 17284 | |2;jquery.html;364.24782823469536;370.33894498320495;380.07072707230833;380.30783973168826;394.2115768463072;15745.212739363029;16396.26216820243;16856.74714879278;17137.742933856003;17165.399211027616;15745.606359840982;15754;16775.412860549884;16790;16823.66352672946;4937.086638971784;5099.821506247282;5112.693238405689;5146.562542183919;5153.020926024062;3714.8699795507164;3913.2173565287057;5040.294358789773;5754.251947246852;6106.8473288167925;5992.49063829575;6020.367861374559;6032.9698351508405;6052.364501727321;6059.484943779784;5756.74094665739;5901;5927.140564618127;5927.703614819285;5936.3173235077875;3380.5605271314816;4896.412430508326;5205.661631993946;5216.921746173811;5217.243499692523;20409.8979505103;20498.79501204984;20572.074256658336;21114.472138196514;21259;2128.4998025464;2272.2842304673973;2364.9054037838464;2490.5517006938744;2505.8245922785413;9519.333646644738;10478.476076196159;12149.817752733716;12726;13220.272884991322;1698.566865449315;1759.5601099725068;1813.9274429022823;1817.5274428648515;1843.7603111595406;63982;65524.3447565523;65933;66775.99999999952;66955.66522167406;10078.546465409074;10249.33379330341;10250.411186266141;10354.223433242538;10356.239439295186;13873.236971966437;13953.162810231419;13977.930110349384;14033.368498417596;14040.438382464587;7169.533980291264;7344.045274114331;7409.147947986051;7476.364509016686;7509.586972716444;6976.372126508537;7066.858662826818;7072.9646351767915;7155.534890232118;7203.423726101899;4157.625813676784;4357.782110894443;4364.323529852878;4458.9554104459185;4520.954790452053;1480.659448326891;1543.2283858070964;1547.3655801121486;1650.191406210972;1822.6354729054242;798.6925033862005;810.1007881251805;860.242986172177;867.9045305016443;916.7983043730369;16860.156992150343;16878.324867005183;16936.745948810778;16982.06598637062;17303.56741081483;813.2274339377497;826.5784449930578;832.7002279179491;868.5440143924363;870.3298460185622;9227.35408521397;10106.090451859369;10221.284510084222;10476.68569942903;10582.894171058191;400343;400523;404318;407563;409071;79495;80250.59874700589;80852.59573702094;80933.19066809374;81740.59129704432;845.7843249971341;864.4553931023415;866.1901122450529;871.4945331707594;873.0832625742944;14262.857371426153;14739.115653060851;16448.917755411145;16696.66606667884;16918;37415.25169496649;37698.7703999556;38237.426438604;38315.42526862155;39294.41058384069;48542.51457485521;49756.50243497663;50277.74861125671;50373.748131260574;50690.74654626703;7295.8540829184185;7543.358814500829;7646.885296720665;7800.492967957065;7885.605719713876;11823.113266504875;11891.227070240408;11945.745453099344;11976.401179941142;12161.39193040362;5843.677935331827;10020.899791002288;10030.899691002996;10186.388816671024;10433.113185379329;10225.948870255601;10394;10454.529546170288;10488.947555262175;10547.78904421892;5253.9211911820585;9838.311318207656;9883.456409897524;10585.100266477128;10902.182336324966;6380.9042864358;6758.797236082925;7049.189343225595;7249.202587715453;8032.277095061472;8560.614772335135;9521.809563808823;9556.474393908402;10131.341462804894;10289.3311934724 04:58:11 INFO - PROCESS | 17284 | |3;mootools.html;1209.3409092044835;1356;1392.8955328350373;1441.5531185332547;1702.9914850425753;6669.5331326807145;7531.096268447787;7783.377329813616;7786;8035.477693949903;7740.187280335554;7887.960560197191;7895.881561776578;7900.130985591581;7911.011123609549;2113.619548481273;2145.3027765976044;2146.3668217875766;2148.11927109885;2157.6332023555956;2125.3730149605826;2163.405063607505;2178.096090122597;2182.2471247419617;2183.5742030304095;2129.276046144311;2164.935051948444;2175.0321107107343;2177.803997640212;2198.3844523533357;2106.641870881946;2115.830733541313;2116.798904104108;2173.0873033326043;2217.2572188316935;2088.822450091729;2113.218109299569;2116.2381542644634;2116.4603026228215;2153.569286142762;7719.691212351499;7867.370610351159;7921.247481489249;7937.285644291984;7977.5612341321785;4477.798499067517;4591.632669386475;4593.793279302406;4597.080583883237;4601.056783359437;2860.7854410919263;2948.115565330392;2974.033439132291;3001.1146711720094;3001.2496875781053;960.5437417226761;972.9562169702381;979.3683074416961;981.9950900245453;996.5565323431076;10486;10576.048155666027;10590.576376944913;10596.470176491222;10621.362718236931;4054.614811592894;4114.218298523331;4180.1848639515;4180.372944058416;4185.434966279574;8387.203215694499;8459.703910363107;8464.534450605275;8517.787055323666;8530.616122274512;4627.953720462752;4630.837920672828;4634.467036290802;4635.6523260755575;4635.6986795858165;3662.487251784752;4093.7748423836974;4185.895352616209;4229.344451610005;4289.013526888771;3421.7775844570024;3448.620651728308;3493;3507.333606614735;3622.0582648511577;1031.437866362834;1033.1734612310122;1034.3225187502198;1045.1220974381556;1049.7585555322319;774.1523032279645;774.5314084978506;856.1139220906332;888.5868071346855;908.0057337215738;5534.252875861787;5549.833504994856;5645.407232240637;5650.74571644277;5744.569157313218;376.12926076133664;380.885734279715;383.8752405468178;402.4446264155447;407.36247772236356;3809.2191100824266;3867.8839634811;3916.9424255450867;3958.247932892741;3972.324704800191;9314.564265817775;9579.808403831885;9720.562574684156;9768.902310976799;9790.314677972616;9605.847298324246;9690.56392462341;9692.41845489273;9755.463449510346;9768.658096966572;6844.452443804484;7162.391196748231;7172.175199851979;7335.926640733631;7343.412526997828;5557.833265002057;5704;5738.397468265939;5767.307923049261;5908;8553.657853686032;8802.251808596086;8881.200691937756;9005.099490050943;9075.954620226856;8797.296216302553;9098.545072746469;9106.726798196065;9389.624415023323;9400.29497787655;6177.938220617736;6577.375149360803;6762.188537375547;6802.795916122524;6913.75801846933;7580.279873412017;7605.315521603082;7704.614769261402;7705.730299439493;7710.614469276626;6557.901631475627;6778.525503214728;6789.89815152783;6817.89773153413;6975.441964642715;6642.269350371359;6646.83382915431;6687.799366019027;6733.69698363565;6814.216365117876;6191.504679625529;6210.596311239755;6263.091851681572;6274.435300822948;6275.309715931336;4653.906921861611;4669.4396672399525;4843.104025755247;4875.975620121877;4930.580900623487;4945.777440015136;5000.524950129878;5033.622478314214;5074.3657042869645;5107.336046313955 04:58:11 INFO - PROCESS | 17284 | |4;prototype.html;291.1019504827607;297.96424429068514;301.29947871199465;305.0725793587494;308.9026956508701;4720.890590711188;4829.203181475053;4896.363472748542;4961.429435614906;4983.601311895049;4739.289106634006;4863.732494712789;4882.633802464811;4896.216605343146;4920.769807548113;3861.2199216564027;3883.8058097095172;3892.3966785148205;3895.961040389588;3923.784191869446;3669.4679271505615;3748.3253014457387;3883.8058097095172;3890.961090389088;3919.4708714323488;3833.9041523961846;3852.4799152114388;3852.7880966546827;3863.343231650612;3868.736788978451;3840.347140986039;3841.1741475582744;3844.2695887781233;3864.613538646141;3886.591907849663;3465.6880880720855;3466.3587236361354;3468.4623883298127;3472;3477.5479187705437;4655.138799322136;4777.378940737716;4791.448983366888;4795.112904112751;4815.109204797123;4382;4402.229609818269;4403.933940990888;4415.646748260131;4424.491183513873;5118.846434606968;5119.795208191668;5125.154944220078;5129.897402051975;5140.768665410065;3584.211473475831;3755.5681096673684;3795.9063363358773;3807.733458657895;3818.579956204815;5342.599305052097;5357.464253574651;5358.196270559409;5369.731513424314;5374.435684253136;3895.941560876589;3901.902452438655;3911.882643520699;3914.530256369197;3927.273454410943;3756.69946404287;3956.8812935611977;3971.126352202511;3984.2629113614075;4000.8397564706493;4384.816099653076;4427.114577084596;4441.089576636782;4448.5773851484055;4463.866084017484;5225.752926241753;5226.059309324282;5238.7904483820985;5247.921281180786;5250.579953603703;1298.298918583954;1335.105479328852;1337.8662133786543;1357.178906761415;1360.3674291454324;867.4665080975154;877.2105105405059;892.2326798952895;897.4525539420948;900.1223806788329;4020.3918432627183;4032.2540330039037;4036.5871944819078;4038.45480860086;4049.190161967618;4658.647383071595;4667.906641867144;4671.766411679402;4690.771883355379;4693.647976401715;3952.6837852971694;3976.681865450757;3986.362182050916;4012.0341032894257;4040.3333449980423;2306.654001899695;2464.9770345306856;2481.5161043596686;2492.2523243027017;2511.849289042627;4330.805113769888;4385.407969924083;4405.449318835145;4406.1187762447635;4412.735235885857;4741.2651039089;4744.817384003328;4758.7164856249765;4774.278661163173;4802.559232230317;4409.735415875058;4422.71252368595;4602.4477062752685;5045.091883461012;5045.7981680732355;5339.145736682268;5362.892742145214;5369.5167434931045;5386.811461598825;5403.324584426947;5257.316548848778;5275.762590683352;5283.973580132075;5286.599051251498;5298.28473156119;4910.88357982557;4918.950810491992;4923.975380123076;4968.950310496849;5003.874903127451;3733.96266037347;3748.9062773430883;3776.490173826608;3799.981000094982;3803.391457366808;5120.977214000374;5340.279062326536;5364.678119312854;5366.919496207482;5380.73096345189;4985.925211121908;5142.305788718475;5182.637215394886;5190.975519547304;5196.32447781786;5128.79484820603;5133.332666753298;5142.331496905378;5155.304033955368;5184.559312458332;4851.223804191312;5042.697438153723;5065.417476990193;5078.873028174326;5082.949170508396;5159.896802064013;5201.491567445399;5213.959181634264;5215.374155101412;5222.686638801684;5075.593952483866;5092.821751238689;5093.643444958965;5116.641835071509;5118.283440318432 04:58:11 INFO - PROCESS | 17284 | |5;yui.html;641.4579680170258;641.5733537197764;678.1658559971236;712.6151877985887;718.579630915914;12741.554045608405;13743.518976835812;13752;13760.454315951556;13884.028118031742;11209.495572699228;12908.290044047573;13021.73956520869;13086.476540938374;13141.145825521335;788.4835432791502;793.6944276453578;797.4059325802285;797.996010019952;801.6633014134048;786.0214033528265;792.8691765858626;793.2939683681528;794.1105961323298;794.7417089445925;846.2299307630058;847.3009766942266;848.2196379331031;848.3722045686179;848.499385362636;830.1781236575807;831.1190138453198;833.112734937296;833.4332653795417;833.8040560468285;615.0405367626516;615.4184295840432;615.4737699267107;615.4891440104702;616.072810420319;11152.052075573585;11172.888271117266;11184.608538701188;11187.832182517268;11199.608013719562;10431.739206519898;10436.895631043668;10604.787904241872;10682.145428365711;10915.399653019082;9222.631094756201;9278.257739380833;9586.424814511152;9677.515203137726;9973.65092221776;3217.3404452087266;3342.38165939302;3357.529945807589;3375.6286808451296;3402.591688997336;40807.183856323005;41739;53263.46736532663;53352.199717004274;59935;10928.787795888516;10967.725806854893;11073.50169242386;11094.778104438028;11287.20989530725;20140.89929550372;20264.49338766513;20447.182112715323;20503.897480512802;20513.17947282122;7337.449691273176;7421.591812450259;7422.146453157956;7575.24247575238;7585.924140758632;3711.16498787776;3762;3779.3764028935466;3784.280986612535;3904.4533765272886;3104.9223769405944;3235.12651584071;3236.8705251789665;3237.7409807215367;3238.465653167201;512.8051340490664;518.9351331083615;521.413409913847;522.6968358352146;528.1496790167904;518.8702824293927;557.567884889206;568.5764105741249;588.520355909932;632.8417895526119;7508.324250817453;7515.549067055994;7956.834174602757;8139.633716482773;8347.791305217419;607.0954278125561;613.7974468425409;618.1623899616045;624.2851934534932;635.199648442956;3999.34010888206;4017.4978127734034;4055.4322394864744;4069.491313585802;4154.376843473503;89681.55159224162;90865.54567227254;94436.52781736047;94541;94716;54912.45087549153;83044;84760.15239847646;85137.57431212804;85401;53024.73487632614;55565.722171389694;63827.680861596324;73622.63188684022;74418.62790686011;9050.321225907952;9315.72052838416;9491.810163796823;9538.284628653018;9587.053516160755;44161.55838441703;44465.2926792749;45682.771586141855;45694.771526142154;47668;55911.44088559225;65000.349996499426;66217;66860.66569667315;67431.32568674447;11347.432628368384;11478.483468244116;11530.308181509135;11539;11764.176507644383;12431;13213.603591892259;13507.527236546674;14144.22206778637;14170.149791012573;12535.185212961129;12913.612591622266;12993;13297.135686180754;13494.865051349361;12237.69405764863;12282.38588070575;12482.251064936132;12507.374631268218;12887.09790314669;12085.456154473246;12659;12734.872651273368;13118.475260989453;13246.668833279246;9716.271279654196;9822.312438129262;10245.129164021142;10416.1667066636;10450.059494645518;9945.254105941938;10004.599816007278;10362.326448780805;10599.470026498799;10626 04:58:11 INFO - PROCESS | 17284 | __end_tp_report 04:58:11 INFO - PROCESS | 17284 | __start_cc_report 04:58:11 INFO - PROCESS | 17284 | _x_x_mozilla_cycle_collect,1183 04:58:11 INFO - PROCESS | 17284 | __end_cc_report 04:58:11 INFO - PROCESS | 17284 | __startTimestamp1466596691542__endTimestamp 04:58:11 INFO - PROCESS | 17284 | 04:58:11 INFO - PROCESS | 17284 | ------- Summary: start ------- 04:58:11 INFO - PROCESS | 17284 | Number of tests: 6 04:58:11 INFO - PROCESS | 17284 | 04:58:11 INFO - PROCESS | 17284 | [#0] dojo.html Cycles:165 Average:4737.14 Median:4864.54 stddev:507.14 (10.4%) stddev-sans-first:479.64 04:58:11 INFO - PROCESS | 17284 | Values: 2580.0 2661.6 2687.3 2690.4 2706.5 4663.4 4738.6 4761.8 4818.6 4908.6 4713.9 4714.5 4728.6 4736.7 4738.0 4302.8 4321.3 4394.5 4428.1 4565.9 4498.2 4502.4 4519.9 4546.0 4577.2 4327.2 4359.5 4366.5 4367.0 4409.3 4379.9 4382.9 4386.7 4388.3 4443.1 4408.8 4412.4 4413.6 4416.6 4445.4 4639.1 4658.8 4776.2 4843.7 4885.3 5201.0 5205.0 5227.6 5227.6 5237.5 5229.3 5263.2 5264.4 5265.2 5266.5 4664.6 4787.1 4836.0 4856.1 4886.1 5290.6 5302.2 5323.6 5363.9 5368.2 5044.7 5065.4 5078.8 5087.2 5090.8 4946.5 5017.7 5077.2 5080.4 5107.4 5032.0 5069.1 5076.3 5078.5 5128.0 4886.7 5071.8 5083.3 5086.6 5093.1 4311.1 4353.4 4396.2 4398.7 4408.6 3743.6 3762.2 3764.5 3800.7 3807.3 4354.0 4355.0 4357.2 4361.8 4418.2 4962.2 5083.7 5127.1 5136.2 5166.3 4375.4 4379.2 4389.2 4391.3 4432.3 4449.4 4606.9 4620.2 4629.1 4670.0 4820.4 4846.1 4877.1 4884.0 4897.6 5195.7 5226.6 5227.8 5238.3 5290.2 4642.0 4807.4 4850.4 4872.0 4895.6 5059.0 5092.7 5120.5 5120.6 5176.3 5176.1 5190.3 5196.2 5198.4 5244.7 4831.2 4864.5 4921.4 5027.9 5053.2 4925.7 4949.4 4954.2 4962.3 4996.7 4865.6 4882.0 4927.1 4933.0 4938.5 4826.9 4893.9 4988.4 4993.4 5032.2 4765.9 4821.7 4831.4 4879.5 4923.4 04:58:11 INFO - PROCESS | 17284 | 04:58:11 INFO - PROCESS | 17284 | [#1] ext.html Cycles:180 Average:45733.71 Median:36711.11 stddev:77166.13 (210.2%) stddev-sans-first:77307.96 04:58:11 INFO - PROCESS | 17284 | Values: 531.3 583.2 589.0 590.1 601.5 26445.9 38675.0 39152.2 39193.6 39466.2 36595.5 40328.0 40469.8 40488.2 40543.2 7456.6 7596.9 7786.3 7790.7 7791.8 7399.7 9887.0 10123.4 10132.9 10153.1 9823.7 9914.4 9918.3 10186.3 10217.5 9782.1 9890.6 9895.1 9899.0 9909.9 9823.4 9916.8 9966.4 9986.0 9994.0 39165.4 39471.4 39559.0 39580.8 39636.0 3113.8 3162.4 3189.5 3240.7 3325.0 30397.5 30414.7 30511.2 30766.2 32021.5 3320.6 3329.2 3356.8 3356.9 3359.1 257535.0 258128.0 259170.0 259608.1 261009.0 56624.0 57891.7 57995.7 58248.4 58261.4 60473.0 61118.0 61159.4 61160.0 61173.7 15463.1 15908.1 15913.9 15924.9 15926.2 10980.1 11907.8 12089.6 12146.8 12252.8 18683.5 18771.3 18849.9 18878.6 18919.8 7102.0 7138.2 7144.7 7153.4 7314.5 790.6 859.0 897.9 970.5 993.1 27596.0 27933.6 28135.0 28141.7 28385.7 950.9 957.3 970.0 988.7 1016.5 14362.2 14737.4 14870.0 14941.6 15137.0 369113.0 371051.0 373867.0 374550.0 375007.0 48825.5 49383.3 49435.3 49493.5 49578.0 1072.9 1087.5 1174.7 1195.0 1216.6 24039.5 26778.3 26785.0 27339.2 27661.6 40784.8 41331.4 41779.6 41841.8 41884.0 230359.0 232068.0 232289.0 233269.0 233313.0 31788.7 37006.3 40210.4 41350.6 41412.6 41449.0 41519.8 41692.4 42496.6 42508.0 36413.8 36514.8 36597.8 36824.4 37029.6 35559.8 35642.0 36038.3 36133.5 37050.8 35037.3 35390.3 35501.6 35581.5 35905.0 31809.0 32077.7 32260.7 32556.8 32916.5 24516.9 24730.5 24832.4 25327.9 25379.2 04:58:11 INFO - PROCESS | 17284 | 04:58:11 INFO - PROCESS | 17284 | [#2] jquery.html Cycles:180 Average:24753.10 Median:402420.50 stddev:66692.18 (16.6%) stddev-sans-first:66854.13 04:58:11 INFO - PROCESS | 17284 | Values: 364.2 370.3 380.1 380.3 394.2 15745.2 16396.3 16856.7 17137.7 17165.4 15745.6 15754.0 16775.4 16790.0 16823.7 4937.1 5099.8 5112.7 5146.6 5153.0 3714.9 3913.2 5040.3 5754.3 6106.8 5992.5 6020.4 6033.0 6052.4 6059.5 5756.7 5901.0 5927.1 5927.7 5936.3 3380.6 4896.4 5205.7 5216.9 5217.2 20409.9 20498.8 20572.1 21114.5 21259.0 2128.5 2272.3 2364.9 2490.6 2505.8 9519.3 10478.5 12149.8 12726.0 13220.3 1698.6 1759.6 1813.9 1817.5 1843.8 63982.0 65524.3 65933.0 66776.0 66955.7 10078.5 10249.3 10250.4 10354.2 10356.2 13873.2 13953.2 13977.9 14033.4 14040.4 7169.5 7344.0 7409.1 7476.4 7509.6 6976.4 7066.9 7073.0 7155.5 7203.4 4157.6 4357.8 4364.3 4459.0 4521.0 1480.7 1543.2 1547.4 1650.2 1822.6 798.7 810.1 860.2 867.9 916.8 16860.2 16878.3 16936.7 16982.1 17303.6 813.2 826.6 832.7 868.5 870.3 9227.4 10106.1 10221.3 10476.7 10582.9 400343.0 400523.0 404318.0 407563.0 409071.0 79495.0 80250.6 80852.6 80933.2 81740.6 845.8 864.5 866.2 871.5 873.1 14262.9 14739.1 16448.9 16696.7 16918.0 37415.3 37698.8 38237.4 38315.4 39294.4 48542.5 49756.5 50277.7 50373.7 50690.7 7295.9 7543.4 7646.9 7800.5 7885.6 11823.1 11891.2 11945.7 11976.4 12161.4 5843.7 10020.9 10030.9 10186.4 10433.1 10225.9 10394.0 10454.5 10488.9 10547.8 5253.9 9838.3 9883.5 10585.1 10902.2 6380.9 6758.8 7049.2 7249.2 8032.3 8560.6 9521.8 9556.5 10131.3 10289.3 04:58:11 INFO - PROCESS | 17284 | 04:58:11 INFO - PROCESS | 17284 | [#3] mootools.html Cycles:180 Average:5147.98 Median:5542.04 stddev:2887.02 (52.1%) stddev-sans-first:2879.94 04:58:11 INFO - PROCESS | 17284 | Values: 1209.3 1356.0 1392.9 1441.6 1703.0 6669.5 7531.1 7783.4 7786.0 8035.5 7740.2 7888.0 7895.9 7900.1 7911.0 2113.6 2145.3 2146.4 2148.1 2157.6 2125.4 2163.4 2178.1 2182.2 2183.6 2129.3 2164.9 2175.0 2177.8 2198.4 2106.6 2115.8 2116.8 2173.1 2217.3 2088.8 2113.2 2116.2 2116.5 2153.6 7719.7 7867.4 7921.2 7937.3 7977.6 4477.8 4591.6 4593.8 4597.1 4601.1 2860.8 2948.1 2974.0 3001.1 3001.2 960.5 973.0 979.4 982.0 996.6 10486.0 10576.0 10590.6 10596.5 10621.4 4054.6 4114.2 4180.2 4180.4 4185.4 8387.2 8459.7 8464.5 8517.8 8530.6 4628.0 4630.8 4634.5 4635.7 4635.7 3662.5 4093.8 4185.9 4229.3 4289.0 3421.8 3448.6 3493.0 3507.3 3622.1 1031.4 1033.2 1034.3 1045.1 1049.8 774.2 774.5 856.1 888.6 908.0 5534.3 5549.8 5645.4 5650.7 5744.6 376.1 380.9 383.9 402.4 407.4 3809.2 3867.9 3916.9 3958.2 3972.3 9314.6 9579.8 9720.6 9768.9 9790.3 9605.8 9690.6 9692.4 9755.5 9768.7 6844.5 7162.4 7172.2 7335.9 7343.4 5557.8 5704.0 5738.4 5767.3 5908.0 8553.7 8802.3 8881.2 9005.1 9076.0 8797.3 9098.5 9106.7 9389.6 9400.3 6177.9 6577.4 6762.2 6802.8 6913.8 7580.3 7605.3 7704.6 7705.7 7710.6 6557.9 6778.5 6789.9 6817.9 6975.4 6642.3 6646.8 6687.8 6733.7 6814.2 6191.5 6210.6 6263.1 6274.4 6275.3 4653.9 4669.4 4843.1 4876.0 4930.6 4945.8 5000.5 5033.6 5074.4 5107.3 04:58:11 INFO - PROCESS | 17284 | 04:58:11 INFO - PROCESS | 17284 | [#4] prototype.html Cycles:180 Average:4205.56 Median:4669.84 stddev:1219.68 (26.1%) stddev-sans-first:1187.18 04:58:11 INFO - PROCESS | 17284 | Values: 291.1 298.0 301.3 305.1 308.9 4720.9 4829.2 4896.4 4961.4 4983.6 4739.3 4863.7 4882.6 4896.2 4920.8 3861.2 3883.8 3892.4 3896.0 3923.8 3669.5 3748.3 3883.8 3891.0 3919.5 3833.9 3852.5 3852.8 3863.3 3868.7 3840.3 3841.2 3844.3 3864.6 3886.6 3465.7 3466.4 3468.5 3472.0 3477.5 4655.1 4777.4 4791.4 4795.1 4815.1 4382.0 4402.2 4403.9 4415.6 4424.5 5118.8 5119.8 5125.2 5129.9 5140.8 3584.2 3755.6 3795.9 3807.7 3818.6 5342.6 5357.5 5358.2 5369.7 5374.4 3895.9 3901.9 3911.9 3914.5 3927.3 3756.7 3956.9 3971.1 3984.3 4000.8 4384.8 4427.1 4441.1 4448.6 4463.9 5225.8 5226.1 5238.8 5247.9 5250.6 1298.3 1335.1 1337.9 1357.2 1360.4 867.5 877.2 892.2 897.5 900.1 4020.4 4032.3 4036.6 4038.5 4049.2 4658.6 4667.9 4671.8 4690.8 4693.6 3952.7 3976.7 3986.4 4012.0 4040.3 2306.7 2465.0 2481.5 2492.3 2511.8 4330.8 4385.4 4405.4 4406.1 4412.7 4741.3 4744.8 4758.7 4774.3 4802.6 4409.7 4422.7 4602.4 5045.1 5045.8 5339.1 5362.9 5369.5 5386.8 5403.3 5257.3 5275.8 5284.0 5286.6 5298.3 4910.9 4919.0 4924.0 4969.0 5003.9 3734.0 3748.9 3776.5 3800.0 3803.4 5121.0 5340.3 5364.7 5366.9 5380.7 4985.9 5142.3 5182.6 5191.0 5196.3 5128.8 5133.3 5142.3 5155.3 5184.6 4851.2 5042.7 5065.4 5078.9 5082.9 5159.9 5201.5 5214.0 5215.4 5222.7 5075.6 5092.8 5093.6 5116.6 5118.3 04:58:11 INFO - PROCESS | 17284 | 04:58:11 INFO - PROCESS | 17284 | [#5] yui.html Cycles:180 Average:17040.39 Median:518.90 stddev:23598.89 (4547.8%) stddev-sans-first:23632.97 04:58:11 INFO - PROCESS | 17284 | Values: 641.5 641.6 678.2 712.6 718.6 12741.6 13743.5 13752.0 13760.5 13884.0 11209.5 12908.3 13021.7 13086.5 13141.1 788.5 793.7 797.4 798.0 801.7 786.0 792.9 793.3 794.1 794.7 846.2 847.3 848.2 848.4 848.5 830.2 831.1 833.1 833.4 833.8 615.0 615.4 615.5 615.5 616.1 11152.1 11172.9 11184.6 11187.8 11199.6 10431.7 10436.9 10604.8 10682.1 10915.4 9222.6 9278.3 9586.4 9677.5 9973.7 3217.3 3342.4 3357.5 3375.6 3402.6 40807.2 41739.0 53263.5 53352.2 59935.0 10928.8 10967.7 11073.5 11094.8 11287.2 20140.9 20264.5 20447.2 20503.9 20513.2 7337.4 7421.6 7422.1 7575.2 7585.9 3711.2 3762.0 3779.4 3784.3 3904.5 3104.9 3235.1 3236.9 3237.7 3238.5 512.8 518.9 521.4 522.7 528.1 518.9 557.6 568.6 588.5 632.8 7508.3 7515.5 7956.8 8139.6 8347.8 607.1 613.8 618.2 624.3 635.2 3999.3 4017.5 4055.4 4069.5 4154.4 89681.6 90865.5 94436.5 94541.0 94716.0 54912.5 83044.0 84760.2 85137.6 85401.0 53024.7 55565.7 63827.7 73622.6 74418.6 9050.3 9315.7 9491.8 9538.3 9587.1 44161.6 44465.3 45682.8 45694.8 47668.0 55911.4 65000.3 66217.0 66860.7 67431.3 11347.4 11478.5 11530.3 11539.0 11764.2 12431.0 13213.6 13507.5 14144.2 14170.1 12535.2 12913.6 12993.0 13297.1 13494.9 12237.7 12282.4 12482.3 12507.4 12887.1 12085.5 12659.0 12734.9 13118.5 13246.7 9716.3 9822.3 10245.1 10416.2 10450.1 9945.3 10004.6 10362.3 10599.5 10626.0 04:58:11 INFO - PROCESS | 17284 | -------- Summary: end -------- 04:58:11 INFO - PROCESS | 17284 | 04:58:12 INFO - TEST-INFO | 17284: exit 0 04:58:12 INFO - TEST-OK | dromaeo_css | took 1120766ms 04:58:12 INFO - TEST-START | kraken 04:58:12 INFO - operating with platform_type : linux_ 04:58:12 INFO - Initialising browser for kraken test... 04:58:12 INFO - TEST-INFO | started process 17463 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAskJI8/profile http://localhost:34865/getInfo.html) 04:58:16 INFO - PROCESS | 17463 | __metrics Screen width/height:1600/1200 04:58:16 INFO - PROCESS | 17463 | colorDepth:24 04:58:16 INFO - PROCESS | 17463 | Browser inner width/height: 1024/697 04:58:16 INFO - PROCESS | 17463 | __metrics 04:58:17 INFO - PROCESS | 17463 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:58:18 INFO - TEST-INFO | 17463: exit 0 04:58:18 INFO - Browser initialized. 04:58:18 INFO - Running cycle 1/1 for kraken test... 04:58:18 INFO - TEST-INFO | started process 17544 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAskJI8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:58:31 INFO - PROCESS | 17544 | RSS: Main: 175042560 04:58:31 INFO - PROCESS | 17544 | 04:58:33 INFO - PROCESS | 17544 | Cycle 1(1): loaded http://localhost:34865/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34865/tests/kraken/driver.html?testName=audio-beat-detection) 04:58:34 INFO - PROCESS | 17544 | RSS: Main: 232587264 04:58:34 INFO - PROCESS | 17544 | 04:58:37 INFO - PROCESS | 17544 | Cycle 1(1): loaded http://localhost:34865/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34865/tests/kraken/driver.html?testName=audio-dft) 04:58:38 INFO - PROCESS | 17544 | RSS: Main: 220205056 04:58:38 INFO - PROCESS | 17544 | 04:58:41 INFO - PROCESS | 17544 | Cycle 1(1): loaded http://localhost:34865/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34865/tests/kraken/driver.html?testName=audio-fft) 04:58:42 INFO - PROCESS | 17544 | RSS: Main: 288452608 04:58:42 INFO - PROCESS | 17544 | 04:58:44 INFO - PROCESS | 17544 | Cycle 1(1): loaded http://localhost:34865/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34865/tests/kraken/driver.html?testName=audio-oscillator) 04:58:44 INFO - PROCESS | 17544 | RSS: Main: 198193152 04:58:44 INFO - PROCESS | 17544 | 04:58:47 INFO - PROCESS | 17544 | Cycle 1(1): loaded http://localhost:34865/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34865/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:58:47 INFO - PROCESS | 17544 | RSS: Main: 203780096 04:58:47 INFO - PROCESS | 17544 | 04:58:50 INFO - PROCESS | 17544 | Cycle 1(1): loaded http://localhost:34865/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34865/tests/kraken/driver.html?testName=imaging-darkroom) 04:58:51 INFO - PROCESS | 17544 | RSS: Main: 239120384 04:58:51 INFO - PROCESS | 17544 | 04:58:55 INFO - PROCESS | 17544 | Cycle 1(1): loaded http://localhost:34865/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34865/tests/kraken/driver.html?testName=imaging-desaturate) 04:58:55 INFO - PROCESS | 17544 | RSS: Main: 239706112 04:58:55 INFO - PROCESS | 17544 | 04:58:58 INFO - PROCESS | 17544 | Cycle 1(1): loaded http://localhost:34865/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34865/tests/kraken/driver.html?testName=json-parse-financial) 04:58:59 INFO - PROCESS | 17544 | RSS: Main: 239181824 04:58:59 INFO - PROCESS | 17544 | 04:59:00 INFO - PROCESS | 17544 | Cycle 1(1): loaded http://localhost:34865/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34865/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:59:01 INFO - PROCESS | 17544 | RSS: Main: 225218560 04:59:01 INFO - PROCESS | 17544 | 04:59:03 INFO - PROCESS | 17544 | Cycle 1(1): loaded http://localhost:34865/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34865/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:59:03 INFO - PROCESS | 17544 | RSS: Main: 230424576 04:59:03 INFO - PROCESS | 17544 | 04:59:06 INFO - PROCESS | 17544 | Cycle 1(1): loaded http://localhost:34865/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34865/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:59:06 INFO - PROCESS | 17544 | RSS: Main: 239038464 04:59:06 INFO - PROCESS | 17544 | 04:59:09 INFO - PROCESS | 17544 | Cycle 1(1): loaded http://localhost:34865/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34865/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:59:10 INFO - PROCESS | 17544 | RSS: Main: 241983488 04:59:10 INFO - PROCESS | 17544 | 04:59:13 INFO - PROCESS | 17544 | Cycle 1(1): loaded http://localhost:34865/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34865/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:59:13 INFO - PROCESS | 17544 | RSS: Main: 240726016 04:59:13 INFO - PROCESS | 17544 | 04:59:15 INFO - PROCESS | 17544 | Cycle 1(1): loaded http://localhost:34865/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34865/tests/kraken/driver.html?testName=ai-astar) 04:59:15 INFO - PROCESS | 17544 | RSS: Main: 283680768 04:59:15 INFO - PROCESS | 17544 | 04:59:15 INFO - PROCESS | 17544 | __start_tp_report 04:59:15 INFO - PROCESS | 17544 | _x_x_mozilla_page_load 04:59:15 INFO - PROCESS | 17544 | _x_x_mozilla_page_load_details 04:59:15 INFO - PROCESS | 17544 | |i|pagename|runs| 04:59:15 INFO - PROCESS | 17544 | |0;ai-astar;113;108;112;114;112;112;113;112;113;112 04:59:15 INFO - PROCESS | 17544 | |1;audio-beat-detection;175;140;138;191;130;162;165;135;201;134 04:59:15 INFO - PROCESS | 17544 | |2;audio-dft;163;162;164;164;164;162;163;162;165;161 04:59:15 INFO - PROCESS | 17544 | |3;audio-fft;77;76;77;103;76;78;75;77;105;76 04:59:15 INFO - PROCESS | 17544 | |4;audio-oscillator;87;88;124;87;88;87;120;86;87;129 04:59:15 INFO - PROCESS | 17544 | |5;imaging-gaussian-blur;117;117;118;118;118;118;118;118;118;118 04:59:15 INFO - PROCESS | 17544 | |6;imaging-darkroom;148;148;147;148;147;148;147;147;147;148 04:59:15 INFO - PROCESS | 17544 | |7;imaging-desaturate;95;95;95;94;96;94;94;95;94;95 04:59:15 INFO - PROCESS | 17544 | |8;json-parse-financial;64;63;63;63;65;64;63;64;63;62 04:59:15 INFO - PROCESS | 17544 | |9;json-stringify-tinderbox;64;66;65;65;66;66;64;66;64;64 04:59:15 INFO - PROCESS | 17544 | |10;stanford-crypto-aes;84;83;83;83;84;84;83;90;123;83 04:59:15 INFO - PROCESS | 17544 | |11;stanford-crypto-ccm;133;134;142;131;130;129;129;133;143;141 04:59:15 INFO - PROCESS | 17544 | |12;stanford-crypto-pbkdf2;173;170;175;176;175;172;172;176;171;168 04:59:15 INFO - PROCESS | 17544 | |13;stanford-crypto-sha256-iterative;69;69;68;68;68;68;68;67;68;67 04:59:15 INFO - PROCESS | 17544 | __end_tp_report 04:59:15 INFO - PROCESS | 17544 | __start_cc_report 04:59:15 INFO - PROCESS | 17544 | _x_x_mozilla_cycle_collect,1905 04:59:15 INFO - PROCESS | 17544 | __end_cc_report 04:59:15 INFO - PROCESS | 17544 | __startTimestamp1466596755898__endTimestamp 04:59:15 INFO - PROCESS | 17544 | 04:59:15 INFO - PROCESS | 17544 | ------- Summary: start ------- 04:59:15 INFO - PROCESS | 17544 | Number of tests: 14 04:59:15 INFO - PROCESS | 17544 | 04:59:15 INFO - PROCESS | 17544 | [#0] ai-astar Cycles:10 Average:112.10 Median:112.50 stddev:1.60 (1.4%) stddev-sans-first:1.66 04:59:15 INFO - PROCESS | 17544 | Values: 113.0 108.0 112.0 114.0 112.0 112.0 113.0 112.0 113.0 112.0 04:59:15 INFO - PROCESS | 17544 | 04:59:15 INFO - PROCESS | 17544 | [#1] audio-beat-detection Cycles:10 Average:157.10 Median:163.50 stddev:25.60 (15.7%) stddev-sans-first:26.32 04:59:15 INFO - PROCESS | 17544 | Values: 175.0 140.0 138.0 191.0 130.0 162.0 165.0 135.0 201.0 134.0 04:59:15 INFO - PROCESS | 17544 | 04:59:15 INFO - PROCESS | 17544 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.50 stddev:1.25 (0.8%) stddev-sans-first:1.32 04:59:15 INFO - PROCESS | 17544 | Values: 163.0 162.0 164.0 164.0 164.0 162.0 163.0 162.0 165.0 161.0 04:59:15 INFO - PROCESS | 17544 | 04:59:15 INFO - PROCESS | 17544 | [#3] audio-fft Cycles:10 Average:82.00 Median:76.50 stddev:11.63 (15.2%) stddev-sans-first:12.20 04:59:15 INFO - PROCESS | 17544 | Values: 77.0 76.0 77.0 103.0 76.0 78.0 75.0 77.0 105.0 76.0 04:59:15 INFO - PROCESS | 17544 | 04:59:15 INFO - PROCESS | 17544 | [#4] audio-oscillator Cycles:10 Average:98.30 Median:87.00 stddev:18.10 (20.8%) stddev-sans-first:18.73 04:59:15 INFO - PROCESS | 17544 | Values: 87.0 88.0 124.0 87.0 88.0 87.0 120.0 86.0 87.0 129.0 04:59:15 INFO - PROCESS | 17544 | 04:59:15 INFO - PROCESS | 17544 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 04:59:15 INFO - PROCESS | 17544 | Values: 117.0 117.0 118.0 118.0 118.0 118.0 118.0 118.0 118.0 118.0 04:59:15 INFO - PROCESS | 17544 | 04:59:15 INFO - PROCESS | 17544 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 04:59:15 INFO - PROCESS | 17544 | Values: 148.0 148.0 147.0 148.0 147.0 148.0 147.0 147.0 147.0 148.0 04:59:15 INFO - PROCESS | 17544 | 04:59:15 INFO - PROCESS | 17544 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 04:59:15 INFO - PROCESS | 17544 | Values: 95.0 95.0 95.0 94.0 96.0 94.0 94.0 95.0 94.0 95.0 04:59:15 INFO - PROCESS | 17544 | 04:59:15 INFO - PROCESS | 17544 | [#8] json-parse-financial Cycles:10 Average:63.40 Median:63.50 stddev:0.84 (1.3%) stddev-sans-first:0.87 04:59:15 INFO - PROCESS | 17544 | Values: 64.0 63.0 63.0 63.0 65.0 64.0 63.0 64.0 63.0 62.0 04:59:15 INFO - PROCESS | 17544 | 04:59:15 INFO - PROCESS | 17544 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.50 stddev:0.94 (1.4%) stddev-sans-first:0.93 04:59:15 INFO - PROCESS | 17544 | Values: 64.0 66.0 65.0 65.0 66.0 66.0 64.0 66.0 64.0 64.0 04:59:15 INFO - PROCESS | 17544 | 04:59:15 INFO - PROCESS | 17544 | [#10] stanford-crypto-aes Cycles:10 Average:88.00 Median:83.50 stddev:12.48 (14.9%) stddev-sans-first:13.15 04:59:15 INFO - PROCESS | 17544 | Values: 84.0 83.0 83.0 83.0 84.0 84.0 83.0 90.0 123.0 83.0 04:59:15 INFO - PROCESS | 17544 | 04:59:15 INFO - PROCESS | 17544 | [#11] stanford-crypto-ccm Cycles:10 Average:134.50 Median:133.50 stddev:5.46 (4.1%) stddev-sans-first:5.77 04:59:15 INFO - PROCESS | 17544 | Values: 133.0 134.0 142.0 131.0 130.0 129.0 129.0 133.0 143.0 141.0 04:59:15 INFO - PROCESS | 17544 | 04:59:15 INFO - PROCESS | 17544 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.80 Median:174.00 stddev:2.70 (1.6%) stddev-sans-first:2.86 04:59:15 INFO - PROCESS | 17544 | Values: 173.0 170.0 175.0 176.0 175.0 172.0 172.0 176.0 171.0 168.0 04:59:15 INFO - PROCESS | 17544 | 04:59:15 INFO - PROCESS | 17544 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 04:59:15 INFO - PROCESS | 17544 | Values: 69.0 69.0 68.0 68.0 68.0 68.0 68.0 67.0 68.0 67.0 04:59:15 INFO - PROCESS | 17544 | -------- Summary: end -------- 04:59:15 INFO - PROCESS | 17544 | 04:59:17 INFO - TEST-INFO | 17544: exit 0 04:59:17 INFO - TEST-OK | kraken | took 64773ms 04:59:17 INFO - SUITE-END | took 1185s 04:59:17 INFO - Completed test suite (00:19:45) 04:59:17 INFO - javascript benchmark 04:59:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2579.9871000644994, 2661.587453944639, 2687.3281679580105, 2690.36776357556, 2706.512827691016, 4663.370444989925, 4738.644601654877, 4761.833335833247, 4818.566329030386, 4908.607311415087, 4713.929291060636, 4714.5285471452835, 4728.598069164125, 4736.739479328636, 4738.0, 4302.838233676913, 4321.330193819963, 4394.5385734497895, 4428.114377124588, 4565.908681826361, 4498.1903257413815, 4502.369668246448, 4519.864404067883, 4546.0, 4577.198990176722, 4327.199468098412, 4359.455068116486, 4366.497852746943, 4366.956330436718, 4409.338599210112, 4379.912401751947, 4382.868513944587, 4386.6929314947965, 4388.319810429389, 4443.066955939256, 4408.801603927831, 4412.360207769888, 4413.646908247332, 4416.602505774464, 4445.355423463612, 4639.118567472169, 4658.767061646904, 4776.188048031808, 4843.709377437365, 4885.316055752198, 5200.97399513, 5204.98502791952, 5227.581793456515, 5227.581793456515, 5237.450067742909, 5229.346331708536, 5263.210518422267, 5264.394594621629, 5265.236540701615, 5266.526012658841, 4664.55686709762, 4787.114383839001, 4836.032793441326, 4856.1016212000895, 4886.1204983103025, 5290.603204759658, 5302.1781623848365, 5323.6273460857365, 5363.946360536423, 5368.221607866915, 5044.697318160922, 5065.366829146356, 5078.771455284521, 5087.186050231945, 5090.796368145307, 4946.455889852114, 5017.749112544431, 5077.238414237894, 5080.441151473335, 5107.387113546324, 5031.974840125776, 5069.087564238399, 5076.340075790124, 5078.542931136216, 5128.0000399921655, 4886.731229782325, 5071.847844564669, 5083.288339632454, 5086.618503612244, 5093.083245015932, 4311.051568654891, 4353.368761529624, 4396.208682437192, 4398.73607583546, 4408.55914408563, 3743.5507739071486, 3762.209935913434, 3764.4917936078277, 3800.7339486235696, 3807.3146833569667, 4354.0, 4354.9782251088545, 4357.215701173819, 4361.8005048611885, 4418.2047231498, 4962.15643340633, 5083.694978301313, 5127.07712611726, 5136.1525348317855, 5166.2508936204795, 4375.431193944767, 4379.167958087953, 4389.1660584488845, 4391.253486907233, 4432.268675668543, 4449.399331090326, 4606.930896036562, 4620.19146649335, 4629.0973260214605, 4670.042641258534, 4820.4456487504385, 4846.103470857903, 4877.073356062337, 4883.975580122076, 4897.608191344612, 5195.6622819516615, 5226.555742761908, 5227.7714737036, 5238.266642670105, 5290.232916227049, 4642.0, 4807.4471435785335, 4850.442199147144, 4872.049950259665, 4895.608351331956, 5059.0, 5092.668976516515, 5120.462351453044, 5120.641555091108, 5176.327077479904, 5176.06830770465, 5190.299309593308, 5196.2465442509865, 5198.428172901054, 5244.685318880879, 4831.227003679394, 4864.537868902448, 4921.434035085867, 5027.924581131213, 5053.2420136979745, 4925.679830810986, 4949.430815456269, 4954.157793175241, 4962.280469331999, 4996.7001979881325, 4865.56209941107, 4882.048000639841, 4927.063857866994, 4932.975335123445, 4938.506149385033, 4826.927596086131, 4893.926591101065, 4988.4263309719845, 4993.400791904995, 5032.194848824171, 4765.928511072268, 4821.662483626113, 4831.444383895897, 4879.512048795092, 4923.359963204761], "value": 4704.311000088481, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [531.3465592422536, 583.2039266401364, 589.0369246282327, 590.1207201270107, 601.5368166511785, 26445.867770661145, 38675.0, 39152.21695566087, 39193.60806391935, 39466.21067578647, 36595.451068234, 40328.0, 40469.7976510117, 40488.19023619526, 40543.18913621726, 7456.5898875561825, 7596.924030759691, 7786.26030527099, 7790.688372465094, 7791.766247012571, 7399.741009064684, 9887.0, 10123.392596444237, 10132.949335253314, 10153.086222240034, 9823.65617203398, 9914.40513569188, 9918.3057185997, 10186.28695991281, 10217.489125543692, 9782.119609235167, 9890.554925028391, 9895.109440150422, 9898.9505052475, 9909.851352229722, 9823.36148150375, 9916.801663966753, 9966.352187107816, 9986.0, 9993.950030249802, 39165.41251881224, 39471.40792888109, 39559.0, 39580.80209598933, 39636.0, 3113.7508999280003, 3162.3517178978486, 3189.521571764231, 3240.675932406764, 3325.0, 30397.544036839467, 30414.66868742085, 30511.23721906948, 30766.23084422885, 32021.519677204862, 3320.6423439358086, 3329.20099176196, 3356.848941797625, 3356.9160770980675, 3359.0930448778695, 257535.0, 258128.0, 259169.9999999981, 259608.10587841197, 261009.0, 56624.0, 57891.71054144702, 57995.71002145047, 58248.4175158243, 58261.41738582645, 60473.0, 61118.0, 61159.38840611626, 61160.0, 61173.69413152906, 15463.149526776135, 15908.125053122189, 15913.920430397773, 15924.92037539805, 15926.203689815462, 10980.121590272758, 11907.821382679267, 12089.637310880687, 12146.75706485883, 12252.81620775689, 18683.532911677044, 18771.34300299483, 18849.90575047116, 18878.62242755137, 18919.81080189208, 7101.964490177619, 7138.179109402381, 7144.714211431588, 7153.427725781925, 7314.48798584094, 790.6442101054548, 858.952757598338, 897.8563429851192, 970.5050424283525, 993.1111655068673, 27596.0, 27933.580996285073, 28135.015274465706, 28141.71858281432, 28385.71614283872, 950.8763860698065, 957.3011701457974, 969.966051188205, 988.7231575158967, 1016.537475448669, 14362.210078445785, 14737.410503579737, 14869.959102862696, 14941.626459338604, 15137.0, 369113.0, 371051.0, 373867.0, 374550.0, 375007.0, 48825.51174488281, 49383.25925111126, 49435.258471122965, 49493.50506494961, 49578.0, 1072.8980746829038, 1087.5486673030603, 1174.7298121431947, 1194.9581764638197, 1216.5620376664394, 24039.51920961606, 26778.330541736614, 26785.0, 27339.19793270438, 27661.58507622347, 40784.79607601943, 41331.38002929898, 41779.58220417757, 41841.79079104585, 41884.0, 230359.0, 232068.0, 232289.0, 233269.0, 233313.0, 31788.682113178573, 37006.25987480181, 40210.39684404795, 41350.586494135874, 41412.585874140874, 41449.0, 41519.792401037805, 41692.374614380205, 42496.57503424926, 42508.0, 36413.817930910176, 36514.8174259127, 36597.81701091584, 36824.39964526156, 37029.62970370369, 35559.82220088883, 35642.0, 36038.27923441569, 36133.457998129525, 37050.81474592718, 35037.299254014266, 35390.292194156485, 35501.644983549835, 35581.46627800533, 35905.0, 31809.0, 32077.67922320747, 32260.677393225767, 32556.837215813768, 32916.50625240671, 24516.87741561281, 24730.50538989246, 24832.37919052038, 25327.87336063308, 25379.238622840607], "value": 18180.73175070059, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.24782823469536, 370.33894498320495, 380.07072707230833, 380.30783973168826, 394.2115768463072, 15745.212739363029, 16396.26216820243, 16856.74714879278, 17137.742933856003, 17165.399211027616, 15745.606359840982, 15754.0, 16775.412860549884, 16790.0, 16823.66352672946, 4937.086638971784, 5099.821506247282, 5112.693238405689, 5146.562542183919, 5153.020926024062, 3714.8699795507164, 3913.2173565287057, 5040.294358789773, 5754.251947246852, 6106.8473288167925, 5992.49063829575, 6020.367861374559, 6032.9698351508405, 6052.364501727321, 6059.484943779784, 5756.74094665739, 5901.0, 5927.140564618127, 5927.703614819285, 5936.3173235077875, 3380.5605271314816, 4896.412430508326, 5205.661631993946, 5216.921746173811, 5217.243499692523, 20409.8979505103, 20498.79501204984, 20572.074256658336, 21114.472138196514, 21259.0, 2128.4998025464, 2272.2842304673973, 2364.9054037838464, 2490.5517006938744, 2505.8245922785413, 9519.333646644738, 10478.476076196159, 12149.817752733716, 12726.0, 13220.272884991322, 1698.566865449315, 1759.5601099725068, 1813.9274429022823, 1817.5274428648515, 1843.7603111595406, 63982.0, 65524.3447565523, 65933.0, 66775.99999999952, 66955.66522167406, 10078.546465409074, 10249.33379330341, 10250.411186266141, 10354.223433242538, 10356.239439295186, 13873.236971966437, 13953.162810231419, 13977.930110349384, 14033.368498417596, 14040.438382464587, 7169.533980291264, 7344.045274114331, 7409.147947986051, 7476.364509016686, 7509.586972716444, 6976.372126508537, 7066.858662826818, 7072.9646351767915, 7155.534890232118, 7203.423726101899, 4157.625813676784, 4357.782110894443, 4364.323529852878, 4458.9554104459185, 4520.954790452053, 1480.659448326891, 1543.2283858070964, 1547.3655801121486, 1650.191406210972, 1822.6354729054242, 798.6925033862005, 810.1007881251805, 860.242986172177, 867.9045305016443, 916.7983043730369, 16860.156992150343, 16878.324867005183, 16936.745948810778, 16982.06598637062, 17303.56741081483, 813.2274339377497, 826.5784449930578, 832.7002279179491, 868.5440143924363, 870.3298460185622, 9227.35408521397, 10106.090451859369, 10221.284510084222, 10476.68569942903, 10582.894171058191, 400343.0, 400523.0, 404318.0, 407563.0, 409071.0, 79495.0, 80250.59874700589, 80852.59573702094, 80933.19066809374, 81740.59129704432, 845.7843249971341, 864.4553931023415, 866.1901122450529, 871.4945331707594, 873.0832625742944, 14262.857371426153, 14739.115653060851, 16448.917755411145, 16696.66606667884, 16918.0, 37415.25169496649, 37698.7703999556, 38237.426438604, 38315.42526862155, 39294.41058384069, 48542.51457485521, 49756.50243497663, 50277.74861125671, 50373.748131260574, 50690.74654626703, 7295.8540829184185, 7543.358814500829, 7646.885296720665, 7800.492967957065, 7885.605719713876, 11823.113266504875, 11891.227070240408, 11945.745453099344, 11976.401179941142, 12161.39193040362, 5843.677935331827, 10020.899791002288, 10030.899691002996, 10186.388816671024, 10433.113185379329, 10225.948870255601, 10394.0, 10454.529546170288, 10488.947555262175, 10547.78904421892, 5253.9211911820585, 9838.311318207656, 9883.456409897524, 10585.100266477128, 10902.182336324966, 6380.9042864358, 6758.797236082925, 7049.189343225595, 7249.202587715453, 8032.277095061472, 8560.614772335135, 9521.809563808823, 9556.474393908402, 10131.341462804894, 10289.3311934724], "value": 8233.00072239646, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1209.3409092044835, 1356.0, 1392.8955328350373, 1441.5531185332547, 1702.9914850425753, 6669.5331326807145, 7531.096268447787, 7783.377329813616, 7786.0, 8035.477693949903, 7740.187280335554, 7887.960560197191, 7895.881561776578, 7900.130985591581, 7911.011123609549, 2113.619548481273, 2145.3027765976044, 2146.3668217875766, 2148.11927109885, 2157.6332023555956, 2125.3730149605826, 2163.405063607505, 2178.096090122597, 2182.2471247419617, 2183.5742030304095, 2129.276046144311, 2164.935051948444, 2175.0321107107343, 2177.803997640212, 2198.3844523533357, 2106.641870881946, 2115.830733541313, 2116.798904104108, 2173.0873033326043, 2217.2572188316935, 2088.822450091729, 2113.218109299569, 2116.2381542644634, 2116.4603026228215, 2153.569286142762, 7719.691212351499, 7867.370610351159, 7921.247481489249, 7937.285644291984, 7977.5612341321785, 4477.798499067517, 4591.632669386475, 4593.793279302406, 4597.080583883237, 4601.056783359437, 2860.7854410919263, 2948.115565330392, 2974.033439132291, 3001.1146711720094, 3001.2496875781053, 960.5437417226761, 972.9562169702381, 979.3683074416961, 981.9950900245453, 996.5565323431076, 10486.0, 10576.048155666027, 10590.576376944913, 10596.470176491222, 10621.362718236931, 4054.614811592894, 4114.218298523331, 4180.1848639515, 4180.372944058416, 4185.434966279574, 8387.203215694499, 8459.703910363107, 8464.534450605275, 8517.787055323666, 8530.616122274512, 4627.953720462752, 4630.837920672828, 4634.467036290802, 4635.6523260755575, 4635.6986795858165, 3662.487251784752, 4093.7748423836974, 4185.895352616209, 4229.344451610005, 4289.013526888771, 3421.7775844570024, 3448.620651728308, 3493.0, 3507.333606614735, 3622.0582648511577, 1031.437866362834, 1033.1734612310122, 1034.3225187502198, 1045.1220974381556, 1049.7585555322319, 774.1523032279645, 774.5314084978506, 856.1139220906332, 888.5868071346855, 908.0057337215738, 5534.252875861787, 5549.833504994856, 5645.407232240637, 5650.74571644277, 5744.569157313218, 376.12926076133664, 380.885734279715, 383.8752405468178, 402.4446264155447, 407.36247772236356, 3809.2191100824266, 3867.8839634811, 3916.9424255450867, 3958.247932892741, 3972.324704800191, 9314.564265817775, 9579.808403831885, 9720.562574684156, 9768.902310976799, 9790.314677972616, 9605.847298324246, 9690.56392462341, 9692.41845489273, 9755.463449510346, 9768.658096966572, 6844.452443804484, 7162.391196748231, 7172.175199851979, 7335.926640733631, 7343.412526997828, 5557.833265002057, 5704.0, 5738.397468265939, 5767.307923049261, 5908.0, 8553.657853686032, 8802.251808596086, 8881.200691937756, 9005.099490050943, 9075.954620226856, 8797.296216302553, 9098.545072746469, 9106.726798196065, 9389.624415023323, 9400.29497787655, 6177.938220617736, 6577.375149360803, 6762.188537375547, 6802.795916122524, 6913.75801846933, 7580.279873412017, 7605.315521603082, 7704.614769261402, 7705.730299439493, 7710.614469276626, 6557.901631475627, 6778.525503214728, 6789.89815152783, 6817.89773153413, 6975.441964642715, 6642.269350371359, 6646.83382915431, 6687.799366019027, 6733.69698363565, 6814.216365117876, 6191.504679625529, 6210.596311239755, 6263.091851681572, 6274.435300822948, 6275.309715931336, 4653.906921861611, 4669.4396672399525, 4843.104025755247, 4875.975620121877, 4930.580900623487, 4945.777440015136, 5000.524950129878, 5033.622478314214, 5074.3657042869645, 5107.336046313955], "value": 4060.671359877723, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.1019504827607, 297.96424429068514, 301.29947871199465, 305.0725793587494, 308.9026956508701, 4720.890590711188, 4829.203181475053, 4896.363472748542, 4961.429435614906, 4983.601311895049, 4739.289106634006, 4863.732494712789, 4882.633802464811, 4896.216605343146, 4920.769807548113, 3861.2199216564027, 3883.8058097095172, 3892.3966785148205, 3895.961040389588, 3923.784191869446, 3669.4679271505615, 3748.3253014457387, 3883.8058097095172, 3890.961090389088, 3919.4708714323488, 3833.9041523961846, 3852.4799152114388, 3852.7880966546827, 3863.343231650612, 3868.736788978451, 3840.347140986039, 3841.1741475582744, 3844.2695887781233, 3864.613538646141, 3886.591907849663, 3465.6880880720855, 3466.3587236361354, 3468.4623883298127, 3472.0, 3477.5479187705437, 4655.138799322136, 4777.378940737716, 4791.448983366888, 4795.112904112751, 4815.109204797123, 4382.0, 4402.229609818269, 4403.933940990888, 4415.646748260131, 4424.491183513873, 5118.846434606968, 5119.795208191668, 5125.154944220078, 5129.897402051975, 5140.768665410065, 3584.211473475831, 3755.5681096673684, 3795.9063363358773, 3807.733458657895, 3818.579956204815, 5342.599305052097, 5357.464253574651, 5358.196270559409, 5369.731513424314, 5374.435684253136, 3895.941560876589, 3901.902452438655, 3911.882643520699, 3914.530256369197, 3927.273454410943, 3756.69946404287, 3956.8812935611977, 3971.126352202511, 3984.2629113614075, 4000.8397564706493, 4384.816099653076, 4427.114577084596, 4441.089576636782, 4448.5773851484055, 4463.866084017484, 5225.752926241753, 5226.059309324282, 5238.7904483820985, 5247.921281180786, 5250.579953603703, 1298.298918583954, 1335.105479328852, 1337.8662133786543, 1357.178906761415, 1360.3674291454324, 867.4665080975154, 877.2105105405059, 892.2326798952895, 897.4525539420948, 900.1223806788329, 4020.3918432627183, 4032.2540330039037, 4036.5871944819078, 4038.45480860086, 4049.190161967618, 4658.647383071595, 4667.906641867144, 4671.766411679402, 4690.771883355379, 4693.647976401715, 3952.6837852971694, 3976.681865450757, 3986.362182050916, 4012.0341032894257, 4040.3333449980423, 2306.654001899695, 2464.9770345306856, 2481.5161043596686, 2492.2523243027017, 2511.849289042627, 4330.805113769888, 4385.407969924083, 4405.449318835145, 4406.1187762447635, 4412.735235885857, 4741.2651039089, 4744.817384003328, 4758.7164856249765, 4774.278661163173, 4802.559232230317, 4409.735415875058, 4422.71252368595, 4602.4477062752685, 5045.091883461012, 5045.7981680732355, 5339.145736682268, 5362.892742145214, 5369.5167434931045, 5386.811461598825, 5403.324584426947, 5257.316548848778, 5275.762590683352, 5283.973580132075, 5286.599051251498, 5298.28473156119, 4910.88357982557, 4918.950810491992, 4923.975380123076, 4968.950310496849, 5003.874903127451, 3733.96266037347, 3748.9062773430883, 3776.490173826608, 3799.981000094982, 3803.391457366808, 5120.977214000374, 5340.279062326536, 5364.678119312854, 5366.919496207482, 5380.73096345189, 4985.925211121908, 5142.305788718475, 5182.637215394886, 5190.975519547304, 5196.32447781786, 5128.79484820603, 5133.332666753298, 5142.331496905378, 5155.304033955368, 5184.559312458332, 4851.223804191312, 5042.697438153723, 5065.417476990193, 5078.873028174326, 5082.949170508396, 5159.896802064013, 5201.491567445399, 5213.959181634264, 5215.374155101412, 5222.686638801684, 5075.593952483866, 5092.821751238689, 5093.643444958965, 5116.641835071509, 5118.283440318432], "value": 3820.9956612562205, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [641.4579680170258, 641.5733537197764, 678.1658559971236, 712.6151877985887, 718.579630915914, 12741.554045608405, 13743.518976835812, 13752.0, 13760.454315951556, 13884.028118031742, 11209.495572699228, 12908.290044047573, 13021.73956520869, 13086.476540938374, 13141.145825521335, 788.4835432791502, 793.6944276453578, 797.4059325802285, 797.996010019952, 801.6633014134048, 786.0214033528265, 792.8691765858626, 793.2939683681528, 794.1105961323298, 794.7417089445925, 846.2299307630058, 847.3009766942266, 848.2196379331031, 848.3722045686179, 848.499385362636, 830.1781236575807, 831.1190138453198, 833.112734937296, 833.4332653795417, 833.8040560468285, 615.0405367626516, 615.4184295840432, 615.4737699267107, 615.4891440104702, 616.072810420319, 11152.052075573585, 11172.888271117266, 11184.608538701188, 11187.832182517268, 11199.608013719562, 10431.739206519898, 10436.895631043668, 10604.787904241872, 10682.145428365711, 10915.399653019082, 9222.631094756201, 9278.257739380833, 9586.424814511152, 9677.515203137726, 9973.65092221776, 3217.3404452087266, 3342.38165939302, 3357.529945807589, 3375.6286808451296, 3402.591688997336, 40807.183856323005, 41739.0, 53263.46736532663, 53352.199717004274, 59935.0, 10928.787795888516, 10967.725806854893, 11073.50169242386, 11094.778104438028, 11287.20989530725, 20140.89929550372, 20264.49338766513, 20447.182112715323, 20503.897480512802, 20513.17947282122, 7337.449691273176, 7421.591812450259, 7422.146453157956, 7575.24247575238, 7585.924140758632, 3711.16498787776, 3762.0, 3779.3764028935466, 3784.280986612535, 3904.4533765272886, 3104.9223769405944, 3235.12651584071, 3236.8705251789665, 3237.7409807215367, 3238.465653167201, 512.8051340490664, 518.9351331083615, 521.413409913847, 522.6968358352146, 528.1496790167904, 518.8702824293927, 557.567884889206, 568.5764105741249, 588.520355909932, 632.8417895526119, 7508.324250817453, 7515.549067055994, 7956.834174602757, 8139.633716482773, 8347.791305217419, 607.0954278125561, 613.7974468425409, 618.1623899616045, 624.2851934534932, 635.199648442956, 3999.34010888206, 4017.4978127734034, 4055.4322394864744, 4069.491313585802, 4154.376843473503, 89681.55159224162, 90865.54567227254, 94436.52781736047, 94541.0, 94716.0, 54912.45087549153, 83044.0, 84760.15239847646, 85137.57431212804, 85401.0, 53024.73487632614, 55565.722171389694, 63827.680861596324, 73622.63188684022, 74418.62790686011, 9050.321225907952, 9315.72052838416, 9491.810163796823, 9538.284628653018, 9587.053516160755, 44161.55838441703, 44465.2926792749, 45682.771586141855, 45694.771526142154, 47668.0, 55911.44088559225, 65000.349996499426, 66217.0, 66860.66569667315, 67431.32568674447, 11347.432628368384, 11478.483468244116, 11530.308181509135, 11539.0, 11764.176507644383, 12431.0, 13213.603591892259, 13507.527236546674, 14144.22206778637, 14170.149791012573, 12535.185212961129, 12913.612591622266, 12993.0, 13297.135686180754, 13494.865051349361, 12237.69405764863, 12282.38588070575, 12482.251064936132, 12507.374631268218, 12887.09790314669, 12085.456154473246, 12659.0, 12734.872651273368, 13118.475260989453, 13246.668833279246, 9716.271279654196, 9822.312438129262, 10245.129164021142, 10416.1667066636, 10450.059494645518, 9945.254105941938, 10004.599816007278, 10362.326448780805, 10599.470026498799, 10626.0], "value": 6601.547809013842, "unit": "score"}], "name": "dromaeo_css", "value": 6451.92822031774, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 108.0, 112.0, 114.0, 112.0, 112.0, 113.0, 112.0, 113.0, 112.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 140.0, 138.0, 191.0, 130.0, 162.0, 165.0, 135.0, 201.0, 134.0], "value": 157.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 164.0, 164.0, 164.0, 162.0, 163.0, 162.0, 165.0, 161.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 103.0, 76.0, 78.0, 75.0, 77.0, 105.0, 76.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 124.0, 87.0, 88.0, 87.0, 120.0, 86.0, 87.0, 129.0], "value": 98.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 148.0, 147.0, 148.0, 147.0, 147.0, 147.0, 148.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 96.0, 94.0, 94.0, 95.0, 94.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 63.0, 65.0, 64.0, 63.0, 64.0, 63.0, 62.0], "value": 63.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 65.0, 66.0, 66.0, 64.0, 66.0, 64.0, 64.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 83.0, 83.0, 84.0, 84.0, 83.0, 90.0, 123.0, 83.0], "value": 88.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 134.0, 142.0, 131.0, 130.0, 129.0, 129.0, 133.0, 143.0, 141.0], "value": 134.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 170.0, 175.0, 176.0, 175.0, 172.0, 172.0, 176.0, 171.0, 168.0], "value": 172.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 68.0, 68.0, 68.0, 68.0, 68.0, 67.0, 68.0, 67.0], "value": 68.0, "unit": "score"}], "name": "kraken", "value": 1564.2, "alertThreshold": 2.0}]} 04:59:17 INFO - Return code: 0 04:59:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:59:17 INFO - # TBPL SUCCESS # 04:59:17 INFO - Running post-action listener: _resource_record_post_action 04:59:17 INFO - ##### 04:59:17 INFO - ##### Finished run-tests step (success) 04:59:17 INFO - ##### 04:59:17 INFO - Running post-run listener: _resource_record_post_run 04:59:17 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 544407552; Read time: 4; Write time: 523212 04:59:17 INFO - TinderboxPrint: CPU usage
13.2% 04:59:17 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 04:59:17 INFO - TinderboxPrint: I/O write bytes / time
544,407,552 / 523,212 04:59:17 INFO - TinderboxPrint: CPU idle
8,327.6 (86.7%) 04:59:17 INFO - TinderboxPrint: CPU user
1,220.8 (12.7%) 04:59:17 INFO - TinderboxPrint: Swap in / out
0 / 0 04:59:17 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 245911552; Read time: 0; Write time: 271864 04:59:17 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 298496000; Read time: 4; Write time: 251348 04:59:18 INFO - Running post-run listener: _upload_blobber_files 04:59:18 INFO - Blob upload gear active. 04:59:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:59:18 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:59:18 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:59:18 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:59:18 INFO - (blobuploader) - INFO - Open directory for files ... 04:59:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:59:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:59:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:59:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:59:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:59:22 INFO - (blobuploader) - INFO - Done attempting. 04:59:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:59:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:59:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:59:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:59:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:59:22 INFO - (blobuploader) - INFO - Done attempting. 04:59:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:59:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:59:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:59:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:59:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:59:23 INFO - (blobuploader) - INFO - Done attempting. 04:59:23 INFO - (blobuploader) - INFO - Iteration through files over. 04:59:23 INFO - Return code: 0 04:59:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:59:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:59:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/00606dbf3c079bd34203aaeabf47435708360435c64d5f37930e1b128c89be136ade1f43565351cba45d045fe1a98f06d4f4e45bf8c41339a0f92b0b02cc237d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9fbb11a41f935b1249373e9b34d636c09cb7a32df477f1ab3bf4449f0e9766c546948a55962cb1555ac2fd677cb6154b0141ed07a4673156d78ffe621870bc0e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b94897951ad913f8cee080d91eecef5ae2eec9c02ece23042ebc986d4097a2426c95bf5ad222bf607df06c263d7af2fe709415cbfd3e1a6e97404acf5286eb4f"} 04:59:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:59:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:59:23 INFO - Contents: 04:59:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/00606dbf3c079bd34203aaeabf47435708360435c64d5f37930e1b128c89be136ade1f43565351cba45d045fe1a98f06d4f4e45bf8c41339a0f92b0b02cc237d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9fbb11a41f935b1249373e9b34d636c09cb7a32df477f1ab3bf4449f0e9766c546948a55962cb1555ac2fd677cb6154b0141ed07a4673156d78ffe621870bc0e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b94897951ad913f8cee080d91eecef5ae2eec9c02ece23042ebc986d4097a2426c95bf5ad222bf607df06c263d7af2fe709415cbfd3e1a6e97404acf5286eb4f"} 04:59:23 INFO - Running post-run listener: copy_logs_to_upload_dir 04:59:23 INFO - Copying logs to upload dir... 04:59:23 INFO - mkdir: /builds/slave/test/build/upload/logs 04:59:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.856445 ========= master_lag: 0.61 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-06-22 04:59:23.903834) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 04:59:23.911112) ========= 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=52faae308a556c440401f8e5000001e8-1466594285.413666-1520447168 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/00606dbf3c079bd34203aaeabf47435708360435c64d5f37930e1b128c89be136ade1f43565351cba45d045fe1a98f06d4f4e45bf8c41339a0f92b0b02cc237d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9fbb11a41f935b1249373e9b34d636c09cb7a32df477f1ab3bf4449f0e9766c546948a55962cb1555ac2fd677cb6154b0141ed07a4673156d78ffe621870bc0e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b94897951ad913f8cee080d91eecef5ae2eec9c02ece23042ebc986d4097a2426c95bf5ad222bf607df06c263d7af2fe709415cbfd3e1a6e97404acf5286eb4f"} build_url:https://queue.taskcluster.net/v1/task/JGVyGV_SQ9OwHj_qt_UU-w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011223 build_url: 'https://queue.taskcluster.net/v1/task/JGVyGV_SQ9OwHj_qt_UU-w/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/00606dbf3c079bd34203aaeabf47435708360435c64d5f37930e1b128c89be136ade1f43565351cba45d045fe1a98f06d4f4e45bf8c41339a0f92b0b02cc237d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9fbb11a41f935b1249373e9b34d636c09cb7a32df477f1ab3bf4449f0e9766c546948a55962cb1555ac2fd677cb6154b0141ed07a4673156d78ffe621870bc0e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b94897951ad913f8cee080d91eecef5ae2eec9c02ece23042ebc986d4097a2426c95bf5ad222bf607df06c263d7af2fe709415cbfd3e1a6e97404acf5286eb4f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 04:59:23.944214) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 04:59:23.944652) ========= 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=52faae308a556c440401f8e5000001e8-1466594285.413666-1520447168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004568 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 04:59:24.001060) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 04:59:24.001546) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 04:59:24.001937) ========= ========= Total master_lag: 0.75 =========