builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-035 starttime: 1463615177.97 results: success (0) buildid: 20160518160449 builduid: 0670e805ec7941a98bbf81331539c06d revision: 55016b253dde7da0b07348bd66ee313c748c0a0c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-18 16:46:17.972089) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-18 16:46:17.972549) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-18 16:46:17.972838) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-18 16:46:18.048590) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 16:46:18.048890) ========= 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=ed14279e38b05397cf4aa391000001a4-1463613528.955999-580362476 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-18 16:46:18-- 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% 228M=0s 2016-05-18 16:46:18 (228 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.172330 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 16:46:18.262429) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 16:46:18.262806) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ed14279e38b05397cf4aa391000001a4-1463613528.955999-580362476 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.127993 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 16:46:18.403114) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-18 16:46:18.403617) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 55016b253dde7da0b07348bd66ee313c748c0a0c --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 55016b253dde7da0b07348bd66ee313c748c0a0c --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=ed14279e38b05397cf4aa391000001a4-1463613528.955999-580362476 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-18 16:46:18,416 truncating revision to first 12 chars 2016-05-18 16:46:18,416 Setting DEBUG logging. 2016-05-18 16:46:18,416 attempt 1/10 2016-05-18 16:46:18,416 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/55016b253dde?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-18 16:46:19,444 unpacking tar archive at: fx-team-55016b253dde/testing/mozharness/ program finished with exit code 0 elapsedTime=1.315722 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-18 16:46:19.731894) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-18 16:46:19.732234) ========= script_repo_revision: 55016b253dde7da0b07348bd66ee313c748c0a0c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-18 16:46:19.732717) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-18 16:46:19.733011) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-18 16:46:19.746622) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-05-18 16:46:19.747018) ========= /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=ed14279e38b05397cf4aa391000001a4-1463613528.955999-580362476 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:46:19 INFO - MultiFileLogger online at 20160518 16:46:19 in /builds/slave/test 16:46:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 16:46:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:46:19 INFO - {'append_to_log': False, 16:46:19 INFO - 'base_work_dir': '/builds/slave/test', 16:46:19 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 16:46:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:46:19 INFO - 'branch': 'Fx-Team-Non-PGO', 16:46:19 INFO - 'buildbot_json_path': 'buildprops.json', 16:46:19 INFO - 'config_files': ('talos/linux_config.py',), 16:46:19 INFO - 'default_actions': ('clobber', 16:46:19 INFO - 'read-buildbot-config', 16:46:19 INFO - 'download-and-extract', 16:46:19 INFO - 'populate-webroot', 16:46:19 INFO - 'create-virtualenv', 16:46:19 INFO - 'install', 16:46:19 INFO - 'run-tests'), 16:46:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:46:19 INFO - 'download_minidump_stackwalk': True, 16:46:19 INFO - 'download_symbols': 'ondemand', 16:46:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:46:19 INFO - 'tooltool.py': '/tools/tooltool.py', 16:46:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:46:19 INFO - '/tools/misc-python/virtualenv.py')}, 16:46:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:46:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:46:19 INFO - 'installer_path': 'installer.exe', 16:46:19 INFO - 'log_level': 'info', 16:46:19 INFO - 'log_name': 'talos', 16:46:19 INFO - 'log_to_console': True, 16:46:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:46:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:46:19 INFO - 'opt_config_files': (), 16:46:19 INFO - 'pip_index': False, 16:46:19 INFO - 'sps_profile': False, 16:46:19 INFO - 'sps_profile_interval': 0, 16:46:19 INFO - 'suite': 'dromaeojs', 16:46:19 INFO - 'system_bits': '32', 16:46:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:46:19 INFO - 'title': 'talos-linux64-ix-035', 16:46:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:46:19 INFO - 'use_talos_json': True, 16:46:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:46:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:46:19 INFO - 'work_dir': 'build'} 16:46:19 INFO - ##### 16:46:19 INFO - ##### Running clobber step. 16:46:19 INFO - ##### 16:46:19 INFO - Running pre-action listener: _resource_record_pre_action 16:46:19 INFO - Running main action method: clobber 16:46:19 INFO - rmtree: /builds/slave/test/build 16:46:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:46:21 INFO - Running post-action listener: _resource_record_post_action 16:46:21 INFO - ##### 16:46:21 INFO - ##### Finished clobber step (success) 16:46:21 INFO - ##### 16:46:21 INFO - ##### 16:46:21 INFO - ##### Running read-buildbot-config step. 16:46:21 INFO - ##### 16:46:21 INFO - Running pre-action listener: _resource_record_pre_action 16:46:21 INFO - Running main action method: read_buildbot_config 16:46:21 INFO - Using buildbot properties: 16:46:21 INFO - { 16:46:21 INFO - "project": "", 16:46:21 INFO - "product": "firefox", 16:46:21 INFO - "script_repo_revision": "production", 16:46:21 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:46:21 INFO - "repository": "", 16:46:21 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 16:46:21 INFO - "buildid": "20160518160449", 16:46:21 INFO - "pgo_build": "False", 16:46:21 INFO - "basedir": "/builds/slave/test", 16:46:21 INFO - "buildnumber": 1756, 16:46:21 INFO - "slavename": "talos-linux64-ix-035", 16:46:21 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:46:21 INFO - "platform": "ubuntu64_hw", 16:46:21 INFO - "scheduler": "tests-fx-team-linux64-talos", 16:46:21 INFO - "branch": "fx-team", 16:46:21 INFO - "repo_path": "integration/fx-team", 16:46:21 INFO - "revision": "55016b253dde7da0b07348bd66ee313c748c0a0c", 16:46:21 INFO - "stage_platform": "linux64", 16:46:21 INFO - "builduid": "0670e805ec7941a98bbf81331539c06d", 16:46:21 INFO - "slavebuilddir": "test" 16:46:21 INFO - } 16:46:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/EfWvuX7nReCO9yNpE9UVyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 16:46:21 INFO - Running post-action listener: _resource_record_post_action 16:46:21 INFO - ##### 16:46:21 INFO - ##### Finished read-buildbot-config step (success) 16:46:21 INFO - ##### 16:46:21 INFO - ##### 16:46:21 INFO - ##### Running download-and-extract step. 16:46:21 INFO - ##### 16:46:21 INFO - Running pre-action listener: _resource_record_pre_action 16:46:21 INFO - Running main action method: download_and_extract 16:46:21 INFO - mkdir: /builds/slave/test/build/tests 16:46: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')]} 16:46:21 INFO - https://queue.taskcluster.net/v1/task/EfWvuX7nReCO9yNpE9UVyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:46:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EfWvuX7nReCO9yNpE9UVyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:46:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EfWvuX7nReCO9yNpE9UVyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:46:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EfWvuX7nReCO9yNpE9UVyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:46:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EfWvuX7nReCO9yNpE9UVyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:46:23 INFO - Downloaded 1361 bytes. 16:46:23 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:46:23 INFO - Using the following test package requirements: 16:46:23 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 16:46:23 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:46:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:46:23 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:46:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:46:23 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:46:23 INFO - u'jsshell-linux-x86_64.zip'], 16:46:23 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:46:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:46:23 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 16:46:23 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:46:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:46:23 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:46:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:46:23 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:46:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:46:23 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:46:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:46:23 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:46:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:46:23 INFO - https://queue.taskcluster.net/v1/task/EfWvuX7nReCO9yNpE9UVyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:46:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EfWvuX7nReCO9yNpE9UVyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:46:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EfWvuX7nReCO9yNpE9UVyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:46:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EfWvuX7nReCO9yNpE9UVyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:46:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EfWvuX7nReCO9yNpE9UVyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:46:26 INFO - Downloaded 22812201 bytes. 16:46:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:46:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:46:28 INFO - Return code: 0 16:46:28 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:46:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:46:28 INFO - https://queue.taskcluster.net/v1/task/EfWvuX7nReCO9yNpE9UVyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:46:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EfWvuX7nReCO9yNpE9UVyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:46:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EfWvuX7nReCO9yNpE9UVyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:46:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EfWvuX7nReCO9yNpE9UVyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:46:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EfWvuX7nReCO9yNpE9UVyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:46:35 INFO - Downloaded 22812201 bytes. 16:46:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:46:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:46:37 INFO - Return code: 0 16:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:46:37 INFO - https://queue.taskcluster.net/v1/task/EfWvuX7nReCO9yNpE9UVyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:46:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EfWvuX7nReCO9yNpE9UVyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 16:46:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EfWvuX7nReCO9yNpE9UVyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 16:46:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EfWvuX7nReCO9yNpE9UVyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 16:46:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EfWvuX7nReCO9yNpE9UVyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:46:37 INFO - Downloaded 10840194 bytes. 16:46:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:46:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:46:38 INFO - Return code: 0 16:46: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')]} 16:46:38 INFO - https://queue.taskcluster.net/v1/task/EfWvuX7nReCO9yNpE9UVyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:46:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EfWvuX7nReCO9yNpE9UVyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:46:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EfWvuX7nReCO9yNpE9UVyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:46:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EfWvuX7nReCO9yNpE9UVyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:46:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EfWvuX7nReCO9yNpE9UVyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:46:39 INFO - Downloaded 54806653 bytes. 16:46:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EfWvuX7nReCO9yNpE9UVyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:46:39 INFO - mkdir: /builds/slave/test/properties 16:46:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:46:39 INFO - Writing to file /builds/slave/test/properties/build_url 16:46:39 INFO - Contents: 16:46:39 INFO - build_url:https://queue.taskcluster.net/v1/task/EfWvuX7nReCO9yNpE9UVyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:46:40 INFO - Running post-action listener: _resource_record_post_action 16:46:40 INFO - Running post-action listener: set_extra_try_arguments 16:46:40 INFO - ##### 16:46:40 INFO - ##### Finished download-and-extract step (success) 16:46:40 INFO - ##### 16:46:40 INFO - ##### 16:46:40 INFO - ##### Running populate-webroot step. 16:46:40 INFO - ##### 16:46:40 INFO - Running pre-action listener: _resource_record_pre_action 16:46:40 INFO - Running main action method: populate_webroot 16:46:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:46:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:46:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:46:40 INFO - '--tppagecycles', 16:46:40 INFO - '7'], 16:46:40 INFO - 'tests': ['tsvgm']}}, 16:46:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:46:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:46:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:46:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:46:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:46:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:46:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:46:40 INFO - 'talos_options': ['--disable-e10s'], 16:46:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:46:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:46:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:46:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:46:40 INFO - 'talos_options': ['--disable-e10s'], 16:46:40 INFO - 'tests': ['damp', 'tps']}, 16:46:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:46:40 INFO - 'tests': ['damp', 'tps']}, 16:46:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:46:40 INFO - 'tests': ['dromaeo_dom']}, 16:46:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:46:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:46:40 INFO - 'tests': ['a11yr', 16:46:40 INFO - 'ts_paint', 16:46:40 INFO - 'tpaint', 16:46:40 INFO - 'sessionrestore', 16:46:40 INFO - 'sessionrestore_no_auto_restore', 16:46:40 INFO - 'tabpaint']}, 16:46:40 INFO - 'other-e10s': {'tests': ['a11yr', 16:46:40 INFO - 'ts_paint', 16:46:40 INFO - 'tpaint', 16:46:40 INFO - 'sessionrestore', 16:46:40 INFO - 'sessionrestore_no_auto_restore', 16:46:40 INFO - 'tabpaint']}, 16:46:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:46:40 INFO - 'ts_paint', 16:46:40 INFO - 'tpaint', 16:46:40 INFO - 'sessionrestore', 16:46:40 INFO - 'sessionrestore_no_auto_restore', 16:46:40 INFO - 'tabpaint']}, 16:46:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:46:40 INFO - 'ts_paint', 16:46:40 INFO - 'tpaint', 16:46:40 INFO - 'sessionrestore', 16:46:40 INFO - 'sessionrestore_no_auto_restore', 16:46:40 INFO - 'tabpaint']}, 16:46:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:46:40 INFO - 'tests': ['a11yr', 16:46:40 INFO - 'ts_paint', 16:46:40 INFO - 'tpaint', 16:46:40 INFO - 'sessionrestore', 16:46:40 INFO - 'sessionrestore_no_auto_restore', 16:46:40 INFO - 'tabpaint']}, 16:46:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:46:40 INFO - 'tests': ['a11yr', 16:46:40 INFO - 'ts_paint', 16:46:40 INFO - 'tpaint', 16:46:40 INFO - 'sessionrestore', 16:46:40 INFO - 'sessionrestore_no_auto_restore', 16:46:40 INFO - 'tabpaint']}, 16:46:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:46:40 INFO - 'tests': ['tsvgx', 16:46:40 INFO - 'tsvgr_opacity', 16:46:40 INFO - 'tart', 16:46:40 INFO - 'tscrollx', 16:46:40 INFO - 'cart']}, 16:46:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:46:40 INFO - 'tsvgr_opacity', 16:46:40 INFO - 'tart', 16:46:40 INFO - 'tscrollx', 16:46:40 INFO - 'cart']}, 16:46:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:46:40 INFO - 'talos_options': ['--disable-e10s'], 16:46:40 INFO - 'tests': ['tp5o']}, 16:46:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:46:40 INFO - 'tests': ['tp5o']}, 16:46:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:46:40 INFO - 'talos_options': ['--disable-e10s', 16:46:40 INFO - '--xperf_path', 16:46:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:46:40 INFO - 'tests': ['tp5n']}, 16:46:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:46:40 INFO - 'talos_options': ['--xperf_path', 16:46:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:46:40 INFO - 'tests': ['tp5n']}}, 16:46:40 INFO - 'talos.zip': {'path': '', 16:46:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:46:40 INFO - Running post-action listener: _resource_record_post_action 16:46:40 INFO - ##### 16:46:40 INFO - ##### Finished populate-webroot step (success) 16:46:40 INFO - ##### 16:46:40 INFO - ##### 16:46:40 INFO - ##### Running create-virtualenv step. 16:46:40 INFO - ##### 16:46:40 INFO - Running pre-action listener: _resource_record_pre_action 16:46:40 INFO - Running main action method: create_virtualenv 16:46:40 INFO - Creating virtualenv /builds/slave/test/build/venv 16:46:40 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:46:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:46:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:46:40 INFO - Using real prefix '/usr' 16:46:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:46:41 INFO - Installing distribute.............................................................................................................................................................................................done. 16:46:43 INFO - Installing pip.................done. 16:46:43 INFO - Return code: 0 16:46:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:46:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:46:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:46:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:46:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46:43 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 0x7f9cd8da8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aba9c0>, '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 0x1abb8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abbd50>, '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': 'ed14279e38b05397cf4aa391000001a4-1463613528.955999-580362476', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:46:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:46:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:46:43 INFO - Using env: {'DISPLAY': ':0', 16:46:43 INFO - 'HOME': '/home/cltbld', 16:46:43 INFO - 'LANG': 'en_US.UTF-8', 16:46:43 INFO - 'LANGUAGE': 'en_US:en', 16:46:43 INFO - 'LOGNAME': 'cltbld', 16:46:43 INFO - 'MAIL': '/var/mail/cltbld', 16:46:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:46:43 INFO - 'MOZ_NO_REMOTE': '1', 16:46:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:46:43 INFO - 'NO_EM_RESTART': '1', 16:46:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:46:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:46:43 INFO - 'PWD': '/builds/slave/test', 16:46:43 INFO - 'SHELL': '/bin/bash', 16:46:43 INFO - 'SHLVL': '1', 16:46:43 INFO - 'TERM': 'linux', 16:46:43 INFO - 'TMOUT': '86400', 16:46:43 INFO - 'USER': 'cltbld', 16:46:43 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1463613528.955999-580362476', 16:46:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:46:43 INFO - '_': '/tools/buildbot/bin/python'} 16:46:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:46:43 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:46:43 INFO - Cleaning up... 16:46:43 INFO - Return code: 0 16:46:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:46:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:46:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:46:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:46:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cd8da8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aba9c0>, '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 0x1abb8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abbd50>, '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': 'ed14279e38b05397cf4aa391000001a4-1463613528.955999-580362476', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:46:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:46:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:46:43 INFO - Using env: {'DISPLAY': ':0', 16:46:43 INFO - 'HOME': '/home/cltbld', 16:46:43 INFO - 'LANG': 'en_US.UTF-8', 16:46:43 INFO - 'LANGUAGE': 'en_US:en', 16:46:43 INFO - 'LOGNAME': 'cltbld', 16:46:43 INFO - 'MAIL': '/var/mail/cltbld', 16:46:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:46:43 INFO - 'MOZ_NO_REMOTE': '1', 16:46:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:46:43 INFO - 'NO_EM_RESTART': '1', 16:46:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:46:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:46:43 INFO - 'PWD': '/builds/slave/test', 16:46:43 INFO - 'SHELL': '/bin/bash', 16:46:43 INFO - 'SHLVL': '1', 16:46:43 INFO - 'TERM': 'linux', 16:46:43 INFO - 'TMOUT': '86400', 16:46:43 INFO - 'USER': 'cltbld', 16:46:43 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1463613528.955999-580362476', 16:46:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:46:43 INFO - '_': '/tools/buildbot/bin/python'} 16:46:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:46:44 INFO - Downloading/unpacking psutil>=3.1.1 16:46:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:46:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:46:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:46:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:46:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:46:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:46:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:46:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:46:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:46:46 INFO - Installing collected packages: psutil 16:46:46 INFO - Running setup.py install for psutil 16:46:46 INFO - building 'psutil._psutil_linux' extension 16:46:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:46: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 16:46:48 INFO - building 'psutil._psutil_posix' extension 16:46:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:46:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:46:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:46:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:46:48 INFO - Successfully installed psutil 16:46:48 INFO - Cleaning up... 16:46:48 INFO - Return code: 0 16:46:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:46:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:46:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:46:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:46:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cd8da8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aba9c0>, '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 0x1abb8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abbd50>, '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': 'ed14279e38b05397cf4aa391000001a4-1463613528.955999-580362476', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:46:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:46:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:46:48 INFO - Using env: {'DISPLAY': ':0', 16:46:48 INFO - 'HOME': '/home/cltbld', 16:46:48 INFO - 'LANG': 'en_US.UTF-8', 16:46:48 INFO - 'LANGUAGE': 'en_US:en', 16:46:48 INFO - 'LOGNAME': 'cltbld', 16:46:48 INFO - 'MAIL': '/var/mail/cltbld', 16:46:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:46:48 INFO - 'MOZ_NO_REMOTE': '1', 16:46:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:46:48 INFO - 'NO_EM_RESTART': '1', 16:46:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:46:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:46:48 INFO - 'PWD': '/builds/slave/test', 16:46:48 INFO - 'SHELL': '/bin/bash', 16:46:48 INFO - 'SHLVL': '1', 16:46:48 INFO - 'TERM': 'linux', 16:46:48 INFO - 'TMOUT': '86400', 16:46:48 INFO - 'USER': 'cltbld', 16:46:48 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1463613528.955999-580362476', 16:46:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:46:48 INFO - '_': '/tools/buildbot/bin/python'} 16:46:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:46:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:46: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 16:46: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 16:46: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 16:46: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 16:46: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 16:46: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 16:46:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:46:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:46:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:46:50 INFO - Installing collected packages: mozsystemmonitor 16:46:50 INFO - Running setup.py install for mozsystemmonitor 16:46:50 INFO - Successfully installed mozsystemmonitor 16:46:50 INFO - Cleaning up... 16:46:50 INFO - Return code: 0 16:46:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:46: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')]} 16:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:46:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46: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')]} 16:46:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:46:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46: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 0x7f9cd8da8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aba9c0>, '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 0x1abb8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abbd50>, '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': 'ed14279e38b05397cf4aa391000001a4-1463613528.955999-580362476', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:46: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 16:46: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 16:46:50 INFO - Using env: {'DISPLAY': ':0', 16:46:50 INFO - 'HOME': '/home/cltbld', 16:46:50 INFO - 'LANG': 'en_US.UTF-8', 16:46:50 INFO - 'LANGUAGE': 'en_US:en', 16:46:50 INFO - 'LOGNAME': 'cltbld', 16:46:50 INFO - 'MAIL': '/var/mail/cltbld', 16:46:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:46:50 INFO - 'MOZ_NO_REMOTE': '1', 16:46:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:46:50 INFO - 'NO_EM_RESTART': '1', 16:46:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:46:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:46:50 INFO - 'PWD': '/builds/slave/test', 16:46:50 INFO - 'SHELL': '/bin/bash', 16:46:50 INFO - 'SHLVL': '1', 16:46:50 INFO - 'TERM': 'linux', 16:46:50 INFO - 'TMOUT': '86400', 16:46:50 INFO - 'USER': 'cltbld', 16:46:50 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1463613528.955999-580362476', 16:46:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:46:50 INFO - '_': '/tools/buildbot/bin/python'} 16:46:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:46:51 INFO - Downloading/unpacking blobuploader==1.2.4 16:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:46:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:46:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:46:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:46:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:46:52 INFO - Downloading blobuploader-1.2.4.tar.gz 16:46:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:46:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:46:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:46:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:46:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:46:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:46:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:46:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:46:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:46:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:46:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:46:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:46:53 INFO - Downloading docopt-0.6.1.tar.gz 16:46:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:46:53 INFO - Installing collected packages: blobuploader, requests, docopt 16:46:53 INFO - Running setup.py install for blobuploader 16:46:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:46:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:46:53 INFO - Running setup.py install for requests 16:46:54 INFO - Running setup.py install for docopt 16:46:54 INFO - Successfully installed blobuploader requests docopt 16:46:54 INFO - Cleaning up... 16:46:54 INFO - Return code: 0 16:46:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:46:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:46:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:46:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46:54 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 0x7f9cd8da8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aba9c0>, '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 0x1abb8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abbd50>, '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': 'ed14279e38b05397cf4aa391000001a4-1463613528.955999-580362476', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:46:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:46:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:46:54 INFO - Using env: {'DISPLAY': ':0', 16:46:54 INFO - 'HOME': '/home/cltbld', 16:46:54 INFO - 'LANG': 'en_US.UTF-8', 16:46:54 INFO - 'LANGUAGE': 'en_US:en', 16:46:54 INFO - 'LOGNAME': 'cltbld', 16:46:54 INFO - 'MAIL': '/var/mail/cltbld', 16:46:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:46:54 INFO - 'MOZ_NO_REMOTE': '1', 16:46:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:46:54 INFO - 'NO_EM_RESTART': '1', 16:46:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:46:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:46:54 INFO - 'PWD': '/builds/slave/test', 16:46:54 INFO - 'SHELL': '/bin/bash', 16:46:54 INFO - 'SHLVL': '1', 16:46:54 INFO - 'TERM': 'linux', 16:46:54 INFO - 'TMOUT': '86400', 16:46:54 INFO - 'USER': 'cltbld', 16:46:54 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1463613528.955999-580362476', 16:46:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:46:54 INFO - '_': '/tools/buildbot/bin/python'} 16:46:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:46:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:46:54 INFO - Running setup.py (path:/tmp/pip-AePzPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:46:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:46:54 INFO - Running setup.py (path:/tmp/pip-h7s7Sh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:46:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:46:54 INFO - Running setup.py (path:/tmp/pip-i9pUf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:46:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:46:54 INFO - Running setup.py (path:/tmp/pip-PNH8ZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:46:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:46:54 INFO - Running setup.py (path:/tmp/pip-Yt_BjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:46:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:46:54 INFO - Running setup.py (path:/tmp/pip-G8RIfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:46:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:46:54 INFO - Running setup.py (path:/tmp/pip-oIhN_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:46:55 INFO - Running setup.py (path:/tmp/pip-zYfLGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:46:55 INFO - Running setup.py (path:/tmp/pip-OMV8a9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:46:55 INFO - Running setup.py (path:/tmp/pip-cIDaRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:46:55 INFO - Running setup.py (path:/tmp/pip-o0XVjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:46:55 INFO - Running setup.py (path:/tmp/pip-acFmIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:46:55 INFO - Running setup.py (path:/tmp/pip-fSWCwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:46:55 INFO - Running setup.py (path:/tmp/pip-DnGWIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:46:55 INFO - Running setup.py (path:/tmp/pip-Xtok7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:46:55 INFO - Running setup.py (path:/tmp/pip-aMVYUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:46:55 INFO - Running setup.py (path:/tmp/pip-SrtNID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:46:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:46:55 INFO - Running setup.py install for manifestparser 16:46:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:46:55 INFO - Running setup.py install for mozcrash 16:46:55 INFO - Running setup.py install for mozdebug 16:46:56 INFO - Running setup.py install for mozdevice 16:46:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:46:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:46:56 INFO - Running setup.py install for mozfile 16:46:56 INFO - Running setup.py install for mozhttpd 16:46:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:46:56 INFO - Running setup.py install for mozinfo 16:46:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:46:56 INFO - Running setup.py install for mozInstall 16:46:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:46:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:46:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:46:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:46:56 INFO - Running setup.py install for mozleak 16:46:56 INFO - Running setup.py install for mozlog 16:46:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:46:56 INFO - Running setup.py install for moznetwork 16:46:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:46:56 INFO - Running setup.py install for mozprocess 16:46:57 INFO - Running setup.py install for mozprofile 16:46:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:46:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:46:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:46:57 INFO - Running setup.py install for mozrunner 16:46:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:46:57 INFO - Running setup.py install for mozscreenshot 16:46:57 INFO - Running setup.py install for moztest 16:46:57 INFO - Running setup.py install for mozversion 16:46:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:46:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:46:57 INFO - Cleaning up... 16:46:57 INFO - Return code: 0 16:46:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:46:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:46:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:46:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:46:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46:57 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 0x7f9cd8da8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aba9c0>, '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 0x1abb8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abbd50>, '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': 'ed14279e38b05397cf4aa391000001a4-1463613528.955999-580362476', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:46:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:46:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:46:57 INFO - Using env: {'DISPLAY': ':0', 16:46:57 INFO - 'HOME': '/home/cltbld', 16:46:57 INFO - 'LANG': 'en_US.UTF-8', 16:46:57 INFO - 'LANGUAGE': 'en_US:en', 16:46:57 INFO - 'LOGNAME': 'cltbld', 16:46:57 INFO - 'MAIL': '/var/mail/cltbld', 16:46:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:46:57 INFO - 'MOZ_NO_REMOTE': '1', 16:46:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:46:57 INFO - 'NO_EM_RESTART': '1', 16:46:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:46:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:46:57 INFO - 'PWD': '/builds/slave/test', 16:46:57 INFO - 'SHELL': '/bin/bash', 16:46:57 INFO - 'SHLVL': '1', 16:46:57 INFO - 'TERM': 'linux', 16:46:57 INFO - 'TMOUT': '86400', 16:46:57 INFO - 'USER': 'cltbld', 16:46:57 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1463613528.955999-580362476', 16:46:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:46:57 INFO - '_': '/tools/buildbot/bin/python'} 16:46:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:46:57 INFO - Running setup.py (path:/tmp/pip-EkLSb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:46: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)) 16:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:46:57 INFO - Running setup.py (path:/tmp/pip-rLNrCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:46: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)) 16:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:46:57 INFO - Running setup.py (path:/tmp/pip-XktwsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:46:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:46:58 INFO - Running setup.py (path:/tmp/pip-UCOYs0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:46:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:46:58 INFO - Running setup.py (path:/tmp/pip-Ehr45M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:46:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:46:58 INFO - Running setup.py (path:/tmp/pip-Uyi6tO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:46:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:46:58 INFO - Running setup.py (path:/tmp/pip-Xq3jeM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:46:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:46:58 INFO - Running setup.py (path:/tmp/pip-jmSz5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:46:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:46:58 INFO - Running setup.py (path:/tmp/pip-xPhKkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:46:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:46:58 INFO - Running setup.py (path:/tmp/pip-8QfvVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:46:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:46:58 INFO - Running setup.py (path:/tmp/pip-i674rY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:46:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:46:58 INFO - Running setup.py (path:/tmp/pip-PcYb7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:46: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)) 16:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:46:58 INFO - Running setup.py (path:/tmp/pip-L_cyuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:46: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)) 16:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:46:58 INFO - Running setup.py (path:/tmp/pip-ch2zW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:46: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)) 16:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:46:58 INFO - Running setup.py (path:/tmp/pip-qZ2A9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:46: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)) 16:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:46:58 INFO - Running setup.py (path:/tmp/pip-0qd6e3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:46: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)) 16:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:46:58 INFO - Running setup.py (path:/tmp/pip-qJCX50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:46:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:46:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:46:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:46:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:46:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:46:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:46:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:46:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:46:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:46:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:46:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:00 INFO - Downloading blessings-1.6.tar.gz 16:47:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:47:00 INFO - Installing collected packages: blessings 16:47:00 INFO - Running setup.py install for blessings 16:47:01 INFO - Successfully installed blessings 16:47:01 INFO - Cleaning up... 16:47:01 INFO - Return code: 0 16:47:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:47:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:47:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:47:01 INFO - Reading from file tmpfile_stdout 16:47:01 INFO - Current package versions: 16:47:01 INFO - argparse == 1.2.1 16:47:01 INFO - blessings == 1.6 16:47:01 INFO - blobuploader == 1.2.4 16:47:01 INFO - docopt == 0.6.1 16:47:01 INFO - manifestparser == 1.1 16:47:01 INFO - mozInstall == 1.12 16:47:01 INFO - mozcrash == 0.17 16:47:01 INFO - mozdebug == 0.1 16:47:01 INFO - mozdevice == 0.48 16:47:01 INFO - mozfile == 1.2 16:47:01 INFO - mozhttpd == 0.7 16:47:01 INFO - mozinfo == 0.9 16:47:01 INFO - mozleak == 0.1 16:47:01 INFO - mozlog == 3.2 16:47:01 INFO - moznetwork == 0.27 16:47:01 INFO - mozprocess == 0.22 16:47:01 INFO - mozprofile == 0.28 16:47:01 INFO - mozrunner == 6.11 16:47:01 INFO - mozscreenshot == 0.1 16:47:01 INFO - mozsystemmonitor == 0.3 16:47:01 INFO - moztest == 0.7 16:47:01 INFO - mozversion == 1.4 16:47:01 INFO - psutil == 3.1.1 16:47:01 INFO - requests == 1.2.3 16:47:01 INFO - wsgiref == 0.1.2 16:47:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:47:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:47:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:01 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 0x7f9cd8da8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aba9c0>, '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 0x1abb8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abbd50>, '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': 'ed14279e38b05397cf4aa391000001a4-1463613528.955999-580362476', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:47:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:47:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:47:01 INFO - Using env: {'DISPLAY': ':0', 16:47:01 INFO - 'HOME': '/home/cltbld', 16:47:01 INFO - 'LANG': 'en_US.UTF-8', 16:47:01 INFO - 'LANGUAGE': 'en_US:en', 16:47:01 INFO - 'LOGNAME': 'cltbld', 16:47:01 INFO - 'MAIL': '/var/mail/cltbld', 16:47:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:01 INFO - 'MOZ_NO_REMOTE': '1', 16:47:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:01 INFO - 'NO_EM_RESTART': '1', 16:47:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:01 INFO - 'PWD': '/builds/slave/test', 16:47:01 INFO - 'SHELL': '/bin/bash', 16:47:01 INFO - 'SHLVL': '1', 16:47:01 INFO - 'TERM': 'linux', 16:47:01 INFO - 'TMOUT': '86400', 16:47:01 INFO - 'USER': 'cltbld', 16:47:01 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1463613528.955999-580362476', 16:47:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:01 INFO - '_': '/tools/buildbot/bin/python'} 16:47:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:47:01 INFO - Cleaning up... 16:47:01 INFO - Return code: 0 16:47:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:47:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:47:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:01 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 0x7f9cd8da8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aba9c0>, '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 0x1abb8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abbd50>, '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': 'ed14279e38b05397cf4aa391000001a4-1463613528.955999-580362476', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:47:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:47:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:47:01 INFO - Using env: {'DISPLAY': ':0', 16:47:01 INFO - 'HOME': '/home/cltbld', 16:47:01 INFO - 'LANG': 'en_US.UTF-8', 16:47:01 INFO - 'LANGUAGE': 'en_US:en', 16:47:01 INFO - 'LOGNAME': 'cltbld', 16:47:01 INFO - 'MAIL': '/var/mail/cltbld', 16:47:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:01 INFO - 'MOZ_NO_REMOTE': '1', 16:47:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:01 INFO - 'NO_EM_RESTART': '1', 16:47:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:01 INFO - 'PWD': '/builds/slave/test', 16:47:01 INFO - 'SHELL': '/bin/bash', 16:47:01 INFO - 'SHLVL': '1', 16:47:01 INFO - 'TERM': 'linux', 16:47:01 INFO - 'TMOUT': '86400', 16:47:01 INFO - 'USER': 'cltbld', 16:47:01 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1463613528.955999-580362476', 16:47:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:01 INFO - '_': '/tools/buildbot/bin/python'} 16:47:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:01 INFO - Downloading/unpacking jsonschema 16:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:47:03 INFO - Downloading/unpacking functools32 (from jsonschema) 16:47: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 16:47: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 16:47: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 16:47: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 16:47: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 16:47: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 16:47:03 INFO - Downloading functools32-3.2.3-2.tar.gz 16:47:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:47:03 INFO - warning: no files found matching '*.txt' 16:47:03 INFO - no previously-included directories found matching 'build' 16:47:03 INFO - no previously-included directories found matching 'dist' 16:47:03 INFO - no previously-included directories found matching '.git*' 16:47:03 INFO - Installing collected packages: jsonschema, functools32 16:47:04 INFO - Running setup.py install for functools32 16:47:04 INFO - warning: no files found matching '*.txt' 16:47:04 INFO - no previously-included directories found matching 'build' 16:47:04 INFO - no previously-included directories found matching 'dist' 16:47:04 INFO - no previously-included directories found matching '.git*' 16:47:04 INFO - Successfully installed jsonschema functools32 16:47:04 INFO - Cleaning up... 16:47:04 INFO - Return code: 0 16:47:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:47:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:04 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 0x7f9cd8da8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aba9c0>, '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 0x1abb8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abbd50>, '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': 'ed14279e38b05397cf4aa391000001a4-1463613528.955999-580362476', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:47:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 16:47:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:47:04 INFO - Using env: {'DISPLAY': ':0', 16:47:04 INFO - 'HOME': '/home/cltbld', 16:47:04 INFO - 'LANG': 'en_US.UTF-8', 16:47:04 INFO - 'LANGUAGE': 'en_US:en', 16:47:04 INFO - 'LOGNAME': 'cltbld', 16:47:04 INFO - 'MAIL': '/var/mail/cltbld', 16:47:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:04 INFO - 'MOZ_NO_REMOTE': '1', 16:47:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:04 INFO - 'NO_EM_RESTART': '1', 16:47:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:04 INFO - 'PWD': '/builds/slave/test', 16:47:04 INFO - 'SHELL': '/bin/bash', 16:47:04 INFO - 'SHLVL': '1', 16:47:04 INFO - 'TERM': 'linux', 16:47:04 INFO - 'TMOUT': '86400', 16:47:04 INFO - 'USER': 'cltbld', 16:47:04 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1463613528.955999-580362476', 16:47:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:04 INFO - '_': '/tools/buildbot/bin/python'} 16:47:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:04 INFO - Downloading/unpacking flake8 16:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:47:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:47:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:47:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:47:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:47:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:47:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:47:06 INFO - no previously-included directories found matching 'docs/_build' 16:47:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:47:07 INFO - Running setup.py install for pep8 16:47:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:47:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:47:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:47:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:47:07 INFO - no previously-included directories found matching 'docs/_build' 16:47:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:47:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:47:07 INFO - Cleaning up... 16:47:07 INFO - Return code: 0 16:47:07 INFO - Running post-action listener: _resource_record_post_action 16:47:07 INFO - Running post-action listener: _start_resource_monitoring 16:47:07 INFO - Starting resource monitoring. 16:47:07 INFO - ##### 16:47:07 INFO - ##### Finished create-virtualenv step (success) 16:47:07 INFO - ##### 16:47:07 INFO - ##### 16:47:07 INFO - ##### Running install step. 16:47:07 INFO - ##### 16:47:07 INFO - Running pre-action listener: _resource_record_pre_action 16:47:07 INFO - Running main action method: install 16:47:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:47:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:47:07 INFO - Reading from file tmpfile_stdout 16:47:07 INFO - Detecting whether we're running mozinstall >=1.0... 16:47:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:47:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:47:07 INFO - Reading from file tmpfile_stdout 16:47:07 INFO - Output received: 16:47:07 INFO - Usage: mozinstall [options] installer 16:47:07 INFO - Options: 16:47:07 INFO - -h, --help show this help message and exit 16:47:07 INFO - -d DEST, --destination=DEST 16:47:07 INFO - Directory to install application into. [default: 16:47:07 INFO - "/builds/slave/test"] 16:47:07 INFO - --app=APP Application being installed. [default: firefox] 16:47:07 INFO - mkdir: /builds/slave/test/build/application 16:47:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:47:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:47:23 INFO - Reading from file tmpfile_stdout 16:47:23 INFO - Output received: 16:47:23 INFO - /builds/slave/test/build/application/firefox/firefox 16:47:23 INFO - Running post-action listener: _resource_record_post_action 16:47:23 INFO - ##### 16:47:23 INFO - ##### Finished install step (success) 16:47:23 INFO - ##### 16:47:23 INFO - ##### 16:47:23 INFO - ##### Running run-tests step. 16:47:23 INFO - ##### 16:47:23 INFO - Running pre-action listener: _resource_record_pre_action 16:47:23 INFO - Running main action method: run_tests 16:47:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:47:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:47:23 INFO - Python 2.7.3 16:47:23 INFO - Return code: 0 16:47:23 INFO - grabbing minidump binary from tooltool 16:47:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:47:23 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aba9c0>, '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 0x1abb8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abbd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:47:23 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:47:23 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:47:23 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:47:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:47:23 INFO - Return code: 0 16:47:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:47:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:47:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:47:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:47:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:47:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:47:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:47:24 INFO - Return code: 0 16:47:24 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/EfWvuX7nReCO9yNpE9UVyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:47:24 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/EfWvuX7nReCO9yNpE9UVyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:47:24 INFO - Using env: {'DISPLAY': ':0', 16:47:24 INFO - 'HOME': '/home/cltbld', 16:47:24 INFO - 'LANG': 'en_US.UTF-8', 16:47:24 INFO - 'LANGUAGE': 'en_US:en', 16:47:24 INFO - 'LOGNAME': 'cltbld', 16:47:24 INFO - 'MAIL': '/var/mail/cltbld', 16:47:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:47:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:47:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:24 INFO - 'MOZ_NO_REMOTE': '1', 16:47:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:47:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:24 INFO - 'NO_EM_RESTART': '1', 16:47:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:24 INFO - 'PWD': '/builds/slave/test', 16:47:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:47:24 INFO - 'SHELL': '/bin/bash', 16:47:24 INFO - 'SHLVL': '1', 16:47:24 INFO - 'TERM': 'linux', 16:47:24 INFO - 'TMOUT': '86400', 16:47:24 INFO - 'USER': 'cltbld', 16:47:24 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1463613528.955999-580362476', 16:47:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:24 INFO - '_': '/tools/buildbot/bin/python'} 16:47:24 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/EfWvuX7nReCO9yNpE9UVyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:47:24 INFO - mozversion application_buildid: 20160518160449 16:47:24 INFO - mozversion application_changeset: 55016b253dde7da0b07348bd66ee313c748c0a0c 16:47:24 INFO - mozversion application_display_name: Nightly 16:47:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:47:24 INFO - mozversion application_name: Firefox 16:47:24 INFO - mozversion application_remotingname: firefox 16:47:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:47:24 INFO - mozversion application_vendor: Mozilla 16:47:24 INFO - mozversion application_version: 49.0a1 16:47:24 INFO - mozversion platform_buildid: 20160518160449 16:47:24 INFO - mozversion platform_changeset: 55016b253dde7da0b07348bd66ee313c748c0a0c 16:47:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:47:24 INFO - mozversion platform_version: 49.0a1 16:47:24 INFO - using testdate: 1463615244 16:47:24 INFO - actual date: 1463615244 16:47:24 INFO - starting webserver on 'localhost:37225' 16:47:24 INFO - SUITE-START | Running 2 tests 16:47:24 INFO - TEST-START | dromaeo_css 16:47:24 INFO - operating with platform_type : linux_ 16:47:24 INFO - Initialising browser for dromaeo_css test... 16:47:24 INFO - TEST-INFO | started process 3289 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMTraB4/profile http://localhost:37225/getInfo.html) 16:47:29 INFO - PROCESS | 3289 | __metrics Screen width/height:1600/1200 16:47:29 INFO - PROCESS | 3289 | colorDepth:24 16:47:29 INFO - PROCESS | 3289 | Browser inner width/height: 1024/697 16:47:29 INFO - PROCESS | 3289 | __metrics 16:47:31 ERROR - PROCESS | 3289 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:47:31 INFO - TEST-INFO | 3289: exit 0 16:47:31 INFO - Browser initialized. 16:47:31 INFO - Running cycle 1/1 for dromaeo_css test... 16:47:31 INFO - TEST-INFO | started process 3372 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMTraB4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:47:43 INFO - PROCESS | 3372 | RSS: Main: 154214400 16:47:43 INFO - PROCESS | 3372 | 16:48:35 INFO - PROCESS | 3372 | 1463615315436 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:50:47 INFO - PROCESS | 3372 | Cycle 1(1): loaded http://localhost:37225/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37225/tests/dromaeo/cssquery-ext.html) 16:50:48 INFO - PROCESS | 3372 | RSS: Main: 257495040 16:50:48 INFO - PROCESS | 3372 | 16:53:50 INFO - PROCESS | 3372 | Cycle 1(1): loaded http://localhost:37225/tests/dromaeo/cssquery-ext.html (next: http://localhost:37225/tests/dromaeo/cssquery-jquery.html) 16:53:51 INFO - PROCESS | 3372 | RSS: Main: 233242624 16:53:51 INFO - PROCESS | 3372 | 16:56:53 INFO - PROCESS | 3372 | Cycle 1(1): loaded http://localhost:37225/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37225/tests/dromaeo/cssquery-mootools.html) 16:56:54 INFO - PROCESS | 3372 | RSS: Main: 232669184 16:56:54 INFO - PROCESS | 3372 | 16:59:56 INFO - PROCESS | 3372 | Cycle 1(1): loaded http://localhost:37225/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37225/tests/dromaeo/cssquery-prototype.html) 16:59:56 INFO - PROCESS | 3372 | RSS: Main: 229695488 16:59:56 INFO - PROCESS | 3372 | 17:02:59 INFO - PROCESS | 3372 | Cycle 1(1): loaded http://localhost:37225/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37225/tests/dromaeo/cssquery-yui.html) 17:03:00 INFO - PROCESS | 3372 | RSS: Main: 215384064 17:03:00 INFO - PROCESS | 3372 | 17:06:03 INFO - PROCESS | 3372 | Cycle 1(1): loaded http://localhost:37225/tests/dromaeo/cssquery-yui.html (next: http://localhost:37225/tests/dromaeo/cssquery-dojo.html) 17:06:03 INFO - PROCESS | 3372 | RSS: Main: 270184448 17:06:03 INFO - PROCESS | 3372 | 17:06:03 INFO - PROCESS | 3372 | __start_tp_report 17:06:03 INFO - PROCESS | 3372 | _x_x_mozilla_page_load 17:06:03 INFO - PROCESS | 3372 | _x_x_mozilla_page_load_details 17:06:03 INFO - PROCESS | 3372 | |i|pagename|runs| 17:06:03 INFO - PROCESS | 3372 | |0;dojo.html;2697.8785954632053;2709.0924540279007;2717.904873329434;2723.645926029616;2755.435135797162;4715.1512727709;4744.14605371033;4803.783829727662;4833.637477189216;4897.779599918003;4752.643551733625;4772.117158325704;4775.044991001805;4806.639502037344;4815.446223684277;4304.2467568175525;4352.020795321059;4383.057642606839;4434.911301773963;4515.977420112895;4438.511763705989;4450.554944505556;4478.216312145361;4498.752568608726;4528.04910968697;4295.6778241632;4299.161663475624;4343.80452879618;4350.978245108786;4374.693771436001;4317;4360.585744354281;4364.345348197796;4384.079343337903;4482.193205223059;4408.250597398418;4415.757133357664;4417.646588272931;4459.665525085599;4460.598546130864;4559.430071241095;4654.930176047362;4745.881352966204;4796.184648609745;4802.807887684488;5116.641835071547;5126.154184559543;5183.870403239949;5185.066687996159;5195.792168313263;5114.462981386975;5200.713960732158;5216.426193118754;5218.76515556797;5223.477652234784;4721.504242054603;4785.59322457595;4799.568038876518;4839.975800120977;4849.248366503198;5295.814646487354;5321.760520776575;5365.490278423544;5376.838694839083;5378.1932710093015;5102.08162530748;5113.642045056885;5154.072266991978;5154.845354639367;5166.147585648401;4993.575546078551;5066.949330506722;5110.744462776846;5126.718030508283;5164.096283150434;5082.720450375265;5086.338775959176;5096.617753668415;5097.158968770185;5141.38303403594;5069.797208111708;5073.3911930568565;5077.213031980049;5080.110980578384;5088.6946783193125;4212.831486740496;4242.575742425733;4244.427002354642;4296.2266791977745;4296.613304802583;3759.2293579816073;3792.943105853414;3799.2401519696173;3802.961970380316;3833.3100041992707;4484.641228701696;4488.506264310923;4491.236489796743;4530.456345238593;4532.093581283756;5150.227465880148;5170.948290517122;5173.275741396207;5174.113578827923;5179.663321884065;4341.869743907688;4415.381846541487;4461;4465.933011004838;4481.977590112028;4612.815487380467;4618.145643056046;4619.46876109245;4620.884477888079;4669.976650116796;4753.83361582343;4868.488808675109;4878.170710979213;4879.243717223836;4925.87685307863;5093.719845408538;5152.948470515397;5160.406553246425;5252.028374750684;5252.317198764136;4843.903121937612;4879.512048795092;4890.095332363524;4891.510848915223;4941.456439791692;5064.4935506449065;5068.442471328077;5074.543291103819;5076.670016448919;5132.12753831842;4961.82633607822;5129.9743501282255;5134.871628209325;5179.741012949413;5215.530602245816;5049.899002019865;5062.974685126551;5065.265536497261;5065.848024559269;5117.1300878851425;4885.780139893643;5057.848264552069;5070.923936140887;5076.086304465084;5076.18780995039;4886.462489126122;4894.853154405374;4936.062148191832;4984.302197692398;5008.649394542493;5045.596352291735;5050.671706339076;5052.8989420210655;5066.493350664904;5105.489451054865;4803.447603525639;4859;4945;4966.652334336562;5017.0216807722145 17:06:03 INFO - PROCESS | 3372 | |1;ext.html;556.5547561950439;597.4085655201351;606.4057223920561;607.7599348257442;610.5787006965194;28202;30804.69195308049;30880.073597792103;41351.17297654045;42335.788321058426;43334;43628.345574816405;43778.562214377846;43814.78092609532;43911.34132988008;7966.522008679469;8133.227343402397;8138.75583732486;8139.267465928066;8140.715074972377;7945.364370850318;8122.9187708123045;8124.390670699691;8124.431289809686;8128.105908350077;8108.432409731321;8174;8174.05998310193;8179.222973817477;8179.79550511239;8072.677092916277;8124.7562573122905;8147.429679922408;8149.307308878693;8154;8002.51984880909;8100.392470564731;8117.782332650149;8118.553479558622;8124.471909325875;40284.39573406401;40550.79724601388;40613;40696.59303406958;40733.388999165036;3315.602127744662;3369.326134773031;3452.3440546296374;3508.438649816043;3576.8211589420425;30109.247268818453;30158.50065065542;30602.08193754191;30651.846740766377;30756;3380.5943286805496;3451.32699123671;3479.0606536235327;3495.07380544156;3583.2475180212186;288667;288785;289096;289215;289650;55190.72404637951;55263.447365526634;55586.72206638941;55791.721041394536;55826;59230.703846480494;59298.703506483056;59366.40633593609;59450;59530;15113.773293400387;15339;15345.693086138215;15352.846471535366;15366.078035317916;11224.158188135922;11289.943550282196;11293.54825806975;11396.829047564293;11404.543818247343;15165.848341516665;16202.59493512648;16207.270672819752;16234.107124108052;16265.837341626433;5116.974415127975;5952.226210592682;5993.962052901947;6060.939390606038;6142.969285153546;885.6545947080643;921.8064206516573;982.9508524573743;1039.4750650921387;1081.1026847716375;29100.9814656486;29757.553636695466;31259.21851953674;31422.842885785423;33288.1677958053;993.4039576254335;1003.9548220330103;1068.3429690740138;1089.7112265249716;1136.534021051365;14878.70242595142;15051.548453546411;15342.923285383502;15515.534533963999;15536.844631553766;412195;413959;416571;418586;418626;50404;50472;50523.74738126286;50540.74729626402;50606;1173.4074292482412;1245.5951815659946;1285.479380850757;1292.8319318488725;1294.6828027133413;28020.29949251285;29526;29579.704202957695;29839.10482685523;30356.544651829798;42375.78812106043;43037.99999999875;43056.13887722165;43080.56919430891;43104;308157;313231;315567;316176;316400;22593.322200334016;23257.767422326237;23273.650895236246;24487.265382038568;24525.26424207205;38526.80736596299;43240.56759432366;44456.22069130992;47241.52758472371;48373;36992.81503592465;37180;38137.80931095327;38294.234115316984;38924;37350.25299494049;37372.43941340937;37556.9343686089;38003.61996380001;38272;36993;37086.072848179014;37595.81202093972;38117.23765524729;38256.23487530289;32766.83616581902;34331.82834085914;34435.4834677475;35081.82459087688;35173;26099.869500652374;26305.868470657526;26449;26609.33476663099;26713.599296010965 17:06:03 INFO - PROCESS | 3372 | |2;jquery.html;368.59638695628286;379.4497977931998;382.55432421229267;382.6689913225061;390.9198614284072;16053.51839444817;17722.556936076606;17925.372611958584;17942.28230870767;17987.571677823507;15702.293396797142;16151.596210094753;16161.434349797759;16162.35350585978;16350.83649163511;4579.267317229244;4818.542238487338;4841.661083724141;4849.927251091236;4853.684510506823;3454.240067185215;5232.319798426218;5449.209864569635;5523.944760552383;5620.887582248352;5525.143602741561;5568.415316391782;5579.38626751057;5585.441455854423;5596.188552659883;5281.234221037928;5401.837944861661;5612.9158062628885;5614.691191984439;5615.213870058195;3388.1868351595685;3529.047157267549;3531.5585551806025;3534.3814832404228;5118.360204974379;12807.487700491969;13321.467141314335;13361.933190333986;16332.918335408365;21118.26086086995;1884.5571290746664;1886.2549293029315;1894.5168981909662;2011.9698204526944;2039.1945181653311;8988.550572471415;9153.908460915372;9278.675246366345;9863.90136098637;9899.950500247525;1686.4097565851976;1761.11944027986;1788.8658350623625;1834.4404956488265;1874.9906250468796;69862.30137698608;71730;72861.6356918212;74006.62996685036;75715.24284757137;10008.949955250177;10097.444640544694;10208;10242.283040187116;10494.790104197873;14210.218437985803;14347.497837575844;14362.353694083791;14459.78310325346;14469.92765036168;7027.016217729522;7096.7516136934955;7265.782026539212;7267.30960558746;7428.888566671504;6704.731810727516;6740.191177058687;6765.797026089225;6851.2806155353965;6919.827004324932;4524.16302983949;4525.456945166536;4531.478879928851;4550.49944506104;4592.2193227151465;1708.6241026974046;1771.5659663382553;1859.6982112521289;1862.2830210368834;1877.774667039964;884.3014018924977;951.3768481644533;963.1139351796364;989.4854675568664;1010.4846528270635;16229.2696828643;16625.251863666163;16716.331346746236;17082.23129959155;17303.91348043277;915.1717695485596;928.928489468489;948.606328373731;958.4441024205944;997.7755005123789;8677.56612169389;9393.76515587102;9721.951390243003;9772.21822254218;9894.208463322917;304079;309717;311562;415617;425474;79488.60255698685;83834.58082709547;83850.58074709709;86117;87127.56436217905;929.4748467116193;932.4079209701753;969.2343048991359;971.4025874087386;975.6633961283488;15614.141222232885;15640.2961866714;15665;15951.122688251793;15969.44106956251;35488.82255588809;36620;37584.812075939444;37636.435453467675;37669.81165094157;49611;50554.74722626364;50825.23762143645;51052.23421648604;51109.744451277504;7598.430117741081;7880;7980.162082981204;7981.8403631928195;8087.110417854149;8155.632996515053;8798.736037918872;11606;11645.941770291094;11682.70793230176;10166;10274.33216840903;10286.177105831664;10320.948395257976;10539.94730026345;9907.405555666683;10081.395116293046;10274.280800344202;10295.485225738534;10387;9950.900490994998;10379.84430233532;10588.311759735592;10592.841107383241;10602.787944241227;7565.810854728676;7693.807654808675;7956.283934445696;8029.678812847421;8102.4328297021;7999.160088190656;9221.492817894812;10152.289339746443;10259.384436933808;10931.508082136483 17:06:03 INFO - PROCESS | 3372 | |3;mootools.html;1312.7308901675158;1505.5107090195686;1521.855423734745;1688.3921788156263;1843.3824668735972;6733.461323094153;7616.466847320683;7807.843843123134;7817.648205830737;8037.91962080379;7761.922380776191;7906.92093079069;7913.643886025128;7919.920800791991;7922.643481043352;2236.586231547161;2262.0047179241083;2266.150193677371;2267.1951457232694;2269.341890851659;2217.9001944912516;2232.9776702232934;2271.716035495563;2272.8863556822175;2275.7951784339407;2233.7825884892773;2253.785890340423;2258.6047441697638;2270.8751018694047;2273.57938781326;2149.3337065509586;2161.546075324176;2162.7080344153574;2166.0685905060977;2170.913163473459;2163.350994701583;2163.707899433572;2170.338046895712;2172.055156007142;2173.3262688566597;7658.693652253904;7743.612819359066;7790.45466817323;7794.72718454857;7891.881621775678;4469.08383781324;4645.024544845586;4648.3957085578995;4649.302604609302;4652.604528615038;2911.69427210142;2917.9708202918123;2928.5899974003655;2940.808847424932;3012.653544842349;932.5943214701626;944.3767113704922;975.2052077556768;976.6386437018277;981.1218959031698;10573.577056917791;10766.946165269124;10827.133829293638;10835.51240194193;10858.294210876267;4261.147770445861;4367.890802729894;4411.2721400968485;4451.354553589711;4456.286994080931;9143.222826059859;9202.585883635253;9239.214666753267;9242.07579242084;9243.214326782165;4712.976435117803;4789.664723469324;4792.424909010941;4793.760311984387;4801.807927682854;3756.3050835595504;3799.1072098056934;4142.544320124784;4406.845760398371;4412.514623391425;3707.8516859325864;3810.923781524354;3868.303705333011;3890.5914878937306;3898.688104951597;1204.0548169686754;1223.8592561855323;1245.0910835090435;1249.537671061713;1261.7476504699098;876.5047748022347;913.1735779119907;919.6597259014208;937.2876613773581;939.2486011191156;5277.261183434322;5389.02997460453;5395;5405.972970135124;5431.592630552725;981.3866333541537;997.670768646345;1017.699778565325;1018.0684673523791;1042.3016578892161;3412.4198886189406;3453.4301840196085;3540.929181416357;3566.1619519412916;3681.7975011374097;9478.57346419399;9652.855207171899;9792.069753373418;9806.558704858298;9811.852822207673;9681.612735490642;9685.6610018649;9694.51527423626;9701.369410988264;9709;7307.926920730724;7336.156342020629;7460.738874139379;7476.962615186889;7527.3225409712295;5187.24784906179;5229.088602073798;5230.34620672416;5322.361316642027;5329.680219186861;8955.462672239686;8963.865542016745;9076.636934522545;9084.137006984325;9104.362694611315;8463.53450560225;8759.16787905148;8777.91222087771;9021.233195178484;9081.409708368936;6049.818505444844;6891.069705589681;6962.060121883481;6988.615626140611;7161.785146445615;7280.890786638311;7472.439567032386;7495.812604684927;7543.8491230173995;7552.811179720551;6466.612003279818;6653.401193892573;6700.564463309869;6798.490113241625;6863.142107236596;6551.344865513411;6563.442107420923;6610.9669451652435;6631.801045968628;6643.335666433318;6135.7238924249405;6209.906851397323;6224.62652240867;6248.094026366242;6251.78118765841;4253.851115210953;4388.858896686948;4404.757738324423;4459.397981272617;4500.459944806644;4671.883202919954;4676.275177347517;4704.976475117603;4731.9763401184155;4732.124556956974 17:06:03 INFO - PROCESS | 3372 | |4;prototype.html;302.42388250383027;305.29629204683204;311.2234973740517;322.31347230399246;322.4373468297821;4593;4711.505291944348;4743.857684269469;4801.255805350176;4804.807807687693;4548.226801443754;4671.159191345565;4678.806904239423;4687.789049492772;4693.366395536602;3701.648343407372;3710.9628903710886;3718.3864662330684;3726.273376691546;3736.271427071722;3541.4156664150382;3594.8202589870534;3687.926241475169;3716.739828212026;3738.1776009277914;3681.558213014442;3704.907377315562;3711.552494527137;3719.7396182267253;3722.4044152935535;3700.2969435807245;3711.795851228181;3721.981390093046;3722.255548890206;3729.757565758217;3319.5850518685165;3328.700416962485;3329.8501567429525;3330.4171769940162;3340.5657264555452;4385.7149285296355;4581.770911454414;4585.638396225946;4607.562281583244;4653.162430762462;4275.3800698898485;4292.7209731367675;4298.161858437606;4299.634531064863;4300.311950088002;4907.901841963177;4942.456329803718;4948.87627809304;4984.87537811554;4989.251612258154;3570.768085010667;3629.4192929131214;3650.1787097903025;3652.214773823641;3653.8355773990234;5093.14100353372;5126.769295381717;5138.820141295074;5159.374796938915;5162.392991539286;3722.516072910504;3730.757500762442;3738.5513738351574;3746.2882052409955;3783.621637836194;3803.1633040730994;3803.2773772983596;3808.7524310919703;3818.427235914635;3819.4843696101225;4039.9596004040172;4238.809253583596;4257.914841703148;4260.510041345223;4271.312831431629;4917.827876024322;4946.614947814618;4952.752362381866;4974.5771609413605;4982.327385802942;1244.3778110944527;1291.7222797098668;1312.6455856918578;1314.566193156256;1329.2888304757103;864.818388138498;872.1452976083347;881.0264657553439;883.6686242659002;889.8976617688919;3941.994791328193;3953.7627742334976;4003.5996400360314;4009.474031360224;4012.1574469361763;4508.684392092588;4531.546845315508;4538.228501154812;4563.9087218255445;4567.200739870509;3952.7628342299554;3980.283548961215;4027.489691365738;4033.7176397651883;4068.7558746475306;2300.8078761811366;2420.4674971506242;2449.358929517228;2451.8283720139775;2456.459578892641;4332.241857674894;4337.37108119321;4340.110277393127;4393.319035549495;4409.933850992237;4641.816336834086;4649.488556258809;4675.298705194248;4678.929816052762;4710.24636058229;4174.248635245624;4370.278903980871;4371.409859668904;4373.212821692063;4375.584319489643;4516.299973504112;4581.404417425713;4588.839390621312;4601.608863246662;4603.424571928509;4370.295584721897;4412.294032954712;4430.778461076869;4457.030411091545;4495.52796956328;4107.870335657718;4278.994436307527;4303.806328715153;4305.921266294615;4357.477102747691;3424.520567120655;3436.862525498952;3459.6161535386045;3459.913502162466;3478.4086705260675;4511.774411279489;4584.381108550437;4601.976990115028;4604.21728306182;4902.612162114959;4785.641076919314;4941.234108713155;4951.257311403318;4959.652824302409;4970.428400733962;4932.03825254072;4933.432655244693;4943.332650092335;4950.702957822542;4962.826301079445;4776.283557466408;4852.95147048525;4867.342908707279;4883.413990321042;4904.730239836843;4942.517244826466;4974.527419895104;5012.373453318335;5012.598992080552;5015.17249653803;4865.099956508057;4876.146674332049;4876.780544875418;4883.487233840396;4890.877728056827 17:06:03 INFO - PROCESS | 3372 | |5;yui.html;623.5884316351207;648.5492582655055;733.1458850439238;742.5693098003159;767.9462437629364;11084.889151108506;11134.443277836117;11251.549938002481;12858.742825143503;13276.933615331922;12391.194572352792;13459.865401345984;13897.444102235899;13921.02552821303;14165.78751318731;683.2450142592413;834.2408408348405;866.2766589897427;870.6647940542905;874.4490970688457;861.3970220845401;870.1733353314345;870.8345414371249;871.0723079919896;871.5119533061475;905.597009330848;909.3043821476575;909.9818003639956;910.1717437132211;910.2263076385053;710.4245561095503;875.829213303406;900.6037343568875;902.4089221559889;902.873597696323;664.2095905871997;664.5447868210291;664.7374287156595;664.8038828545591;665.0523004718257;12392.256464612063;12446.25322480645;12453.93773031129;12462.81305780414;12476.625701228886;11705.122115841346;12037.93981030098;12095.153339266255;12161.331126788024;12425.31660758658;10969.616063437821;11170.609028683957;11376.089912807038;11453.255538389978;11631.360275184861;3960.089179488734;4033.1127152026506;4040.6363427291685;4053.4527838741687;4189.455370801807;48326.516734832556;48402;48473.99999999965;48749;48853;9985.251106167067;10184.185265178769;10225.437600931871;10282.794344113076;10556.841647375295;17299.13504324779;17309.56726081858;17332.480025599252;17336.219870105877;17345.653086938444;6753.898691519631;6765.052892594942;6804.183497980175;6807.047013418125;6961.060256865359;3540.4866294387684;3630.5643322801434;3683.686886614614;3697.2975134724315;3701.3522633539023;2718.103026001415;2802.369466869938;2809.3819359740824;2817.943641127166;2819.2669905824223;501.5110267489169;505.1765622036131;508.3416975017361;509.6050560815398;517.4644243208261;481.674869463118;488.3407400009958;561.0378201384644;572.5991805736002;601.7863658401292;7813.335866451415;7863.685452581833;7927.167647397056;7999.920487807228;8140.5929703514585;563.3521450332069;584.6083124306725;593.7535922592162;598.7485256192409;603.9396060393925;3675.5221821163614;3679.2641471705765;3748.1379282765115;3798.9430158547643;3869.9226015480094;50284;51879;51932;56098;57053.71473142691;45593.316100258526;47324.5267547327;50713;50728.74635626872;51933.74033129886;47655.28517072247;48235.03529929382;48424.273635895486;48933;50538.494615054115;8491.363147764067;8523.95738021306;8530.402871799162;8640.524771137396;8675.913240867763;31580.684193157773;31842.6815731849;32608.184795380304;32868.50697239591;33824.49263261004;38940.41589376218;39883.40174897437;42087;42093.78953105337;42233;9120.771980700536;10919.727006824893;11115.110791136527;11248.718782030515;11328.093752499615;12292.38538073075;12579.622611321674;12732.936335318635;13247.536336228186;13263.403146858222;10720.678379648623;11028.28316159447;11389.316641001566;12156.331401772988;12495.250284982567;11755.47100380502;11795;12067.215630983957;12183.390830458618;12502.624921252376;11389.544418223179;11464.656060318204;11499.597514087302;12077.094217933514;12252.693682657648;9962.302638815214;10026;10394.844077338998;10448.68653940383;10477.895221047693;10106;10305.484725763532;10329.535170917177;10337.995977783014;10378.273520853469 17:06:03 INFO - PROCESS | 3372 | __end_tp_report 17:06:03 INFO - PROCESS | 3372 | __start_cc_report 17:06:03 INFO - PROCESS | 3372 | _x_x_mozilla_cycle_collect,921 17:06:03 INFO - PROCESS | 3372 | __end_cc_report 17:06:03 INFO - PROCESS | 3372 | __startTimestamp1463616363810__endTimestamp 17:06:03 INFO - PROCESS | 3372 | 17:06:03 INFO - PROCESS | 3372 | ------- Summary: start ------- 17:06:03 INFO - PROCESS | 3372 | Number of tests: 6 17:06:03 INFO - PROCESS | 3372 | 17:06:03 INFO - PROCESS | 3372 | [#0] dojo.html Cycles:165 Average:4755.00 Median:4885.78 stddev:504.37 (10.3%) stddev-sans-first:479.41 17:06:03 INFO - PROCESS | 3372 | Values: 2697.9 2709.1 2717.9 2723.6 2755.4 4715.2 4744.1 4803.8 4833.6 4897.8 4752.6 4772.1 4775.0 4806.6 4815.4 4304.2 4352.0 4383.1 4434.9 4516.0 4438.5 4450.6 4478.2 4498.8 4528.0 4295.7 4299.2 4343.8 4351.0 4374.7 4317.0 4360.6 4364.3 4384.1 4482.2 4408.3 4415.8 4417.6 4459.7 4460.6 4559.4 4654.9 4745.9 4796.2 4802.8 5116.6 5126.2 5183.9 5185.1 5195.8 5114.5 5200.7 5216.4 5218.8 5223.5 4721.5 4785.6 4799.6 4840.0 4849.2 5295.8 5321.8 5365.5 5376.8 5378.2 5102.1 5113.6 5154.1 5154.8 5166.1 4993.6 5066.9 5110.7 5126.7 5164.1 5082.7 5086.3 5096.6 5097.2 5141.4 5069.8 5073.4 5077.2 5080.1 5088.7 4212.8 4242.6 4244.4 4296.2 4296.6 3759.2 3792.9 3799.2 3803.0 3833.3 4484.6 4488.5 4491.2 4530.5 4532.1 5150.2 5170.9 5173.3 5174.1 5179.7 4341.9 4415.4 4461.0 4465.9 4482.0 4612.8 4618.1 4619.5 4620.9 4670.0 4753.8 4868.5 4878.2 4879.2 4925.9 5093.7 5152.9 5160.4 5252.0 5252.3 4843.9 4879.5 4890.1 4891.5 4941.5 5064.5 5068.4 5074.5 5076.7 5132.1 4961.8 5130.0 5134.9 5179.7 5215.5 5049.9 5063.0 5065.3 5065.8 5117.1 4885.8 5057.8 5070.9 5076.1 5076.2 4886.5 4894.9 4936.1 4984.3 5008.6 5045.6 5050.7 5052.9 5066.5 5105.5 4803.4 4859.0 4945.0 4966.7 5017.0 17:06:03 INFO - PROCESS | 3372 | 17:06:03 INFO - PROCESS | 3372 | [#1] ext.html Cycles:180 Average:49843.38 Median:37576.37 stddev:90656.30 (241.3%) stddev-sans-first:90835.09 17:06:03 INFO - PROCESS | 3372 | Values: 556.6 597.4 606.4 607.8 610.6 28202.0 30804.7 30880.1 41351.2 42335.8 43334.0 43628.3 43778.6 43814.8 43911.3 7966.5 8133.2 8138.8 8139.3 8140.7 7945.4 8122.9 8124.4 8124.4 8128.1 8108.4 8174.0 8174.1 8179.2 8179.8 8072.7 8124.8 8147.4 8149.3 8154.0 8002.5 8100.4 8117.8 8118.6 8124.5 40284.4 40550.8 40613.0 40696.6 40733.4 3315.6 3369.3 3452.3 3508.4 3576.8 30109.2 30158.5 30602.1 30651.8 30756.0 3380.6 3451.3 3479.1 3495.1 3583.2 288667.0 288785.0 289096.0 289215.0 289650.0 55190.7 55263.4 55586.7 55791.7 55826.0 59230.7 59298.7 59366.4 59450.0 59530.0 15113.8 15339.0 15345.7 15352.8 15366.1 11224.2 11289.9 11293.5 11396.8 11404.5 15165.8 16202.6 16207.3 16234.1 16265.8 5117.0 5952.2 5994.0 6060.9 6143.0 885.7 921.8 983.0 1039.5 1081.1 29101.0 29757.6 31259.2 31422.8 33288.2 993.4 1004.0 1068.3 1089.7 1136.5 14878.7 15051.5 15342.9 15515.5 15536.8 412195.0 413959.0 416571.0 418586.0 418626.0 50404.0 50472.0 50523.7 50540.7 50606.0 1173.4 1245.6 1285.5 1292.8 1294.7 28020.3 29526.0 29579.7 29839.1 30356.5 42375.8 43038.0 43056.1 43080.6 43104.0 308157.0 313231.0 315567.0 316176.0 316400.0 22593.3 23257.8 23273.7 24487.3 24525.3 38526.8 43240.6 44456.2 47241.5 48373.0 36992.8 37180.0 38137.8 38294.2 38924.0 37350.3 37372.4 37556.9 38003.6 38272.0 36993.0 37086.1 37595.8 38117.2 38256.2 32766.8 34331.8 34435.5 35081.8 35173.0 26099.9 26305.9 26449.0 26609.3 26713.6 17:06:03 INFO - PROCESS | 3372 | 17:06:03 INFO - PROCESS | 3372 | [#2] jquery.html Cycles:180 Average:23383.81 Median:4524.81 stddev:59612.56 (1317.5%) stddev-sans-first:59754.75 17:06:03 INFO - PROCESS | 3372 | Values: 368.6 379.4 382.6 382.7 390.9 16053.5 17722.6 17925.4 17942.3 17987.6 15702.3 16151.6 16161.4 16162.4 16350.8 4579.3 4818.5 4841.7 4849.9 4853.7 3454.2 5232.3 5449.2 5523.9 5620.9 5525.1 5568.4 5579.4 5585.4 5596.2 5281.2 5401.8 5612.9 5614.7 5615.2 3388.2 3529.0 3531.6 3534.4 5118.4 12807.5 13321.5 13361.9 16332.9 21118.3 1884.6 1886.3 1894.5 2012.0 2039.2 8988.6 9153.9 9278.7 9863.9 9900.0 1686.4 1761.1 1788.9 1834.4 1875.0 69862.3 71730.0 72861.6 74006.6 75715.2 10008.9 10097.4 10208.0 10242.3 10494.8 14210.2 14347.5 14362.4 14459.8 14469.9 7027.0 7096.8 7265.8 7267.3 7428.9 6704.7 6740.2 6765.8 6851.3 6919.8 4524.2 4525.5 4531.5 4550.5 4592.2 1708.6 1771.6 1859.7 1862.3 1877.8 884.3 951.4 963.1 989.5 1010.5 16229.3 16625.3 16716.3 17082.2 17303.9 915.2 928.9 948.6 958.4 997.8 8677.6 9393.8 9722.0 9772.2 9894.2 304079.0 309717.0 311562.0 415617.0 425474.0 79488.6 83834.6 83850.6 86117.0 87127.6 929.5 932.4 969.2 971.4 975.7 15614.1 15640.3 15665.0 15951.1 15969.4 35488.8 36620.0 37584.8 37636.4 37669.8 49611.0 50554.7 50825.2 51052.2 51109.7 7598.4 7880.0 7980.2 7981.8 8087.1 8155.6 8798.7 11606.0 11645.9 11682.7 10166.0 10274.3 10286.2 10320.9 10539.9 9907.4 10081.4 10274.3 10295.5 10387.0 9950.9 10379.8 10588.3 10592.8 10602.8 7565.8 7693.8 7956.3 8029.7 8102.4 7999.2 9221.5 10152.3 10259.4 10931.5 17:06:03 INFO - PROCESS | 3372 | 17:06:03 INFO - PROCESS | 3372 | [#3] mootools.html Cycles:180 Average:5179.58 Median:5253.80 stddev:2864.80 (54.5%) stddev-sans-first:2858.09 17:06:03 INFO - PROCESS | 3372 | Values: 1312.7 1505.5 1521.9 1688.4 1843.4 6733.5 7616.5 7807.8 7817.6 8037.9 7761.9 7906.9 7913.6 7919.9 7922.6 2236.6 2262.0 2266.2 2267.2 2269.3 2217.9 2233.0 2271.7 2272.9 2275.8 2233.8 2253.8 2258.6 2270.9 2273.6 2149.3 2161.5 2162.7 2166.1 2170.9 2163.4 2163.7 2170.3 2172.1 2173.3 7658.7 7743.6 7790.5 7794.7 7891.9 4469.1 4645.0 4648.4 4649.3 4652.6 2911.7 2918.0 2928.6 2940.8 3012.7 932.6 944.4 975.2 976.6 981.1 10573.6 10766.9 10827.1 10835.5 10858.3 4261.1 4367.9 4411.3 4451.4 4456.3 9143.2 9202.6 9239.2 9242.1 9243.2 4713.0 4789.7 4792.4 4793.8 4801.8 3756.3 3799.1 4142.5 4406.8 4412.5 3707.9 3810.9 3868.3 3890.6 3898.7 1204.1 1223.9 1245.1 1249.5 1261.7 876.5 913.2 919.7 937.3 939.2 5277.3 5389.0 5395.0 5406.0 5431.6 981.4 997.7 1017.7 1018.1 1042.3 3412.4 3453.4 3540.9 3566.2 3681.8 9478.6 9652.9 9792.1 9806.6 9811.9 9681.6 9685.7 9694.5 9701.4 9709.0 7307.9 7336.2 7460.7 7477.0 7527.3 5187.2 5229.1 5230.3 5322.4 5329.7 8955.5 8963.9 9076.6 9084.1 9104.4 8463.5 8759.2 8777.9 9021.2 9081.4 6049.8 6891.1 6962.1 6988.6 7161.8 7280.9 7472.4 7495.8 7543.8 7552.8 6466.6 6653.4 6700.6 6798.5 6863.1 6551.3 6563.4 6611.0 6631.8 6643.3 6135.7 6209.9 6224.6 6248.1 6251.8 4253.9 4388.9 4404.8 4459.4 4500.5 4671.9 4676.3 4705.0 4732.0 4732.1 17:06:03 INFO - PROCESS | 3372 | 17:06:03 INFO - PROCESS | 3372 | [#4] prototype.html Cycles:180 Average:3988.80 Median:4370.85 stddev:1125.26 (25.7%) stddev-sans-first:1093.87 17:06:03 INFO - PROCESS | 3372 | Values: 302.4 305.3 311.2 322.3 322.4 4593.0 4711.5 4743.9 4801.3 4804.8 4548.2 4671.2 4678.8 4687.8 4693.4 3701.6 3711.0 3718.4 3726.3 3736.3 3541.4 3594.8 3687.9 3716.7 3738.2 3681.6 3704.9 3711.6 3719.7 3722.4 3700.3 3711.8 3722.0 3722.3 3729.8 3319.6 3328.7 3329.9 3330.4 3340.6 4385.7 4581.8 4585.6 4607.6 4653.2 4275.4 4292.7 4298.2 4299.6 4300.3 4907.9 4942.5 4948.9 4984.9 4989.3 3570.8 3629.4 3650.2 3652.2 3653.8 5093.1 5126.8 5138.8 5159.4 5162.4 3722.5 3730.8 3738.6 3746.3 3783.6 3803.2 3803.3 3808.8 3818.4 3819.5 4040.0 4238.8 4257.9 4260.5 4271.3 4917.8 4946.6 4952.8 4974.6 4982.3 1244.4 1291.7 1312.6 1314.6 1329.3 864.8 872.1 881.0 883.7 889.9 3942.0 3953.8 4003.6 4009.5 4012.2 4508.7 4531.5 4538.2 4563.9 4567.2 3952.8 3980.3 4027.5 4033.7 4068.8 2300.8 2420.5 2449.4 2451.8 2456.5 4332.2 4337.4 4340.1 4393.3 4409.9 4641.8 4649.5 4675.3 4678.9 4710.2 4174.2 4370.3 4371.4 4373.2 4375.6 4516.3 4581.4 4588.8 4601.6 4603.4 4370.3 4412.3 4430.8 4457.0 4495.5 4107.9 4279.0 4303.8 4305.9 4357.5 3424.5 3436.9 3459.6 3459.9 3478.4 4511.8 4584.4 4602.0 4604.2 4902.6 4785.6 4941.2 4951.3 4959.7 4970.4 4932.0 4933.4 4943.3 4950.7 4962.8 4776.3 4853.0 4867.3 4883.4 4904.7 4942.5 4974.5 5012.4 5012.6 5015.2 4865.1 4876.1 4876.8 4883.5 4890.9 17:06:03 INFO - PROCESS | 3372 | 17:06:03 INFO - PROCESS | 3372 | [#5] yui.html Cycles:180 Average:13501.95 Median:4036.87 stddev:15433.31 (382.3%) stddev-sans-first:15446.30 17:06:03 INFO - PROCESS | 3372 | Values: 623.6 648.5 733.1 742.6 767.9 11084.9 11134.4 11251.5 12858.7 13276.9 12391.2 13459.9 13897.4 13921.0 14165.8 683.2 834.2 866.3 870.7 874.4 861.4 870.2 870.8 871.1 871.5 905.6 909.3 910.0 910.2 910.2 710.4 875.8 900.6 902.4 902.9 664.2 664.5 664.7 664.8 665.1 12392.3 12446.3 12453.9 12462.8 12476.6 11705.1 12037.9 12095.2 12161.3 12425.3 10969.6 11170.6 11376.1 11453.3 11631.4 3960.1 4033.1 4040.6 4053.5 4189.5 48326.5 48402.0 48474.0 48749.0 48853.0 9985.3 10184.2 10225.4 10282.8 10556.8 17299.1 17309.6 17332.5 17336.2 17345.7 6753.9 6765.1 6804.2 6807.0 6961.1 3540.5 3630.6 3683.7 3697.3 3701.4 2718.1 2802.4 2809.4 2817.9 2819.3 501.5 505.2 508.3 509.6 517.5 481.7 488.3 561.0 572.6 601.8 7813.3 7863.7 7927.2 7999.9 8140.6 563.4 584.6 593.8 598.7 603.9 3675.5 3679.3 3748.1 3798.9 3869.9 50284.0 51879.0 51932.0 56098.0 57053.7 45593.3 47324.5 50713.0 50728.7 51933.7 47655.3 48235.0 48424.3 48933.0 50538.5 8491.4 8524.0 8530.4 8640.5 8675.9 31580.7 31842.7 32608.2 32868.5 33824.5 38940.4 39883.4 42087.0 42093.8 42233.0 9120.8 10919.7 11115.1 11248.7 11328.1 12292.4 12579.6 12732.9 13247.5 13263.4 10720.7 11028.3 11389.3 12156.3 12495.3 11755.5 11795.0 12067.2 12183.4 12502.6 11389.5 11464.7 11499.6 12077.1 12252.7 9962.3 10026.0 10394.8 10448.7 10477.9 10106.0 10305.5 10329.5 10338.0 10378.3 17:06:03 INFO - PROCESS | 3372 | -------- Summary: end -------- 17:06:03 INFO - PROCESS | 3372 | 17:06:04 INFO - TEST-INFO | 3372: exit 0 17:06:04 INFO - TEST-OK | dromaeo_css | took 1119786ms 17:06:04 INFO - TEST-START | kraken 17:06:04 INFO - operating with platform_type : linux_ 17:06:04 INFO - Initialising browser for kraken test... 17:06:04 INFO - TEST-INFO | started process 3552 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMnhZT4/profile http://localhost:37225/getInfo.html) 17:06:08 INFO - PROCESS | 3552 | __metrics Screen width/height:1600/1200 17:06:08 INFO - PROCESS | 3552 | colorDepth:24 17:06:08 INFO - PROCESS | 3552 | Browser inner width/height: 1024/697 17:06:08 INFO - PROCESS | 3552 | __metrics 17:06:09 ERROR - PROCESS | 3552 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:06:10 INFO - TEST-INFO | 3552: exit 0 17:06:10 INFO - Browser initialized. 17:06:10 INFO - Running cycle 1/1 for kraken test... 17:06:10 INFO - TEST-INFO | started process 3631 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMnhZT4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:06:22 INFO - PROCESS | 3631 | RSS: Main: 154832896 17:06:22 INFO - PROCESS | 3631 | 17:06:25 INFO - PROCESS | 3631 | Cycle 1(1): loaded http://localhost:37225/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37225/tests/kraken/driver.html?testName=audio-beat-detection) 17:06:26 INFO - PROCESS | 3631 | RSS: Main: 210378752 17:06:26 INFO - PROCESS | 3631 | 17:06:29 INFO - PROCESS | 3631 | Cycle 1(1): loaded http://localhost:37225/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37225/tests/kraken/driver.html?testName=audio-dft) 17:06:29 INFO - PROCESS | 3631 | RSS: Main: 198823936 17:06:29 INFO - PROCESS | 3631 | 17:06:33 INFO - PROCESS | 3631 | Cycle 1(1): loaded http://localhost:37225/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37225/tests/kraken/driver.html?testName=audio-fft) 17:06:33 INFO - PROCESS | 3631 | RSS: Main: 267325440 17:06:33 INFO - PROCESS | 3631 | 17:06:35 INFO - PROCESS | 3631 | Cycle 1(1): loaded http://localhost:37225/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37225/tests/kraken/driver.html?testName=audio-oscillator) 17:06:36 INFO - PROCESS | 3631 | RSS: Main: 176672768 17:06:36 INFO - PROCESS | 3631 | 17:06:38 INFO - PROCESS | 3631 | Cycle 1(1): loaded http://localhost:37225/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37225/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:06:39 INFO - PROCESS | 3631 | RSS: Main: 180555776 17:06:39 INFO - PROCESS | 3631 | 17:06:42 INFO - PROCESS | 3631 | Cycle 1(1): loaded http://localhost:37225/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37225/tests/kraken/driver.html?testName=imaging-darkroom) 17:06:43 INFO - PROCESS | 3631 | RSS: Main: 215883776 17:06:43 INFO - PROCESS | 3631 | 17:06:47 INFO - PROCESS | 3631 | Cycle 1(1): loaded http://localhost:37225/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37225/tests/kraken/driver.html?testName=imaging-desaturate) 17:06:47 INFO - PROCESS | 3631 | RSS: Main: 214376448 17:06:47 INFO - PROCESS | 3631 | 17:06:50 INFO - PROCESS | 3631 | Cycle 1(1): loaded http://localhost:37225/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37225/tests/kraken/driver.html?testName=json-parse-financial) 17:06:51 INFO - PROCESS | 3631 | RSS: Main: 216064000 17:06:51 INFO - PROCESS | 3631 | 17:06:53 INFO - PROCESS | 3631 | Cycle 1(1): loaded http://localhost:37225/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37225/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:06:53 INFO - PROCESS | 3631 | RSS: Main: 208076800 17:06:53 INFO - PROCESS | 3631 | 17:06:55 INFO - PROCESS | 3631 | Cycle 1(1): loaded http://localhost:37225/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37225/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:06:56 INFO - PROCESS | 3631 | RSS: Main: 210694144 17:06:56 INFO - PROCESS | 3631 | 17:06:58 INFO - PROCESS | 3631 | Cycle 1(1): loaded http://localhost:37225/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37225/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:06:59 INFO - PROCESS | 3631 | RSS: Main: 216788992 17:06:59 INFO - PROCESS | 3631 | 17:07:02 INFO - PROCESS | 3631 | Cycle 1(1): loaded http://localhost:37225/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37225/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:07:02 INFO - PROCESS | 3631 | RSS: Main: 220688384 17:07:02 INFO - PROCESS | 3631 | 17:07:06 INFO - PROCESS | 3631 | Cycle 1(1): loaded http://localhost:37225/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37225/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:07:06 INFO - PROCESS | 3631 | RSS: Main: 219766784 17:07:06 INFO - PROCESS | 3631 | 17:07:08 INFO - PROCESS | 3631 | Cycle 1(1): loaded http://localhost:37225/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37225/tests/kraken/driver.html?testName=ai-astar) 17:07:08 INFO - PROCESS | 3631 | RSS: Main: 267075584 17:07:08 INFO - PROCESS | 3631 | 17:07:08 INFO - PROCESS | 3631 | __start_tp_report 17:07:08 INFO - PROCESS | 3631 | _x_x_mozilla_page_load 17:07:08 INFO - PROCESS | 3631 | _x_x_mozilla_page_load_details 17:07:08 INFO - PROCESS | 3631 | |i|pagename|runs| 17:07:08 INFO - PROCESS | 3631 | |0;ai-astar;113;106;113;113;112;111;113;114;113;114 17:07:08 INFO - PROCESS | 3631 | |1;audio-beat-detection;158;129;153;214;137;149;150;138;186;128 17:07:08 INFO - PROCESS | 3631 | |2;audio-dft;161;160;160;160;164;160;161;161;161;162 17:07:08 INFO - PROCESS | 3631 | |3;audio-fft;75;76;76;150;78;79;77;75;124;75 17:07:08 INFO - PROCESS | 3631 | |4;audio-oscillator;94;94;155;93;93;94;122;93;93;123 17:07:08 INFO - PROCESS | 3631 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;117;117 17:07:08 INFO - PROCESS | 3631 | |6;imaging-darkroom;147;147;146;146;146;147;146;146;146;146 17:07:08 INFO - PROCESS | 3631 | |7;imaging-desaturate;95;94;94;94;94;94;94;96;95;94 17:07:08 INFO - PROCESS | 3631 | |8;json-parse-financial;63;66;63;63;64;63;63;64;64;63 17:07:08 INFO - PROCESS | 3631 | |9;json-stringify-tinderbox;65;65;65;65;66;64;64;64;66;64 17:07:08 INFO - PROCESS | 3631 | |10;stanford-crypto-aes;82;82;88;85;81;88;82;82;156;84 17:07:08 INFO - PROCESS | 3631 | |11;stanford-crypto-ccm;130;129;127;134;125;126;135;126;150;131 17:07:08 INFO - PROCESS | 3631 | |12;stanford-crypto-pbkdf2;170;175;173;172;169;169;167;169;170;169 17:07:08 INFO - PROCESS | 3631 | |13;stanford-crypto-sha256-iterative;66;67;66;65;64;65;65;65;65;66 17:07:08 INFO - PROCESS | 3631 | __end_tp_report 17:07:08 INFO - PROCESS | 3631 | __start_cc_report 17:07:08 INFO - PROCESS | 3631 | _x_x_mozilla_cycle_collect,2119 17:07:08 INFO - PROCESS | 3631 | __end_cc_report 17:07:08 INFO - PROCESS | 3631 | __startTimestamp1463616428791__endTimestamp 17:07:08 INFO - PROCESS | 3631 | 17:07:08 INFO - PROCESS | 3631 | ------- Summary: start ------- 17:07:08 INFO - PROCESS | 3631 | Number of tests: 14 17:07:08 INFO - PROCESS | 3631 | 17:07:08 INFO - PROCESS | 3631 | [#0] ai-astar Cycles:10 Average:112.20 Median:113.00 stddev:2.35 (2.1%) stddev-sans-first:2.47 17:07:08 INFO - PROCESS | 3631 | Values: 113.0 106.0 113.0 113.0 112.0 111.0 113.0 114.0 113.0 114.0 17:07:08 INFO - PROCESS | 3631 | 17:07:08 INFO - PROCESS | 3631 | [#1] audio-beat-detection Cycles:10 Average:154.20 Median:151.50 stddev:26.93 (17.8%) stddev-sans-first:28.53 17:07:08 INFO - PROCESS | 3631 | Values: 158.0 129.0 153.0 214.0 137.0 149.0 150.0 138.0 186.0 128.0 17:07:08 INFO - PROCESS | 3631 | 17:07:08 INFO - PROCESS | 3631 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.25 (0.8%) stddev-sans-first:1.32 17:07:08 INFO - PROCESS | 3631 | Values: 161.0 160.0 160.0 160.0 164.0 160.0 161.0 161.0 161.0 162.0 17:07:08 INFO - PROCESS | 3631 | 17:07:08 INFO - PROCESS | 3631 | [#3] audio-fft Cycles:10 Average:88.50 Median:76.00 stddev:26.32 (34.6%) stddev-sans-first:27.46 17:07:08 INFO - PROCESS | 3631 | Values: 75.0 76.0 76.0 150.0 78.0 79.0 77.0 75.0 124.0 75.0 17:07:08 INFO - PROCESS | 3631 | 17:07:08 INFO - PROCESS | 3631 | [#4] audio-oscillator Cycles:10 Average:105.40 Median:93.00 stddev:21.21 (22.8%) stddev-sans-first:22.10 17:07:08 INFO - PROCESS | 3631 | Values: 94.0 94.0 155.0 93.0 93.0 94.0 122.0 93.0 93.0 123.0 17:07:08 INFO - PROCESS | 3631 | 17:07:08 INFO - PROCESS | 3631 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 17:07:08 INFO - PROCESS | 3631 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 17:07:08 INFO - PROCESS | 3631 | 17:07:08 INFO - PROCESS | 3631 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 17:07:08 INFO - PROCESS | 3631 | Values: 147.0 147.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 17:07:08 INFO - PROCESS | 3631 | 17:07:08 INFO - PROCESS | 3631 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 17:07:08 INFO - PROCESS | 3631 | Values: 95.0 94.0 94.0 94.0 94.0 94.0 94.0 96.0 95.0 94.0 17:07:08 INFO - PROCESS | 3631 | 17:07:08 INFO - PROCESS | 3631 | [#8] json-parse-financial Cycles:10 Average:63.60 Median:63.50 stddev:0.97 (1.5%) stddev-sans-first:1.00 17:07:08 INFO - PROCESS | 3631 | Values: 63.0 66.0 63.0 63.0 64.0 63.0 63.0 64.0 64.0 63.0 17:07:08 INFO - PROCESS | 3631 | 17:07:08 INFO - PROCESS | 3631 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 17:07:08 INFO - PROCESS | 3631 | Values: 65.0 65.0 65.0 65.0 66.0 64.0 64.0 64.0 66.0 64.0 17:07:08 INFO - PROCESS | 3631 | 17:07:08 INFO - PROCESS | 3631 | [#10] stanford-crypto-aes Cycles:10 Average:91.00 Median:83.00 stddev:22.98 (27.7%) stddev-sans-first:24.14 17:07:08 INFO - PROCESS | 3631 | Values: 82.0 82.0 88.0 85.0 81.0 88.0 82.0 82.0 156.0 84.0 17:07:08 INFO - PROCESS | 3631 | 17:07:08 INFO - PROCESS | 3631 | [#11] stanford-crypto-ccm Cycles:10 Average:131.30 Median:130.50 stddev:7.39 (5.7%) stddev-sans-first:7.83 17:07:08 INFO - PROCESS | 3631 | Values: 130.0 129.0 127.0 134.0 125.0 126.0 135.0 126.0 150.0 131.0 17:07:08 INFO - PROCESS | 3631 | 17:07:08 INFO - PROCESS | 3631 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.30 Median:170.00 stddev:2.36 (1.4%) stddev-sans-first:2.50 17:07:08 INFO - PROCESS | 3631 | Values: 170.0 175.0 173.0 172.0 169.0 169.0 167.0 169.0 170.0 169.0 17:07:08 INFO - PROCESS | 3631 | 17:07:08 INFO - PROCESS | 3631 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:65.50 stddev:0.84 (1.3%) stddev-sans-first:0.87 17:07:08 INFO - PROCESS | 3631 | Values: 66.0 67.0 66.0 65.0 64.0 65.0 65.0 65.0 65.0 66.0 17:07:08 INFO - PROCESS | 3631 | -------- Summary: end -------- 17:07:08 INFO - PROCESS | 3631 | 17:07:10 INFO - TEST-INFO | 3631: exit 0 17:07:10 INFO - TEST-OK | kraken | took 65950ms 17:07:10 INFO - SUITE-END | took 1185s 17:07:10 INFO - Completed test suite (00:19:46) 17:07:10 INFO - javascript benchmark 17:07:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2697.8785954632053, 2709.0924540279007, 2717.904873329434, 2723.645926029616, 2755.435135797162, 4715.1512727709, 4744.14605371033, 4803.783829727662, 4833.637477189216, 4897.779599918003, 4752.643551733625, 4772.117158325704, 4775.044991001805, 4806.639502037344, 4815.446223684277, 4304.2467568175525, 4352.020795321059, 4383.057642606839, 4434.911301773963, 4515.977420112895, 4438.511763705989, 4450.554944505556, 4478.216312145361, 4498.752568608726, 4528.04910968697, 4295.6778241632, 4299.161663475624, 4343.80452879618, 4350.978245108786, 4374.693771436001, 4317.0, 4360.585744354281, 4364.345348197796, 4384.079343337903, 4482.193205223059, 4408.250597398418, 4415.757133357664, 4417.646588272931, 4459.665525085599, 4460.598546130864, 4559.430071241095, 4654.930176047362, 4745.881352966204, 4796.184648609745, 4802.807887684488, 5116.641835071547, 5126.154184559543, 5183.870403239949, 5185.066687996159, 5195.792168313263, 5114.462981386975, 5200.713960732158, 5216.426193118754, 5218.76515556797, 5223.477652234784, 4721.504242054603, 4785.59322457595, 4799.568038876518, 4839.975800120977, 4849.248366503198, 5295.814646487354, 5321.760520776575, 5365.490278423544, 5376.838694839083, 5378.1932710093015, 5102.08162530748, 5113.642045056885, 5154.072266991978, 5154.845354639367, 5166.147585648401, 4993.575546078551, 5066.949330506722, 5110.744462776846, 5126.718030508283, 5164.096283150434, 5082.720450375265, 5086.338775959176, 5096.617753668415, 5097.158968770185, 5141.38303403594, 5069.797208111708, 5073.3911930568565, 5077.213031980049, 5080.110980578384, 5088.6946783193125, 4212.831486740496, 4242.575742425733, 4244.427002354642, 4296.2266791977745, 4296.613304802583, 3759.2293579816073, 3792.943105853414, 3799.2401519696173, 3802.961970380316, 3833.3100041992707, 4484.641228701696, 4488.506264310923, 4491.236489796743, 4530.456345238593, 4532.093581283756, 5150.227465880148, 5170.948290517122, 5173.275741396207, 5174.113578827923, 5179.663321884065, 4341.869743907688, 4415.381846541487, 4461.0, 4465.933011004838, 4481.977590112028, 4612.815487380467, 4618.145643056046, 4619.46876109245, 4620.884477888079, 4669.976650116796, 4753.83361582343, 4868.488808675109, 4878.170710979213, 4879.243717223836, 4925.87685307863, 5093.719845408538, 5152.948470515397, 5160.406553246425, 5252.028374750684, 5252.317198764136, 4843.903121937612, 4879.512048795092, 4890.095332363524, 4891.510848915223, 4941.456439791692, 5064.4935506449065, 5068.442471328077, 5074.543291103819, 5076.670016448919, 5132.12753831842, 4961.82633607822, 5129.9743501282255, 5134.871628209325, 5179.741012949413, 5215.530602245816, 5049.899002019865, 5062.974685126551, 5065.265536497261, 5065.848024559269, 5117.1300878851425, 4885.780139893643, 5057.848264552069, 5070.923936140887, 5076.086304465084, 5076.18780995039, 4886.462489126122, 4894.853154405374, 4936.062148191832, 4984.302197692398, 5008.649394542493, 5045.596352291735, 5050.671706339076, 5052.8989420210655, 5066.493350664904, 5105.489451054865, 4803.447603525639, 4859.0, 4945.0, 4966.652334336562, 5017.0216807722145], "value": 4722.851739457734, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.5547561950439, 597.4085655201351, 606.4057223920561, 607.7599348257442, 610.5787006965194, 28202.0, 30804.69195308049, 30880.073597792103, 41351.17297654045, 42335.788321058426, 43334.0, 43628.345574816405, 43778.562214377846, 43814.78092609532, 43911.34132988008, 7966.522008679469, 8133.227343402397, 8138.75583732486, 8139.267465928066, 8140.715074972377, 7945.364370850318, 8122.9187708123045, 8124.390670699691, 8124.431289809686, 8128.105908350077, 8108.432409731321, 8174.0, 8174.05998310193, 8179.222973817477, 8179.79550511239, 8072.677092916277, 8124.7562573122905, 8147.429679922408, 8149.307308878693, 8154.0, 8002.51984880909, 8100.392470564731, 8117.782332650149, 8118.553479558622, 8124.471909325875, 40284.39573406401, 40550.79724601388, 40613.0, 40696.59303406958, 40733.388999165036, 3315.602127744662, 3369.326134773031, 3452.3440546296374, 3508.438649816043, 3576.8211589420425, 30109.247268818453, 30158.50065065542, 30602.08193754191, 30651.846740766377, 30756.0, 3380.5943286805496, 3451.32699123671, 3479.0606536235327, 3495.07380544156, 3583.2475180212186, 288667.0, 288785.0, 289096.0, 289215.0, 289650.0, 55190.72404637951, 55263.447365526634, 55586.72206638941, 55791.721041394536, 55826.0, 59230.703846480494, 59298.703506483056, 59366.40633593609, 59450.0, 59530.0, 15113.773293400387, 15339.0, 15345.693086138215, 15352.846471535366, 15366.078035317916, 11224.158188135922, 11289.943550282196, 11293.54825806975, 11396.829047564293, 11404.543818247343, 15165.848341516665, 16202.59493512648, 16207.270672819752, 16234.107124108052, 16265.837341626433, 5116.974415127975, 5952.226210592682, 5993.962052901947, 6060.939390606038, 6142.969285153546, 885.6545947080643, 921.8064206516573, 982.9508524573743, 1039.4750650921387, 1081.1026847716375, 29100.9814656486, 29757.553636695466, 31259.21851953674, 31422.842885785423, 33288.1677958053, 993.4039576254335, 1003.9548220330103, 1068.3429690740138, 1089.7112265249716, 1136.534021051365, 14878.70242595142, 15051.548453546411, 15342.923285383502, 15515.534533963999, 15536.844631553766, 412195.0, 413959.0, 416571.0, 418586.0, 418626.0, 50404.0, 50472.0, 50523.74738126286, 50540.74729626402, 50606.0, 1173.4074292482412, 1245.5951815659946, 1285.479380850757, 1292.8319318488725, 1294.6828027133413, 28020.29949251285, 29526.0, 29579.704202957695, 29839.10482685523, 30356.544651829798, 42375.78812106043, 43037.99999999875, 43056.13887722165, 43080.56919430891, 43104.0, 308157.0, 313231.0, 315567.0, 316176.0, 316400.0, 22593.322200334016, 23257.767422326237, 23273.650895236246, 24487.265382038568, 24525.26424207205, 38526.80736596299, 43240.56759432366, 44456.22069130992, 47241.52758472371, 48373.0, 36992.81503592465, 37180.0, 38137.80931095327, 38294.234115316984, 38924.0, 37350.25299494049, 37372.43941340937, 37556.9343686089, 38003.61996380001, 38272.0, 36993.0, 37086.072848179014, 37595.81202093972, 38117.23765524729, 38256.23487530289, 32766.83616581902, 34331.82834085914, 34435.4834677475, 35081.82459087688, 35173.0, 26099.869500652374, 26305.868470657526, 26449.0, 26609.33476663099, 26713.599296010965], "value": 18111.65137446059, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.59638695628286, 379.4497977931998, 382.55432421229267, 382.6689913225061, 390.9198614284072, 16053.51839444817, 17722.556936076606, 17925.372611958584, 17942.28230870767, 17987.571677823507, 15702.293396797142, 16151.596210094753, 16161.434349797759, 16162.35350585978, 16350.83649163511, 4579.267317229244, 4818.542238487338, 4841.661083724141, 4849.927251091236, 4853.684510506823, 3454.240067185215, 5232.319798426218, 5449.209864569635, 5523.944760552383, 5620.887582248352, 5525.143602741561, 5568.415316391782, 5579.38626751057, 5585.441455854423, 5596.188552659883, 5281.234221037928, 5401.837944861661, 5612.9158062628885, 5614.691191984439, 5615.213870058195, 3388.1868351595685, 3529.047157267549, 3531.5585551806025, 3534.3814832404228, 5118.360204974379, 12807.487700491969, 13321.467141314335, 13361.933190333986, 16332.918335408365, 21118.26086086995, 1884.5571290746664, 1886.2549293029315, 1894.5168981909662, 2011.9698204526944, 2039.1945181653311, 8988.550572471415, 9153.908460915372, 9278.675246366345, 9863.90136098637, 9899.950500247525, 1686.4097565851976, 1761.11944027986, 1788.8658350623625, 1834.4404956488265, 1874.9906250468796, 69862.30137698608, 71730.0, 72861.6356918212, 74006.62996685036, 75715.24284757137, 10008.949955250177, 10097.444640544694, 10208.0, 10242.283040187116, 10494.790104197873, 14210.218437985803, 14347.497837575844, 14362.353694083791, 14459.78310325346, 14469.92765036168, 7027.016217729522, 7096.7516136934955, 7265.782026539212, 7267.30960558746, 7428.888566671504, 6704.731810727516, 6740.191177058687, 6765.797026089225, 6851.2806155353965, 6919.827004324932, 4524.16302983949, 4525.456945166536, 4531.478879928851, 4550.49944506104, 4592.2193227151465, 1708.6241026974046, 1771.5659663382553, 1859.6982112521289, 1862.2830210368834, 1877.774667039964, 884.3014018924977, 951.3768481644533, 963.1139351796364, 989.4854675568664, 1010.4846528270635, 16229.2696828643, 16625.251863666163, 16716.331346746236, 17082.23129959155, 17303.91348043277, 915.1717695485596, 928.928489468489, 948.606328373731, 958.4441024205944, 997.7755005123789, 8677.56612169389, 9393.76515587102, 9721.951390243003, 9772.21822254218, 9894.208463322917, 304079.0, 309717.0, 311562.0, 415617.0, 425474.0, 79488.60255698685, 83834.58082709547, 83850.58074709709, 86117.0, 87127.56436217905, 929.4748467116193, 932.4079209701753, 969.2343048991359, 971.4025874087386, 975.6633961283488, 15614.141222232885, 15640.2961866714, 15665.0, 15951.122688251793, 15969.44106956251, 35488.82255588809, 36620.0, 37584.812075939444, 37636.435453467675, 37669.81165094157, 49611.0, 50554.74722626364, 50825.23762143645, 51052.23421648604, 51109.744451277504, 7598.430117741081, 7880.0, 7980.162082981204, 7981.8403631928195, 8087.110417854149, 8155.632996515053, 8798.736037918872, 11606.0, 11645.941770291094, 11682.70793230176, 10166.0, 10274.33216840903, 10286.177105831664, 10320.948395257976, 10539.94730026345, 9907.405555666683, 10081.395116293046, 10274.280800344202, 10295.485225738534, 10387.0, 9950.900490994998, 10379.84430233532, 10588.311759735592, 10592.841107383241, 10602.787944241227, 7565.810854728676, 7693.807654808675, 7956.283934445696, 8029.678812847421, 8102.4328297021, 7999.160088190656, 9221.492817894812, 10152.289339746443, 10259.384436933808, 10931.508082136483], "value": 8122.557049949643, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1312.7308901675158, 1505.5107090195686, 1521.855423734745, 1688.3921788156263, 1843.3824668735972, 6733.461323094153, 7616.466847320683, 7807.843843123134, 7817.648205830737, 8037.91962080379, 7761.922380776191, 7906.92093079069, 7913.643886025128, 7919.920800791991, 7922.643481043352, 2236.586231547161, 2262.0047179241083, 2266.150193677371, 2267.1951457232694, 2269.341890851659, 2217.9001944912516, 2232.9776702232934, 2271.716035495563, 2272.8863556822175, 2275.7951784339407, 2233.7825884892773, 2253.785890340423, 2258.6047441697638, 2270.8751018694047, 2273.57938781326, 2149.3337065509586, 2161.546075324176, 2162.7080344153574, 2166.0685905060977, 2170.913163473459, 2163.350994701583, 2163.707899433572, 2170.338046895712, 2172.055156007142, 2173.3262688566597, 7658.693652253904, 7743.612819359066, 7790.45466817323, 7794.72718454857, 7891.881621775678, 4469.08383781324, 4645.024544845586, 4648.3957085578995, 4649.302604609302, 4652.604528615038, 2911.69427210142, 2917.9708202918123, 2928.5899974003655, 2940.808847424932, 3012.653544842349, 932.5943214701626, 944.3767113704922, 975.2052077556768, 976.6386437018277, 981.1218959031698, 10573.577056917791, 10766.946165269124, 10827.133829293638, 10835.51240194193, 10858.294210876267, 4261.147770445861, 4367.890802729894, 4411.2721400968485, 4451.354553589711, 4456.286994080931, 9143.222826059859, 9202.585883635253, 9239.214666753267, 9242.07579242084, 9243.214326782165, 4712.976435117803, 4789.664723469324, 4792.424909010941, 4793.760311984387, 4801.807927682854, 3756.3050835595504, 3799.1072098056934, 4142.544320124784, 4406.845760398371, 4412.514623391425, 3707.8516859325864, 3810.923781524354, 3868.303705333011, 3890.5914878937306, 3898.688104951597, 1204.0548169686754, 1223.8592561855323, 1245.0910835090435, 1249.537671061713, 1261.7476504699098, 876.5047748022347, 913.1735779119907, 919.6597259014208, 937.2876613773581, 939.2486011191156, 5277.261183434322, 5389.02997460453, 5395.0, 5405.972970135124, 5431.592630552725, 981.3866333541537, 997.670768646345, 1017.699778565325, 1018.0684673523791, 1042.3016578892161, 3412.4198886189406, 3453.4301840196085, 3540.929181416357, 3566.1619519412916, 3681.7975011374097, 9478.57346419399, 9652.855207171899, 9792.069753373418, 9806.558704858298, 9811.852822207673, 9681.612735490642, 9685.6610018649, 9694.51527423626, 9701.369410988264, 9709.0, 7307.926920730724, 7336.156342020629, 7460.738874139379, 7476.962615186889, 7527.3225409712295, 5187.24784906179, 5229.088602073798, 5230.34620672416, 5322.361316642027, 5329.680219186861, 8955.462672239686, 8963.865542016745, 9076.636934522545, 9084.137006984325, 9104.362694611315, 8463.53450560225, 8759.16787905148, 8777.91222087771, 9021.233195178484, 9081.409708368936, 6049.818505444844, 6891.069705589681, 6962.060121883481, 6988.615626140611, 7161.785146445615, 7280.890786638311, 7472.439567032386, 7495.812604684927, 7543.8491230173995, 7552.811179720551, 6466.612003279818, 6653.401193892573, 6700.564463309869, 6798.490113241625, 6863.142107236596, 6551.344865513411, 6563.442107420923, 6610.9669451652435, 6631.801045968628, 6643.335666433318, 6135.7238924249405, 6209.906851397323, 6224.62652240867, 6248.094026366242, 6251.78118765841, 4253.851115210953, 4388.858896686948, 4404.757738324423, 4459.397981272617, 4500.459944806644, 4671.883202919954, 4676.275177347517, 4704.976475117603, 4731.9763401184155, 4732.124556956974], "value": 4215.962037668202, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.42388250383027, 305.29629204683204, 311.2234973740517, 322.31347230399246, 322.4373468297821, 4593.0, 4711.505291944348, 4743.857684269469, 4801.255805350176, 4804.807807687693, 4548.226801443754, 4671.159191345565, 4678.806904239423, 4687.789049492772, 4693.366395536602, 3701.648343407372, 3710.9628903710886, 3718.3864662330684, 3726.273376691546, 3736.271427071722, 3541.4156664150382, 3594.8202589870534, 3687.926241475169, 3716.739828212026, 3738.1776009277914, 3681.558213014442, 3704.907377315562, 3711.552494527137, 3719.7396182267253, 3722.4044152935535, 3700.2969435807245, 3711.795851228181, 3721.981390093046, 3722.255548890206, 3729.757565758217, 3319.5850518685165, 3328.700416962485, 3329.8501567429525, 3330.4171769940162, 3340.5657264555452, 4385.7149285296355, 4581.770911454414, 4585.638396225946, 4607.562281583244, 4653.162430762462, 4275.3800698898485, 4292.7209731367675, 4298.161858437606, 4299.634531064863, 4300.311950088002, 4907.901841963177, 4942.456329803718, 4948.87627809304, 4984.87537811554, 4989.251612258154, 3570.768085010667, 3629.4192929131214, 3650.1787097903025, 3652.214773823641, 3653.8355773990234, 5093.14100353372, 5126.769295381717, 5138.820141295074, 5159.374796938915, 5162.392991539286, 3722.516072910504, 3730.757500762442, 3738.5513738351574, 3746.2882052409955, 3783.621637836194, 3803.1633040730994, 3803.2773772983596, 3808.7524310919703, 3818.427235914635, 3819.4843696101225, 4039.9596004040172, 4238.809253583596, 4257.914841703148, 4260.510041345223, 4271.312831431629, 4917.827876024322, 4946.614947814618, 4952.752362381866, 4974.5771609413605, 4982.327385802942, 1244.3778110944527, 1291.7222797098668, 1312.6455856918578, 1314.566193156256, 1329.2888304757103, 864.818388138498, 872.1452976083347, 881.0264657553439, 883.6686242659002, 889.8976617688919, 3941.994791328193, 3953.7627742334976, 4003.5996400360314, 4009.474031360224, 4012.1574469361763, 4508.684392092588, 4531.546845315508, 4538.228501154812, 4563.9087218255445, 4567.200739870509, 3952.7628342299554, 3980.283548961215, 4027.489691365738, 4033.7176397651883, 4068.7558746475306, 2300.8078761811366, 2420.4674971506242, 2449.358929517228, 2451.8283720139775, 2456.459578892641, 4332.241857674894, 4337.37108119321, 4340.110277393127, 4393.319035549495, 4409.933850992237, 4641.816336834086, 4649.488556258809, 4675.298705194248, 4678.929816052762, 4710.24636058229, 4174.248635245624, 4370.278903980871, 4371.409859668904, 4373.212821692063, 4375.584319489643, 4516.299973504112, 4581.404417425713, 4588.839390621312, 4601.608863246662, 4603.424571928509, 4370.295584721897, 4412.294032954712, 4430.778461076869, 4457.030411091545, 4495.52796956328, 4107.870335657718, 4278.994436307527, 4303.806328715153, 4305.921266294615, 4357.477102747691, 3424.520567120655, 3436.862525498952, 3459.6161535386045, 3459.913502162466, 3478.4086705260675, 4511.774411279489, 4584.381108550437, 4601.976990115028, 4604.21728306182, 4902.612162114959, 4785.641076919314, 4941.234108713155, 4951.257311403318, 4959.652824302409, 4970.428400733962, 4932.03825254072, 4933.432655244693, 4943.332650092335, 4950.702957822542, 4962.826301079445, 4776.283557466408, 4852.95147048525, 4867.342908707279, 4883.413990321042, 4904.730239836843, 4942.517244826466, 4974.527419895104, 5012.373453318335, 5012.598992080552, 5015.17249653803, 4865.099956508057, 4876.146674332049, 4876.780544875418, 4883.487233840396, 4890.877728056827], "value": 3643.6320444745143, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [623.5884316351207, 648.5492582655055, 733.1458850439238, 742.5693098003159, 767.9462437629364, 11084.889151108506, 11134.443277836117, 11251.549938002481, 12858.742825143503, 13276.933615331922, 12391.194572352792, 13459.865401345984, 13897.444102235899, 13921.02552821303, 14165.78751318731, 683.2450142592413, 834.2408408348405, 866.2766589897427, 870.6647940542905, 874.4490970688457, 861.3970220845401, 870.1733353314345, 870.8345414371249, 871.0723079919896, 871.5119533061475, 905.597009330848, 909.3043821476575, 909.9818003639956, 910.1717437132211, 910.2263076385053, 710.4245561095503, 875.829213303406, 900.6037343568875, 902.4089221559889, 902.873597696323, 664.2095905871997, 664.5447868210291, 664.7374287156595, 664.8038828545591, 665.0523004718257, 12392.256464612063, 12446.25322480645, 12453.93773031129, 12462.81305780414, 12476.625701228886, 11705.122115841346, 12037.93981030098, 12095.153339266255, 12161.331126788024, 12425.31660758658, 10969.616063437821, 11170.609028683957, 11376.089912807038, 11453.255538389978, 11631.360275184861, 3960.089179488734, 4033.1127152026506, 4040.6363427291685, 4053.4527838741687, 4189.455370801807, 48326.516734832556, 48402.0, 48473.99999999965, 48749.0, 48853.0, 9985.251106167067, 10184.185265178769, 10225.437600931871, 10282.794344113076, 10556.841647375295, 17299.13504324779, 17309.56726081858, 17332.480025599252, 17336.219870105877, 17345.653086938444, 6753.898691519631, 6765.052892594942, 6804.183497980175, 6807.047013418125, 6961.060256865359, 3540.4866294387684, 3630.5643322801434, 3683.686886614614, 3697.2975134724315, 3701.3522633539023, 2718.103026001415, 2802.369466869938, 2809.3819359740824, 2817.943641127166, 2819.2669905824223, 501.5110267489169, 505.1765622036131, 508.3416975017361, 509.6050560815398, 517.4644243208261, 481.674869463118, 488.3407400009958, 561.0378201384644, 572.5991805736002, 601.7863658401292, 7813.335866451415, 7863.685452581833, 7927.167647397056, 7999.920487807228, 8140.5929703514585, 563.3521450332069, 584.6083124306725, 593.7535922592162, 598.7485256192409, 603.9396060393925, 3675.5221821163614, 3679.2641471705765, 3748.1379282765115, 3798.9430158547643, 3869.9226015480094, 50284.0, 51879.0, 51932.0, 56098.0, 57053.71473142691, 45593.316100258526, 47324.5267547327, 50713.0, 50728.74635626872, 51933.74033129886, 47655.28517072247, 48235.03529929382, 48424.273635895486, 48933.0, 50538.494615054115, 8491.363147764067, 8523.95738021306, 8530.402871799162, 8640.524771137396, 8675.913240867763, 31580.684193157773, 31842.6815731849, 32608.184795380304, 32868.50697239591, 33824.49263261004, 38940.41589376218, 39883.40174897437, 42087.0, 42093.78953105337, 42233.0, 9120.771980700536, 10919.727006824893, 11115.110791136527, 11248.718782030515, 11328.093752499615, 12292.38538073075, 12579.622611321674, 12732.936335318635, 13247.536336228186, 13263.403146858222, 10720.678379648623, 11028.28316159447, 11389.316641001566, 12156.331401772988, 12495.250284982567, 11755.47100380502, 11795.0, 12067.215630983957, 12183.390830458618, 12502.624921252376, 11389.544418223179, 11464.656060318204, 11499.597514087302, 12077.094217933514, 12252.693682657648, 9962.302638815214, 10026.0, 10394.844077338998, 10448.68653940383, 10477.895221047693, 10106.0, 10305.484725763532, 10329.535170917177, 10337.995977783014, 10378.273520853469], "value": 6180.318557499574, "unit": "score"}], "name": "dromaeo_css", "value": 6356.599579863601, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 106.0, 113.0, 113.0, 112.0, 111.0, 113.0, 114.0, 113.0, 114.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 129.0, 153.0, 214.0, 137.0, 149.0, 150.0, 138.0, 186.0, 128.0], "value": 154.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 160.0, 164.0, 160.0, 161.0, 161.0, 161.0, 162.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 150.0, 78.0, 79.0, 77.0, 75.0, 124.0, 75.0], "value": 88.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 155.0, 93.0, 93.0, 94.0, 122.0, 93.0, 93.0, 123.0], "value": 105.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.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, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 96.0, 95.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 63.0, 63.0, 64.0, 63.0, 63.0, 64.0, 64.0, 63.0], "value": 63.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 66.0, 64.0, 64.0, 64.0, 66.0, 64.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 88.0, 85.0, 81.0, 88.0, 82.0, 82.0, 156.0, 84.0], "value": 91.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 129.0, 127.0, 134.0, 125.0, 126.0, 135.0, 126.0, 150.0, 131.0], "value": 131.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 175.0, 173.0, 172.0, 169.0, 169.0, 167.0, 169.0, 170.0, 169.0], "value": 170.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 65.0, 64.0, 65.0, 65.0, 65.0, 65.0, 66.0], "value": 65.4, "unit": "score"}], "name": "kraken", "value": 1565.3, "alertThreshold": 2.0}]} 17:07:11 INFO - Return code: 0 17:07:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:07:11 ERROR - # TBPL SUCCESS # 17:07:11 INFO - Running post-action listener: _resource_record_post_action 17:07:11 INFO - ##### 17:07:11 INFO - ##### Finished run-tests step (success) 17:07:11 INFO - ##### 17:07:11 INFO - Running post-run listener: _resource_record_post_run 17:07:11 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 7806976; Write bytes: 462974976; Read time: 1472; Write time: 298760 17:07:11 INFO - TinderboxPrint: CPU usage
13.2% 17:07:11 INFO - TinderboxPrint: I/O read bytes / time
7,806,976 / 1,472 17:07:11 INFO - TinderboxPrint: I/O write bytes / time
462,974,976 / 298,760 17:07:11 INFO - TinderboxPrint: CPU idle
8,336.0 (86.8%) 17:07:11 INFO - TinderboxPrint: CPU user
1,221.4 (12.7%) 17:07:11 INFO - TinderboxPrint: Swap in / out
0 / 0 17:07:11 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 32768000; Read time: 0; Write time: 8084 17:07:11 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 6045696; Write bytes: 356286464; Read time: 1248; Write time: 220932 17:07:11 INFO - Running post-run listener: _upload_blobber_files 17:07:11 INFO - Blob upload gear active. 17:07:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:07:11 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 17:07:11 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'] 17:07:11 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 17:07:12 INFO - (blobuploader) - INFO - Open directory for files ... 17:07:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:07:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:07:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:07:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:07:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:07:12 INFO - (blobuploader) - INFO - Done attempting. 17:07:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:07:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:07:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:07:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:07:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:07:17 INFO - (blobuploader) - INFO - Done attempting. 17:07:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:07:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:07:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:07:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:07:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:07:17 INFO - (blobuploader) - INFO - Done attempting. 17:07:17 INFO - (blobuploader) - INFO - Iteration through files over. 17:07:17 INFO - Return code: 0 17:07:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:07:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:07:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/200572fe687b816ded606a25d62bb561469f562733bd33a2f6a7291199b5974e456981ec19697af086e304ce0662d593a4dbff6f9a6203bdcf274538874a274d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/012a28ca911605ca14c9f0e3d97b0d831287d294980226cea2ed7ad97b0653ff2b6a5a1ec50fd3d05e675752f37a5ef3af564565b212e316fd2f88b9999af3d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/39b6a248c28f173e5f93a9b30d3364f6326a13c6c6701c20635c61f33e804b154d8fd3634ea4955ba3f877b2086d1255f6a6a4128dd3452abc8c674ed3d0a6ba"} 17:07:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:07:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:07:17 INFO - Contents: 17:07:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/200572fe687b816ded606a25d62bb561469f562733bd33a2f6a7291199b5974e456981ec19697af086e304ce0662d593a4dbff6f9a6203bdcf274538874a274d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/012a28ca911605ca14c9f0e3d97b0d831287d294980226cea2ed7ad97b0653ff2b6a5a1ec50fd3d05e675752f37a5ef3af564565b212e316fd2f88b9999af3d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/39b6a248c28f173e5f93a9b30d3364f6326a13c6c6701c20635c61f33e804b154d8fd3634ea4955ba3f877b2086d1255f6a6a4128dd3452abc8c674ed3d0a6ba"} 17:07:17 INFO - Running post-run listener: copy_logs_to_upload_dir 17:07:17 INFO - Copying logs to upload dir... 17:07:17 INFO - mkdir: /builds/slave/test/build/upload/logs 17:07:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.013717 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-05-18 17:07:17.772340) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-18 17:07:17.776043) ========= 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=ed14279e38b05397cf4aa391000001a4-1463613528.955999-580362476 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/200572fe687b816ded606a25d62bb561469f562733bd33a2f6a7291199b5974e456981ec19697af086e304ce0662d593a4dbff6f9a6203bdcf274538874a274d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/012a28ca911605ca14c9f0e3d97b0d831287d294980226cea2ed7ad97b0653ff2b6a5a1ec50fd3d05e675752f37a5ef3af564565b212e316fd2f88b9999af3d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/39b6a248c28f173e5f93a9b30d3364f6326a13c6c6701c20635c61f33e804b154d8fd3634ea4955ba3f877b2086d1255f6a6a4128dd3452abc8c674ed3d0a6ba"} build_url:https://queue.taskcluster.net/v1/task/EfWvuX7nReCO9yNpE9UVyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011126 build_url: 'https://queue.taskcluster.net/v1/task/EfWvuX7nReCO9yNpE9UVyQ/artifacts/public/build/firefox-49.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/200572fe687b816ded606a25d62bb561469f562733bd33a2f6a7291199b5974e456981ec19697af086e304ce0662d593a4dbff6f9a6203bdcf274538874a274d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/012a28ca911605ca14c9f0e3d97b0d831287d294980226cea2ed7ad97b0653ff2b6a5a1ec50fd3d05e675752f37a5ef3af564565b212e316fd2f88b9999af3d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/39b6a248c28f173e5f93a9b30d3364f6326a13c6c6701c20635c61f33e804b154d8fd3634ea4955ba3f877b2086d1255f6a6a4128dd3452abc8c674ed3d0a6ba"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-18 17:07:17.800623) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 17:07:17.800949) ========= 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=ed14279e38b05397cf4aa391000001a4-1463613528.955999-580362476 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004385 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 17:07:17.883767) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-18 17:07:17.884126) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-18 17:07:17.884449) ========= ========= Total master_lag: 0.17 =========