builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-055 starttime: 1460421793.57 results: success (0) buildid: 20160411160652 builduid: 0dc00d7666f1478faf79f7636684998e revision: 4118760a3981d37b7ae31d8c6a9326318e6b3ee8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-11 17:43:13.569413) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-11 17:43:13.569774) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-11 17:43:13.570064) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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=82e07478c745e68b1fe4678a000001bc-1460421554.469346-590543354 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006394 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-11 17:43:13.597046) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-11 17:43:13.597372) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-11 17:43:13.629355) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 17:43:13.629646) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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=82e07478c745e68b1fe4678a000001bc-1460421554.469346-590543354 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004618 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 17:43:13.683350) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-11 17:43:13.683631) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-11 17:43:13.683978) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 17:43:13.684265) ========= 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=82e07478c745e68b1fe4678a000001bc-1460421554.469346-590543354 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-11 17:43:13-- 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% 39.5M=0s 2016-04-11 17:43:13 (39.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.166631 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 17:43:13.864218) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 17:43:13.864512) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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=82e07478c745e68b1fe4678a000001bc-1460421554.469346-590543354 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018432 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 17:43:13.913959) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 17:43:13.914281) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4118760a3981d37b7ae31d8c6a9326318e6b3ee8 --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 4118760a3981d37b7ae31d8c6a9326318e6b3ee8 --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=82e07478c745e68b1fe4678a000001bc-1460421554.469346-590543354 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-11 17:43:14,073 truncating revision to first 12 chars 2016-04-11 17:43:14,074 Setting DEBUG logging. 2016-04-11 17:43:14,074 attempt 1/10 2016-04-11 17:43:14,074 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4118760a3981?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-11 17:43:14,756 unpacking tar archive at: fx-team-4118760a3981/testing/mozharness/ program finished with exit code 0 elapsedTime=0.933584 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 17:43:14.859931) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-11 17:43:14.860254) ========= echo 4118760a3981d37b7ae31d8c6a9326318e6b3ee8 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'4118760a3981d37b7ae31d8c6a9326318e6b3ee8'] 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=82e07478c745e68b1fe4678a000001bc-1460421554.469346-590543354 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 4118760a3981d37b7ae31d8c6a9326318e6b3ee8 program finished with exit code 0 elapsedTime=0.004408 script_repo_revision: '4118760a3981d37b7ae31d8c6a9326318e6b3ee8' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-11 17:43:14.908467) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-11 17:43:14.908760) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-11 17:43:14.918706) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-04-11 17:43:14.918977) ========= /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=82e07478c745e68b1fe4678a000001bc-1460421554.469346-590543354 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:43:15 INFO - MultiFileLogger online at 20160411 17:43:15 in /builds/slave/test 17:43:15 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 17:43:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:43:15 INFO - {'append_to_log': False, 17:43:15 INFO - 'base_work_dir': '/builds/slave/test', 17:43:15 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 17:43:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:43:15 INFO - 'branch': 'Fx-Team-Non-PGO', 17:43:15 INFO - 'buildbot_json_path': 'buildprops.json', 17:43:15 INFO - 'config_files': ('talos/linux_config.py',), 17:43:15 INFO - 'default_actions': ('clobber', 17:43:15 INFO - 'read-buildbot-config', 17:43:15 INFO - 'download-and-extract', 17:43:15 INFO - 'populate-webroot', 17:43:15 INFO - 'create-virtualenv', 17:43:15 INFO - 'install', 17:43:15 INFO - 'run-tests'), 17:43:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:43:15 INFO - 'download_minidump_stackwalk': True, 17:43:15 INFO - 'download_symbols': 'ondemand', 17:43:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:43:15 INFO - 'tooltool.py': '/tools/tooltool.py', 17:43:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:43:15 INFO - '/tools/misc-python/virtualenv.py')}, 17:43:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:43:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:43:15 INFO - 'installer_path': 'installer.exe', 17:43:15 INFO - 'log_level': 'info', 17:43:15 INFO - 'log_name': 'talos', 17:43:15 INFO - 'log_to_console': True, 17:43:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:43:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:43:15 INFO - 'opt_config_files': (), 17:43:15 INFO - 'pip_index': False, 17:43:15 INFO - 'sps_profile': False, 17:43:15 INFO - 'sps_profile_interval': 0, 17:43:15 INFO - 'suite': 'dromaeojs', 17:43:15 INFO - 'system_bits': '32', 17:43:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:43:15 INFO - 'title': 'talos-linux64-ix-055', 17:43:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:43:15 INFO - 'use_talos_json': True, 17:43:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:43:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:43:15 INFO - 'work_dir': 'build'} 17:43:15 INFO - ##### 17:43:15 INFO - ##### Running clobber step. 17:43:15 INFO - ##### 17:43:15 INFO - Running pre-action listener: _resource_record_pre_action 17:43:15 INFO - Running main action method: clobber 17:43:15 INFO - rmtree: /builds/slave/test/build 17:43:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:43:15 INFO - Running post-action listener: _resource_record_post_action 17:43:15 INFO - ##### 17:43:15 INFO - ##### Running read-buildbot-config step. 17:43:15 INFO - ##### 17:43:15 INFO - Running pre-action listener: _resource_record_pre_action 17:43:15 INFO - Running main action method: read_buildbot_config 17:43:15 INFO - Using buildbot properties: 17:43:15 INFO - { 17:43:15 INFO - "project": "", 17:43:15 INFO - "product": "firefox", 17:43:15 INFO - "script_repo_revision": "production", 17:43:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:43:15 INFO - "repository": "", 17:43:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 17:43:15 INFO - "buildid": "20160411160652", 17:43:15 INFO - "pgo_build": "False", 17:43:15 INFO - "basedir": "/builds/slave/test", 17:43:15 INFO - "buildnumber": 2804, 17:43:15 INFO - "slavename": "talos-linux64-ix-055", 17:43:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:43:15 INFO - "platform": "ubuntu64_hw", 17:43:15 INFO - "scheduler": "tests-fx-team-linux64-talos", 17:43:15 INFO - "branch": "fx-team", 17:43:15 INFO - "repo_path": "integration/fx-team", 17:43:15 INFO - "revision": "4118760a3981d37b7ae31d8c6a9326318e6b3ee8", 17:43:15 INFO - "stage_platform": "linux64", 17:43:15 INFO - "builduid": "0dc00d7666f1478faf79f7636684998e", 17:43:15 INFO - "slavebuilddir": "test" 17:43:15 INFO - } 17:43:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 17:43:15 INFO - Running post-action listener: _resource_record_post_action 17:43:15 INFO - ##### 17:43:15 INFO - ##### Running download-and-extract step. 17:43:15 INFO - ##### 17:43:15 INFO - Running pre-action listener: _resource_record_pre_action 17:43:15 INFO - Running main action method: download_and_extract 17:43:15 INFO - mkdir: /builds/slave/test/build/tests 17:43:15 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')]} 17:43:15 INFO - https://queue.taskcluster.net/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:43:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:43:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:43:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:43:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:43:17 INFO - Downloaded 1361 bytes. 17:43:17 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:43:17 INFO - Using the following test package requirements: 17:43:17 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:43:17 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:43:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:43:17 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:43:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:43:17 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:43:17 INFO - u'jsshell-linux-x86_64.zip'], 17:43:17 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:43:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:43:17 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:43:17 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:43:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:43:17 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:43:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:43:17 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:43:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:43:17 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:43:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:43:17 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:43:17 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')]} 17:43:17 INFO - https://queue.taskcluster.net/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:43:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:43:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:43:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:43:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:43:20 INFO - Downloaded 22190342 bytes. 17:43:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:43:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:43:21 INFO - Return code: 0 17:43:21 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:43:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:21 INFO - https://queue.taskcluster.net/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:43:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:43:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:43:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:43:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:43:36 INFO - Downloaded 22190342 bytes. 17:43:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:43:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:43:38 INFO - Return code: 0 17:43:38 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')]} 17:43:38 INFO - https://queue.taskcluster.net/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:43:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:43:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:43:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:43:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:43:39 INFO - Downloaded 10841046 bytes. 17:43:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:43:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:43:39 INFO - Return code: 0 17:43:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:39 INFO - https://queue.taskcluster.net/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:43:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:43:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:43:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:43:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:43:41 INFO - Downloaded 54105197 bytes. 17:43:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:43:41 INFO - mkdir: /builds/slave/test/properties 17:43:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:43:41 INFO - Writing to file /builds/slave/test/properties/build_url 17:43:41 INFO - Contents: 17:43:41 INFO - build_url:https://queue.taskcluster.net/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:43:42 INFO - Running post-action listener: _resource_record_post_action 17:43:42 INFO - Running post-action listener: set_extra_try_arguments 17:43:42 INFO - ##### 17:43:42 INFO - ##### Running populate-webroot step. 17:43:42 INFO - ##### 17:43:42 INFO - Running pre-action listener: _resource_record_pre_action 17:43:42 INFO - Running main action method: populate_webroot 17:43:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:43:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:43:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:43:42 INFO - '--tppagecycles', 17:43:42 INFO - '7'], 17:43:42 INFO - 'tests': ['tsvgm']}}, 17:43:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:43:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:43:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:43:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:43:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:43:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:43:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:42 INFO - 'talos_options': ['--disable-e10s'], 17:43:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:43:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:43:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:42 INFO - 'talos_options': ['--disable-e10s'], 17:43:42 INFO - 'tests': ['damp', 'tps']}, 17:43:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:42 INFO - 'tests': ['damp', 'tps']}, 17:43:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:43:42 INFO - 'tests': ['dromaeo_dom']}, 17:43:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:43:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:43:42 INFO - 'tests': ['a11yr', 17:43:42 INFO - 'ts_paint', 17:43:42 INFO - 'tpaint', 17:43:42 INFO - 'sessionrestore', 17:43:42 INFO - 'sessionrestore_no_auto_restore', 17:43:42 INFO - 'tabpaint']}, 17:43:42 INFO - 'other-e10s': {'tests': ['a11yr', 17:43:42 INFO - 'ts_paint', 17:43:42 INFO - 'tpaint', 17:43:42 INFO - 'sessionrestore', 17:43:42 INFO - 'sessionrestore_no_auto_restore', 17:43:42 INFO - 'tabpaint']}, 17:43:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:43:42 INFO - 'ts_paint', 17:43:42 INFO - 'tpaint', 17:43:42 INFO - 'sessionrestore', 17:43:42 INFO - 'sessionrestore_no_auto_restore', 17:43:42 INFO - 'tabpaint']}, 17:43:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:43:42 INFO - 'ts_paint', 17:43:42 INFO - 'tpaint', 17:43:42 INFO - 'sessionrestore', 17:43:42 INFO - 'sessionrestore_no_auto_restore', 17:43:42 INFO - 'tabpaint']}, 17:43:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:43:42 INFO - 'tests': ['a11yr', 17:43:42 INFO - 'ts_paint', 17:43:42 INFO - 'tpaint', 17:43:42 INFO - 'sessionrestore', 17:43:42 INFO - 'sessionrestore_no_auto_restore', 17:43:42 INFO - 'tabpaint']}, 17:43:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:43:42 INFO - 'tests': ['a11yr', 17:43:42 INFO - 'ts_paint', 17:43:42 INFO - 'tpaint', 17:43:42 INFO - 'sessionrestore', 17:43:42 INFO - 'sessionrestore_no_auto_restore', 17:43:42 INFO - 'tabpaint']}, 17:43:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:43:42 INFO - 'tests': ['tsvgx', 17:43:42 INFO - 'tsvgr_opacity', 17:43:42 INFO - 'tart', 17:43:42 INFO - 'tscrollx', 17:43:42 INFO - 'cart']}, 17:43:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:43:42 INFO - 'tsvgr_opacity', 17:43:42 INFO - 'tart', 17:43:42 INFO - 'tscrollx', 17:43:42 INFO - 'cart']}, 17:43:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:42 INFO - 'talos_options': ['--disable-e10s'], 17:43:42 INFO - 'tests': ['tp5o']}, 17:43:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:42 INFO - 'tests': ['tp5o']}, 17:43:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:42 INFO - 'talos_options': ['--disable-e10s', 17:43:42 INFO - '--xperf_path', 17:43:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:43:42 INFO - 'tests': ['tp5n']}, 17:43:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:42 INFO - 'talos_options': ['--xperf_path', 17:43:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:43:42 INFO - 'tests': ['tp5n']}}, 17:43:42 INFO - 'talos.zip': {'path': '', 17:43:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:43:42 INFO - Running post-action listener: _resource_record_post_action 17:43:42 INFO - ##### 17:43:42 INFO - ##### Running create-virtualenv step. 17:43:42 INFO - ##### 17:43:42 INFO - Running pre-action listener: _resource_record_pre_action 17:43:42 INFO - Running main action method: create_virtualenv 17:43:42 INFO - Creating virtualenv /builds/slave/test/build/venv 17:43:42 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 17:43:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:43:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:43:42 INFO - Using real prefix '/usr' 17:43:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:43:43 INFO - Installing distribute.............................................................................................................................................................................................done. 17:43:45 INFO - Installing pip.................done. 17:43:45 INFO - Return code: 0 17:43:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:43: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')]} 17:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43: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')]} 17:43:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:45 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 0x7fc163769f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1655410>, '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 0x1656310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16567a0>, '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': '82e07478c745e68b1fe4678a000001bc-1460421554.469346-590543354', '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 17:43:45 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 17:43:45 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 17:43:45 INFO - Using env: {'DISPLAY': ':0', 17:43:45 INFO - 'HOME': '/home/cltbld', 17:43:45 INFO - 'LANG': 'en_US.UTF-8', 17:43:45 INFO - 'LANGUAGE': 'en_US:en', 17:43:45 INFO - 'LOGNAME': 'cltbld', 17:43:45 INFO - 'MAIL': '/var/mail/cltbld', 17:43:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:45 INFO - 'MOZ_NO_REMOTE': '1', 17:43:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:45 INFO - 'NO_EM_RESTART': '1', 17:43:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:45 INFO - 'PWD': '/builds/slave/test', 17:43:45 INFO - 'SHELL': '/bin/bash', 17:43:45 INFO - 'SHLVL': '1', 17:43:45 INFO - 'TERM': 'linux', 17:43:45 INFO - 'TMOUT': '86400', 17:43:45 INFO - 'USER': 'cltbld', 17:43:45 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1460421554.469346-590543354', 17:43:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:45 INFO - '_': '/tools/buildbot/bin/python'} 17:43:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:45 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 17:43:45 INFO - Cleaning up... 17:43:45 INFO - Return code: 0 17:43:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:43: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')]} 17:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43: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')]} 17:43:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:45 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc163769f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1655410>, '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 0x1656310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16567a0>, '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': '82e07478c745e68b1fe4678a000001bc-1460421554.469346-590543354', '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 17:43:45 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>=0.7.1'] in /builds/slave/test/build 17:43:45 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>=0.7.1 17:43:45 INFO - Using env: {'DISPLAY': ':0', 17:43:45 INFO - 'HOME': '/home/cltbld', 17:43:45 INFO - 'LANG': 'en_US.UTF-8', 17:43:45 INFO - 'LANGUAGE': 'en_US:en', 17:43:45 INFO - 'LOGNAME': 'cltbld', 17:43:45 INFO - 'MAIL': '/var/mail/cltbld', 17:43:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:45 INFO - 'MOZ_NO_REMOTE': '1', 17:43:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:45 INFO - 'NO_EM_RESTART': '1', 17:43:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:45 INFO - 'PWD': '/builds/slave/test', 17:43:45 INFO - 'SHELL': '/bin/bash', 17:43:45 INFO - 'SHLVL': '1', 17:43:45 INFO - 'TERM': 'linux', 17:43:45 INFO - 'TMOUT': '86400', 17:43:45 INFO - 'USER': 'cltbld', 17:43:45 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1460421554.469346-590543354', 17:43:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:45 INFO - '_': '/tools/buildbot/bin/python'} 17:43:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:45 INFO - Downloading/unpacking psutil>=0.7.1 17:43:45 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 17:43:45 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 17:43:45 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 17:43:45 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 17:43:45 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 17:43:45 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 17:43:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:43:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:43:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:43:47 INFO - Installing collected packages: psutil 17:43:47 INFO - Running setup.py install for psutil 17:43:47 INFO - building 'psutil._psutil_linux' extension 17:43:47 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 17:43:47 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 17:43:47 INFO - building 'psutil._psutil_posix' extension 17:43:47 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 17:43:47 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 17:43:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:43:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:43:47 INFO - Successfully installed psutil 17:43:47 INFO - Cleaning up... 17:43:47 INFO - Return code: 0 17:43:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:43:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:47 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc163769f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1655410>, '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 0x1656310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16567a0>, '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': '82e07478c745e68b1fe4678a000001bc-1460421554.469346-590543354', '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 17:43:47 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.0.0'] in /builds/slave/test/build 17:43:47 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.0.0 17:43:47 INFO - Using env: {'DISPLAY': ':0', 17:43:47 INFO - 'HOME': '/home/cltbld', 17:43:47 INFO - 'LANG': 'en_US.UTF-8', 17:43:47 INFO - 'LANGUAGE': 'en_US:en', 17:43:47 INFO - 'LOGNAME': 'cltbld', 17:43:47 INFO - 'MAIL': '/var/mail/cltbld', 17:43:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:47 INFO - 'MOZ_NO_REMOTE': '1', 17:43:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:47 INFO - 'NO_EM_RESTART': '1', 17:43:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:47 INFO - 'PWD': '/builds/slave/test', 17:43:47 INFO - 'SHELL': '/bin/bash', 17:43:47 INFO - 'SHLVL': '1', 17:43:47 INFO - 'TERM': 'linux', 17:43:47 INFO - 'TMOUT': '86400', 17:43:47 INFO - 'USER': 'cltbld', 17:43:47 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1460421554.469346-590543354', 17:43:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:47 INFO - '_': '/tools/buildbot/bin/python'} 17:43:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:43:48 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 17:43:48 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 17:43:48 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 17:43:48 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 17:43:48 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 17:43:48 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 17:43:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:43:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:43:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:43:50 INFO - Installing collected packages: mozsystemmonitor 17:43:50 INFO - Running setup.py install for mozsystemmonitor 17:43:50 INFO - Successfully installed mozsystemmonitor 17:43:50 INFO - Cleaning up... 17:43:50 INFO - Return code: 0 17:43:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:43:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:50 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 0x7fc163769f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1655410>, '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 0x1656310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16567a0>, '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': '82e07478c745e68b1fe4678a000001bc-1460421554.469346-590543354', '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 17:43:50 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 17:43:50 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 17:43:50 INFO - Using env: {'DISPLAY': ':0', 17:43:50 INFO - 'HOME': '/home/cltbld', 17:43:50 INFO - 'LANG': 'en_US.UTF-8', 17:43:50 INFO - 'LANGUAGE': 'en_US:en', 17:43:50 INFO - 'LOGNAME': 'cltbld', 17:43:50 INFO - 'MAIL': '/var/mail/cltbld', 17:43:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:50 INFO - 'MOZ_NO_REMOTE': '1', 17:43:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:50 INFO - 'NO_EM_RESTART': '1', 17:43:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:50 INFO - 'PWD': '/builds/slave/test', 17:43:50 INFO - 'SHELL': '/bin/bash', 17:43:50 INFO - 'SHLVL': '1', 17:43:50 INFO - 'TERM': 'linux', 17:43:50 INFO - 'TMOUT': '86400', 17:43:50 INFO - 'USER': 'cltbld', 17:43:50 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1460421554.469346-590543354', 17:43:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:50 INFO - '_': '/tools/buildbot/bin/python'} 17:43:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:50 INFO - Downloading/unpacking blobuploader==1.2.4 17:43:50 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 17:43:50 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 17:43:50 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 17:43:50 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 17:43:50 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 17:43:50 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 17:43:52 INFO - Downloading blobuploader-1.2.4.tar.gz 17:43:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:43:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:43: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 17:43: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 17:43: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 17:43: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 17:43: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 17:43: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 17:43:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:43:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:43: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 17:43: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 17:43: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 17:43: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 17:43: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 17:43: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 17:43:53 INFO - Downloading docopt-0.6.1.tar.gz 17:43:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:43:53 INFO - Installing collected packages: blobuploader, requests, docopt 17:43:53 INFO - Running setup.py install for blobuploader 17:43:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:43:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:43:53 INFO - Running setup.py install for requests 17:43:53 INFO - Running setup.py install for docopt 17:43:53 INFO - Successfully installed blobuploader requests docopt 17:43:53 INFO - Cleaning up... 17:43:53 INFO - Return code: 0 17:43:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:53 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 0x7fc163769f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1655410>, '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 0x1656310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16567a0>, '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': '82e07478c745e68b1fe4678a000001bc-1460421554.469346-590543354', '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 17:43:53 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 17:43:53 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 17:43:53 INFO - Using env: {'DISPLAY': ':0', 17:43:53 INFO - 'HOME': '/home/cltbld', 17:43:53 INFO - 'LANG': 'en_US.UTF-8', 17:43:53 INFO - 'LANGUAGE': 'en_US:en', 17:43:53 INFO - 'LOGNAME': 'cltbld', 17:43:53 INFO - 'MAIL': '/var/mail/cltbld', 17:43:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:53 INFO - 'MOZ_NO_REMOTE': '1', 17:43:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:53 INFO - 'NO_EM_RESTART': '1', 17:43:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:53 INFO - 'PWD': '/builds/slave/test', 17:43:53 INFO - 'SHELL': '/bin/bash', 17:43:53 INFO - 'SHLVL': '1', 17:43:53 INFO - 'TERM': 'linux', 17:43:53 INFO - 'TMOUT': '86400', 17:43:53 INFO - 'USER': 'cltbld', 17:43:53 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1460421554.469346-590543354', 17:43:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:53 INFO - '_': '/tools/buildbot/bin/python'} 17:43:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:43:53 INFO - Running setup.py (path:/tmp/pip-D2y5QC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:43:53 INFO - Running setup.py (path:/tmp/pip-kmcjj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:43:54 INFO - Running setup.py (path:/tmp/pip-tuVT8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:43:54 INFO - Running setup.py (path:/tmp/pip-DUSKhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:43:54 INFO - Running setup.py (path:/tmp/pip-L4zV2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:43:54 INFO - Running setup.py (path:/tmp/pip-jswrps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:43:54 INFO - Running setup.py (path:/tmp/pip-NMudo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:43:54 INFO - Running setup.py (path:/tmp/pip-d6pZS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:43:54 INFO - Running setup.py (path:/tmp/pip-5zA1dG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:43:54 INFO - Running setup.py (path:/tmp/pip-0ge_aD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:43:54 INFO - Running setup.py (path:/tmp/pip-wkUAa8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:43:54 INFO - Running setup.py (path:/tmp/pip-TTiHEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:43:54 INFO - Running setup.py (path:/tmp/pip-ZE7sW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:43:54 INFO - Running setup.py (path:/tmp/pip-uIiP1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:43:54 INFO - Running setup.py (path:/tmp/pip-pFq4Vr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:43:54 INFO - Running setup.py (path:/tmp/pip-YAnosg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:43:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:43:55 INFO - Running setup.py (path:/tmp/pip-BsJC9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:43:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:43:55 INFO - Running setup.py install for manifestparser 17:43:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:43:55 INFO - Running setup.py install for mozcrash 17:43:55 INFO - Running setup.py install for mozdebug 17:43:55 INFO - Running setup.py install for mozdevice 17:43:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:43:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:43:55 INFO - Running setup.py install for mozfile 17:43:55 INFO - Running setup.py install for mozhttpd 17:43:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:43:55 INFO - Running setup.py install for mozinfo 17:43:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:43:55 INFO - Running setup.py install for mozInstall 17:43:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:43:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:43:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:43:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:43:55 INFO - Running setup.py install for mozleak 17:43:56 INFO - Running setup.py install for mozlog 17:43:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:43:56 INFO - Running setup.py install for moznetwork 17:43:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:43:56 INFO - Running setup.py install for mozprocess 17:43:56 INFO - Running setup.py install for mozprofile 17:43:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:43:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:43:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:43:56 INFO - Running setup.py install for mozrunner 17:43:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:43:56 INFO - Running setup.py install for mozscreenshot 17:43:56 INFO - Running setup.py install for moztest 17:43:56 INFO - Running setup.py install for mozversion 17:43:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:43:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:43:56 INFO - Cleaning up... 17:43:56 INFO - Return code: 0 17:43:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:43:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:56 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 0x7fc163769f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1655410>, '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 0x1656310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16567a0>, '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': '82e07478c745e68b1fe4678a000001bc-1460421554.469346-590543354', '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 17:43:56 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 17:43:56 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 17:43:56 INFO - Using env: {'DISPLAY': ':0', 17:43:56 INFO - 'HOME': '/home/cltbld', 17:43:56 INFO - 'LANG': 'en_US.UTF-8', 17:43:56 INFO - 'LANGUAGE': 'en_US:en', 17:43:56 INFO - 'LOGNAME': 'cltbld', 17:43:56 INFO - 'MAIL': '/var/mail/cltbld', 17:43:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:56 INFO - 'MOZ_NO_REMOTE': '1', 17:43:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:56 INFO - 'NO_EM_RESTART': '1', 17:43:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:56 INFO - 'PWD': '/builds/slave/test', 17:43:56 INFO - 'SHELL': '/bin/bash', 17:43:56 INFO - 'SHLVL': '1', 17:43:56 INFO - 'TERM': 'linux', 17:43:56 INFO - 'TMOUT': '86400', 17:43:56 INFO - 'USER': 'cltbld', 17:43:56 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1460421554.469346-590543354', 17:43:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:56 INFO - '_': '/tools/buildbot/bin/python'} 17:43:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:43:57 INFO - Running setup.py (path:/tmp/pip-v52P2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:43:57 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)) 17:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:43:57 INFO - Running setup.py (path:/tmp/pip-PKDSQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:43:57 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)) 17:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:43:57 INFO - Running setup.py (path:/tmp/pip-d50Cyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:43:57 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)) 17:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:43:57 INFO - Running setup.py (path:/tmp/pip-ue6RwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:43:57 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)) 17:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:43:57 INFO - Running setup.py (path:/tmp/pip-66tBa4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:43:57 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)) 17:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:43:57 INFO - Running setup.py (path:/tmp/pip-kwWqtx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:43:57 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)) 17:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:43:57 INFO - Running setup.py (path:/tmp/pip-EXojni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:43:57 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)) 17:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:43:57 INFO - Running setup.py (path:/tmp/pip-XNDF06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:43:57 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)) 17:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:43:57 INFO - Running setup.py (path:/tmp/pip-ErbyNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:43:57 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)) 17:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:43:57 INFO - Running setup.py (path:/tmp/pip-NqxlMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 17:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:43:57 INFO - Running setup.py (path:/tmp/pip-J6zYKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:43:57 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)) 17:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:43:57 INFO - Running setup.py (path:/tmp/pip-FOvsXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:43:58 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)) 17:43:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:43:58 INFO - Running setup.py (path:/tmp/pip-Xs9wv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:43:58 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)) 17:43:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:43:58 INFO - Running setup.py (path:/tmp/pip-6pmo8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:43:58 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)) 17:43:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:43:58 INFO - Running setup.py (path:/tmp/pip-xg_7ej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:43:58 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)) 17:43:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:43:58 INFO - Running setup.py (path:/tmp/pip-SeSM1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:43:58 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)) 17:43:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:43:58 INFO - Running setup.py (path:/tmp/pip-PxE18D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:43:58 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)) 17:43:58 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)) 17:43:58 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)) 17:43:58 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)) 17:43:58 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)) 17:43:58 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)) 17:43:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:00 INFO - Downloading blessings-1.6.tar.gz 17:44:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:44:00 INFO - Installing collected packages: blessings 17:44:00 INFO - Running setup.py install for blessings 17:44:00 INFO - Successfully installed blessings 17:44:00 INFO - Cleaning up... 17:44:00 INFO - Return code: 0 17:44:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:44:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:44:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:44:00 INFO - Reading from file tmpfile_stdout 17:44:00 INFO - Current package versions: 17:44:00 INFO - argparse == 1.2.1 17:44:00 INFO - blessings == 1.6 17:44:00 INFO - blobuploader == 1.2.4 17:44:00 INFO - docopt == 0.6.1 17:44:00 INFO - manifestparser == 1.1 17:44:00 INFO - mozInstall == 1.12 17:44:00 INFO - mozcrash == 0.17 17:44:00 INFO - mozdebug == 0.1 17:44:00 INFO - mozdevice == 0.48 17:44:00 INFO - mozfile == 1.2 17:44:00 INFO - mozhttpd == 0.7 17:44:00 INFO - mozinfo == 0.9 17:44:00 INFO - mozleak == 0.1 17:44:00 INFO - mozlog == 3.1 17:44:00 INFO - moznetwork == 0.27 17:44:00 INFO - mozprocess == 0.22 17:44:00 INFO - mozprofile == 0.28 17:44:00 INFO - mozrunner == 6.11 17:44:00 INFO - mozscreenshot == 0.1 17:44:00 INFO - mozsystemmonitor == 0.0 17:44:00 INFO - moztest == 0.7 17:44:00 INFO - mozversion == 1.4 17:44:00 INFO - psutil == 3.1.1 17:44:00 INFO - requests == 1.2.3 17:44:00 INFO - wsgiref == 0.1.2 17:44:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:44:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:00 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 0x7fc163769f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1655410>, '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 0x1656310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16567a0>, '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': '82e07478c745e68b1fe4678a000001bc-1460421554.469346-590543354', '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 17:44:00 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 17:44:00 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 17:44:00 INFO - Using env: {'DISPLAY': ':0', 17:44:00 INFO - 'HOME': '/home/cltbld', 17:44:00 INFO - 'LANG': 'en_US.UTF-8', 17:44:00 INFO - 'LANGUAGE': 'en_US:en', 17:44:00 INFO - 'LOGNAME': 'cltbld', 17:44:00 INFO - 'MAIL': '/var/mail/cltbld', 17:44:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:00 INFO - 'MOZ_NO_REMOTE': '1', 17:44:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:00 INFO - 'NO_EM_RESTART': '1', 17:44:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:00 INFO - 'PWD': '/builds/slave/test', 17:44:00 INFO - 'SHELL': '/bin/bash', 17:44:00 INFO - 'SHLVL': '1', 17:44:00 INFO - 'TERM': 'linux', 17:44:00 INFO - 'TMOUT': '86400', 17:44:00 INFO - 'USER': 'cltbld', 17:44:00 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1460421554.469346-590543354', 17:44:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:00 INFO - '_': '/tools/buildbot/bin/python'} 17:44:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:00 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)) 17:44:00 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)) 17:44:00 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)) 17:44:00 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)) 17:44:00 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)) 17:44:00 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)) 17:44:00 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)) 17:44:00 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)) 17:44:00 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)) 17:44:00 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)) 17:44:00 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)) 17:44:00 INFO - Cleaning up... 17:44:00 INFO - Return code: 0 17:44:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:44:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:00 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 0x7fc163769f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1655410>, '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 0x1656310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16567a0>, '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': '82e07478c745e68b1fe4678a000001bc-1460421554.469346-590543354', '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 17:44:00 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 17:44:00 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 17:44:00 INFO - Using env: {'DISPLAY': ':0', 17:44:00 INFO - 'HOME': '/home/cltbld', 17:44:00 INFO - 'LANG': 'en_US.UTF-8', 17:44:00 INFO - 'LANGUAGE': 'en_US:en', 17:44:00 INFO - 'LOGNAME': 'cltbld', 17:44:00 INFO - 'MAIL': '/var/mail/cltbld', 17:44:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:00 INFO - 'MOZ_NO_REMOTE': '1', 17:44:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:00 INFO - 'NO_EM_RESTART': '1', 17:44:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:00 INFO - 'PWD': '/builds/slave/test', 17:44:00 INFO - 'SHELL': '/bin/bash', 17:44:00 INFO - 'SHLVL': '1', 17:44:00 INFO - 'TERM': 'linux', 17:44:00 INFO - 'TMOUT': '86400', 17:44:00 INFO - 'USER': 'cltbld', 17:44:00 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1460421554.469346-590543354', 17:44:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:00 INFO - '_': '/tools/buildbot/bin/python'} 17:44:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:01 INFO - Downloading/unpacking jsonschema 17:44: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 17:44: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 17:44: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 17:44: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 17:44: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 17:44: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 17:44:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:44:02 INFO - Downloading/unpacking functools32 (from jsonschema) 17:44: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 17:44: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 17:44: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 17:44: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 17:44: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 17:44: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 17:44:03 INFO - Downloading functools32-3.2.3-2.tar.gz 17:44:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:44:03 INFO - warning: no files found matching '*.txt' 17:44:03 INFO - no previously-included directories found matching 'build' 17:44:03 INFO - no previously-included directories found matching 'dist' 17:44:03 INFO - no previously-included directories found matching '.git*' 17:44:03 INFO - Installing collected packages: jsonschema, functools32 17:44:03 INFO - Running setup.py install for functools32 17:44:03 INFO - warning: no files found matching '*.txt' 17:44:03 INFO - no previously-included directories found matching 'build' 17:44:03 INFO - no previously-included directories found matching 'dist' 17:44:03 INFO - no previously-included directories found matching '.git*' 17:44:03 INFO - Successfully installed jsonschema functools32 17:44:03 INFO - Cleaning up... 17:44:03 INFO - Return code: 0 17:44:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:44: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')]} 17:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44: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')]} 17:44:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:03 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 0x7fc163769f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1655410>, '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 0x1656310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16567a0>, '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': '82e07478c745e68b1fe4678a000001bc-1460421554.469346-590543354', '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 17:44:03 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 17:44:03 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 17:44:03 INFO - Using env: {'DISPLAY': ':0', 17:44:03 INFO - 'HOME': '/home/cltbld', 17:44:03 INFO - 'LANG': 'en_US.UTF-8', 17:44:03 INFO - 'LANGUAGE': 'en_US:en', 17:44:03 INFO - 'LOGNAME': 'cltbld', 17:44:03 INFO - 'MAIL': '/var/mail/cltbld', 17:44:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:03 INFO - 'MOZ_NO_REMOTE': '1', 17:44:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:03 INFO - 'NO_EM_RESTART': '1', 17:44:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:03 INFO - 'PWD': '/builds/slave/test', 17:44:03 INFO - 'SHELL': '/bin/bash', 17:44:03 INFO - 'SHLVL': '1', 17:44:03 INFO - 'TERM': 'linux', 17:44:03 INFO - 'TMOUT': '86400', 17:44:03 INFO - 'USER': 'cltbld', 17:44:03 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1460421554.469346-590543354', 17:44:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:03 INFO - '_': '/tools/buildbot/bin/python'} 17:44:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:03 INFO - Downloading/unpacking flake8 17:44:03 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 17:44:03 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 17:44:03 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 17:44:03 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 17:44:03 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 17:44:03 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 17:44:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:44:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:44:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:44:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:44:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:44:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:44:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:44:06 INFO - no previously-included directories found matching 'docs/_build' 17:44:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:44:06 INFO - Running setup.py install for pep8 17:44:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:44:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:44:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:44:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:44:06 INFO - no previously-included directories found matching 'docs/_build' 17:44:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:44:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:44:06 INFO - Cleaning up... 17:44:06 INFO - Return code: 0 17:44:06 INFO - Running post-action listener: _resource_record_post_action 17:44:06 INFO - Running post-action listener: _start_resource_monitoring 17:44:06 INFO - Starting resource monitoring. 17:44:06 INFO - ##### 17:44:06 INFO - ##### Running install step. 17:44:06 INFO - ##### 17:44:06 INFO - Running pre-action listener: _resource_record_pre_action 17:44:06 INFO - Running main action method: install 17:44:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:44:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:44:06 INFO - Reading from file tmpfile_stdout 17:44:06 INFO - Detecting whether we're running mozinstall >=1.0... 17:44:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:44:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:44:06 INFO - Reading from file tmpfile_stdout 17:44:06 INFO - Output received: 17:44:06 INFO - Usage: mozinstall [options] installer 17:44:06 INFO - Options: 17:44:06 INFO - -h, --help show this help message and exit 17:44:06 INFO - -d DEST, --destination=DEST 17:44:06 INFO - Directory to install application into. [default: 17:44:06 INFO - "/builds/slave/test"] 17:44:06 INFO - --app=APP Application being installed. [default: firefox] 17:44:06 INFO - mkdir: /builds/slave/test/build/application 17:44:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:44:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:44:22 INFO - Reading from file tmpfile_stdout 17:44:22 INFO - Output received: 17:44:22 INFO - /builds/slave/test/build/application/firefox/firefox 17:44:22 INFO - Running post-action listener: _resource_record_post_action 17:44:22 INFO - ##### 17:44:22 INFO - ##### Running run-tests step. 17:44:22 INFO - ##### 17:44:22 INFO - Running pre-action listener: _resource_record_pre_action 17:44:22 INFO - Running main action method: run_tests 17:44:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:44:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:44:22 INFO - Python 2.7.3 17:44:22 INFO - Return code: 0 17:44:22 INFO - grabbing minidump binary from tooltool 17:44:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:44:22 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1655410>, '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 0x1656310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16567a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:44:22 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 17:44:22 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 17:44:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:44:22 INFO - Return code: 0 17:44:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:44:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:44:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:44:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:44:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:44:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:44:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:44:23 INFO - Return code: 0 17:44:23 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/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 17:44:23 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/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --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 17:44:23 INFO - Using env: {'DISPLAY': ':0', 17:44:23 INFO - 'HOME': '/home/cltbld', 17:44:23 INFO - 'LANG': 'en_US.UTF-8', 17:44:23 INFO - 'LANGUAGE': 'en_US:en', 17:44:23 INFO - 'LOGNAME': 'cltbld', 17:44:23 INFO - 'MAIL': '/var/mail/cltbld', 17:44:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:44:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:44:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:23 INFO - 'MOZ_NO_REMOTE': '1', 17:44:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:44:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:23 INFO - 'NO_EM_RESTART': '1', 17:44:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:23 INFO - 'PWD': '/builds/slave/test', 17:44:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:44:23 INFO - 'SHELL': '/bin/bash', 17:44:23 INFO - 'SHLVL': '1', 17:44:23 INFO - 'TERM': 'linux', 17:44:23 INFO - 'TMOUT': '86400', 17:44:23 INFO - 'USER': 'cltbld', 17:44:23 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1460421554.469346-590543354', 17:44:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:23 INFO - '_': '/tools/buildbot/bin/python'} 17:44:23 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/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 17:44:23 INFO - mozversion application_buildid: 20160411160652 17:44:23 INFO - mozversion application_changeset: 4118760a3981d37b7ae31d8c6a9326318e6b3ee8 17:44:23 INFO - mozversion application_display_name: Nightly 17:44:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:44:23 INFO - mozversion application_name: Firefox 17:44:23 INFO - mozversion application_remotingname: firefox 17:44:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:44:23 INFO - mozversion application_vendor: Mozilla 17:44:23 INFO - mozversion application_version: 48.0a1 17:44:23 INFO - mozversion platform_buildid: 20160411160652 17:44:23 INFO - mozversion platform_changeset: 4118760a3981d37b7ae31d8c6a9326318e6b3ee8 17:44:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:44:23 INFO - mozversion platform_version: 48.0a1 17:44:23 INFO - using testdate: 1460421863 17:44:23 INFO - actual date: 1460421863 17:44:23 INFO - starting webserver on 'localhost:49290' 17:44:23 INFO - SUITE-START | Running 2 tests 17:44:23 INFO - TEST-START | dromaeo_css 17:44:23 INFO - operating with platform_type : linux_ 17:44:23 INFO - Initialising browser for dromaeo_css test... 17:44:23 INFO - TEST-INFO | started process 29105 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8h6eiO/profile http://localhost:49290/getInfo.html) 17:44:28 INFO - PROCESS | 29105 | __metrics Screen width/height:1600/1200 17:44:28 INFO - PROCESS | 29105 | colorDepth:24 17:44:28 INFO - PROCESS | 29105 | Browser inner width/height: 1024/697 17:44:28 INFO - PROCESS | 29105 | __metrics 17:44:29 ERROR - PROCESS | 29105 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:44:29 INFO - TEST-INFO | 29105: exit 0 17:44:29 INFO - Browser initialized. 17:44:29 INFO - Running cycle 1/1 for dromaeo_css test... 17:44:29 INFO - TEST-INFO | started process 29185 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8h6eiO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:44:41 INFO - PROCESS | 29185 | RSS: Main: 154693632 17:44:41 INFO - PROCESS | 29185 | 17:45:33 INFO - PROCESS | 29185 | 1460421933357 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] 17:47:44 INFO - PROCESS | 29185 | Cycle 1(1): loaded http://localhost:49290/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49290/tests/dromaeo/cssquery-ext.html) 17:47:45 INFO - PROCESS | 29185 | RSS: Main: 227868672 17:47:45 INFO - PROCESS | 29185 | 17:50:48 INFO - PROCESS | 29185 | Cycle 1(1): loaded http://localhost:49290/tests/dromaeo/cssquery-ext.html (next: http://localhost:49290/tests/dromaeo/cssquery-jquery.html) 17:50:48 INFO - PROCESS | 29185 | RSS: Main: 245366784 17:50:48 INFO - PROCESS | 29185 | 17:53:50 INFO - PROCESS | 29185 | Cycle 1(1): loaded http://localhost:49290/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49290/tests/dromaeo/cssquery-mootools.html) 17:53:51 INFO - PROCESS | 29185 | RSS: Main: 234696704 17:53:51 INFO - PROCESS | 29185 | 17:56:53 INFO - PROCESS | 29185 | Cycle 1(1): loaded http://localhost:49290/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49290/tests/dromaeo/cssquery-prototype.html) 17:56:54 INFO - PROCESS | 29185 | RSS: Main: 214069248 17:56:54 INFO - PROCESS | 29185 | 17:59:56 INFO - PROCESS | 29185 | Cycle 1(1): loaded http://localhost:49290/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49290/tests/dromaeo/cssquery-yui.html) 17:59:57 INFO - PROCESS | 29185 | RSS: Main: 211050496 17:59:57 INFO - PROCESS | 29185 | 18:03:00 INFO - PROCESS | 29185 | Cycle 1(1): loaded http://localhost:49290/tests/dromaeo/cssquery-yui.html (next: http://localhost:49290/tests/dromaeo/cssquery-dojo.html) 18:03:00 INFO - PROCESS | 29185 | RSS: Main: 268013568 18:03:00 INFO - PROCESS | 29185 | 18:03:00 INFO - PROCESS | 29185 | __start_tp_report 18:03:00 INFO - PROCESS | 29185 | _x_x_mozilla_page_load 18:03:00 INFO - PROCESS | 29185 | _x_x_mozilla_page_load_details 18:03:00 INFO - PROCESS | 29185 | |i|pagename|runs| 18:03:00 INFO - PROCESS | 29185 | |0;dojo.html;2587.93530161746;2639.986800065998;2648.854313012786;2655.083996021373;2678.558037923742;4494.528074552174;4552.567506086921;4555.658325625574;4560.429946256714;4581.839635612754;4614.607758340537;4620.399348084753;4674.415698037746;4691.179043667362;4707.05858828234;4210.894727631819;4251.4048033275285;4260.339647354665;4311.482622085354;4384.97807510962;4334.60988511034;4366.345048242757;4380.97809510952;4406.735595864258;4411;4172.666186705056;4252.149570085964;4260.1479704059;4311.1808756336195;4321.135772845443;4263.317869140923;4290.828366865321;4339.457567804025;4343.717658352197;4387.100644367929;4197.4753155855515;4240.067185219247;4247.320428731388;4249.596288352602;4290.635295999844;4438.42300500936;4506.932396014063;4533.5013148553635;4600.815967361302;4627.8611641650805;4963.875903102451;4983.152864013126;4985;4985.252212168168;5019.673721208146;4961;4994.750262486898;5000.649954503187;5005.074061298671;5045.974770126162;4540.046590216026;4623.283391074388;4683.437987441494;4711.717296962193;4720.834770783006;5007.073691367109;5019.949800502021;5020.874478138076;5022.045811295842;5070.6957582545165;4818.036392721469;4819.132556139858;4824.204006338985;4836.806527738851;4869.001854619794;4892.3884514435695;4950.25746138075;4982.978489409662;5007.524285192901;5029.119904016782;4877.414710234794;4879;4891.070696567641;4893.192623217201;4940.2342636891335;4717.834875779331;4862.708237505761;4864.537868902448;4865.221564549655;4916.508349165055;4230.8519201827785;4256.893577660583;4262.808173632194;4296.205202037633;4303.354496825501;3700.4634328022285;3706.5181526401393;3713.405855063177;3714.23858109087;3737.663610275034;4190.622843944059;4258.723182993095;4272.359146128106;4274.316109422478;4312.05134870328;4917.065757506062;4949.826756063592;4958.082754690394;5002.474740152305;5004.9499505005215;4269.935950960738;4280.036991676848;4283.87148385549;4309.030468144642;4329.9134017319475;4419.46966364032;4451.866444006685;4530.456345238593;4533.977330113395;4542.931856022163;4720.693154944917;4736.100140973204;4742.596879265301;4765.070811191854;4784.210605250164;4948.331975183448;4991.3511243538105;4994.875128121681;4996.450390456974;5045.949540504548;4629.4676112247525;4677.766111694334;4706.505816889177;4740.360051393156;4787.808487660454;4874.2444921037295;4887.169181239126;4898.485659005753;4929.285253638274;4943.975280123576;4927.408710954708;4951.10880041596;4954.515596074652;4962.478939711423;5007.048660754591;4739.099571081483;4830.1305764961235;4862.513748625109;4874.610031197425;4943.184374578154;4689.718616882998;4719.032598317405;4722.693024953367;4762.238041913277;4767.022760334054;4633.096546173464;4638;4639.32729754177;4650.558196971282;4677.508861569622;4749.548792864673;4788.090262850047;4871.123197824426;4934.259861020732;4956.430010548833;4771.427428708438;4776.307435421914;4794.664373493962;4798;4853 18:03:00 INFO - PROCESS | 29185 | |1;ext.html;580.6109906362736;589.254592939931;602.4006113916654;611.9443959170432;624.640831521875;32487.67512324876;33136.17159571009;33171.83414082926;33210.833945830236;33217.501737473955;31807.36385272293;32518.67481325186;32542.67457325426;32684.67315326846;32753;7536.96231518843;7708.57602831844;7720.536767793922;7722.61386930654;7731.884021739678;7542.472026958115;7650.502717323357;7656.157822639505;7669.386449084088;7698.653560589787;7788.805279867992;7858.371330293563;7865.331446827026;7866.881996770053;7867.134615192324;7775.30022297993;7821.217878212134;7837.843243135162;7842.764717058498;7852.960735196345;7756;7867.6852925882895;7874.370050395954;7874.842503149905;7882.684692612289;32772.180695482806;33054.834725826215;33074.17314567131;33083.6691633083;33113.834430827694;2945.7348838604416;3067.097101528559;3071.9466576704353;3078.291992841659;3086.3981523602906;27978.89812372484;28068;28085.438291234062;28986.565201521993;29062.564061539095;3093.180307218589;3102.332998405331;3175.364927014606;3180.9661859895396;3219.5170724391296;176737;177059;177800;177986;178065;49642.255366169535;49727.50272497301;49927;49938;50066.24900626494;41139;43499.130017399475;54251.18623220655;55937.16094258589;56003.719981400645;12574.559890403792;12695.36523173856;12697.809532857014;12712.364381780873;12715.872841271654;9040.683576074805;10243.84634230487;10317.27779055474;10318.690439286833;10323.070923616911;14639.414423422944;15026.549203523911;15103.093814371174;15120.54638360851;15121.924390377977;5856.770078283608;6050.667213303311;6129.325774164839;6133.417325354084;6197.597156184834;880.4805164952709;957.4351132831663;963.2871674960619;983.7835676151235;1010.5351538292321;24035.639465408032;25174;25394;25441.872790635927;25604;998.6354980432089;999.01097913067;1065.6643157405392;1081.5025088459397;1114.5820317380983;13534.458621655023;13972.650683732989;13979.79030314546;14012.64989325399;14161.645958851112;319244;324769;325042;325556;325774;45059;46373.536264637594;46427.535724643;46498.5350146501;46597;1166.6966588686832;1170.3446070200544;1204.1992075270023;1239.1016513027982;1273.535159666715;18542.814571854648;27947.301317467227;28648.907321742503;29183.416331672823;31526.842365788023;41995.37006944959;42649.78675106604;42819.14361712811;42838.57161428346;42912.57087429086;250772;253135;253952;254022;254065;30299.545506816976;32767.34465310728;33046.50430243596;36390.27219455543;36527.817360913024;33293.16767080843;37702.811485942395;37945.43081853719;38287.42568861414;38923.416148758355;32659.510107348884;32852;32861.67138328586;33317.33365332728;33728.15679608029;29410.264743381587;29505.852470737507;29722.40555188841;29797.553036704034;29855.552166717953;32041.35917281688;32779.18052048718;33155.668443315255;33184.834075829465;33253.50119748157;29395.85302073476;29691.703082968892;30118.548221777128;30118.84940575283;30188.396232075676;23960.64059039081;23977.880110600032;24047.27858164258;24256.51486970286;24377.756222438256 18:03:00 INFO - PROCESS | 29185 | |2;jquery.html;350.75972958523414;353.56688057130003;362.4147002590816;371.1908040471772;378.490929699554;15926.601834954117;16349.918250408746;16923.915380423095;17053.57366065849;17063;15568.610784730387;16355.83644163558;17186.57033574158;17212;17215.82784172158;5082.822101226467;5206.713630750326;5268.92096618551;5276.947230527703;5279.736013199344;3680.926381472369;3843.6592594070935;3877.9030524236837;3887.105965627907;5187.766550505236;3933.4886464759543;5861.648301101926;5874.794382196624;5875.676837773921;5880.7059647017695;5063.316452278968;5770.307563092435;5884.117382392676;5900.586958912856;5908.1433192187105;3328.7170590499595;5265.526102650741;5265.6840589564745;5270.314859068335;5272.683638981635;10563.313384629975;10632.62785802501;10741.570337186504;11688.883111168865;12265.018798496189;1864.2263460663808;1922.865399422041;2002.3792624286518;2048.944793431384;2123.235635171337;9121.179093881516;9227.400218985811;9334.766630834216;9641.228701703916;9659.46872921989;1754.1580041579984;1808.2495764257817;1849.9722504162448;1878.2393130782054;1889.527618095476;66271.66864165648;68953;69031.30968690349;69514;69575.30424695738;9737.318387712934;9741.366811157393;9750.219982401391;9897.754190279164;10049.934769895252;13493.797593036112;13536.458541658223;13539.39072741729;13600.591982240549;13616.046876718534;6769.627670478171;6799.898001529981;6836.658167091626;6860.965695171592;7076.938459231156;6272.749090036347;6527.477801775846;6601.108850305243;6629.734810607618;6638;4104.404861295156;4236.788160591958;4262.46719160105;4266.914661706748;4408.735475871458;1797.4158398520271;1824.2885274742862;1872.5880306332585;1879.0886420086247;1897.297999740105;774.6630215856121;883.4213590098495;889.9822003559892;936.1200471556715;940.9435433873989;15879.047257164377;16090.275937582837;16386.788145854396;16464.83535164657;16995.23521441538;850.1371108325055;853.4623187391903;895.8611415230649;928.3919033033374;958.5925981457852;8931.866022009675;8958.238549723215;9207.309451791143;9248.445093294424;9655.565499552536;387294;389786;395228;397162;403242;75836.62081689556;77848.61075694585;78295.60852195702;78750.6062469684;78819;918.7519369770258;937.6436953957316;942.1097063275276;953.580424613168;963.9132478077007;13987;14366.928165359106;14471;14783.926080369529;14799;22614.660780087983;24981.375465613506;25482.872585636953;33569;33619.663803361655;46859.29711054405;47387.052258955315;47694.761526192146;47883.5211647893;47970.76014619905;7747.84327910751;7853.725119620786;7898.5260884344825;8013.919860801318;8017.278444939983;11488.770224595628;11789.764204715686;11868.465919033491;11895.702607434883;11948;10155.136813370946;10425.895741042492;10433.791324173322;10612.56730341394;10784.191185661264;10305.330153539995;10348.689539313833;10445.68662940113;10590.41752703578;10825.188110891871;10189;10471.528781205016;10493.895061049598;10533.9473302633;10839.295445796313;7720.575368354795;7802.843943120993;7832.804179895548;7940.404469664682;7956.721514746956;8695.347848911231;10070.748231293983;10143.695689129338;10232.48837558134;10489.160867130458 18:03:00 INFO - PROCESS | 29185 | |3;mootools.html;1162.273579013117;1230.1020255213691;1295.6436979830546;1333.0735139078342;1743.4159556548555;6435.903461448076;7467.589282589455;7682;7694.7306844260465;7704.383649308056;7545.584992825392;7545.622718864049;7603.619819009041;7604.885926711104;7619.695212191506;1922.1830721943188;2192.3642143778284;2278.8860556972168;2315.3632750993443;2317.73346065203;2292.5300313435705;2325.8604483730946;2328.9767102329015;2330.149495434171;2331.2423462374713;2257.3115199864037;2261.6155253606926;2296.517731276434;2296.7358753743365;2296.81625469962;1820.1900154431282;1885.7831349394721;1886.141805478504;2123.0870725587993;2159.8164156046755;2220.0897631970975;2248.415411992877;2248.449129963153;2253.7971582557648;2266.1162146762613;7551.207123252035;7609.429292803062;7619.276168763959;7621.466497345188;7642.235776422369;4455.309427038814;4606.815727370901;4612.262038073892;4618.49196588375;4619.122366750306;2821.633187685588;2878.956815647767;3021.350409661933;3027.7729170312095;3029.727324540802;970.0832713086137;977.8510250455757;978.8335982882855;980.9607615695363;1014.9035841595037;10394.792104157874;10438.37369757817;10460.52927618259;10465.529051192714;10470.16238700902;4316.287812510964;4326.740395576276;4457.710248833815;4516.480604730433;4519.706219095749;8935.642574296955;8952.910470895338;8999.055099214489;9006.684766033157;9016.098390161063;4678.906421871544;4695.5069717679835;4697.177993851063;4713.57577817998;4722.268048452495;3702.315071711742;4125.216208920296;4250.298700714409;4282.743035417885;4288.914221715549;3678.5953545110015;3737.383331750285;3783.829727662262;3800.9619903801163;3902.726809123334;1241.6213055018306;1268.898488120948;1273.8216649669055;1283.0569531394417;1288.323630094208;1172.5309876049648;1177.7467844413493;1202.6933132051445;1203.7532305877448;1223.9816402753966;7003.404710599554;7126.679299431435;7129.3583577478275;7132.536385134949;7345.302196291451;1014.3010457483832;1021.5556233038652;1036.9792604147874;1037.444966942682;1078.800421921947;5388.838334849961;5515.503604675599;5523.364813046471;5555.3611334697025;5558.610897237155;9084.81830363389;9394.67118650844;9499.857502137334;9512;9518.857217141749;9021.864672029924;9210.355275130676;9302.767430814283;9318.90681093194;9387.57755900986;7047.718091276394;7206.099237595301;7263.4915555910575;7295.562266263935;7323.414126869944;7207.063081799332;7266.237045110187;7328.5969271690565;7351.154617218875;7404.888926665996;8731.345149113715;8850.291976641982;8903.065178156201;8906.198442140238;9010.729678109667;8848.955755221183;8867.290616750774;9117.17945384892;9205.631774728936;9208.907910920805;5983.222181116601;6151;6710.63091529951;6785.117934668461;6926.272741362084;7471.514351567131;7488.8876666848955;7550.7734767957045;7560.130584982578;7564.810879727831;6583.604983700993;6592.538522303585;6674.7997560071335;6681.498887583353;6856.485763567653;6346.1432706585865;6399.072134540559;6541.738330466918;6561.770338038145;6679.398854103154;7069.6111713856235;7248.710051598088;7273.309035641606;7292.380147687506;7294.307040831112;6477.805665830033;6524.249711283263;6531.216254049545;6544.869102618016;6562.376574225441;6635.369639884203;6654.301298363602;6680.164979377578;6691.130153080068;6695.564788288746 18:03:00 INFO - PROCESS | 29185 | |4;prototype.html;295.2662633356111;300.05333173836544;304.4671824307461;304.87500124948775;305.4761084739671;4941.728204948727;4975.129352363336;5001.099802035632;5049.166887463573;5068.5945124390055;4943.876403089925;4956.776945037473;4965.751712414383;4967.652264341497;4970.8011679532865;3703.555573331204;3787.6212378762043;3796.9620303797024;3897.4543563901075;3916.686665066802;3877.9806100969454;3900.960990390088;3926.5680775114715;3930.528336599598;3936.252112098706;3854.402567602026;3867.8839634811;3886.300465916148;3891.182851601167;3893.7079719021185;3702.1114932416294;3766.133789228493;3861.8841434757;3894.3768996960634;3900.941485877714;3423.691867731916;3437.845296961618;3439.329330780499;3452.602950660656;3454.3436747017986;4793.904121917577;4798.376211092571;4819.108464933998;4823.782929768169;4846.321514987904;4154.792260386998;4326.762028088454;4359.062801497693;4487.371767952489;4495.280755079204;5209.984053109645;5241.73791310433;5250.133727934886;5250.238715386286;5259.211118332242;3650.671439570425;3654.4152935530456;3654.7258955578436;3659.8536058557625;3665.9450108248398;5187.250757098744;5448.210009548633;5511.173324001392;5523;5527.39198688144;3690.5755838078426;3698.500702405141;3712.6472985066375;3714.2200137971327;3730.7015438764834;3749.175181460129;3751.2872554214614;3753.962460375416;3762.8682996095004;3770.6417890300377;4318.395424640553;4351.912961740747;4359.324304732771;4373.322135069069;4388.232059389594;5103.413107492612;5189.610779191576;5219.712915789592;5256.526912577886;5270.841874743764;1312.3307113372248;1323.9474617678968;1331.6803967047838;1334.6930206052468;1339.1496399786206;835.4861760017667;873.0963452826294;884.5798245833178;906.6464079009191;907.6278725722422;4457.353683715843;4557;4565.246734288805;4569.086182763461;4722.433308003062;5453.890922181534;5462.890742185134;5476.083370820261;5489.890202196014;5495.076723146946;4587.816487340469;4641.767911604406;4658.301254811805;4668.183067963161;4691.554302341272;2905.8837646494326;2907.447584958851;2927.838968856733;2933.4133173365412;2937.0454602254354;5181.533661970366;5193.649651090744;5203.713795741271;5222.242774797709;5235.842924712265;5293.153095504701;5589.524890384363;5589.847908555235;5648.293963254593;5669.206311116447;5205.791768329224;5235.293235413246;5241.816536421284;5244;5245.423003469616;5495.422980587141;5509.173623956439;5522.392536820867;5528.281323428089;5529.341197640772;5172.508611681884;5358.732063396893;5375.569954403716;5378.865528361665;5397.190421436816;5183.300254465599;5186.8962620748125;5190.8183213587345;5205.505476979681;5215.947840521546;3767.547894252707;3777.1690228149764;3790.65884070435;3790.7915064671706;3790.8104594769597;5350.090484617546;5364.839054828361;5422.728863556886;5456.945430545644;5495.6153069284765;5245.554127899019;5267.420583735862;5269.631125821155;5274.261603375608;5285.603579731459;5085.796568137381;5251.868703282448;5274.578033757367;5288.312519372457;5310.3893052297935;5166.328377311076;5178.093833579033;5183.170692689152;5188.9740551297;5191.558717508903;5058.266551350107;5110.71891045996;5273.525382715574;5354.518093371616;5356.035913535445;5171.146760784429;5199.194124910645;5201.895962080813;5202;5203.843884683465 18:03:00 INFO - PROCESS | 29185 | |5;yui.html;568.6929058308514;589.1310317282008;641.4739913271117;650.7624716978298;651.6155468273718;10626;11801.586944456934;12128.575499857507;12138.211016283936;12185.939070304636;13573.321333933312;13583.84537314327;13642.93178534106;13648.317584120803;13685.110467819584;650.362644608283;672.8822456070193;673.5285300289793;673.8719643267764;810.3274282345668;824.8102936324649;827.3587969323762;829.8381815545971;830.3398797955609;831.5925196653657;850.268768858781;851.5912362066211;852.0882655558555;853.5561508015828;853.6500034985658;847.4279861093737;849.9447535910147;850.2602735620019;850.4344610833788;851.2466467176594;624.5565648389648;624.5815303746456;624.6064979063207;625.1747693045182;625.3059104394118;11549.480273387633;11653;11667.883321166764;11680.591179308683;11715.589954351643;12922.612321630366;12986.28575428351;12990.480380784757;13027.674308142277;13314.533991310258;9990.850137247948;10035.498225088717;10285.691429257135;10323.84514232287;10722.839157412567;3198.2484116232667;3202.6797320267788;3208.342289830579;3272.345530893831;3290.2925870937624;49260.50739492595;49327.753361232964;49379;49429.50570494321;50635.746821266024;9717.659881904241;9815.901840981498;9983.850242246372;10417.583296668048;10587.947060264649;16552.83447165513;16606;16627.418040368528;16669.41657042022;16867;6411.487081033506;6564.934350656527;6694.163229596301;6712.731490740413;6743.831404214934;3630.8184590770884;3688.483612294281;3709.0592161950613;3779.6220377961986;3850.7882066486054;2567.987160064225;2650.748178922999;2671.345520347488;2673.8262012969485;2681.1286331942197;508.63378367575285;527.8073503171315;528.1444060621741;536.3965538768884;564.6442741073098;506.74915916621507;507.8730317420645;553.5737482138811;560.8569814697227;569.473237255537;7556;7583.568103258727;7628.398036412415;8004.759857204293;8015.799605009922;571.5684658083204;601.9189892528663;605.2736715940889;611.7124951272895;626.79629120536;3616.9095772605897;3712.1647629283734;3713.7586056906216;3754.737168398186;3826.426036094608;40898.79550602228;41803.163936721096;41861.372079418834;41962.79018604887;53057;37200.627993720256;37407.62592374096;38042.809785951446;38546.229075418334;38565;36655.26689466196;37826.621733782864;38230.61769382326;38332;38939.610603894165;7941.801454963441;8058.919410806051;8572.614232359683;8644.870326945227;8792.648294068165;25756.61365079488;26233;26800;26803.19590412291;27424.17727468179;34107;35430.64569354377;35652.82173589116;35830.64169358273;36157.27685446224;9144.63421463134;9302.302327325342;9389.671361502587;9478.526073696425;9592.23262139041;10892.019718225081;10962.890371096506;11008.614698485515;11335.433228338716;11395.14536409756;10337.431441270803;10622.150227981589;10684.99445571063;10926.562937482411;10927.672169834917;10739.194560407845;10814.188935829687;10875.129989600655;10926.071283940637;11068;9065;9460.243180545678;9768.413895166314;11120.165987550805;11141.554337826396;8450.281726053108;8924.330675199515;9221.631134754803;9302.348835581444;9473.289503287418;8448.577571121543;8570;8573.399862009599;8595.398322117391;9088.363814532919 18:03:00 INFO - PROCESS | 29185 | __end_tp_report 18:03:00 INFO - PROCESS | 29185 | __start_cc_report 18:03:00 INFO - PROCESS | 29185 | _x_x_mozilla_cycle_collect,1020 18:03:00 INFO - PROCESS | 29185 | __end_cc_report 18:03:00 INFO - PROCESS | 29185 | __startTimestamp1460422980465__endTimestamp 18:03:00 INFO - PROCESS | 29185 | 18:03:00 INFO - PROCESS | 29185 | ------- Summary: start ------- 18:03:00 INFO - PROCESS | 29185 | Number of tests: 6 18:03:00 INFO - PROCESS | 29185 | 18:03:00 INFO - PROCESS | 29185 | [#0] dojo.html Cycles:165 Average:4585.56 Median:4711.72 stddev:463.44 (9.8%) stddev-sans-first:437.57 18:03:00 INFO - PROCESS | 29185 | Values: 2587.9 2640.0 2648.9 2655.1 2678.6 4494.5 4552.6 4555.7 4560.4 4581.8 4614.6 4620.4 4674.4 4691.2 4707.1 4210.9 4251.4 4260.3 4311.5 4385.0 4334.6 4366.3 4381.0 4406.7 4411.0 4172.7 4252.1 4260.1 4311.2 4321.1 4263.3 4290.8 4339.5 4343.7 4387.1 4197.5 4240.1 4247.3 4249.6 4290.6 4438.4 4506.9 4533.5 4600.8 4627.9 4963.9 4983.2 4985.0 4985.3 5019.7 4961.0 4994.8 5000.6 5005.1 5046.0 4540.0 4623.3 4683.4 4711.7 4720.8 5007.1 5019.9 5020.9 5022.0 5070.7 4818.0 4819.1 4824.2 4836.8 4869.0 4892.4 4950.3 4983.0 5007.5 5029.1 4877.4 4879.0 4891.1 4893.2 4940.2 4717.8 4862.7 4864.5 4865.2 4916.5 4230.9 4256.9 4262.8 4296.2 4303.4 3700.5 3706.5 3713.4 3714.2 3737.7 4190.6 4258.7 4272.4 4274.3 4312.1 4917.1 4949.8 4958.1 5002.5 5004.9 4269.9 4280.0 4283.9 4309.0 4329.9 4419.5 4451.9 4530.5 4534.0 4542.9 4720.7 4736.1 4742.6 4765.1 4784.2 4948.3 4991.4 4994.9 4996.5 5045.9 4629.5 4677.8 4706.5 4740.4 4787.8 4874.2 4887.2 4898.5 4929.3 4944.0 4927.4 4951.1 4954.5 4962.5 5007.0 4739.1 4830.1 4862.5 4874.6 4943.2 4689.7 4719.0 4722.7 4762.2 4767.0 4633.1 4638.0 4639.3 4650.6 4677.5 4749.5 4788.1 4871.1 4934.3 4956.4 4771.4 4776.3 4794.7 4798.0 4853.0 18:03:00 INFO - PROCESS | 29185 | 18:03:00 INFO - PROCESS | 29185 | [#1] ext.html Cycles:180 Average:40284.00 Median:32718.84 stddev:67844.02 (207.4%) stddev-sans-first:67968.85 18:03:00 INFO - PROCESS | 29185 | Values: 580.6 589.3 602.4 611.9 624.6 32487.7 33136.2 33171.8 33210.8 33217.5 31807.4 32518.7 32542.7 32684.7 32753.0 7537.0 7708.6 7720.5 7722.6 7731.9 7542.5 7650.5 7656.2 7669.4 7698.7 7788.8 7858.4 7865.3 7866.9 7867.1 7775.3 7821.2 7837.8 7842.8 7853.0 7756.0 7867.7 7874.4 7874.8 7882.7 32772.2 33054.8 33074.2 33083.7 33113.8 2945.7 3067.1 3071.9 3078.3 3086.4 27978.9 28068.0 28085.4 28986.6 29062.6 3093.2 3102.3 3175.4 3181.0 3219.5 176737.0 177059.0 177800.0 177986.0 178065.0 49642.3 49727.5 49927.0 49938.0 50066.2 41139.0 43499.1 54251.2 55937.2 56003.7 12574.6 12695.4 12697.8 12712.4 12715.9 9040.7 10243.8 10317.3 10318.7 10323.1 14639.4 15026.5 15103.1 15120.5 15121.9 5856.8 6050.7 6129.3 6133.4 6197.6 880.5 957.4 963.3 983.8 1010.5 24035.6 25174.0 25394.0 25441.9 25604.0 998.6 999.0 1065.7 1081.5 1114.6 13534.5 13972.7 13979.8 14012.6 14161.6 319244.0 324769.0 325042.0 325556.0 325774.0 45059.0 46373.5 46427.5 46498.5 46597.0 1166.7 1170.3 1204.2 1239.1 1273.5 18542.8 27947.3 28648.9 29183.4 31526.8 41995.4 42649.8 42819.1 42838.6 42912.6 250772.0 253135.0 253952.0 254022.0 254065.0 30299.5 32767.3 33046.5 36390.3 36527.8 33293.2 37702.8 37945.4 38287.4 38923.4 32659.5 32852.0 32861.7 33317.3 33728.2 29410.3 29505.9 29722.4 29797.6 29855.6 32041.4 32779.2 33155.7 33184.8 33253.5 29395.9 29691.7 30118.5 30118.8 30188.4 23960.6 23977.9 24047.3 24256.5 24377.8 18:03:00 INFO - PROCESS | 29185 | 18:03:00 INFO - PROCESS | 29185 | [#2] jquery.html Cycles:180 Average:23747.49 Median:203673.20 stddev:65119.72 (32.0%) stddev-sans-first:65278.70 18:03:00 INFO - PROCESS | 29185 | Values: 350.8 353.6 362.4 371.2 378.5 15926.6 16349.9 16923.9 17053.6 17063.0 15568.6 16355.8 17186.6 17212.0 17215.8 5082.8 5206.7 5268.9 5276.9 5279.7 3680.9 3843.7 3877.9 3887.1 5187.8 3933.5 5861.6 5874.8 5875.7 5880.7 5063.3 5770.3 5884.1 5900.6 5908.1 3328.7 5265.5 5265.7 5270.3 5272.7 10563.3 10632.6 10741.6 11688.9 12265.0 1864.2 1922.9 2002.4 2048.9 2123.2 9121.2 9227.4 9334.8 9641.2 9659.5 1754.2 1808.2 1850.0 1878.2 1889.5 66271.7 68953.0 69031.3 69514.0 69575.3 9737.3 9741.4 9750.2 9897.8 10049.9 13493.8 13536.5 13539.4 13600.6 13616.0 6769.6 6799.9 6836.7 6861.0 7076.9 6272.7 6527.5 6601.1 6629.7 6638.0 4104.4 4236.8 4262.5 4266.9 4408.7 1797.4 1824.3 1872.6 1879.1 1897.3 774.7 883.4 890.0 936.1 940.9 15879.0 16090.3 16386.8 16464.8 16995.2 850.1 853.5 895.9 928.4 958.6 8931.9 8958.2 9207.3 9248.4 9655.6 387294.0 389786.0 395228.0 397162.0 403242.0 75836.6 77848.6 78295.6 78750.6 78819.0 918.8 937.6 942.1 953.6 963.9 13987.0 14366.9 14471.0 14783.9 14799.0 22614.7 24981.4 25482.9 33569.0 33619.7 46859.3 47387.1 47694.8 47883.5 47970.8 7747.8 7853.7 7898.5 8013.9 8017.3 11488.8 11789.8 11868.5 11895.7 11948.0 10155.1 10425.9 10433.8 10612.6 10784.2 10305.3 10348.7 10445.7 10590.4 10825.2 10189.0 10471.5 10493.9 10533.9 10839.3 7720.6 7802.8 7832.8 7940.4 7956.7 8695.3 10070.7 10143.7 10232.5 10489.2 18:03:00 INFO - PROCESS | 29185 | 18:03:00 INFO - PROCESS | 29185 | [#3] mootools.html Cycles:180 Average:5413.91 Median:6456.85 stddev:2830.42 (43.8%) stddev-sans-first:2820.31 18:03:00 INFO - PROCESS | 29185 | Values: 1162.3 1230.1 1295.6 1333.1 1743.4 6435.9 7467.6 7682.0 7694.7 7704.4 7545.6 7545.6 7603.6 7604.9 7619.7 1922.2 2192.4 2278.9 2315.4 2317.7 2292.5 2325.9 2329.0 2330.1 2331.2 2257.3 2261.6 2296.5 2296.7 2296.8 1820.2 1885.8 1886.1 2123.1 2159.8 2220.1 2248.4 2248.4 2253.8 2266.1 7551.2 7609.4 7619.3 7621.5 7642.2 4455.3 4606.8 4612.3 4618.5 4619.1 2821.6 2879.0 3021.4 3027.8 3029.7 970.1 977.9 978.8 981.0 1014.9 10394.8 10438.4 10460.5 10465.5 10470.2 4316.3 4326.7 4457.7 4516.5 4519.7 8935.6 8952.9 8999.1 9006.7 9016.1 4678.9 4695.5 4697.2 4713.6 4722.3 3702.3 4125.2 4250.3 4282.7 4288.9 3678.6 3737.4 3783.8 3801.0 3902.7 1241.6 1268.9 1273.8 1283.1 1288.3 1172.5 1177.7 1202.7 1203.8 1224.0 7003.4 7126.7 7129.4 7132.5 7345.3 1014.3 1021.6 1037.0 1037.4 1078.8 5388.8 5515.5 5523.4 5555.4 5558.6 9084.8 9394.7 9499.9 9512.0 9518.9 9021.9 9210.4 9302.8 9318.9 9387.6 7047.7 7206.1 7263.5 7295.6 7323.4 7207.1 7266.2 7328.6 7351.2 7404.9 8731.3 8850.3 8903.1 8906.2 9010.7 8849.0 8867.3 9117.2 9205.6 9208.9 5983.2 6151.0 6710.6 6785.1 6926.3 7471.5 7488.9 7550.8 7560.1 7564.8 6583.6 6592.5 6674.8 6681.5 6856.5 6346.1 6399.1 6541.7 6561.8 6679.4 7069.6 7248.7 7273.3 7292.4 7294.3 6477.8 6524.2 6531.2 6544.9 6562.4 6635.4 6654.3 6680.2 6691.1 6695.6 18:03:00 INFO - PROCESS | 29185 | 18:03:00 INFO - PROCESS | 29185 | [#4] prototype.html Cycles:180 Average:4358.46 Median:4972.97 stddev:1285.85 (25.9%) stddev-sans-first:1252.77 18:03:00 INFO - PROCESS | 29185 | Values: 295.3 300.1 304.5 304.9 305.5 4941.7 4975.1 5001.1 5049.2 5068.6 4943.9 4956.8 4965.8 4967.7 4970.8 3703.6 3787.6 3797.0 3897.5 3916.7 3878.0 3901.0 3926.6 3930.5 3936.3 3854.4 3867.9 3886.3 3891.2 3893.7 3702.1 3766.1 3861.9 3894.4 3900.9 3423.7 3437.8 3439.3 3452.6 3454.3 4793.9 4798.4 4819.1 4823.8 4846.3 4154.8 4326.8 4359.1 4487.4 4495.3 5210.0 5241.7 5250.1 5250.2 5259.2 3650.7 3654.4 3654.7 3659.9 3665.9 5187.3 5448.2 5511.2 5523.0 5527.4 3690.6 3698.5 3712.6 3714.2 3730.7 3749.2 3751.3 3754.0 3762.9 3770.6 4318.4 4351.9 4359.3 4373.3 4388.2 5103.4 5189.6 5219.7 5256.5 5270.8 1312.3 1323.9 1331.7 1334.7 1339.1 835.5 873.1 884.6 906.6 907.6 4457.4 4557.0 4565.2 4569.1 4722.4 5453.9 5462.9 5476.1 5489.9 5495.1 4587.8 4641.8 4658.3 4668.2 4691.6 2905.9 2907.4 2927.8 2933.4 2937.0 5181.5 5193.6 5203.7 5222.2 5235.8 5293.2 5589.5 5589.8 5648.3 5669.2 5205.8 5235.3 5241.8 5244.0 5245.4 5495.4 5509.2 5522.4 5528.3 5529.3 5172.5 5358.7 5375.6 5378.9 5397.2 5183.3 5186.9 5190.8 5205.5 5215.9 3767.5 3777.2 3790.7 3790.8 3790.8 5350.1 5364.8 5422.7 5456.9 5495.6 5245.6 5267.4 5269.6 5274.3 5285.6 5085.8 5251.9 5274.6 5288.3 5310.4 5166.3 5178.1 5183.2 5189.0 5191.6 5058.3 5110.7 5273.5 5354.5 5356.0 5171.1 5199.2 5201.9 5202.0 5203.8 18:03:00 INFO - PROCESS | 29185 | 18:03:00 INFO - PROCESS | 29185 | [#5] yui.html Cycles:180 Average:11968.21 Median:41912.08 stddev:13106.16 (31.3%) stddev-sans-first:13114.96 18:03:00 INFO - PROCESS | 29185 | Values: 568.7 589.1 641.5 650.8 651.6 10626.0 11801.6 12128.6 12138.2 12185.9 13573.3 13583.8 13642.9 13648.3 13685.1 650.4 672.9 673.5 673.9 810.3 824.8 827.4 829.8 830.3 831.6 850.3 851.6 852.1 853.6 853.7 847.4 849.9 850.3 850.4 851.2 624.6 624.6 624.6 625.2 625.3 11549.5 11653.0 11667.9 11680.6 11715.6 12922.6 12986.3 12990.5 13027.7 13314.5 9990.9 10035.5 10285.7 10323.8 10722.8 3198.2 3202.7 3208.3 3272.3 3290.3 49260.5 49327.8 49379.0 49429.5 50635.7 9717.7 9815.9 9983.9 10417.6 10587.9 16552.8 16606.0 16627.4 16669.4 16867.0 6411.5 6564.9 6694.2 6712.7 6743.8 3630.8 3688.5 3709.1 3779.6 3850.8 2568.0 2650.7 2671.3 2673.8 2681.1 508.6 527.8 528.1 536.4 564.6 506.7 507.9 553.6 560.9 569.5 7556.0 7583.6 7628.4 8004.8 8015.8 571.6 601.9 605.3 611.7 626.8 3616.9 3712.2 3713.8 3754.7 3826.4 40898.8 41803.2 41861.4 41962.8 53057.0 37200.6 37407.6 38042.8 38546.2 38565.0 36655.3 37826.6 38230.6 38332.0 38939.6 7941.8 8058.9 8572.6 8644.9 8792.6 25756.6 26233.0 26800.0 26803.2 27424.2 34107.0 35430.6 35652.8 35830.6 36157.3 9144.6 9302.3 9389.7 9478.5 9592.2 10892.0 10962.9 11008.6 11335.4 11395.1 10337.4 10622.2 10685.0 10926.6 10927.7 10739.2 10814.2 10875.1 10926.1 11068.0 9065.0 9460.2 9768.4 11120.2 11141.6 8450.3 8924.3 9221.6 9302.3 9473.3 8448.6 8570.0 8573.4 8595.4 9088.4 18:03:00 INFO - PROCESS | 29185 | -------- Summary: end -------- 18:03:00 INFO - PROCESS | 29185 | 18:03:01 INFO - TEST-INFO | 29185: exit 0 18:03:01 INFO - TEST-OK | dromaeo_css | took 1117609ms 18:03:01 INFO - TEST-START | kraken 18:03:01 INFO - operating with platform_type : linux_ 18:03:01 INFO - Initialising browser for kraken test... 18:03:01 INFO - TEST-INFO | started process 29362 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9W3QKT/profile http://localhost:49290/getInfo.html) 18:03:05 INFO - PROCESS | 29362 | __metrics Screen width/height:1600/1200 18:03:05 INFO - PROCESS | 29362 | colorDepth:24 18:03:05 INFO - PROCESS | 29362 | Browser inner width/height: 1024/697 18:03:05 INFO - PROCESS | 29362 | __metrics 18:03:06 ERROR - PROCESS | 29362 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:03:07 INFO - TEST-INFO | 29362: exit 0 18:03:07 INFO - Browser initialized. 18:03:07 INFO - Running cycle 1/1 for kraken test... 18:03:07 INFO - TEST-INFO | started process 29444 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9W3QKT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:03:19 INFO - PROCESS | 29444 | RSS: Main: 154693632 18:03:19 INFO - PROCESS | 29444 | 18:03:21 INFO - PROCESS | 29444 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49290/tests/kraken/driver.html?testName=audio-beat-detection) 18:03:22 INFO - PROCESS | 29444 | RSS: Main: 210079744 18:03:22 INFO - PROCESS | 29444 | 18:03:25 INFO - PROCESS | 29444 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49290/tests/kraken/driver.html?testName=audio-dft) 18:03:26 INFO - PROCESS | 29444 | RSS: Main: 195031040 18:03:26 INFO - PROCESS | 29444 | 18:03:29 INFO - PROCESS | 29444 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49290/tests/kraken/driver.html?testName=audio-fft) 18:03:30 INFO - PROCESS | 29444 | RSS: Main: 265637888 18:03:30 INFO - PROCESS | 29444 | 18:03:32 INFO - PROCESS | 29444 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49290/tests/kraken/driver.html?testName=audio-oscillator) 18:03:32 INFO - PROCESS | 29444 | RSS: Main: 173989888 18:03:32 INFO - PROCESS | 29444 | 18:03:34 INFO - PROCESS | 29444 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49290/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:03:35 INFO - PROCESS | 29444 | RSS: Main: 178941952 18:03:35 INFO - PROCESS | 29444 | 18:03:38 INFO - PROCESS | 29444 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49290/tests/kraken/driver.html?testName=imaging-darkroom) 18:03:39 INFO - PROCESS | 29444 | RSS: Main: 214552576 18:03:39 INFO - PROCESS | 29444 | 18:03:42 INFO - PROCESS | 29444 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49290/tests/kraken/driver.html?testName=imaging-desaturate) 18:03:43 INFO - PROCESS | 29444 | RSS: Main: 212160512 18:03:43 INFO - PROCESS | 29444 | 18:03:46 INFO - PROCESS | 29444 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49290/tests/kraken/driver.html?testName=json-parse-financial) 18:03:46 INFO - PROCESS | 29444 | RSS: Main: 213471232 18:03:46 INFO - PROCESS | 29444 | 18:03:48 INFO - PROCESS | 29444 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49290/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:03:49 INFO - PROCESS | 29444 | RSS: Main: 199864320 18:03:49 INFO - PROCESS | 29444 | 18:03:50 INFO - PROCESS | 29444 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49290/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:03:51 INFO - PROCESS | 29444 | RSS: Main: 202887168 18:03:51 INFO - PROCESS | 29444 | 18:03:53 INFO - PROCESS | 29444 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49290/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:03:54 INFO - PROCESS | 29444 | RSS: Main: 217452544 18:03:54 INFO - PROCESS | 29444 | 18:03:57 INFO - PROCESS | 29444 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49290/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:03:57 INFO - PROCESS | 29444 | RSS: Main: 224129024 18:03:57 INFO - PROCESS | 29444 | 18:04:00 INFO - PROCESS | 29444 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49290/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:04:01 INFO - PROCESS | 29444 | RSS: Main: 219312128 18:04:01 INFO - PROCESS | 29444 | 18:04:03 INFO - PROCESS | 29444 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49290/tests/kraken/driver.html?testName=ai-astar) 18:04:03 INFO - PROCESS | 29444 | RSS: Main: 283176960 18:04:03 INFO - PROCESS | 29444 | 18:04:03 INFO - PROCESS | 29444 | __start_tp_report 18:04:03 INFO - PROCESS | 29444 | _x_x_mozilla_page_load 18:04:03 INFO - PROCESS | 29444 | _x_x_mozilla_page_load_details 18:04:03 INFO - PROCESS | 29444 | |i|pagename|runs| 18:04:03 INFO - PROCESS | 29444 | |0;ai-astar;110;113;107;112;112;114;103;113;112;113 18:04:03 INFO - PROCESS | 29444 | |1;audio-beat-detection;156;132;162;195;134;159;162;133;191;134 18:04:03 INFO - PROCESS | 29444 | |2;audio-dft;162;161;163;160;162;162;161;161;160;162 18:04:03 INFO - PROCESS | 29444 | |3;audio-fft;74;76;97;112;75;73;74;117;101;73 18:04:03 INFO - PROCESS | 29444 | |4;audio-oscillator;94;96;147;94;94;94;149;94;94;148 18:04:03 INFO - PROCESS | 29444 | |5;imaging-gaussian-blur;117;116;117;118;117;117;116;117;117;117 18:04:03 INFO - PROCESS | 29444 | |6;imaging-darkroom;147;147;146;146;145;146;147;145;146;145 18:04:03 INFO - PROCESS | 29444 | |7;imaging-desaturate;95;95;95;96;95;95;96;95;95;95 18:04:03 INFO - PROCESS | 29444 | |8;json-parse-financial;65;66;67;68;65;67;67;90;65;63 18:04:03 INFO - PROCESS | 29444 | |9;json-stringify-tinderbox;64;65;64;64;65;65;65;64;64;64 18:04:03 INFO - PROCESS | 29444 | |10;stanford-crypto-aes;85;83;83;84;84;85;84;85;85;85 18:04:03 INFO - PROCESS | 29444 | |11;stanford-crypto-ccm;136;138;148;138;145;139;136;134;182;137 18:04:03 INFO - PROCESS | 29444 | |12;stanford-crypto-pbkdf2;170;170;170;170;169;170;168;168;169;169 18:04:03 INFO - PROCESS | 29444 | |13;stanford-crypto-sha256-iterative;86;71;71;71;77;71;69;79;71;73 18:04:03 INFO - PROCESS | 29444 | __end_tp_report 18:04:03 INFO - PROCESS | 29444 | __start_cc_report 18:04:03 INFO - PROCESS | 29444 | _x_x_mozilla_cycle_collect,1898 18:04:03 INFO - PROCESS | 29444 | __end_cc_report 18:04:03 INFO - PROCESS | 29444 | __startTimestamp1460423043369__endTimestamp 18:04:03 INFO - PROCESS | 29444 | 18:04:03 INFO - PROCESS | 29444 | ------- Summary: start ------- 18:04:03 INFO - PROCESS | 29444 | Number of tests: 14 18:04:03 INFO - PROCESS | 29444 | 18:04:03 INFO - PROCESS | 29444 | [#0] ai-astar Cycles:10 Average:110.90 Median:112.50 stddev:3.41 (3.0%) stddev-sans-first:3.61 18:04:03 INFO - PROCESS | 29444 | Values: 110.0 113.0 107.0 112.0 112.0 114.0 103.0 113.0 112.0 113.0 18:04:03 INFO - PROCESS | 29444 | 18:04:03 INFO - PROCESS | 29444 | [#1] audio-beat-detection Cycles:10 Average:155.80 Median:160.50 stddev:23.33 (14.5%) stddev-sans-first:24.75 18:04:03 INFO - PROCESS | 29444 | Values: 156.0 132.0 162.0 195.0 134.0 159.0 162.0 133.0 191.0 134.0 18:04:03 INFO - PROCESS | 29444 | 18:04:03 INFO - PROCESS | 29444 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 18:04:03 INFO - PROCESS | 29444 | Values: 162.0 161.0 163.0 160.0 162.0 162.0 161.0 161.0 160.0 162.0 18:04:03 INFO - PROCESS | 29444 | 18:04:03 INFO - PROCESS | 29444 | [#3] audio-fft Cycles:10 Average:87.20 Median:74.00 stddev:17.69 (23.9%) stddev-sans-first:18.10 18:04:03 INFO - PROCESS | 29444 | Values: 74.0 76.0 97.0 112.0 75.0 73.0 74.0 117.0 101.0 73.0 18:04:03 INFO - PROCESS | 29444 | 18:04:03 INFO - PROCESS | 29444 | [#4] audio-oscillator Cycles:10 Average:110.40 Median:94.00 stddev:25.96 (27.6%) stddev-sans-first:26.85 18:04:03 INFO - PROCESS | 29444 | Values: 94.0 96.0 147.0 94.0 94.0 94.0 149.0 94.0 94.0 148.0 18:04:03 INFO - PROCESS | 29444 | 18:04:03 INFO - PROCESS | 29444 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 18:04:03 INFO - PROCESS | 29444 | Values: 117.0 116.0 117.0 118.0 117.0 117.0 116.0 117.0 117.0 117.0 18:04:03 INFO - PROCESS | 29444 | 18:04:03 INFO - PROCESS | 29444 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 18:04:03 INFO - PROCESS | 29444 | Values: 147.0 147.0 146.0 146.0 145.0 146.0 147.0 145.0 146.0 145.0 18:04:03 INFO - PROCESS | 29444 | 18:04:03 INFO - PROCESS | 29444 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 18:04:03 INFO - PROCESS | 29444 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 18:04:03 INFO - PROCESS | 29444 | 18:04:03 INFO - PROCESS | 29444 | [#8] json-parse-financial Cycles:10 Average:68.30 Median:67.00 stddev:7.76 (11.6%) stddev-sans-first:8.14 18:04:03 INFO - PROCESS | 29444 | Values: 65.0 66.0 67.0 68.0 65.0 67.0 67.0 90.0 65.0 63.0 18:04:03 INFO - PROCESS | 29444 | 18:04:03 INFO - PROCESS | 29444 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 18:04:03 INFO - PROCESS | 29444 | Values: 64.0 65.0 64.0 64.0 65.0 65.0 65.0 64.0 64.0 64.0 18:04:03 INFO - PROCESS | 29444 | 18:04:03 INFO - PROCESS | 29444 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:85.00 stddev:0.82 (1.0%) stddev-sans-first:0.83 18:04:03 INFO - PROCESS | 29444 | Values: 85.0 83.0 83.0 84.0 84.0 85.0 84.0 85.0 85.0 85.0 18:04:03 INFO - PROCESS | 29444 | 18:04:03 INFO - PROCESS | 29444 | [#11] stanford-crypto-ccm Cycles:10 Average:143.30 Median:138.50 stddev:14.26 (10.3%) stddev-sans-first:14.88 18:04:03 INFO - PROCESS | 29444 | Values: 136.0 138.0 148.0 138.0 145.0 139.0 136.0 134.0 182.0 137.0 18:04:03 INFO - PROCESS | 29444 | 18:04:03 INFO - PROCESS | 29444 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.30 Median:170.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 18:04:03 INFO - PROCESS | 29444 | Values: 170.0 170.0 170.0 170.0 169.0 170.0 168.0 168.0 169.0 169.0 18:04:03 INFO - PROCESS | 29444 | 18:04:03 INFO - PROCESS | 29444 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.90 Median:72.00 stddev:5.26 (7.3%) stddev-sans-first:3.28 18:04:03 INFO - PROCESS | 29444 | Values: 86.0 71.0 71.0 71.0 77.0 71.0 69.0 79.0 71.0 73.0 18:04:03 INFO - PROCESS | 29444 | -------- Summary: end -------- 18:04:03 INFO - PROCESS | 29444 | 18:04:04 INFO - TEST-INFO | 29444: exit 0 18:04:04 INFO - TEST-OK | kraken | took 63125ms 18:04:04 INFO - SUITE-END | took 1180s 18:04:04 INFO - Completed test suite (00:19:40) 18:04:04 INFO - javascript benchmark 18:04:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2587.93530161746, 2639.986800065998, 2648.854313012786, 2655.083996021373, 2678.558037923742, 4494.528074552174, 4552.567506086921, 4555.658325625574, 4560.429946256714, 4581.839635612754, 4614.607758340537, 4620.399348084753, 4674.415698037746, 4691.179043667362, 4707.05858828234, 4210.894727631819, 4251.4048033275285, 4260.339647354665, 4311.482622085354, 4384.97807510962, 4334.60988511034, 4366.345048242757, 4380.97809510952, 4406.735595864258, 4411.0, 4172.666186705056, 4252.149570085964, 4260.1479704059, 4311.1808756336195, 4321.135772845443, 4263.317869140923, 4290.828366865321, 4339.457567804025, 4343.717658352197, 4387.100644367929, 4197.4753155855515, 4240.067185219247, 4247.320428731388, 4249.596288352602, 4290.635295999844, 4438.42300500936, 4506.932396014063, 4533.5013148553635, 4600.815967361302, 4627.8611641650805, 4963.875903102451, 4983.152864013126, 4985.0, 4985.252212168168, 5019.673721208146, 4961.0, 4994.750262486898, 5000.649954503187, 5005.074061298671, 5045.974770126162, 4540.046590216026, 4623.283391074388, 4683.437987441494, 4711.717296962193, 4720.834770783006, 5007.073691367109, 5019.949800502021, 5020.874478138076, 5022.045811295842, 5070.6957582545165, 4818.036392721469, 4819.132556139858, 4824.204006338985, 4836.806527738851, 4869.001854619794, 4892.3884514435695, 4950.25746138075, 4982.978489409662, 5007.524285192901, 5029.119904016782, 4877.414710234794, 4879.0, 4891.070696567641, 4893.192623217201, 4940.2342636891335, 4717.834875779331, 4862.708237505761, 4864.537868902448, 4865.221564549655, 4916.508349165055, 4230.8519201827785, 4256.893577660583, 4262.808173632194, 4296.205202037633, 4303.354496825501, 3700.4634328022285, 3706.5181526401393, 3713.405855063177, 3714.23858109087, 3737.663610275034, 4190.622843944059, 4258.723182993095, 4272.359146128106, 4274.316109422478, 4312.05134870328, 4917.065757506062, 4949.826756063592, 4958.082754690394, 5002.474740152305, 5004.9499505005215, 4269.935950960738, 4280.036991676848, 4283.87148385549, 4309.030468144642, 4329.9134017319475, 4419.46966364032, 4451.866444006685, 4530.456345238593, 4533.977330113395, 4542.931856022163, 4720.693154944917, 4736.100140973204, 4742.596879265301, 4765.070811191854, 4784.210605250164, 4948.331975183448, 4991.3511243538105, 4994.875128121681, 4996.450390456974, 5045.949540504548, 4629.4676112247525, 4677.766111694334, 4706.505816889177, 4740.360051393156, 4787.808487660454, 4874.2444921037295, 4887.169181239126, 4898.485659005753, 4929.285253638274, 4943.975280123576, 4927.408710954708, 4951.10880041596, 4954.515596074652, 4962.478939711423, 5007.048660754591, 4739.099571081483, 4830.1305764961235, 4862.513748625109, 4874.610031197425, 4943.184374578154, 4689.718616882998, 4719.032598317405, 4722.693024953367, 4762.238041913277, 4767.022760334054, 4633.096546173464, 4638.0, 4639.32729754177, 4650.558196971282, 4677.508861569622, 4749.548792864673, 4788.090262850047, 4871.123197824426, 4934.259861020732, 4956.430010548833, 4771.427428708438, 4776.307435421914, 4794.664373493962, 4798.0, 4853.0], "value": 4557.120587213046, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.6109906362736, 589.254592939931, 602.4006113916654, 611.9443959170432, 624.640831521875, 32487.67512324876, 33136.17159571009, 33171.83414082926, 33210.833945830236, 33217.501737473955, 31807.36385272293, 32518.67481325186, 32542.67457325426, 32684.67315326846, 32753.0, 7536.96231518843, 7708.57602831844, 7720.536767793922, 7722.61386930654, 7731.884021739678, 7542.472026958115, 7650.502717323357, 7656.157822639505, 7669.386449084088, 7698.653560589787, 7788.805279867992, 7858.371330293563, 7865.331446827026, 7866.881996770053, 7867.134615192324, 7775.30022297993, 7821.217878212134, 7837.843243135162, 7842.764717058498, 7852.960735196345, 7756.0, 7867.6852925882895, 7874.370050395954, 7874.842503149905, 7882.684692612289, 32772.180695482806, 33054.834725826215, 33074.17314567131, 33083.6691633083, 33113.834430827694, 2945.7348838604416, 3067.097101528559, 3071.9466576704353, 3078.291992841659, 3086.3981523602906, 27978.89812372484, 28068.0, 28085.438291234062, 28986.565201521993, 29062.564061539095, 3093.180307218589, 3102.332998405331, 3175.364927014606, 3180.9661859895396, 3219.5170724391296, 176737.0, 177059.0, 177800.0, 177986.0, 178065.0, 49642.255366169535, 49727.50272497301, 49927.0, 49938.0, 50066.24900626494, 41139.0, 43499.130017399475, 54251.18623220655, 55937.16094258589, 56003.719981400645, 12574.559890403792, 12695.36523173856, 12697.809532857014, 12712.364381780873, 12715.872841271654, 9040.683576074805, 10243.84634230487, 10317.27779055474, 10318.690439286833, 10323.070923616911, 14639.414423422944, 15026.549203523911, 15103.093814371174, 15120.54638360851, 15121.924390377977, 5856.770078283608, 6050.667213303311, 6129.325774164839, 6133.417325354084, 6197.597156184834, 880.4805164952709, 957.4351132831663, 963.2871674960619, 983.7835676151235, 1010.5351538292321, 24035.639465408032, 25174.0, 25394.0, 25441.872790635927, 25604.0, 998.6354980432089, 999.01097913067, 1065.6643157405392, 1081.5025088459397, 1114.5820317380983, 13534.458621655023, 13972.650683732989, 13979.79030314546, 14012.64989325399, 14161.645958851112, 319244.0, 324769.0, 325042.0, 325556.0, 325774.0, 45059.0, 46373.536264637594, 46427.535724643, 46498.5350146501, 46597.0, 1166.6966588686832, 1170.3446070200544, 1204.1992075270023, 1239.1016513027982, 1273.535159666715, 18542.814571854648, 27947.301317467227, 28648.907321742503, 29183.416331672823, 31526.842365788023, 41995.37006944959, 42649.78675106604, 42819.14361712811, 42838.57161428346, 42912.57087429086, 250772.0, 253135.0, 253952.0, 254022.0, 254065.0, 30299.545506816976, 32767.34465310728, 33046.50430243596, 36390.27219455543, 36527.817360913024, 33293.16767080843, 37702.811485942395, 37945.43081853719, 38287.42568861414, 38923.416148758355, 32659.510107348884, 32852.0, 32861.67138328586, 33317.33365332728, 33728.15679608029, 29410.264743381587, 29505.852470737507, 29722.40555188841, 29797.553036704034, 29855.552166717953, 32041.35917281688, 32779.18052048718, 33155.668443315255, 33184.834075829465, 33253.50119748157, 29395.85302073476, 29691.703082968892, 30118.548221777128, 30118.84940575283, 30188.396232075676, 23960.64059039081, 23977.880110600032, 24047.27858164258, 24256.51486970286, 24377.756222438256], "value": 16335.34570493737, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.75972958523414, 353.56688057130003, 362.4147002590816, 371.1908040471772, 378.490929699554, 15926.601834954117, 16349.918250408746, 16923.915380423095, 17053.57366065849, 17063.0, 15568.610784730387, 16355.83644163558, 17186.57033574158, 17212.0, 17215.82784172158, 5082.822101226467, 5206.713630750326, 5268.92096618551, 5276.947230527703, 5279.736013199344, 3680.926381472369, 3843.6592594070935, 3877.9030524236837, 3887.105965627907, 5187.766550505236, 3933.4886464759543, 5861.648301101926, 5874.794382196624, 5875.676837773921, 5880.7059647017695, 5063.316452278968, 5770.307563092435, 5884.117382392676, 5900.586958912856, 5908.1433192187105, 3328.7170590499595, 5265.526102650741, 5265.6840589564745, 5270.314859068335, 5272.683638981635, 10563.313384629975, 10632.62785802501, 10741.570337186504, 11688.883111168865, 12265.018798496189, 1864.2263460663808, 1922.865399422041, 2002.3792624286518, 2048.944793431384, 2123.235635171337, 9121.179093881516, 9227.400218985811, 9334.766630834216, 9641.228701703916, 9659.46872921989, 1754.1580041579984, 1808.2495764257817, 1849.9722504162448, 1878.2393130782054, 1889.527618095476, 66271.66864165648, 68953.0, 69031.30968690349, 69514.0, 69575.30424695738, 9737.318387712934, 9741.366811157393, 9750.219982401391, 9897.754190279164, 10049.934769895252, 13493.797593036112, 13536.458541658223, 13539.39072741729, 13600.591982240549, 13616.046876718534, 6769.627670478171, 6799.898001529981, 6836.658167091626, 6860.965695171592, 7076.938459231156, 6272.749090036347, 6527.477801775846, 6601.108850305243, 6629.734810607618, 6638.0, 4104.404861295156, 4236.788160591958, 4262.46719160105, 4266.914661706748, 4408.735475871458, 1797.4158398520271, 1824.2885274742862, 1872.5880306332585, 1879.0886420086247, 1897.297999740105, 774.6630215856121, 883.4213590098495, 889.9822003559892, 936.1200471556715, 940.9435433873989, 15879.047257164377, 16090.275937582837, 16386.788145854396, 16464.83535164657, 16995.23521441538, 850.1371108325055, 853.4623187391903, 895.8611415230649, 928.3919033033374, 958.5925981457852, 8931.866022009675, 8958.238549723215, 9207.309451791143, 9248.445093294424, 9655.565499552536, 387294.0, 389786.0, 395228.0, 397162.0, 403242.0, 75836.62081689556, 77848.61075694585, 78295.60852195702, 78750.6062469684, 78819.0, 918.7519369770258, 937.6436953957316, 942.1097063275276, 953.580424613168, 963.9132478077007, 13987.0, 14366.928165359106, 14471.0, 14783.926080369529, 14799.0, 22614.660780087983, 24981.375465613506, 25482.872585636953, 33569.0, 33619.663803361655, 46859.29711054405, 47387.052258955315, 47694.761526192146, 47883.5211647893, 47970.76014619905, 7747.84327910751, 7853.725119620786, 7898.5260884344825, 8013.919860801318, 8017.278444939983, 11488.770224595628, 11789.764204715686, 11868.465919033491, 11895.702607434883, 11948.0, 10155.136813370946, 10425.895741042492, 10433.791324173322, 10612.56730341394, 10784.191185661264, 10305.330153539995, 10348.689539313833, 10445.68662940113, 10590.41752703578, 10825.188110891871, 10189.0, 10471.528781205016, 10493.895061049598, 10533.9473302633, 10839.295445796313, 7720.575368354795, 7802.843943120993, 7832.804179895548, 7940.404469664682, 7956.721514746956, 8695.347848911231, 10070.748231293983, 10143.695689129338, 10232.48837558134, 10489.160867130458], "value": 7926.956758133817, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1162.273579013117, 1230.1020255213691, 1295.6436979830546, 1333.0735139078342, 1743.4159556548555, 6435.903461448076, 7467.589282589455, 7682.0, 7694.7306844260465, 7704.383649308056, 7545.584992825392, 7545.622718864049, 7603.619819009041, 7604.885926711104, 7619.695212191506, 1922.1830721943188, 2192.3642143778284, 2278.8860556972168, 2315.3632750993443, 2317.73346065203, 2292.5300313435705, 2325.8604483730946, 2328.9767102329015, 2330.149495434171, 2331.2423462374713, 2257.3115199864037, 2261.6155253606926, 2296.517731276434, 2296.7358753743365, 2296.81625469962, 1820.1900154431282, 1885.7831349394721, 1886.141805478504, 2123.0870725587993, 2159.8164156046755, 2220.0897631970975, 2248.415411992877, 2248.449129963153, 2253.7971582557648, 2266.1162146762613, 7551.207123252035, 7609.429292803062, 7619.276168763959, 7621.466497345188, 7642.235776422369, 4455.309427038814, 4606.815727370901, 4612.262038073892, 4618.49196588375, 4619.122366750306, 2821.633187685588, 2878.956815647767, 3021.350409661933, 3027.7729170312095, 3029.727324540802, 970.0832713086137, 977.8510250455757, 978.8335982882855, 980.9607615695363, 1014.9035841595037, 10394.792104157874, 10438.37369757817, 10460.52927618259, 10465.529051192714, 10470.16238700902, 4316.287812510964, 4326.740395576276, 4457.710248833815, 4516.480604730433, 4519.706219095749, 8935.642574296955, 8952.910470895338, 8999.055099214489, 9006.684766033157, 9016.098390161063, 4678.906421871544, 4695.5069717679835, 4697.177993851063, 4713.57577817998, 4722.268048452495, 3702.315071711742, 4125.216208920296, 4250.298700714409, 4282.743035417885, 4288.914221715549, 3678.5953545110015, 3737.383331750285, 3783.829727662262, 3800.9619903801163, 3902.726809123334, 1241.6213055018306, 1268.898488120948, 1273.8216649669055, 1283.0569531394417, 1288.323630094208, 1172.5309876049648, 1177.7467844413493, 1202.6933132051445, 1203.7532305877448, 1223.9816402753966, 7003.404710599554, 7126.679299431435, 7129.3583577478275, 7132.536385134949, 7345.302196291451, 1014.3010457483832, 1021.5556233038652, 1036.9792604147874, 1037.444966942682, 1078.800421921947, 5388.838334849961, 5515.503604675599, 5523.364813046471, 5555.3611334697025, 5558.610897237155, 9084.81830363389, 9394.67118650844, 9499.857502137334, 9512.0, 9518.857217141749, 9021.864672029924, 9210.355275130676, 9302.767430814283, 9318.90681093194, 9387.57755900986, 7047.718091276394, 7206.099237595301, 7263.4915555910575, 7295.562266263935, 7323.414126869944, 7207.063081799332, 7266.237045110187, 7328.5969271690565, 7351.154617218875, 7404.888926665996, 8731.345149113715, 8850.291976641982, 8903.065178156201, 8906.198442140238, 9010.729678109667, 8848.955755221183, 8867.290616750774, 9117.17945384892, 9205.631774728936, 9208.907910920805, 5983.222181116601, 6151.0, 6710.63091529951, 6785.117934668461, 6926.272741362084, 7471.514351567131, 7488.8876666848955, 7550.7734767957045, 7560.130584982578, 7564.810879727831, 6583.604983700993, 6592.538522303585, 6674.7997560071335, 6681.498887583353, 6856.485763567653, 6346.1432706585865, 6399.072134540559, 6541.738330466918, 6561.770338038145, 6679.398854103154, 7069.6111713856235, 7248.710051598088, 7273.309035641606, 7292.380147687506, 7294.307040831112, 6477.805665830033, 6524.249711283263, 6531.216254049545, 6544.869102618016, 6562.376574225441, 6635.369639884203, 6654.301298363602, 6680.164979377578, 6691.130153080068, 6695.564788288746], "value": 4430.98190480766, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.2662633356111, 300.05333173836544, 304.4671824307461, 304.87500124948775, 305.4761084739671, 4941.728204948727, 4975.129352363336, 5001.099802035632, 5049.166887463573, 5068.5945124390055, 4943.876403089925, 4956.776945037473, 4965.751712414383, 4967.652264341497, 4970.8011679532865, 3703.555573331204, 3787.6212378762043, 3796.9620303797024, 3897.4543563901075, 3916.686665066802, 3877.9806100969454, 3900.960990390088, 3926.5680775114715, 3930.528336599598, 3936.252112098706, 3854.402567602026, 3867.8839634811, 3886.300465916148, 3891.182851601167, 3893.7079719021185, 3702.1114932416294, 3766.133789228493, 3861.8841434757, 3894.3768996960634, 3900.941485877714, 3423.691867731916, 3437.845296961618, 3439.329330780499, 3452.602950660656, 3454.3436747017986, 4793.904121917577, 4798.376211092571, 4819.108464933998, 4823.782929768169, 4846.321514987904, 4154.792260386998, 4326.762028088454, 4359.062801497693, 4487.371767952489, 4495.280755079204, 5209.984053109645, 5241.73791310433, 5250.133727934886, 5250.238715386286, 5259.211118332242, 3650.671439570425, 3654.4152935530456, 3654.7258955578436, 3659.8536058557625, 3665.9450108248398, 5187.250757098744, 5448.210009548633, 5511.173324001392, 5523.0, 5527.39198688144, 3690.5755838078426, 3698.500702405141, 3712.6472985066375, 3714.2200137971327, 3730.7015438764834, 3749.175181460129, 3751.2872554214614, 3753.962460375416, 3762.8682996095004, 3770.6417890300377, 4318.395424640553, 4351.912961740747, 4359.324304732771, 4373.322135069069, 4388.232059389594, 5103.413107492612, 5189.610779191576, 5219.712915789592, 5256.526912577886, 5270.841874743764, 1312.3307113372248, 1323.9474617678968, 1331.6803967047838, 1334.6930206052468, 1339.1496399786206, 835.4861760017667, 873.0963452826294, 884.5798245833178, 906.6464079009191, 907.6278725722422, 4457.353683715843, 4557.0, 4565.246734288805, 4569.086182763461, 4722.433308003062, 5453.890922181534, 5462.890742185134, 5476.083370820261, 5489.890202196014, 5495.076723146946, 4587.816487340469, 4641.767911604406, 4658.301254811805, 4668.183067963161, 4691.554302341272, 2905.8837646494326, 2907.447584958851, 2927.838968856733, 2933.4133173365412, 2937.0454602254354, 5181.533661970366, 5193.649651090744, 5203.713795741271, 5222.242774797709, 5235.842924712265, 5293.153095504701, 5589.524890384363, 5589.847908555235, 5648.293963254593, 5669.206311116447, 5205.791768329224, 5235.293235413246, 5241.816536421284, 5244.0, 5245.423003469616, 5495.422980587141, 5509.173623956439, 5522.392536820867, 5528.281323428089, 5529.341197640772, 5172.508611681884, 5358.732063396893, 5375.569954403716, 5378.865528361665, 5397.190421436816, 5183.300254465599, 5186.8962620748125, 5190.8183213587345, 5205.505476979681, 5215.947840521546, 3767.547894252707, 3777.1690228149764, 3790.65884070435, 3790.7915064671706, 3790.8104594769597, 5350.090484617546, 5364.839054828361, 5422.728863556886, 5456.945430545644, 5495.6153069284765, 5245.554127899019, 5267.420583735862, 5269.631125821155, 5274.261603375608, 5285.603579731459, 5085.796568137381, 5251.868703282448, 5274.578033757367, 5288.312519372457, 5310.3893052297935, 5166.328377311076, 5178.093833579033, 5183.170692689152, 5188.9740551297, 5191.558717508903, 5058.266551350107, 5110.71891045996, 5273.525382715574, 5354.518093371616, 5356.035913535445, 5171.146760784429, 5199.194124910645, 5201.895962080813, 5202.0, 5203.843884683465], "value": 3947.515193519363, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.6929058308514, 589.1310317282008, 641.4739913271117, 650.7624716978298, 651.6155468273718, 10626.0, 11801.586944456934, 12128.575499857507, 12138.211016283936, 12185.939070304636, 13573.321333933312, 13583.84537314327, 13642.93178534106, 13648.317584120803, 13685.110467819584, 650.362644608283, 672.8822456070193, 673.5285300289793, 673.8719643267764, 810.3274282345668, 824.8102936324649, 827.3587969323762, 829.8381815545971, 830.3398797955609, 831.5925196653657, 850.268768858781, 851.5912362066211, 852.0882655558555, 853.5561508015828, 853.6500034985658, 847.4279861093737, 849.9447535910147, 850.2602735620019, 850.4344610833788, 851.2466467176594, 624.5565648389648, 624.5815303746456, 624.6064979063207, 625.1747693045182, 625.3059104394118, 11549.480273387633, 11653.0, 11667.883321166764, 11680.591179308683, 11715.589954351643, 12922.612321630366, 12986.28575428351, 12990.480380784757, 13027.674308142277, 13314.533991310258, 9990.850137247948, 10035.498225088717, 10285.691429257135, 10323.84514232287, 10722.839157412567, 3198.2484116232667, 3202.6797320267788, 3208.342289830579, 3272.345530893831, 3290.2925870937624, 49260.50739492595, 49327.753361232964, 49379.0, 49429.50570494321, 50635.746821266024, 9717.659881904241, 9815.901840981498, 9983.850242246372, 10417.583296668048, 10587.947060264649, 16552.83447165513, 16606.0, 16627.418040368528, 16669.41657042022, 16867.0, 6411.487081033506, 6564.934350656527, 6694.163229596301, 6712.731490740413, 6743.831404214934, 3630.8184590770884, 3688.483612294281, 3709.0592161950613, 3779.6220377961986, 3850.7882066486054, 2567.987160064225, 2650.748178922999, 2671.345520347488, 2673.8262012969485, 2681.1286331942197, 508.63378367575285, 527.8073503171315, 528.1444060621741, 536.3965538768884, 564.6442741073098, 506.74915916621507, 507.8730317420645, 553.5737482138811, 560.8569814697227, 569.473237255537, 7556.0, 7583.568103258727, 7628.398036412415, 8004.759857204293, 8015.799605009922, 571.5684658083204, 601.9189892528663, 605.2736715940889, 611.7124951272895, 626.79629120536, 3616.9095772605897, 3712.1647629283734, 3713.7586056906216, 3754.737168398186, 3826.426036094608, 40898.79550602228, 41803.163936721096, 41861.372079418834, 41962.79018604887, 53057.0, 37200.627993720256, 37407.62592374096, 38042.809785951446, 38546.229075418334, 38565.0, 36655.26689466196, 37826.621733782864, 38230.61769382326, 38332.0, 38939.610603894165, 7941.801454963441, 8058.919410806051, 8572.614232359683, 8644.870326945227, 8792.648294068165, 25756.61365079488, 26233.0, 26800.0, 26803.19590412291, 27424.17727468179, 34107.0, 35430.64569354377, 35652.82173589116, 35830.64169358273, 36157.27685446224, 9144.63421463134, 9302.302327325342, 9389.671361502587, 9478.526073696425, 9592.23262139041, 10892.019718225081, 10962.890371096506, 11008.614698485515, 11335.433228338716, 11395.14536409756, 10337.431441270803, 10622.150227981589, 10684.99445571063, 10926.562937482411, 10927.672169834917, 10739.194560407845, 10814.188935829687, 10875.129989600655, 10926.071283940637, 11068.0, 9065.0, 9460.243180545678, 9768.413895166314, 11120.165987550805, 11141.554337826396, 8450.281726053108, 8924.330675199515, 9221.631134754803, 9302.348835581444, 9473.289503287418, 8448.577571121543, 8570.0, 8573.399862009599, 8595.398322117391, 9088.363814532919], "value": 5712.636172945335, "unit": "score"}], "name": "dromaeo_css", "value": 6238.853529902912, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 107.0, 112.0, 112.0, 114.0, 103.0, 113.0, 112.0, 113.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 132.0, 162.0, 195.0, 134.0, 159.0, 162.0, 133.0, 191.0, 134.0], "value": 155.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 160.0, 162.0, 162.0, 161.0, 161.0, 160.0, 162.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 97.0, 112.0, 75.0, 73.0, 74.0, 117.0, 101.0, 73.0], "value": 87.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 147.0, 94.0, 94.0, 94.0, 149.0, 94.0, 94.0, 148.0], "value": 110.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 118.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 145.0, 146.0, 147.0, 145.0, 146.0, 145.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 67.0, 68.0, 65.0, 67.0, 67.0, 90.0, 65.0, 63.0], "value": 68.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 65.0, 65.0, 65.0, 64.0, 64.0, 64.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 83.0, 84.0, 84.0, 85.0, 84.0, 85.0, 85.0, 85.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 138.0, 148.0, 138.0, 145.0, 139.0, 136.0, 134.0, 182.0, 137.0], "value": 143.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 170.0, 170.0, 170.0, 169.0, 170.0, 168.0, 168.0, 169.0, 169.0], "value": 169.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 71.0, 71.0, 71.0, 77.0, 71.0, 69.0, 79.0, 71.0, 73.0], "value": 73.9, "unit": "score"}], "name": "kraken", "value": 1587.3000000000002, "alertThreshold": 2.0}]} 18:04:04 INFO - Return code: 0 18:04:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:04:04 ERROR - # TBPL SUCCESS # 18:04:04 INFO - Running post-action listener: _resource_record_post_action 18:04:04 INFO - Running post-run listener: _resource_record_post_run 18:04:05 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 12288; Write bytes: 518946816; Read time: 312; Write time: 403736 18:04:05 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 233566208; Read time: 156; Write time: 229428 18:04:05 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 8192; Write bytes: 285380608; Read time: 156; Write time: 174308 18:04:05 INFO - Running post-run listener: _upload_blobber_files 18:04:05 INFO - Blob upload gear active. 18:04:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:04:05 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 18:04:05 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'] 18:04:05 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 18:04:06 INFO - (blobuploader) - INFO - Open directory for files ... 18:04:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:04:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:04:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:04:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:04:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:04:07 INFO - (blobuploader) - INFO - Done attempting. 18:04:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:04:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:04:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:04:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:04:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:04:08 INFO - (blobuploader) - INFO - Done attempting. 18:04:08 INFO - (blobuploader) - INFO - Iteration through files over. 18:04:08 INFO - Return code: 0 18:04:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:04:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:04:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e0b6e9f0ba62de09f95925c08df494bdc8d8138efd0062919b6eff20051e79d228e0b3fa5a85008c04c91b27082465b086c4023a17759a89055c2019d9064114", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aff66bdefcddde066b53bd01d18c087a5a09a6d49e8c736b258d7c2e39a185b8fa9b8e603cd193bf3d0296da8dfa09c673a5321ebce06eab6f70d0e6e34f8722"} 18:04:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:04:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:04:08 INFO - Contents: 18:04:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e0b6e9f0ba62de09f95925c08df494bdc8d8138efd0062919b6eff20051e79d228e0b3fa5a85008c04c91b27082465b086c4023a17759a89055c2019d9064114", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aff66bdefcddde066b53bd01d18c087a5a09a6d49e8c736b258d7c2e39a185b8fa9b8e603cd193bf3d0296da8dfa09c673a5321ebce06eab6f70d0e6e34f8722"} 18:04:08 INFO - Running post-run listener: copy_logs_to_upload_dir 18:04:08 INFO - Copying logs to upload dir... 18:04:08 INFO - mkdir: /builds/slave/test/build/upload/logs 18:04:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.547106 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-04-11 18:04:08.473346) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-11 18:04:08.476401) ========= 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=82e07478c745e68b1fe4678a000001bc-1460421554.469346-590543354 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/e0b6e9f0ba62de09f95925c08df494bdc8d8138efd0062919b6eff20051e79d228e0b3fa5a85008c04c91b27082465b086c4023a17759a89055c2019d9064114", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aff66bdefcddde066b53bd01d18c087a5a09a6d49e8c736b258d7c2e39a185b8fa9b8e603cd193bf3d0296da8dfa09c673a5321ebce06eab6f70d0e6e34f8722"} build_url:https://queue.taskcluster.net/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011361 build_url: 'https://queue.taskcluster.net/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.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/e0b6e9f0ba62de09f95925c08df494bdc8d8138efd0062919b6eff20051e79d228e0b3fa5a85008c04c91b27082465b086c4023a17759a89055c2019d9064114", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aff66bdefcddde066b53bd01d18c087a5a09a6d49e8c736b258d7c2e39a185b8fa9b8e603cd193bf3d0296da8dfa09c673a5321ebce06eab6f70d0e6e34f8722"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-11 18:04:08.500970) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 18:04:08.501287) ========= 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=82e07478c745e68b1fe4678a000001bc-1460421554.469346-590543354 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004491 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 18:04:08.583615) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-11 18:04:08.583916) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-11 18:04:08.584200) ========= ========= Total master_lag: 0.27 =========