builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-008 starttime: 1464899492.84 results: success (0) buildid: 20160602095636 builduid: a0b367753f2c4474a385cbc3a17a9062 revision: c2f28446c94a222c145c436d6d9e78ec68b7e17a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 13:31:32.843104) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 13:31:32.843719) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 13:31:32.844002) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 13:31:32.860671) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 13:31:32.860968) ========= 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=32c5991c409366f7fec8a718000001d2-1464898236.696220-1917848186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-02 13:31:33-- 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% 70.5M=0s 2016-06-02 13:31:33 (70.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126511 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 13:31:33.000954) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 13:31:33.001253) ========= 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=32c5991c409366f7fec8a718000001d2-1464898236.696220-1917848186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023126 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 13:31:33.050007) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-02 13:31:33.050327) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c2f28446c94a222c145c436d6d9e78ec68b7e17a --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 c2f28446c94a222c145c436d6d9e78ec68b7e17a --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=32c5991c409366f7fec8a718000001d2-1464898236.696220-1917848186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-02 13:31:33,652 truncating revision to first 12 chars 2016-06-02 13:31:33,652 Setting DEBUG logging. 2016-06-02 13:31:33,652 attempt 1/10 2016-06-02 13:31:33,652 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c2f28446c94a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-02 13:31:34,969 unpacking tar archive at: fx-team-c2f28446c94a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.667333 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-02 13:31:34.730916) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 13:31:34.731228) ========= script_repo_revision: c2f28446c94a222c145c436d6d9e78ec68b7e17a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 13:31:34.731652) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 13:31:34.731934) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 13:31:34.741481) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-02 13:31:34.741858) ========= /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=32c5991c409366f7fec8a718000001d2-1464898236.696220-1917848186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:31:35 INFO - MultiFileLogger online at 20160602 13:31:35 in /builds/slave/test 13:31:35 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 13:31:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:31:35 INFO - {'append_to_log': False, 13:31:35 INFO - 'base_work_dir': '/builds/slave/test', 13:31:35 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 13:31:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:31:35 INFO - 'branch': 'Fx-Team-Non-PGO', 13:31:35 INFO - 'buildbot_json_path': 'buildprops.json', 13:31:35 INFO - 'config_files': ('talos/linux_config.py',), 13:31:35 INFO - 'default_actions': ('clobber', 13:31:35 INFO - 'read-buildbot-config', 13:31:35 INFO - 'download-and-extract', 13:31:35 INFO - 'populate-webroot', 13:31:35 INFO - 'create-virtualenv', 13:31:35 INFO - 'install', 13:31:35 INFO - 'run-tests'), 13:31:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:31:35 INFO - 'download_minidump_stackwalk': True, 13:31:35 INFO - 'download_symbols': 'ondemand', 13:31:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:31:35 INFO - 'tooltool.py': '/tools/tooltool.py', 13:31:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:31:35 INFO - '/tools/misc-python/virtualenv.py')}, 13:31:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:31:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:31:35 INFO - 'installer_path': 'installer.exe', 13:31:35 INFO - 'log_level': 'info', 13:31:35 INFO - 'log_name': 'talos', 13:31:35 INFO - 'log_to_console': True, 13:31:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:31:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:31:35 INFO - 'opt_config_files': (), 13:31:35 INFO - 'pip_index': False, 13:31:35 INFO - 'sps_profile': False, 13:31:35 INFO - 'sps_profile_interval': 0, 13:31:35 INFO - 'suite': 'dromaeojs', 13:31:35 INFO - 'system_bits': '32', 13:31:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:31:35 INFO - 'title': 'talos-linux64-ix-008', 13:31:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:31:35 INFO - 'use_talos_json': True, 13:31:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:31:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:31:35 INFO - 'work_dir': 'build'} 13:31:35 INFO - ##### 13:31:35 INFO - ##### Running clobber step. 13:31:35 INFO - ##### 13:31:35 INFO - Running pre-action listener: _resource_record_pre_action 13:31:35 INFO - Running main action method: clobber 13:31:35 INFO - rmtree: /builds/slave/test/build 13:31:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:31:36 INFO - Running post-action listener: _resource_record_post_action 13:31:36 INFO - ##### 13:31:36 INFO - ##### Finished clobber step (success) 13:31:36 INFO - ##### 13:31:36 INFO - ##### 13:31:36 INFO - ##### Running read-buildbot-config step. 13:31:36 INFO - ##### 13:31:36 INFO - Running pre-action listener: _resource_record_pre_action 13:31:36 INFO - Running main action method: read_buildbot_config 13:31:36 INFO - Using buildbot properties: 13:31:36 INFO - { 13:31:36 INFO - "project": "", 13:31:36 INFO - "product": "firefox", 13:31:36 INFO - "script_repo_revision": "production", 13:31:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:31:36 INFO - "repository": "", 13:31:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 13:31:36 INFO - "buildid": "20160602095636", 13:31:36 INFO - "pgo_build": "False", 13:31:36 INFO - "basedir": "/builds/slave/test", 13:31:36 INFO - "buildnumber": 1744, 13:31:36 INFO - "slavename": "talos-linux64-ix-008", 13:31:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:31:36 INFO - "platform": "ubuntu64_hw", 13:31:36 INFO - "scheduler": "tests-fx-team-linux64-talos", 13:31:36 INFO - "branch": "fx-team", 13:31:36 INFO - "repo_path": "integration/fx-team", 13:31:36 INFO - "revision": "c2f28446c94a222c145c436d6d9e78ec68b7e17a", 13:31:36 INFO - "stage_platform": "linux64", 13:31:36 INFO - "builduid": "a0b367753f2c4474a385cbc3a17a9062", 13:31:36 INFO - "slavebuilddir": "test" 13:31:36 INFO - } 13:31:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/Q3RLhiEXTteVBXPJleGvxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 13:31:36 INFO - Running post-action listener: _resource_record_post_action 13:31:36 INFO - ##### 13:31:36 INFO - ##### Finished read-buildbot-config step (success) 13:31:36 INFO - ##### 13:31:36 INFO - ##### 13:31:36 INFO - ##### Running download-and-extract step. 13:31:36 INFO - ##### 13:31:36 INFO - Running pre-action listener: _resource_record_pre_action 13:31:36 INFO - Running main action method: download_and_extract 13:31:36 INFO - mkdir: /builds/slave/test/build/tests 13:31:36 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')]} 13:31:36 INFO - https://queue.taskcluster.net/v1/task/Q3RLhiEXTteVBXPJleGvxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:31:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q3RLhiEXTteVBXPJleGvxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:31:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q3RLhiEXTteVBXPJleGvxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:31:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q3RLhiEXTteVBXPJleGvxA/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 13:31:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q3RLhiEXTteVBXPJleGvxA/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 13:31:37 INFO - Downloaded 1361 bytes. 13:31:37 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:31:37 INFO - Using the following test package requirements: 13:31:37 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:31:37 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:31:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:31:37 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:31:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:31:37 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:31:37 INFO - u'jsshell-linux-x86_64.zip'], 13:31:37 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:31:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:31:37 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:31:37 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:31:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:31:37 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:31:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:31:37 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:31:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:31:37 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:31:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:31:37 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:31: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')]} 13:31:37 INFO - https://queue.taskcluster.net/v1/task/Q3RLhiEXTteVBXPJleGvxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:31:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q3RLhiEXTteVBXPJleGvxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:31:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q3RLhiEXTteVBXPJleGvxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:31:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q3RLhiEXTteVBXPJleGvxA/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 13:31:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q3RLhiEXTteVBXPJleGvxA/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 13:31:39 INFO - Downloaded 22866922 bytes. 13:31:39 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'] 13:31:39 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 13:31:40 INFO - Return code: 0 13:31:40 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 13:31:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:31:40 INFO - https://queue.taskcluster.net/v1/task/Q3RLhiEXTteVBXPJleGvxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:31:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q3RLhiEXTteVBXPJleGvxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:31:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q3RLhiEXTteVBXPJleGvxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:31:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q3RLhiEXTteVBXPJleGvxA/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 13:31:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q3RLhiEXTteVBXPJleGvxA/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 13:31:42 INFO - Downloaded 22866922 bytes. 13:31:42 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'] 13:31:42 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 13:31:43 INFO - Return code: 0 13:31: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')]} 13:31:43 INFO - https://queue.taskcluster.net/v1/task/Q3RLhiEXTteVBXPJleGvxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:31:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q3RLhiEXTteVBXPJleGvxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:31:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q3RLhiEXTteVBXPJleGvxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:31:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q3RLhiEXTteVBXPJleGvxA/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 13:31:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q3RLhiEXTteVBXPJleGvxA/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 13:31:44 INFO - Downloaded 10834055 bytes. 13:31:44 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'] 13:31:44 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 13:31:44 INFO - Return code: 0 13:31:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:31:44 INFO - https://queue.taskcluster.net/v1/task/Q3RLhiEXTteVBXPJleGvxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:31:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q3RLhiEXTteVBXPJleGvxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:31:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q3RLhiEXTteVBXPJleGvxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:31:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q3RLhiEXTteVBXPJleGvxA/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 13:31:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q3RLhiEXTteVBXPJleGvxA/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 13:31:46 INFO - Downloaded 55081351 bytes. 13:31:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q3RLhiEXTteVBXPJleGvxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:31:46 INFO - mkdir: /builds/slave/test/properties 13:31:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:31:46 INFO - Writing to file /builds/slave/test/properties/build_url 13:31:46 INFO - Contents: 13:31:46 INFO - build_url:https://queue.taskcluster.net/v1/task/Q3RLhiEXTteVBXPJleGvxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:31:46 INFO - Running post-action listener: _resource_record_post_action 13:31:46 INFO - Running post-action listener: set_extra_try_arguments 13:31:46 INFO - ##### 13:31:46 INFO - ##### Finished download-and-extract step (success) 13:31:46 INFO - ##### 13:31:46 INFO - ##### 13:31:46 INFO - ##### Running populate-webroot step. 13:31:46 INFO - ##### 13:31:46 INFO - Running pre-action listener: _resource_record_pre_action 13:31:46 INFO - Running main action method: populate_webroot 13:31:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:31:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:31:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:31:46 INFO - '--tppagecycles', 13:31:46 INFO - '7'], 13:31:46 INFO - 'tests': ['tsvgm']}}, 13:31:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:31:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:31:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:31:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:31:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:31:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:31:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:31:46 INFO - 'talos_options': ['--disable-e10s'], 13:31:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:31:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:31:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:31:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:31:46 INFO - 'talos_options': ['--disable-e10s'], 13:31:46 INFO - 'tests': ['damp', 'tps']}, 13:31:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:31:46 INFO - 'tests': ['damp', 'tps']}, 13:31:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:31:46 INFO - 'tests': ['dromaeo_dom']}, 13:31:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:31:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:31:46 INFO - 'tests': ['a11yr', 13:31:46 INFO - 'ts_paint', 13:31:46 INFO - 'tpaint', 13:31:46 INFO - 'sessionrestore', 13:31:46 INFO - 'sessionrestore_no_auto_restore', 13:31:46 INFO - 'tabpaint']}, 13:31:46 INFO - 'other-e10s': {'tests': ['a11yr', 13:31:46 INFO - 'ts_paint', 13:31:46 INFO - 'tpaint', 13:31:46 INFO - 'sessionrestore', 13:31:46 INFO - 'sessionrestore_no_auto_restore', 13:31:46 INFO - 'tabpaint']}, 13:31:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:31:46 INFO - 'ts_paint', 13:31:46 INFO - 'tpaint', 13:31:46 INFO - 'sessionrestore', 13:31:46 INFO - 'sessionrestore_no_auto_restore', 13:31:46 INFO - 'tabpaint']}, 13:31:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:31:46 INFO - 'ts_paint', 13:31:46 INFO - 'tpaint', 13:31:46 INFO - 'sessionrestore', 13:31:46 INFO - 'sessionrestore_no_auto_restore', 13:31:46 INFO - 'tabpaint']}, 13:31:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:31:46 INFO - 'tests': ['a11yr', 13:31:46 INFO - 'ts_paint', 13:31:46 INFO - 'tpaint', 13:31:46 INFO - 'sessionrestore', 13:31:46 INFO - 'sessionrestore_no_auto_restore', 13:31:46 INFO - 'tabpaint']}, 13:31:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:31:46 INFO - 'tests': ['a11yr', 13:31:46 INFO - 'ts_paint', 13:31:46 INFO - 'tpaint', 13:31:46 INFO - 'sessionrestore', 13:31:46 INFO - 'sessionrestore_no_auto_restore', 13:31:46 INFO - 'tabpaint']}, 13:31:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:31:46 INFO - 'tests': ['tsvgx', 13:31:46 INFO - 'tsvgr_opacity', 13:31:46 INFO - 'tart', 13:31:46 INFO - 'tscrollx', 13:31:46 INFO - 'cart']}, 13:31:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:31:46 INFO - 'tsvgr_opacity', 13:31:46 INFO - 'tart', 13:31:46 INFO - 'tscrollx', 13:31:46 INFO - 'cart']}, 13:31:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:31:46 INFO - 'talos_options': ['--disable-e10s'], 13:31:46 INFO - 'tests': ['tp5o']}, 13:31:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:31:46 INFO - 'tests': ['tp5o']}, 13:31:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:31:46 INFO - 'talos_options': ['--disable-e10s', 13:31:46 INFO - '--xperf_path', 13:31:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:31:46 INFO - 'tests': ['tp5n']}, 13:31:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:31:46 INFO - 'talos_options': ['--xperf_path', 13:31:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:31:46 INFO - 'tests': ['tp5n']}}, 13:31:46 INFO - 'talos.zip': {'path': '', 13:31:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:31:46 INFO - Running post-action listener: _resource_record_post_action 13:31:46 INFO - ##### 13:31:46 INFO - ##### Finished populate-webroot step (success) 13:31:46 INFO - ##### 13:31:46 INFO - ##### 13:31:46 INFO - ##### Running create-virtualenv step. 13:31:46 INFO - ##### 13:31:46 INFO - Running pre-action listener: _resource_record_pre_action 13:31:46 INFO - Running main action method: create_virtualenv 13:31:46 INFO - Creating virtualenv /builds/slave/test/build/venv 13:31:46 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:31:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:31:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:31:46 INFO - Using real prefix '/usr' 13:31:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:31:47 INFO - Installing distribute.............................................................................................................................................................................................done. 13:31:49 INFO - Installing pip.................done. 13:31:49 INFO - Return code: 0 13:31:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:31:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:31:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:31:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:31:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6ead903f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fc9c0>, '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 0x26fd8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fdd50>, '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': '32c5991c409366f7fec8a718000001d2-1464898236.696220-1917848186', '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 13:31:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:31:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:31:49 INFO - Using env: {'DISPLAY': ':0', 13:31:49 INFO - 'HOME': '/home/cltbld', 13:31:49 INFO - 'LANG': 'en_US.UTF-8', 13:31:49 INFO - 'LANGUAGE': 'en_US:en', 13:31:49 INFO - 'LOGNAME': 'cltbld', 13:31:49 INFO - 'MAIL': '/var/mail/cltbld', 13:31:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:31:49 INFO - 'MOZ_NO_REMOTE': '1', 13:31:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:31:49 INFO - 'NO_EM_RESTART': '1', 13:31:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:31:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:31:49 INFO - 'PWD': '/builds/slave/test', 13:31:49 INFO - 'SHELL': '/bin/bash', 13:31:49 INFO - 'SHLVL': '1', 13:31:49 INFO - 'TERM': 'linux', 13:31:49 INFO - 'TMOUT': '86400', 13:31:49 INFO - 'USER': 'cltbld', 13:31:49 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464898236.696220-1917848186', 13:31:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:31:49 INFO - '_': '/tools/buildbot/bin/python'} 13:31:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:31:49 INFO - Cleaning up... 13:31:49 INFO - Return code: 0 13:31:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:31:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:31:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:31:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:31:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6ead903f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fc9c0>, '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 0x26fd8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fdd50>, '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': '32c5991c409366f7fec8a718000001d2-1464898236.696220-1917848186', '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 13:31:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:31:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:31:49 INFO - Using env: {'DISPLAY': ':0', 13:31:49 INFO - 'HOME': '/home/cltbld', 13:31:49 INFO - 'LANG': 'en_US.UTF-8', 13:31:49 INFO - 'LANGUAGE': 'en_US:en', 13:31:49 INFO - 'LOGNAME': 'cltbld', 13:31:49 INFO - 'MAIL': '/var/mail/cltbld', 13:31:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:31:49 INFO - 'MOZ_NO_REMOTE': '1', 13:31:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:31:49 INFO - 'NO_EM_RESTART': '1', 13:31:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:31:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:31:49 INFO - 'PWD': '/builds/slave/test', 13:31:49 INFO - 'SHELL': '/bin/bash', 13:31:49 INFO - 'SHLVL': '1', 13:31:49 INFO - 'TERM': 'linux', 13:31:49 INFO - 'TMOUT': '86400', 13:31:49 INFO - 'USER': 'cltbld', 13:31:49 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464898236.696220-1917848186', 13:31:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:31:49 INFO - '_': '/tools/buildbot/bin/python'} 13:31:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:31:49 INFO - Downloading/unpacking psutil>=3.1.1 13:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:31:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:31:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:31:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:31:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:31:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:31:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:31:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:31:51 INFO - Installing collected packages: psutil 13:31:51 INFO - Running setup.py install for psutil 13:31:51 INFO - building 'psutil._psutil_linux' extension 13:31:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 13:31:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 13:31:52 INFO - building 'psutil._psutil_posix' extension 13:31:52 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 13:31:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 13:31:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:31:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:31:52 INFO - Successfully installed psutil 13:31:52 INFO - Cleaning up... 13:31:52 INFO - Return code: 0 13:31:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:31:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:31:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:31:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:31:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6ead903f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fc9c0>, '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 0x26fd8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fdd50>, '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': '32c5991c409366f7fec8a718000001d2-1464898236.696220-1917848186', '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 13:31:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:31:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:31:52 INFO - Using env: {'DISPLAY': ':0', 13:31:52 INFO - 'HOME': '/home/cltbld', 13:31:52 INFO - 'LANG': 'en_US.UTF-8', 13:31:52 INFO - 'LANGUAGE': 'en_US:en', 13:31:52 INFO - 'LOGNAME': 'cltbld', 13:31:52 INFO - 'MAIL': '/var/mail/cltbld', 13:31:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:31:52 INFO - 'MOZ_NO_REMOTE': '1', 13:31:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:31:52 INFO - 'NO_EM_RESTART': '1', 13:31:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:31:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:31:52 INFO - 'PWD': '/builds/slave/test', 13:31:52 INFO - 'SHELL': '/bin/bash', 13:31:52 INFO - 'SHLVL': '1', 13:31:52 INFO - 'TERM': 'linux', 13:31:52 INFO - 'TMOUT': '86400', 13:31:52 INFO - 'USER': 'cltbld', 13:31:52 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464898236.696220-1917848186', 13:31:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:31:52 INFO - '_': '/tools/buildbot/bin/python'} 13:31:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:31:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:31:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:31:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:31:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:31:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:31:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:31:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:31:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:31:54 INFO - Installing collected packages: mozsystemmonitor 13:31:54 INFO - Running setup.py install for mozsystemmonitor 13:31:54 INFO - Successfully installed mozsystemmonitor 13:31:54 INFO - Cleaning up... 13:31:54 INFO - Return code: 0 13:31:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:31: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')]} 13:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:31:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31: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')]} 13:31:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:31:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6ead903f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fc9c0>, '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 0x26fd8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fdd50>, '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': '32c5991c409366f7fec8a718000001d2-1464898236.696220-1917848186', '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 13:31:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:31:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:31:54 INFO - Using env: {'DISPLAY': ':0', 13:31:54 INFO - 'HOME': '/home/cltbld', 13:31:54 INFO - 'LANG': 'en_US.UTF-8', 13:31:54 INFO - 'LANGUAGE': 'en_US:en', 13:31:54 INFO - 'LOGNAME': 'cltbld', 13:31:54 INFO - 'MAIL': '/var/mail/cltbld', 13:31:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:31:54 INFO - 'MOZ_NO_REMOTE': '1', 13:31:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:31:54 INFO - 'NO_EM_RESTART': '1', 13:31:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:31:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:31:54 INFO - 'PWD': '/builds/slave/test', 13:31:54 INFO - 'SHELL': '/bin/bash', 13:31:54 INFO - 'SHLVL': '1', 13:31:54 INFO - 'TERM': 'linux', 13:31:54 INFO - 'TMOUT': '86400', 13:31:54 INFO - 'USER': 'cltbld', 13:31:54 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464898236.696220-1917848186', 13:31:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:31:54 INFO - '_': '/tools/buildbot/bin/python'} 13:31:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:31:54 INFO - Downloading/unpacking blobuploader==1.2.4 13:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:31:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:31:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:31:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:31:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:31:56 INFO - Downloading blobuploader-1.2.4.tar.gz 13:31:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:31:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:31:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:31:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:31:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:31:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:31:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:31:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:31:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:31:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:31:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:31:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:31:57 INFO - Downloading docopt-0.6.1.tar.gz 13:31:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:31:57 INFO - Installing collected packages: blobuploader, requests, docopt 13:31:57 INFO - Running setup.py install for blobuploader 13:31:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:31:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:31:57 INFO - Running setup.py install for requests 13:31:57 INFO - Running setup.py install for docopt 13:31:58 INFO - Successfully installed blobuploader requests docopt 13:31:58 INFO - Cleaning up... 13:31:58 INFO - Return code: 0 13:31:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:31:58 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')]} 13:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:31:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31:58 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')]} 13:31:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:31:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31:58 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 0x7f6ead903f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fc9c0>, '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 0x26fd8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fdd50>, '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': '32c5991c409366f7fec8a718000001d2-1464898236.696220-1917848186', '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 13:31:58 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 13:31:58 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 13:31:58 INFO - Using env: {'DISPLAY': ':0', 13:31:58 INFO - 'HOME': '/home/cltbld', 13:31:58 INFO - 'LANG': 'en_US.UTF-8', 13:31:58 INFO - 'LANGUAGE': 'en_US:en', 13:31:58 INFO - 'LOGNAME': 'cltbld', 13:31:58 INFO - 'MAIL': '/var/mail/cltbld', 13:31:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:31:58 INFO - 'MOZ_NO_REMOTE': '1', 13:31:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:31:58 INFO - 'NO_EM_RESTART': '1', 13:31:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:31:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:31:58 INFO - 'PWD': '/builds/slave/test', 13:31:58 INFO - 'SHELL': '/bin/bash', 13:31:58 INFO - 'SHLVL': '1', 13:31:58 INFO - 'TERM': 'linux', 13:31:58 INFO - 'TMOUT': '86400', 13:31:58 INFO - 'USER': 'cltbld', 13:31:58 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464898236.696220-1917848186', 13:31:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:31:58 INFO - '_': '/tools/buildbot/bin/python'} 13:31:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:31:58 INFO - Running setup.py (path:/tmp/pip-AjDgQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:31:58 INFO - Running setup.py (path:/tmp/pip-OX8PqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:31:58 INFO - Running setup.py (path:/tmp/pip-ftU8Wg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:31:58 INFO - Running setup.py (path:/tmp/pip-YoWl3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:31:58 INFO - Running setup.py (path:/tmp/pip-VeaW2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:31:58 INFO - Running setup.py (path:/tmp/pip-bAQmqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:31:58 INFO - Running setup.py (path:/tmp/pip-iBDP8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:31:58 INFO - Running setup.py (path:/tmp/pip-XeQZ0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:31:58 INFO - Running setup.py (path:/tmp/pip-OO0oPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:31:58 INFO - Running setup.py (path:/tmp/pip-blpLpQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:31:59 INFO - Running setup.py (path:/tmp/pip-5MnqPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:31:59 INFO - Running setup.py (path:/tmp/pip-JEnvHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:31:59 INFO - Running setup.py (path:/tmp/pip-RUkPEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:31:59 INFO - Running setup.py (path:/tmp/pip-trJ__q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:31:59 INFO - Running setup.py (path:/tmp/pip-yGTq3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:31:59 INFO - Running setup.py (path:/tmp/pip-0dW2WG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:31:59 INFO - Running setup.py (path:/tmp/pip-JyJM07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:31:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:31:59 INFO - Running setup.py install for manifestparser 13:31:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:31:59 INFO - Running setup.py install for mozcrash 13:31:59 INFO - Running setup.py install for mozdebug 13:31:59 INFO - Running setup.py install for mozdevice 13:31:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:31:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:31:59 INFO - Running setup.py install for mozfile 13:32:00 INFO - Running setup.py install for mozhttpd 13:32:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:32:00 INFO - Running setup.py install for mozinfo 13:32:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:32:00 INFO - Running setup.py install for mozInstall 13:32:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:32:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:32:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:32:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:32:00 INFO - Running setup.py install for mozleak 13:32:00 INFO - Running setup.py install for mozlog 13:32:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:32:00 INFO - Running setup.py install for moznetwork 13:32:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:32:00 INFO - Running setup.py install for mozprocess 13:32:00 INFO - Running setup.py install for mozprofile 13:32:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:32:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:32:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:32:00 INFO - Running setup.py install for mozrunner 13:32:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:32:01 INFO - Running setup.py install for mozscreenshot 13:32:01 INFO - Running setup.py install for moztest 13:32:01 INFO - Running setup.py install for mozversion 13:32:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:32:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:32:01 INFO - Cleaning up... 13:32:01 INFO - Return code: 0 13:32:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:32: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')]} 13:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32: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')]} 13:32:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:01 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 0x7f6ead903f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fc9c0>, '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 0x26fd8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fdd50>, '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': '32c5991c409366f7fec8a718000001d2-1464898236.696220-1917848186', '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 13:32:01 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 13:32:01 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 13:32:01 INFO - Using env: {'DISPLAY': ':0', 13:32:01 INFO - 'HOME': '/home/cltbld', 13:32:01 INFO - 'LANG': 'en_US.UTF-8', 13:32:01 INFO - 'LANGUAGE': 'en_US:en', 13:32:01 INFO - 'LOGNAME': 'cltbld', 13:32:01 INFO - 'MAIL': '/var/mail/cltbld', 13:32:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:01 INFO - 'MOZ_NO_REMOTE': '1', 13:32:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:01 INFO - 'NO_EM_RESTART': '1', 13:32:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:01 INFO - 'PWD': '/builds/slave/test', 13:32:01 INFO - 'SHELL': '/bin/bash', 13:32:01 INFO - 'SHLVL': '1', 13:32:01 INFO - 'TERM': 'linux', 13:32:01 INFO - 'TMOUT': '86400', 13:32:01 INFO - 'USER': 'cltbld', 13:32:01 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464898236.696220-1917848186', 13:32:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:01 INFO - '_': '/tools/buildbot/bin/python'} 13:32:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:32:01 INFO - Running setup.py (path:/tmp/pip-p__omc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:32:01 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)) 13:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:32:01 INFO - Running setup.py (path:/tmp/pip-6CFqU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:32:01 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)) 13:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:32:01 INFO - Running setup.py (path:/tmp/pip-PDlDHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:32:01 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)) 13:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:32:01 INFO - Running setup.py (path:/tmp/pip-v0xIkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:32:01 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)) 13:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:32:01 INFO - Running setup.py (path:/tmp/pip-YlcAqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:32:01 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)) 13:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:32:01 INFO - Running setup.py (path:/tmp/pip-lxxloD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:32:01 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)) 13:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:32:01 INFO - Running setup.py (path:/tmp/pip-62lPe8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:32:02 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)) 13:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:32:02 INFO - Running setup.py (path:/tmp/pip-6oRkag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:32:02 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)) 13:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:32:02 INFO - Running setup.py (path:/tmp/pip-ScX_Ua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:32:02 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)) 13:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:32:02 INFO - Running setup.py (path:/tmp/pip-4l8bgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:32:02 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)) 13:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:32:02 INFO - Running setup.py (path:/tmp/pip-aIZpWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:32:02 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)) 13:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:32:02 INFO - Running setup.py (path:/tmp/pip-VYKjmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:32:02 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)) 13:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:32:02 INFO - Running setup.py (path:/tmp/pip-PpwvzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:32:02 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)) 13:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:32:02 INFO - Running setup.py (path:/tmp/pip-bUuAj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:32:02 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)) 13:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:32:02 INFO - Running setup.py (path:/tmp/pip-ABJpDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:32:02 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)) 13:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:32:02 INFO - Running setup.py (path:/tmp/pip-zx2zyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:32:02 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)) 13:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:32:02 INFO - Running setup.py (path:/tmp/pip-b8rEp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:32:02 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)) 13:32:02 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)) 13:32:02 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)) 13:32:02 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)) 13:32:02 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)) 13:32:02 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)) 13:32:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:04 INFO - Downloading blessings-1.6.tar.gz 13:32:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:32:04 INFO - Installing collected packages: blessings 13:32:04 INFO - Running setup.py install for blessings 13:32:04 INFO - Successfully installed blessings 13:32:04 INFO - Cleaning up... 13:32:04 INFO - Return code: 0 13:32:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:32:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:32:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:32:05 INFO - Reading from file tmpfile_stdout 13:32:05 INFO - Current package versions: 13:32:05 INFO - argparse == 1.2.1 13:32:05 INFO - blessings == 1.6 13:32:05 INFO - blobuploader == 1.2.4 13:32:05 INFO - docopt == 0.6.1 13:32:05 INFO - manifestparser == 1.1 13:32:05 INFO - mozInstall == 1.12 13:32:05 INFO - mozcrash == 0.17 13:32:05 INFO - mozdebug == 0.1 13:32:05 INFO - mozdevice == 0.48 13:32:05 INFO - mozfile == 1.2 13:32:05 INFO - mozhttpd == 0.7 13:32:05 INFO - mozinfo == 0.9 13:32:05 INFO - mozleak == 0.1 13:32:05 INFO - mozlog == 3.2 13:32:05 INFO - moznetwork == 0.27 13:32:05 INFO - mozprocess == 0.22 13:32:05 INFO - mozprofile == 0.28 13:32:05 INFO - mozrunner == 6.11 13:32:05 INFO - mozscreenshot == 0.1 13:32:05 INFO - mozsystemmonitor == 0.3 13:32:05 INFO - moztest == 0.7 13:32:05 INFO - mozversion == 1.4 13:32:05 INFO - psutil == 3.1.1 13:32:05 INFO - requests == 1.2.3 13:32:05 INFO - wsgiref == 0.1.2 13:32:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:05 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 0x7f6ead903f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fc9c0>, '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 0x26fd8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fdd50>, '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': '32c5991c409366f7fec8a718000001d2-1464898236.696220-1917848186', '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 13:32:05 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 13:32:05 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 13:32:05 INFO - Using env: {'DISPLAY': ':0', 13:32:05 INFO - 'HOME': '/home/cltbld', 13:32:05 INFO - 'LANG': 'en_US.UTF-8', 13:32:05 INFO - 'LANGUAGE': 'en_US:en', 13:32:05 INFO - 'LOGNAME': 'cltbld', 13:32:05 INFO - 'MAIL': '/var/mail/cltbld', 13:32:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:05 INFO - 'MOZ_NO_REMOTE': '1', 13:32:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:05 INFO - 'NO_EM_RESTART': '1', 13:32:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:05 INFO - 'PWD': '/builds/slave/test', 13:32:05 INFO - 'SHELL': '/bin/bash', 13:32:05 INFO - 'SHLVL': '1', 13:32:05 INFO - 'TERM': 'linux', 13:32:05 INFO - 'TMOUT': '86400', 13:32:05 INFO - 'USER': 'cltbld', 13:32:05 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464898236.696220-1917848186', 13:32:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:05 INFO - '_': '/tools/buildbot/bin/python'} 13:32:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:05 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)) 13:32:05 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)) 13:32:05 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)) 13:32:05 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)) 13:32:05 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)) 13:32:05 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)) 13:32:05 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)) 13:32:05 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)) 13:32:05 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)) 13:32:05 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)) 13:32:05 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)) 13:32:05 INFO - Cleaning up... 13:32:05 INFO - Return code: 0 13:32:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6ead903f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fc9c0>, '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 0x26fd8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fdd50>, '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': '32c5991c409366f7fec8a718000001d2-1464898236.696220-1917848186', '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 13:32:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:32:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:32:05 INFO - Using env: {'DISPLAY': ':0', 13:32:05 INFO - 'HOME': '/home/cltbld', 13:32:05 INFO - 'LANG': 'en_US.UTF-8', 13:32:05 INFO - 'LANGUAGE': 'en_US:en', 13:32:05 INFO - 'LOGNAME': 'cltbld', 13:32:05 INFO - 'MAIL': '/var/mail/cltbld', 13:32:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:05 INFO - 'MOZ_NO_REMOTE': '1', 13:32:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:05 INFO - 'NO_EM_RESTART': '1', 13:32:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:05 INFO - 'PWD': '/builds/slave/test', 13:32:05 INFO - 'SHELL': '/bin/bash', 13:32:05 INFO - 'SHLVL': '1', 13:32:05 INFO - 'TERM': 'linux', 13:32:05 INFO - 'TMOUT': '86400', 13:32:05 INFO - 'USER': 'cltbld', 13:32:05 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464898236.696220-1917848186', 13:32:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:05 INFO - '_': '/tools/buildbot/bin/python'} 13:32:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:05 INFO - Downloading/unpacking jsonschema 13:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:32:07 INFO - Downloading/unpacking functools32 (from jsonschema) 13:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:07 INFO - Downloading functools32-3.2.3-2.tar.gz 13:32:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:32:07 INFO - warning: no files found matching '*.txt' 13:32:07 INFO - no previously-included directories found matching 'build' 13:32:07 INFO - no previously-included directories found matching 'dist' 13:32:07 INFO - no previously-included directories found matching '.git*' 13:32:07 INFO - Installing collected packages: jsonschema, functools32 13:32:07 INFO - Running setup.py install for functools32 13:32:07 INFO - warning: no files found matching '*.txt' 13:32:07 INFO - no previously-included directories found matching 'build' 13:32:07 INFO - no previously-included directories found matching 'dist' 13:32:07 INFO - no previously-included directories found matching '.git*' 13:32:07 INFO - Successfully installed jsonschema functools32 13:32:07 INFO - Cleaning up... 13:32:07 INFO - Return code: 0 13:32:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:32:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6ead903f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fc9c0>, '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 0x26fd8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fdd50>, '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': '32c5991c409366f7fec8a718000001d2-1464898236.696220-1917848186', '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 13:32:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 13:32:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 13:32:07 INFO - Using env: {'DISPLAY': ':0', 13:32:07 INFO - 'HOME': '/home/cltbld', 13:32:07 INFO - 'LANG': 'en_US.UTF-8', 13:32:07 INFO - 'LANGUAGE': 'en_US:en', 13:32:07 INFO - 'LOGNAME': 'cltbld', 13:32:07 INFO - 'MAIL': '/var/mail/cltbld', 13:32:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:07 INFO - 'MOZ_NO_REMOTE': '1', 13:32:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:07 INFO - 'NO_EM_RESTART': '1', 13:32:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:07 INFO - 'PWD': '/builds/slave/test', 13:32:07 INFO - 'SHELL': '/bin/bash', 13:32:07 INFO - 'SHLVL': '1', 13:32:07 INFO - 'TERM': 'linux', 13:32:07 INFO - 'TMOUT': '86400', 13:32:07 INFO - 'USER': 'cltbld', 13:32:07 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464898236.696220-1917848186', 13:32:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:07 INFO - '_': '/tools/buildbot/bin/python'} 13:32:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:08 INFO - Downloading/unpacking flake8 13:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:32:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:32:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:32:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:32:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:32:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:32:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:32:10 INFO - no previously-included directories found matching 'docs/_build' 13:32:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:32:10 INFO - Running setup.py install for pep8 13:32:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:32:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:32:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:32:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:32:10 INFO - no previously-included directories found matching 'docs/_build' 13:32:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:32:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:32:10 INFO - Cleaning up... 13:32:11 INFO - Return code: 0 13:32:11 INFO - Running post-action listener: _resource_record_post_action 13:32:11 INFO - Running post-action listener: _start_resource_monitoring 13:32:11 INFO - Starting resource monitoring. 13:32:11 INFO - ##### 13:32:11 INFO - ##### Finished create-virtualenv step (success) 13:32:11 INFO - ##### 13:32:11 INFO - ##### 13:32:11 INFO - ##### Running install step. 13:32:11 INFO - ##### 13:32:11 INFO - Running pre-action listener: _resource_record_pre_action 13:32:11 INFO - Running main action method: install 13:32:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:32:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:32:11 INFO - Reading from file tmpfile_stdout 13:32:11 INFO - Detecting whether we're running mozinstall >=1.0... 13:32:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:32:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:32:11 INFO - Reading from file tmpfile_stdout 13:32:11 INFO - Output received: 13:32:11 INFO - Usage: mozinstall [options] installer 13:32:11 INFO - Options: 13:32:11 INFO - -h, --help show this help message and exit 13:32:11 INFO - -d DEST, --destination=DEST 13:32:11 INFO - Directory to install application into. [default: 13:32:11 INFO - "/builds/slave/test"] 13:32:11 INFO - --app=APP Application being installed. [default: firefox] 13:32:11 INFO - mkdir: /builds/slave/test/build/application 13:32:11 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'] 13:32:11 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 13:32:27 INFO - Reading from file tmpfile_stdout 13:32:27 INFO - Output received: 13:32:27 INFO - /builds/slave/test/build/application/firefox/firefox 13:32:27 INFO - Running post-action listener: _resource_record_post_action 13:32:27 INFO - ##### 13:32:27 INFO - ##### Finished install step (success) 13:32:27 INFO - ##### 13:32:27 INFO - ##### 13:32:27 INFO - ##### Running run-tests step. 13:32:27 INFO - ##### 13:32:27 INFO - Running pre-action listener: _resource_record_pre_action 13:32:27 INFO - Running main action method: run_tests 13:32:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:32:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:32:27 INFO - Python 2.7.3 13:32:27 INFO - Return code: 0 13:32:27 INFO - grabbing minidump binary from tooltool 13:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:27 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fc9c0>, '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 0x26fd8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fdd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:32:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:32:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:32:27 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 13:32:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:32:27 INFO - Return code: 0 13:32:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:32:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:32:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:32:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:32:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:32:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:32:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:32:28 INFO - Return code: 0 13:32:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q3RLhiEXTteVBXPJleGvxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 13:32:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Q3RLhiEXTteVBXPJleGvxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 13:32:28 INFO - Using env: {'DISPLAY': ':0', 13:32:28 INFO - 'HOME': '/home/cltbld', 13:32:28 INFO - 'LANG': 'en_US.UTF-8', 13:32:28 INFO - 'LANGUAGE': 'en_US:en', 13:32:28 INFO - 'LOGNAME': 'cltbld', 13:32:28 INFO - 'MAIL': '/var/mail/cltbld', 13:32:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:32:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:32:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:28 INFO - 'MOZ_NO_REMOTE': '1', 13:32:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:32:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:28 INFO - 'NO_EM_RESTART': '1', 13:32:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:28 INFO - 'PWD': '/builds/slave/test', 13:32:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:32:28 INFO - 'SHELL': '/bin/bash', 13:32:28 INFO - 'SHLVL': '1', 13:32:28 INFO - 'TERM': 'linux', 13:32:28 INFO - 'TMOUT': '86400', 13:32:28 INFO - 'USER': 'cltbld', 13:32:28 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464898236.696220-1917848186', 13:32:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:28 INFO - '_': '/tools/buildbot/bin/python'} 13:32:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q3RLhiEXTteVBXPJleGvxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 13:32:28 INFO - mozversion application_buildid: 20160602095636 13:32:28 INFO - mozversion application_changeset: c2f28446c94a222c145c436d6d9e78ec68b7e17a 13:32:28 INFO - mozversion application_display_name: Nightly 13:32:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:32:28 INFO - mozversion application_name: Firefox 13:32:28 INFO - mozversion application_remotingname: firefox 13:32:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:32:28 INFO - mozversion application_vendor: Mozilla 13:32:28 INFO - mozversion application_version: 49.0a1 13:32:28 INFO - mozversion platform_buildid: 20160602095636 13:32:28 INFO - mozversion platform_changeset: c2f28446c94a222c145c436d6d9e78ec68b7e17a 13:32:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:32:28 INFO - mozversion platform_version: 49.0a1 13:32:28 INFO - using testdate: 1464899548 13:32:28 INFO - actual date: 1464899548 13:32:28 INFO - starting webserver on 'localhost:60391' 13:32:28 INFO - SUITE-START | Running 2 tests 13:32:28 INFO - TEST-START | dromaeo_css 13:32:28 INFO - operating with platform_type : linux_ 13:32:28 INFO - Initialising browser for dromaeo_css test... 13:32:28 INFO - TEST-INFO | started process 22375 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu75kyH/profile http://localhost:60391/getInfo.html) 13:32:32 INFO - PROCESS | 22375 | __metrics Screen width/height:1600/1200 13:32:32 INFO - PROCESS | 22375 | colorDepth:24 13:32:32 INFO - PROCESS | 22375 | Browser inner width/height: 1024/697 13:32:32 INFO - PROCESS | 22375 | __metrics 13:32:33 ERROR - PROCESS | 22375 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:32:34 INFO - TEST-INFO | 22375: exit 0 13:32:34 INFO - Browser initialized. 13:32:34 INFO - Running cycle 1/1 for dromaeo_css test... 13:32:34 INFO - TEST-INFO | started process 22455 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu75kyH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:32:46 INFO - PROCESS | 22455 | RSS: Main: 157847552 13:32:46 INFO - PROCESS | 22455 | 13:33:38 INFO - PROCESS | 22455 | 1464899618026 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] 13:35:49 INFO - PROCESS | 22455 | Cycle 1(1): loaded http://localhost:60391/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60391/tests/dromaeo/cssquery-ext.html) 13:35:50 INFO - PROCESS | 22455 | RSS: Main: 239550464 13:35:50 INFO - PROCESS | 22455 | 13:38:53 INFO - PROCESS | 22455 | Cycle 1(1): loaded http://localhost:60391/tests/dromaeo/cssquery-ext.html (next: http://localhost:60391/tests/dromaeo/cssquery-jquery.html) 13:38:53 INFO - PROCESS | 22455 | RSS: Main: 245514240 13:38:53 INFO - PROCESS | 22455 | 13:41:56 INFO - PROCESS | 22455 | Cycle 1(1): loaded http://localhost:60391/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60391/tests/dromaeo/cssquery-mootools.html) 13:41:56 INFO - PROCESS | 22455 | RSS: Main: 242794496 13:41:56 INFO - PROCESS | 22455 | 13:44:59 INFO - PROCESS | 22455 | Cycle 1(1): loaded http://localhost:60391/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60391/tests/dromaeo/cssquery-prototype.html) 13:44:59 INFO - PROCESS | 22455 | RSS: Main: 239525888 13:44:59 INFO - PROCESS | 22455 | 13:48:02 INFO - PROCESS | 22455 | Cycle 1(1): loaded http://localhost:60391/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60391/tests/dromaeo/cssquery-yui.html) 13:48:03 INFO - PROCESS | 22455 | RSS: Main: 221331456 13:48:03 INFO - PROCESS | 22455 | 13:51:06 INFO - PROCESS | 22455 | Cycle 1(1): loaded http://localhost:60391/tests/dromaeo/cssquery-yui.html (next: http://localhost:60391/tests/dromaeo/cssquery-dojo.html) 13:51:06 INFO - PROCESS | 22455 | RSS: Main: 278339584 13:51:06 INFO - PROCESS | 22455 | 13:51:06 INFO - PROCESS | 22455 | __start_tp_report 13:51:06 INFO - PROCESS | 22455 | _x_x_mozilla_page_load 13:51:06 INFO - PROCESS | 22455 | _x_x_mozilla_page_load_details 13:51:06 INFO - PROCESS | 22455 | |i|pagename|runs| 13:51:06 INFO - PROCESS | 22455 | |0;dojo.html;2689.6100065490505;2707.444973780375;2710.5934109883515;2717.7035405082697;2736.2065001149667;4693.554112359329;4722.834700785474;4783.832565860195;4818.686785358954;4858.587020103291;4766.7616619169075;4830.589399901004;4834.323194752737;4839.516048395168;4845.733484658351;4403.3394990751485;4431.601155895969;4492.573205545468;4547.317902314646;4589.059242855206;4471.709338892978;4525.977370113162;4544.477385100723;4554.157480866033;4565.201089809287;4242.321228603409;4299.226139294926;4367.323064924942;4444.377787109807;4447.555244475527;4397.098594788061;4407.140607581523;4409.757463339515;4446.3108218226225;4469.351943968107;4429.313456414261;4445.777711114431;4452.888677783049;4502.369668246448;4503.572160644766;4570.10882877839;4689.882752931204;4745.928811067837;4780.282957556359;4789.664723469358;5200;5216.504432078947;5218.8695282617855;5218.921716174261;5232.2674825524455;5203.895922081537;5231.189165679326;5245.580353571705;5250.632455728062;5252.553532949704;4662.184117779375;4833.589144922721;4864.391951006124;4882.902341953212;4885.877853053631;5327.600429967768;5359.892802144013;5377.381601115843;5381.7578208980685;5386.784528618811;4839.201531747292;5154.690718556899;5165.070287348238;5166.689998600096;5173.456787037382;4985.127602669519;5024.57291130258;5060.51925067118;5071.518205770446;5078.923816142761;5044.596432285409;5055.848324550269;5094.388673359221;5095.617828662791;5143.614228932845;4908.901821963541;5026;5047.545720885065;5063.291139240509;5071.644984851099;4279;4294.033842385438;4296.011917258986;4325.545817689097;4338.848140315074;3740.0275928258848;3753.4369844522994;3762.8494860205287;3796.145867179918;3800.1829606634706;4339.500957389878;4393.0994146199955;4432.091421258634;4487.080148569536;4493.977530112328;5184.429712731597;5206.97396513015;5207.843764687065;5214.895702085937;5297.7880884764945;4472.351509031172;4492.213862574036;4493.123840851003;4493.820247190141;4538.2738761797955;4530.909381812346;4596.333531637893;4654.325122857167;4686.226772582554;4716.787744551503;4839.032193561372;4867.9269810952865;4883.755812209446;4887.022595480918;4911.9754401227765;5189.76646050921;5214.739263036757;5216.895662086813;5217.165253559412;5219.712915789668;4630.4443466784205;4651.604613607881;4821.180399332052;4842.491538388418;4899.216125419915;5029.44676085623;5059.696418214919;5064.898702026013;5066.594672426123;5167.095758242217;5164.8192313268855;5177.663451875616;5183.196604526304;5186.611004174627;5191.11751002338;4845.53967373099;4957.082939656031;5033.0688822567945;5040.042391945519;5062.696238225718;5015.623828212972;5049.293098966221;5054.772535235849;5055.494450555062;5105.617078719037;4760.833370832004;4979;4991.201407774739;4996.675216110941;5040.117979353525;4997.650164488451;5069.721165335942;5077.136886729191;5082.390113186441;5097.362829646294;4953.133201689762;4959.925601115914;4965.4289756677;4968.378952630921;5015.824446144367 13:51:06 INFO - PROCESS | 22455 | |1;ext.html;591.9112133180023;600.6576251536624;602.1178972804843;608.0271565495206;630.8233694565522;27462.86268568657;30101.24746881329;39587.40618890719;41425.378619320734;41541.58458415415;42819.3577096343;43195.78402107985;43255.35116973248;43375.56624433755;43403.34894976578;7840.372770178386;8025.23760242776;8027.839443211133;8028.237317454832;8032;7753.612319384037;7842.960785196066;7878.330341920915;7881.17247688993;7883.605819709021;7860.174681658429;7941.761747147595;7953.403494737918;7959.840803183933;7960.840783184332;7884.290413862751;7935.444518883681;7935.920640793604;7936.603169841543;7940.364770818378;7885.842283154305;7935.285824275843;7945.4438189326775;7946.443748937577;7959.124496305401;38821.61178388236;39153.21693566141;39260.411093833616;39336.21327573433;39395.4090688637;3190.489521676544;3250.951235731466;3292.901212963615;3307.7353811695007;3774.75464094833;29485.41029179426;30011.69988300133;30154.837037258658;30706.38587228265;31002;3531.770434921722;3564.8930532084078;3588.910277243064;3592.8562857485667;3630.5824830144343;265322;265497;266209.9999999981;266375;266621;47807.760961195665;54591.18113228305;56098.158527622116;57032.71869125189;57227.14159287614;57644;58564.707176463846;58646;58783.412165878646;58891.705541472016;15115.470958516618;15271.770923436157;15288.541343759705;15294.770578441332;15304.540863774104;9714;11350.318980861175;11624.709382265342;11684.47419866108;11903.940480297542;17092.48722538326;17105.23026463812;17125;17147.57131071708;17159.399421020455;5832.300123985149;5918.704064796743;6041.78853740117;6103.6948152592195;6279.560430769802;833.9457935234191;917.7934964632905;926.7127190570944;955.0020228860857;1038.2939601071344;26935.86532067327;28582.28544286368;28585.28536786597;28834;29263.414731705674;976.2775546095838;998.4458625462793;1015.9542820573092;1066.3921564708041;1089.5315014543821;14697.85302146965;15444.382224711111;15825.366985320688;16830.495085147464;16946.40687575929;386404;389623;391152;391718;391736;49816.501834981915;50842;50883;50911.23633145506;50957.235641465406;1071.212658695858;1140.520981187903;1180.4805885410392;1198.526582000105;1219.426869371394;26346;28907.132786016453;29649.703502964694;29760.70239297666;29962.850185749805;43194;43258.35112473252;43631.78184109059;43668;43740;242111;242759;243295;243602;243678;21979.670304945117;23053.077876884738;24660.260192194262;25509.23472295834;25734.227973160836;41526.58473415348;41609.0471405216;42080.3687944675;42640;42903.785481072395;36371.45442818413;36398.27203455863;36631.45052824156;36779.63220367762;36834.63165368312;35497.645023549434;36890.8155459221;36980.44529332008;37193.81403092967;37319.81340093282;35742.64257357393;35779.642203578675;35885.64114358927;36439.81780091082;36742.26515469729;31486.212844679067;32617.34765304633;32944.67055329416;32973;33130.834345828116;24906;25126.62310065387;25356.619650704884;25433.79561862733;25571.36071598225 13:51:06 INFO - PROCESS | 22455 | |2;jquery.html;365.786015181119;375.63188075685827;384.58080692045667;386.767939236458;387.42080589518673;15666.530004099866;16531;16790.748138777897;17059.829401705963;17152.228149733262;16009.19954002298;16323.265453054611;17124.400645977392;17136.657266854654;17160.056196909165;4890.828820991257;5000.424951130612;5066.645334826564;5070.898582028376;5089.211172268304;3612.710983121357;3789.1663833956486;5036.84889453317;5534.169874518814;5878.265216847894;5890.587658863881;5910.172575839386;5917.319508256563;5929.525637948954;5932.555058370639;5700.287464066992;5785.190073389729;5846.678432686201;5907.6750778707155;5919.260092488439;3327.750418718606;4811.59101476375;5072.289879416885;5101.948980510185;5148.6910785353;19392.80607193924;19874.503137421536;19908;20055.29806456767;20060.899695501575;1903.8667293289475;1988.9909351738204;2080.583883223361;2283.6917016202765;2513.987430062856;8498.19267169624;8879.644814207424;9004.369694121415;9629;12946.805797913039;1705.1133410626405;1760.331074191799;1780.2167046499499;1792.9820701792946;1798.5863251452108;62534;65309;66497.66751166261;75422;75481.24518754742;9768.755781105529;9962.402255864527;10235.897641023494;10277.047361001385;10334.556140859353;14073.87409007277;14187.929060354632;14194.787078193835;14195.574132776033;14204.786928196085;7438.330550250504;7479.925200748032;7539.962300188464;7553.811154721176;7665.770026899202;7216.530925489827;7265.12818461788;7334.706611735471;7366;7381.520201186906;4370.213361594943;4462.665300102441;4462.709923854939;4514.6614003949835;4567.794449249792;1672.991635041817;1789.91945362459;1790.2302010135506;1811.4746723450053;1833.4408005558166;627.2263811614082;826.8387664405383;869.1472545550918;959.5154447004358;998.1515711645044;16337.754933676004;16615.50153495397;16845.83154168467;16941.491755247363;17188.65622687539;865.6667183134539;910.1171863292595;920.963161473547;942.2132519346286;956.818204541135;9235.399699019543;9628.229741620653;9664.516774161264;9681.9031809681;9837.409755414697;339356;339768;342057;347889;353033;68640.31359686339;75368.62315688496;76732.61633691796;78051;78221.21778782253;932.2309094996655;950.6815216902277;979.774651830083;988.9604415823286;995.6017592962872;15014.924925375302;15495.612609684396;15646.374145034071;15811.288492017657;15946.760798588262;32715.34569308648;35262.823685881405;35938.46092308565;36096;37052.44421333736;39897.40153897636;47709.52290477051;49554;49897.501024990735;50234.49765502445;7502;7510.62446877643;7552.282533159341;7575.545467271982;7729.9227007729205;8193.426460147972;10429.217808664229;11830.704232394259;11912;12143.939280303543;9564.904350956402;9697.6605818796;9957.800843983225;10179.236557258087;10192.796144077225;10107.444090575089;10252.282340236112;10320;10445.843312350473;10448.634297799541;9307.441553506811;9574.547166538752;9860.753481163028;9913.950430247802;10269.589216431259;7442.96278518604;7510.586917719578;7520.586367749826;7611.809704757426;7627.275408836152;9765.365251258645;10110.49447527606;10198.235132364955;10536.631217907336;10606.575736970435 13:51:06 INFO - PROCESS | 22455 | |3;mootools.html;1225.963221103366;1399.706061727037;1427.9214643194623;1524.4207201263519;1770.1503278426355;6316.936830631692;6961.7911462656075;7100.431965442765;7125.643717814101;7387.26127387261;7105.5026148169645;7235.782926512213;7242.6378681066;7249.565026098438;7250.564966102024;2081.1155259014936;2106.410205142555;2106.536561956375;2109.4620871677776;2109.9789002110015;2037.6128535578266;2043.2439997201056;2077.2937201351538;2111.788821117884;2114.302280247515;2099.6220680277543;2121.321177223289;2130.4141361125735;2136.6154092263464;2176.336217453676;2086.353230498543;2087.488565301496;2093.518490747129;2093.6336141175234;2094.0890712540095;1977.0947552760629;2050.0569737920573;2053.117159621362;2053.887036213008;2054.681524363726;7073.893891591631;7182.748603798842;7230.638468076628;7243.384312333458;7245.818854528627;4282.892927676802;4453.198424283628;4454.510003899569;4455.064436468346;4462.866114016585;2809.9016534421403;2909.8836046558113;2951.911442656724;2968.554716792477;2969.228000719807;943.2831048403194;957.0477375011839;975.9707208783748;991.2714155095998;1007.8639383683255;9845.310828242025;9911.702648920544;9932.255080868963;9963.950180249125;9988.750281242954;3910.9608903911167;3999.6000399960353;4007.0984028593334;4202.873913782591;4212.389203565466;7541.585212813348;7564.735234266775;7617.542947423061;7625.199354067743;7631.084269887538;4379.934300985487;4380.8685739427865;4382.364557139261;4382.69321147523;4385.978070109692;3620.728445366555;3987.4816273884207;4083.0608959938786;4098.7130900836655;4099.098198396348;3347.0795531229105;3357.4292370297107;3406.1314364837303;3424.07549961509;3479.2867462170193;1008.702432782331;1074.8172810622214;1075.7203127186988;1077.3482043363808;1080.4981076303943;856.3577317012241;859.1923591823665;866.1165611076666;866.6273502393905;881.8412685716632;5301.125314323093;5318.787248510016;5350.545203657733;5595.804146854841;5617.045102332613;848.3722045686271;876.9693060742843;902.8239493298744;928.4475736936512;935.4013431403907;3629.6733294003666;3640.8361623726996;3693.4644476550748;3706.5366829146355;3741.5884252732176;8655.307575393954;8862.335324850663;9024.729258122266;9029.23251523628;9035.819283614292;8362.16378362171;8667.263282620921;8720.8691869622;8909.465432074096;8951.149640784115;6839.726410943506;7037.683304251321;7044.731948249364;7045.225025247219;7046.506744527834;5215.921761173509;5239.633225674166;5257.185136303879;5482.342118945752;5524.281843360337;8201.589920503831;8208.753737387888;8308.70919517814;8452.788680283042;8478.02502712196;7962.6814927404575;8522.446041007315;8550.444221125606;8552.315814734931;8589.613467393858;5779.624324418899;6180.81457556274;6289.465395441256;6466.967665161644;6482.513811464065;7209.495335326476;7266;7288.599127047851;7297.270272972661;7312.744053958086;6282.780102696383;6460.644664543307;6473.2232132144445;6550.312217217123;6571.145751052524;5984.790532331347;6141;6241.344658810759;6311.116443697978;6385.106085148176;6158.3841615838055;6193.876122477615;6199.535034872493;6217.253929528486;6218.875622487615;4296.2266791977745;4659.370984917128;4673.158831410379;4718.056388722201;4723.976380118077;4661.184292748823;4667.8599642010795;4689.460712018162;4695.882602934954;4782.0435912818275 13:51:06 INFO - PROCESS | 22455 | |4;prototype.html;301.616946477973;301.71487943893015;306.4147478316415;308.76225306513976;308.76533834285937;4894.681845680028;4906.901861962759;4923.581495572872;4940.209566469365;4948.109340318746;4814.157522433569;4858.757062146888;4862.2706594010915;4863.878403039926;4870;3599.8560057597665;3694.501242332291;3719.572249191337;3784.7539909905904;3849.557300910389;3782.7352085354037;3813.2564149990762;3820.5606355269083;3833.175867188554;3855.7879316637573;3587.515685382479;3792.677622402099;3804.676602488778;3805.0487378155462;3807.02920755207;3675.375186218336;3788.6211378862167;3799.3731034379434;3800.5676367124784;3802.923941521182;3358.8488518016748;3361.3949489091956;3375.1899544109237;3377.9662203377898;3386.102682789063;4636.629069674418;4637.536246375369;4658.371119898804;4661.906761864744;4688.156131896258;4231.196072746168;4337.63130133939;4360.433143691332;4379.1022840317655;4379.4525684289465;5042.1176294148745;5051.19180931053;5071.3407257056715;5071.797128114871;5099.898002039976;3670.284294562561;3684.5946945835935;3688.61269566697;3691.298653255873;3701.2597480504005;5161.845144645629;5191.6884986900905;5250.474952504757;5304.469553044703;5331.386890507563;3735.43968404736;3741.7006639468777;3764.3600587900123;3764.830582623734;3766.548014238254;3773.603771603997;3788.677962373174;3815.569161564413;3846.7114966377635;3852.2488114817343;4308.46144231971;4327.783610819446;4335.588119128678;4338.958649924059;4351.43431353922;4891.413030436299;5024.874378140576;5037.848864534069;5056.63470862865;5058.494150584912;1300.0379719007867;1316.453671726242;1321.359140816703;1338.8125662407272;1339.852616212216;846.95341756204;858.8368210040072;888.2494292322976;898.9460632362079;904.4166512599337;4372.256716358227;4426.535213802505;4513.50351461339;4585.426821647294;4585.518520555361;5276.894462110737;5280.81517146898;5302.92045619316;5306.46935306474;5312.123499622519;4348.804078878334;4427.889302767392;4473.642108631302;4587.311903214544;4590;2731.713170117149;2743.053646491957;2755.2698534888273;2756.517609418384;2789.0337312194856;4869.245266983623;4901.264810278415;4905.754712264373;4919.827806026843;4946.851594452172;4974.253861920669;5345.786168553214;5348.9732551337775;5373.194020896819;5386.946130538723;4891.779869905863;4897.094037603055;4919.926201107058;4932.630052746058;4941.802327906916;5268.394134674561;5295.27903431394;5301.25782390458;5315.335583052119;5327.280817089798;4902.828401005948;5185.196294574347;5191.923230707747;5192.636515443883;5213.270142180174;4945.826896058621;4961.677490963076;4966.950330496648;4968.403791545038;4972.513743128436;3701.6113308102263;3701.611330810334;3706.3699171140433;3707.1844194277214;3734.682551983003;5165.199394093921;5300.416954134965;5326.467353264643;5332.30680011596;5332.68003919766;5135.460776618401;5147.327118686517;5151.639385242997;5163.3545806774155;5166.095933211598;5160.664556803796;5164.889548747037;5165.7933682653775;5177.870553236199;5181.766820493162;4862.82980095695;4875.707937396522;5048.848534543969;5055;5070.8225212117395;5049.9495005049475;5158.406783219828;5168.53483186515;5178;5181;5038.420581633159;5038.974805125951;5046.116929537243;5055.797768089235;5060.1903695408555 13:51:06 INFO - PROCESS | 22455 | |5;yui.html;668.5453891353881;713.9362350098352;719.5466855880793;722.7145277615342;746.4550877859159;12625.873741262585;12907.096503244777;13135.802962955539;13168.407421666025;13465.259410732406;11833.29000259985;11884.227525210856;11885.524579016828;11902.2263552869;11907.52369905205;628.6228263042184;781.0744268042359;801.4229754576695;814.4828034198297;814.5601375257354;811.0470197517923;811.9594020298991;817.1746535998655;818.2226884459757;818.4271010292789;861.6725644255174;866.2766589897443;866.5927014303298;867.1371984875058;867.2151702709027;663.3499170812582;673.3703986772359;678.6437120511771;681.3731367142241;854.4616891358436;597.6742675242003;614.8678034222663;616.9043798211285;618.6226401894841;619.0188551146439;11413;11501.712457188554;11729.296242225408;11757.706057348549;11766.529338826436;12224.327661978588;12695.238285702795;12706.428210730539;12810.167339122927;13026.934865325613;11498.905744467693;11663.76672466546;11738.06095512357;11767.2939623622;11800.055995520337;4119.649829764474;4196.244675958326;4211.263028969918;4293.935590966138;4303.634191093761;52737.94524109496;53081.2037819433;53101;53331.20003199955;53538.73230633822;10163.390196588081;10352.430616316175;10536.051755341903;10899.83650245247;10960.123190144928;18896.81103188978;18966.905165474083;18973;18995.62008759817;19019;6746.055552222692;6799.286074962157;6913.688884000232;6958.965205173941;7093.32613401726;3700.50043244164;3811.6950643948417;3874.5544262410185;3984.30274701926;3995.9400608990886;2841.886324547036;2926.678065412803;2955.600993865801;2957.940841183164;2960.259935016246;540.608059157108;564.892670392624;597.1430996520007;597.6951754605183;597.8953683105439;407.2974119643591;522.3966318901674;571.7541457173372;583.8919799837043;599.6029251843195;8049.078050764222;8051;8252.092269850311;8385.45494542865;8411.621477033548;581.7498475655424;581.7672930827703;584.801167603017;589.2104579863004;608.2457752387008;4034.576369481221;4139.110091330318;4175.352820312795;4178.456800615901;4227.957720422756;99169.50415248022;100184;100230.49884750675;100236.49881750545;104621.47689261504;67307.66346168336;67450.66274668595;80123;85903.57048214719;85941;68498;72009;72349.63825180946;72584.91122633165;72834;8257;8383.634139643977;8470.068292487944;8535.61589728476;8619.094995025433;39695;41303.58696413117;44021.77989110034;45154.322685159095;45224;53714.46285537095;59564;59838.70080649743;60174;60834;9493.0981556752;9618;9735.22118230554;9791.510424478605;9846.409215447096;11942.16404851652;12198.573049943565;12297.877021229673;12612.55856045034;13120.60638180856;11092.116049827264;11331.773364532828;11378.487968041292;11399.943000285277;11479.311241325548;11329.490172942073;11356.545738170711;11496.597619083626;11897.940510297392;11923.284602923852;11231.213815033196;11414.885851141382;11451.14116441287;12001.219920705125;12002.519899203933;8806.60370283326;9149.908500914906;9316;9460.479673617741;9658;9416.340856140005;9562.3225496861;9622.47076410804;9660.37207581505;9666.468344240853 13:51:06 INFO - PROCESS | 22455 | __end_tp_report 13:51:06 INFO - PROCESS | 22455 | __start_cc_report 13:51:06 INFO - PROCESS | 22455 | _x_x_mozilla_cycle_collect,926 13:51:06 INFO - PROCESS | 22455 | __end_cc_report 13:51:06 INFO - PROCESS | 22455 | __startTimestamp1464900666252__endTimestamp 13:51:06 INFO - PROCESS | 22455 | 13:51:06 INFO - PROCESS | 22455 | ------- Summary: start ------- 13:51:06 INFO - PROCESS | 22455 | Number of tests: 6 13:51:06 INFO - PROCESS | 22455 | 13:51:06 INFO - PROCESS | 22455 | [#0] dojo.html Cycles:165 Average:4764.25 Median:4882.90 stddev:504.96 (10.3%) stddev-sans-first:479.56 13:51:06 INFO - PROCESS | 22455 | Values: 2689.6 2707.4 2710.6 2717.7 2736.2 4693.6 4722.8 4783.8 4818.7 4858.6 4766.8 4830.6 4834.3 4839.5 4845.7 4403.3 4431.6 4492.6 4547.3 4589.1 4471.7 4526.0 4544.5 4554.2 4565.2 4242.3 4299.2 4367.3 4444.4 4447.6 4397.1 4407.1 4409.8 4446.3 4469.4 4429.3 4445.8 4452.9 4502.4 4503.6 4570.1 4689.9 4745.9 4780.3 4789.7 5200.0 5216.5 5218.9 5218.9 5232.3 5203.9 5231.2 5245.6 5250.6 5252.6 4662.2 4833.6 4864.4 4882.9 4885.9 5327.6 5359.9 5377.4 5381.8 5386.8 4839.2 5154.7 5165.1 5166.7 5173.5 4985.1 5024.6 5060.5 5071.5 5078.9 5044.6 5055.8 5094.4 5095.6 5143.6 4908.9 5026.0 5047.5 5063.3 5071.6 4279.0 4294.0 4296.0 4325.5 4338.8 3740.0 3753.4 3762.8 3796.1 3800.2 4339.5 4393.1 4432.1 4487.1 4494.0 5184.4 5207.0 5207.8 5214.9 5297.8 4472.4 4492.2 4493.1 4493.8 4538.3 4530.9 4596.3 4654.3 4686.2 4716.8 4839.0 4867.9 4883.8 4887.0 4912.0 5189.8 5214.7 5216.9 5217.2 5219.7 4630.4 4651.6 4821.2 4842.5 4899.2 5029.4 5059.7 5064.9 5066.6 5167.1 5164.8 5177.7 5183.2 5186.6 5191.1 4845.5 4957.1 5033.1 5040.0 5062.7 5015.6 5049.3 5054.8 5055.5 5105.6 4760.8 4979.0 4991.2 4996.7 5040.1 4997.7 5069.7 5077.1 5082.4 5097.4 4953.1 4959.9 4965.4 4968.4 5015.8 13:51:06 INFO - PROCESS | 22455 | 13:51:06 INFO - PROCESS | 22455 | [#1] ext.html Cycles:180 Average:46172.28 Median:36935.63 stddev:80645.69 (218.3%) stddev-sans-first:80799.31 13:51:06 INFO - PROCESS | 22455 | Values: 591.9 600.7 602.1 608.0 630.8 27462.9 30101.2 39587.4 41425.4 41541.6 42819.4 43195.8 43255.4 43375.6 43403.3 7840.4 8025.2 8027.8 8028.2 8032.0 7753.6 7843.0 7878.3 7881.2 7883.6 7860.2 7941.8 7953.4 7959.8 7960.8 7884.3 7935.4 7935.9 7936.6 7940.4 7885.8 7935.3 7945.4 7946.4 7959.1 38821.6 39153.2 39260.4 39336.2 39395.4 3190.5 3251.0 3292.9 3307.7 3774.8 29485.4 30011.7 30154.8 30706.4 31002.0 3531.8 3564.9 3588.9 3592.9 3630.6 265322.0 265497.0 266210.0 266375.0 266621.0 47807.8 54591.2 56098.2 57032.7 57227.1 57644.0 58564.7 58646.0 58783.4 58891.7 15115.5 15271.8 15288.5 15294.8 15304.5 9714.0 11350.3 11624.7 11684.5 11903.9 17092.5 17105.2 17125.0 17147.6 17159.4 5832.3 5918.7 6041.8 6103.7 6279.6 833.9 917.8 926.7 955.0 1038.3 26935.9 28582.3 28585.3 28834.0 29263.4 976.3 998.4 1016.0 1066.4 1089.5 14697.9 15444.4 15825.4 16830.5 16946.4 386404.0 389623.0 391152.0 391718.0 391736.0 49816.5 50842.0 50883.0 50911.2 50957.2 1071.2 1140.5 1180.5 1198.5 1219.4 26346.0 28907.1 29649.7 29760.7 29962.9 43194.0 43258.4 43631.8 43668.0 43740.0 242111.0 242759.0 243295.0 243602.0 243678.0 21979.7 23053.1 24660.3 25509.2 25734.2 41526.6 41609.0 42080.4 42640.0 42903.8 36371.5 36398.3 36631.5 36779.6 36834.6 35497.6 36890.8 36980.4 37193.8 37319.8 35742.6 35779.6 35885.6 36439.8 36742.3 31486.2 32617.3 32944.7 32973.0 33130.8 24906.0 25126.6 25356.6 25433.8 25571.4 13:51:06 INFO - PROCESS | 22455 | 13:51:06 INFO - PROCESS | 22455 | [#2] jquery.html Cycles:180 Average:22825.41 Median:4851.21 stddev:57121.95 (1177.5%) stddev-sans-first:57257.30 13:51:06 INFO - PROCESS | 22455 | Values: 365.8 375.6 384.6 386.8 387.4 15666.5 16531.0 16790.7 17059.8 17152.2 16009.2 16323.3 17124.4 17136.7 17160.1 4890.8 5000.4 5066.6 5070.9 5089.2 3612.7 3789.2 5036.8 5534.2 5878.3 5890.6 5910.2 5917.3 5929.5 5932.6 5700.3 5785.2 5846.7 5907.7 5919.3 3327.8 4811.6 5072.3 5101.9 5148.7 19392.8 19874.5 19908.0 20055.3 20060.9 1903.9 1989.0 2080.6 2283.7 2514.0 8498.2 8879.6 9004.4 9629.0 12946.8 1705.1 1760.3 1780.2 1793.0 1798.6 62534.0 65309.0 66497.7 75422.0 75481.2 9768.8 9962.4 10235.9 10277.0 10334.6 14073.9 14187.9 14194.8 14195.6 14204.8 7438.3 7479.9 7540.0 7553.8 7665.8 7216.5 7265.1 7334.7 7366.0 7381.5 4370.2 4462.7 4462.7 4514.7 4567.8 1673.0 1789.9 1790.2 1811.5 1833.4 627.2 826.8 869.1 959.5 998.2 16337.8 16615.5 16845.8 16941.5 17188.7 865.7 910.1 921.0 942.2 956.8 9235.4 9628.2 9664.5 9681.9 9837.4 339356.0 339768.0 342057.0 347889.0 353033.0 68640.3 75368.6 76732.6 78051.0 78221.2 932.2 950.7 979.8 989.0 995.6 15014.9 15495.6 15646.4 15811.3 15946.8 32715.3 35262.8 35938.5 36096.0 37052.4 39897.4 47709.5 49554.0 49897.5 50234.5 7502.0 7510.6 7552.3 7575.5 7729.9 8193.4 10429.2 11830.7 11912.0 12143.9 9564.9 9697.7 9957.8 10179.2 10192.8 10107.4 10252.3 10320.0 10445.8 10448.6 9307.4 9574.5 9860.8 9914.0 10269.6 7443.0 7510.6 7520.6 7611.8 7627.3 9765.4 10110.5 10198.2 10536.6 10606.6 13:51:06 INFO - PROCESS | 22455 | 13:51:06 INFO - PROCESS | 22455 | [#3] mootools.html Cycles:180 Average:4871.74 Median:5698.33 stddev:2614.88 (45.9%) stddev-sans-first:2607.86 13:51:06 INFO - PROCESS | 22455 | Values: 1226.0 1399.7 1427.9 1524.4 1770.2 6316.9 6961.8 7100.4 7125.6 7387.3 7105.5 7235.8 7242.6 7249.6 7250.6 2081.1 2106.4 2106.5 2109.5 2110.0 2037.6 2043.2 2077.3 2111.8 2114.3 2099.6 2121.3 2130.4 2136.6 2176.3 2086.4 2087.5 2093.5 2093.6 2094.1 1977.1 2050.1 2053.1 2053.9 2054.7 7073.9 7182.7 7230.6 7243.4 7245.8 4282.9 4453.2 4454.5 4455.1 4462.9 2809.9 2909.9 2951.9 2968.6 2969.2 943.3 957.0 976.0 991.3 1007.9 9845.3 9911.7 9932.3 9964.0 9988.8 3911.0 3999.6 4007.1 4202.9 4212.4 7541.6 7564.7 7617.5 7625.2 7631.1 4379.9 4380.9 4382.4 4382.7 4386.0 3620.7 3987.5 4083.1 4098.7 4099.1 3347.1 3357.4 3406.1 3424.1 3479.3 1008.7 1074.8 1075.7 1077.3 1080.5 856.4 859.2 866.1 866.6 881.8 5301.1 5318.8 5350.5 5595.8 5617.0 848.4 877.0 902.8 928.4 935.4 3629.7 3640.8 3693.5 3706.5 3741.6 8655.3 8862.3 9024.7 9029.2 9035.8 8362.2 8667.3 8720.9 8909.5 8951.1 6839.7 7037.7 7044.7 7045.2 7046.5 5215.9 5239.6 5257.2 5482.3 5524.3 8201.6 8208.8 8308.7 8452.8 8478.0 7962.7 8522.4 8550.4 8552.3 8589.6 5779.6 6180.8 6289.5 6467.0 6482.5 7209.5 7266.0 7288.6 7297.3 7312.7 6282.8 6460.6 6473.2 6550.3 6571.1 5984.8 6141.0 6241.3 6311.1 6385.1 6158.4 6193.9 6199.5 6217.3 6218.9 4296.2 4659.4 4673.2 4718.1 4724.0 4661.2 4667.9 4689.5 4695.9 4782.0 13:51:06 INFO - PROCESS | 22455 | 13:51:06 INFO - PROCESS | 22455 | [#4] prototype.html Cycles:180 Average:4241.70 Median:4869.62 stddev:1229.18 (25.2%) stddev-sans-first:1196.52 13:51:06 INFO - PROCESS | 22455 | Values: 301.6 301.7 306.4 308.8 308.8 4894.7 4906.9 4923.6 4940.2 4948.1 4814.2 4858.8 4862.3 4863.9 4870.0 3599.9 3694.5 3719.6 3784.8 3849.6 3782.7 3813.3 3820.6 3833.2 3855.8 3587.5 3792.7 3804.7 3805.0 3807.0 3675.4 3788.6 3799.4 3800.6 3802.9 3358.8 3361.4 3375.2 3378.0 3386.1 4636.6 4637.5 4658.4 4661.9 4688.2 4231.2 4337.6 4360.4 4379.1 4379.5 5042.1 5051.2 5071.3 5071.8 5099.9 3670.3 3684.6 3688.6 3691.3 3701.3 5161.8 5191.7 5250.5 5304.5 5331.4 3735.4 3741.7 3764.4 3764.8 3766.5 3773.6 3788.7 3815.6 3846.7 3852.2 4308.5 4327.8 4335.6 4339.0 4351.4 4891.4 5024.9 5037.8 5056.6 5058.5 1300.0 1316.5 1321.4 1338.8 1339.9 847.0 858.8 888.2 898.9 904.4 4372.3 4426.5 4513.5 4585.4 4585.5 5276.9 5280.8 5302.9 5306.5 5312.1 4348.8 4427.9 4473.6 4587.3 4590.0 2731.7 2743.1 2755.3 2756.5 2789.0 4869.2 4901.3 4905.8 4919.8 4946.9 4974.3 5345.8 5349.0 5373.2 5386.9 4891.8 4897.1 4919.9 4932.6 4941.8 5268.4 5295.3 5301.3 5315.3 5327.3 4902.8 5185.2 5191.9 5192.6 5213.3 4945.8 4961.7 4967.0 4968.4 4972.5 3701.6 3701.6 3706.4 3707.2 3734.7 5165.2 5300.4 5326.5 5332.3 5332.7 5135.5 5147.3 5151.6 5163.4 5166.1 5160.7 5164.9 5165.8 5177.9 5181.8 4862.8 4875.7 5048.8 5055.0 5070.8 5049.9 5158.4 5168.5 5178.0 5181.0 5038.4 5039.0 5046.1 5055.8 5060.2 13:51:06 INFO - PROCESS | 22455 | 13:51:06 INFO - PROCESS | 22455 | [#5] yui.html Cycles:180 Average:17110.42 Median:53626.60 stddev:24379.70 (45.5%) stddev-sans-first:24416.83 13:51:06 INFO - PROCESS | 22455 | Values: 668.5 713.9 719.5 722.7 746.5 12625.9 12907.1 13135.8 13168.4 13465.3 11833.3 11884.2 11885.5 11902.2 11907.5 628.6 781.1 801.4 814.5 814.6 811.0 812.0 817.2 818.2 818.4 861.7 866.3 866.6 867.1 867.2 663.3 673.4 678.6 681.4 854.5 597.7 614.9 616.9 618.6 619.0 11413.0 11501.7 11729.3 11757.7 11766.5 12224.3 12695.2 12706.4 12810.2 13026.9 11498.9 11663.8 11738.1 11767.3 11800.1 4119.6 4196.2 4211.3 4293.9 4303.6 52737.9 53081.2 53101.0 53331.2 53538.7 10163.4 10352.4 10536.1 10899.8 10960.1 18896.8 18966.9 18973.0 18995.6 19019.0 6746.1 6799.3 6913.7 6959.0 7093.3 3700.5 3811.7 3874.6 3984.3 3995.9 2841.9 2926.7 2955.6 2957.9 2960.3 540.6 564.9 597.1 597.7 597.9 407.3 522.4 571.8 583.9 599.6 8049.1 8051.0 8252.1 8385.5 8411.6 581.7 581.8 584.8 589.2 608.2 4034.6 4139.1 4175.4 4178.5 4228.0 99169.5 100184.0 100230.5 100236.5 104621.5 67307.7 67450.7 80123.0 85903.6 85941.0 68498.0 72009.0 72349.6 72584.9 72834.0 8257.0 8383.6 8470.1 8535.6 8619.1 39695.0 41303.6 44021.8 45154.3 45224.0 53714.5 59564.0 59838.7 60174.0 60834.0 9493.1 9618.0 9735.2 9791.5 9846.4 11942.2 12198.6 12297.9 12612.6 13120.6 11092.1 11331.8 11378.5 11399.9 11479.3 11329.5 11356.5 11496.6 11897.9 11923.3 11231.2 11414.9 11451.1 12001.2 12002.5 8806.6 9149.9 9316.0 9460.5 9658.0 9416.3 9562.3 9622.5 9660.4 9666.5 13:51:06 INFO - PROCESS | 22455 | -------- Summary: end -------- 13:51:06 INFO - PROCESS | 22455 | 13:51:07 INFO - TEST-INFO | 22455: exit 0 13:51:07 INFO - TEST-OK | dromaeo_css | took 1118573ms 13:51:07 INFO - TEST-START | kraken 13:51:07 INFO - operating with platform_type : linux_ 13:51:07 INFO - Initialising browser for kraken test... 13:51:07 INFO - TEST-INFO | started process 22636 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxkCmDJ/profile http://localhost:60391/getInfo.html) 13:51:11 INFO - PROCESS | 22636 | __metrics Screen width/height:1600/1200 13:51:11 INFO - PROCESS | 22636 | colorDepth:24 13:51:11 INFO - PROCESS | 22636 | Browser inner width/height: 1024/697 13:51:11 INFO - PROCESS | 22636 | __metrics 13:51:11 ERROR - PROCESS | 22636 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:51:12 INFO - TEST-INFO | 22636: exit 0 13:51:12 INFO - Browser initialized. 13:51:12 INFO - Running cycle 1/1 for kraken test... 13:51:12 INFO - TEST-INFO | started process 22715 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxkCmDJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:51:24 INFO - PROCESS | 22715 | RSS: Main: 158126080 13:51:24 INFO - PROCESS | 22715 | 13:51:27 INFO - PROCESS | 22715 | Cycle 1(1): loaded http://localhost:60391/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60391/tests/kraken/driver.html?testName=audio-beat-detection) 13:51:28 INFO - PROCESS | 22715 | RSS: Main: 215023616 13:51:28 INFO - PROCESS | 22715 | 13:51:31 INFO - PROCESS | 22715 | Cycle 1(1): loaded http://localhost:60391/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60391/tests/kraken/driver.html?testName=audio-dft) 13:51:31 INFO - PROCESS | 22715 | RSS: Main: 201682944 13:51:31 INFO - PROCESS | 22715 | 13:51:35 INFO - PROCESS | 22715 | Cycle 1(1): loaded http://localhost:60391/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60391/tests/kraken/driver.html?testName=audio-fft) 13:51:35 INFO - PROCESS | 22715 | RSS: Main: 270725120 13:51:35 INFO - PROCESS | 22715 | 13:51:37 INFO - PROCESS | 22715 | Cycle 1(1): loaded http://localhost:60391/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60391/tests/kraken/driver.html?testName=audio-oscillator) 13:51:38 INFO - PROCESS | 22715 | RSS: Main: 180994048 13:51:38 INFO - PROCESS | 22715 | 13:51:40 INFO - PROCESS | 22715 | Cycle 1(1): loaded http://localhost:60391/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60391/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:51:41 INFO - PROCESS | 22715 | RSS: Main: 184283136 13:51:41 INFO - PROCESS | 22715 | 13:51:44 INFO - PROCESS | 22715 | Cycle 1(1): loaded http://localhost:60391/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60391/tests/kraken/driver.html?testName=imaging-darkroom) 13:51:45 INFO - PROCESS | 22715 | RSS: Main: 220536832 13:51:45 INFO - PROCESS | 22715 | 13:51:48 INFO - PROCESS | 22715 | Cycle 1(1): loaded http://localhost:60391/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60391/tests/kraken/driver.html?testName=imaging-desaturate) 13:51:49 INFO - PROCESS | 22715 | RSS: Main: 216719360 13:51:49 INFO - PROCESS | 22715 | 13:51:52 INFO - PROCESS | 22715 | Cycle 1(1): loaded http://localhost:60391/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60391/tests/kraken/driver.html?testName=json-parse-financial) 13:51:52 INFO - PROCESS | 22715 | RSS: Main: 218624000 13:51:52 INFO - PROCESS | 22715 | 13:51:54 INFO - PROCESS | 22715 | Cycle 1(1): loaded http://localhost:60391/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60391/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:51:54 INFO - PROCESS | 22715 | RSS: Main: 208338944 13:51:54 INFO - PROCESS | 22715 | 13:51:56 INFO - PROCESS | 22715 | Cycle 1(1): loaded http://localhost:60391/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60391/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:51:57 INFO - PROCESS | 22715 | RSS: Main: 210071552 13:51:57 INFO - PROCESS | 22715 | 13:51:59 INFO - PROCESS | 22715 | Cycle 1(1): loaded http://localhost:60391/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60391/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:52:00 INFO - PROCESS | 22715 | RSS: Main: 216186880 13:52:00 INFO - PROCESS | 22715 | 13:52:03 INFO - PROCESS | 22715 | Cycle 1(1): loaded http://localhost:60391/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60391/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:52:03 INFO - PROCESS | 22715 | RSS: Main: 222990336 13:52:03 INFO - PROCESS | 22715 | 13:52:06 INFO - PROCESS | 22715 | Cycle 1(1): loaded http://localhost:60391/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60391/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:52:07 INFO - PROCESS | 22715 | RSS: Main: 222359552 13:52:07 INFO - PROCESS | 22715 | 13:52:08 INFO - PROCESS | 22715 | Cycle 1(1): loaded http://localhost:60391/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60391/tests/kraken/driver.html?testName=ai-astar) 13:52:09 INFO - PROCESS | 22715 | RSS: Main: 264237056 13:52:09 INFO - PROCESS | 22715 | 13:52:09 INFO - PROCESS | 22715 | __start_tp_report 13:52:09 INFO - PROCESS | 22715 | _x_x_mozilla_page_load 13:52:09 INFO - PROCESS | 22715 | _x_x_mozilla_page_load_details 13:52:09 INFO - PROCESS | 22715 | |i|pagename|runs| 13:52:09 INFO - PROCESS | 22715 | |0;ai-astar;113;109;116;115;114;114;115;115;114;116 13:52:09 INFO - PROCESS | 22715 | |1;audio-beat-detection;160;131;141;189;130;155;164;129;186;129 13:52:09 INFO - PROCESS | 22715 | |2;audio-dft;161;162;162;162;162;162;163;161;161;161 13:52:09 INFO - PROCESS | 22715 | |3;audio-fft;75;76;76;101;76;76;75;78;112;74 13:52:09 INFO - PROCESS | 22715 | |4;audio-oscillator;85;84;117;85;85;84;116;84;85;125 13:52:09 INFO - PROCESS | 22715 | |5;imaging-gaussian-blur;117;117;116;117;116;117;117;116;117;117 13:52:09 INFO - PROCESS | 22715 | |6;imaging-darkroom;146;147;146;146;146;146;147;145;147;146 13:52:09 INFO - PROCESS | 22715 | |7;imaging-desaturate;95;95;95;96;95;95;95;95;95;95 13:52:09 INFO - PROCESS | 22715 | |8;json-parse-financial;63;65;66;64;72;65;66;66;63;65 13:52:09 INFO - PROCESS | 22715 | |9;json-stringify-tinderbox;64;64;65;65;64;64;64;65;65;64 13:52:09 INFO - PROCESS | 22715 | |10;stanford-crypto-aes;83;95;88;82;84;90;85;91;117;84 13:52:09 INFO - PROCESS | 22715 | |11;stanford-crypto-ccm;133;136;133;130;137;131;136;133;144;140 13:52:09 INFO - PROCESS | 22715 | |12;stanford-crypto-pbkdf2;175;176;168;171;168;172;170;168;168;167 13:52:09 INFO - PROCESS | 22715 | |13;stanford-crypto-sha256-iterative;70;67;67;67;67;66;68;67;66;66 13:52:09 INFO - PROCESS | 22715 | __end_tp_report 13:52:09 INFO - PROCESS | 22715 | __start_cc_report 13:52:09 INFO - PROCESS | 22715 | _x_x_mozilla_cycle_collect,1902 13:52:09 INFO - PROCESS | 22715 | __end_cc_report 13:52:09 INFO - PROCESS | 22715 | __startTimestamp1464900729187__endTimestamp 13:52:09 INFO - PROCESS | 22715 | 13:52:09 INFO - PROCESS | 22715 | ------- Summary: start ------- 13:52:09 INFO - PROCESS | 22715 | Number of tests: 14 13:52:09 INFO - PROCESS | 22715 | 13:52:09 INFO - PROCESS | 22715 | [#0] ai-astar Cycles:10 Average:114.10 Median:115.00 stddev:2.02 (1.8%) stddev-sans-first:2.11 13:52:09 INFO - PROCESS | 22715 | Values: 113.0 109.0 116.0 115.0 114.0 114.0 115.0 115.0 114.0 116.0 13:52:09 INFO - PROCESS | 22715 | 13:52:09 INFO - PROCESS | 22715 | [#1] audio-beat-detection Cycles:10 Average:151.40 Median:157.50 stddev:23.20 (14.7%) stddev-sans-first:24.39 13:52:09 INFO - PROCESS | 22715 | Values: 160.0 131.0 141.0 189.0 130.0 155.0 164.0 129.0 186.0 129.0 13:52:09 INFO - PROCESS | 22715 | 13:52:09 INFO - PROCESS | 22715 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.67 (0.4%) stddev-sans-first:0.67 13:52:09 INFO - PROCESS | 22715 | Values: 161.0 162.0 162.0 162.0 162.0 162.0 163.0 161.0 161.0 161.0 13:52:09 INFO - PROCESS | 22715 | 13:52:09 INFO - PROCESS | 22715 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.00 stddev:13.26 (17.4%) stddev-sans-first:13.83 13:52:09 INFO - PROCESS | 22715 | Values: 75.0 76.0 76.0 101.0 76.0 76.0 75.0 78.0 112.0 74.0 13:52:09 INFO - PROCESS | 22715 | 13:52:09 INFO - PROCESS | 22715 | [#4] audio-oscillator Cycles:10 Average:95.00 Median:84.50 stddev:16.96 (20.1%) stddev-sans-first:17.60 13:52:09 INFO - PROCESS | 22715 | Values: 85.0 84.0 117.0 85.0 85.0 84.0 116.0 84.0 85.0 125.0 13:52:09 INFO - PROCESS | 22715 | 13:52:09 INFO - PROCESS | 22715 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 13:52:09 INFO - PROCESS | 22715 | Values: 117.0 117.0 116.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 13:52:09 INFO - PROCESS | 22715 | 13:52:09 INFO - PROCESS | 22715 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 13:52:09 INFO - PROCESS | 22715 | Values: 146.0 147.0 146.0 146.0 146.0 146.0 147.0 145.0 147.0 146.0 13:52:09 INFO - PROCESS | 22715 | 13:52:09 INFO - PROCESS | 22715 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 13:52:09 INFO - PROCESS | 22715 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 13:52:09 INFO - PROCESS | 22715 | 13:52:09 INFO - PROCESS | 22715 | [#8] json-parse-financial Cycles:10 Average:65.50 Median:65.50 stddev:2.55 (3.9%) stddev-sans-first:2.54 13:52:09 INFO - PROCESS | 22715 | Values: 63.0 65.0 66.0 64.0 72.0 65.0 66.0 66.0 63.0 65.0 13:52:09 INFO - PROCESS | 22715 | 13:52:09 INFO - PROCESS | 22715 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 13:52:09 INFO - PROCESS | 22715 | Values: 64.0 64.0 65.0 65.0 64.0 64.0 64.0 65.0 65.0 64.0 13:52:09 INFO - PROCESS | 22715 | 13:52:09 INFO - PROCESS | 22715 | [#10] stanford-crypto-aes Cycles:10 Average:89.90 Median:86.50 stddev:10.38 (12.0%) stddev-sans-first:10.70 13:52:09 INFO - PROCESS | 22715 | Values: 83.0 95.0 88.0 82.0 84.0 90.0 85.0 91.0 117.0 84.0 13:52:09 INFO - PROCESS | 22715 | 13:52:09 INFO - PROCESS | 22715 | [#11] stanford-crypto-ccm Cycles:10 Average:135.30 Median:136.00 stddev:4.27 (3.1%) stddev-sans-first:4.45 13:52:09 INFO - PROCESS | 22715 | Values: 133.0 136.0 133.0 130.0 137.0 131.0 136.0 133.0 144.0 140.0 13:52:09 INFO - PROCESS | 22715 | 13:52:09 INFO - PROCESS | 22715 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.30 Median:170.50 stddev:3.16 (1.9%) stddev-sans-first:2.86 13:52:09 INFO - PROCESS | 22715 | Values: 175.0 176.0 168.0 171.0 168.0 172.0 170.0 168.0 168.0 167.0 13:52:09 INFO - PROCESS | 22715 | 13:52:09 INFO - PROCESS | 22715 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:1.20 (1.8%) stddev-sans-first:0.67 13:52:09 INFO - PROCESS | 22715 | Values: 70.0 67.0 67.0 67.0 67.0 66.0 68.0 67.0 66.0 66.0 13:52:09 INFO - PROCESS | 22715 | -------- Summary: end -------- 13:52:09 INFO - PROCESS | 22715 | 13:52:10 INFO - TEST-INFO | 22715: exit 0 13:52:10 INFO - TEST-OK | kraken | took 63191ms 13:52:10 INFO - SUITE-END | took 1181s 13:52:10 INFO - Completed test suite (00:19:41) 13:52:10 INFO - javascript benchmark 13:52:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2689.6100065490505, 2707.444973780375, 2710.5934109883515, 2717.7035405082697, 2736.2065001149667, 4693.554112359329, 4722.834700785474, 4783.832565860195, 4818.686785358954, 4858.587020103291, 4766.7616619169075, 4830.589399901004, 4834.323194752737, 4839.516048395168, 4845.733484658351, 4403.3394990751485, 4431.601155895969, 4492.573205545468, 4547.317902314646, 4589.059242855206, 4471.709338892978, 4525.977370113162, 4544.477385100723, 4554.157480866033, 4565.201089809287, 4242.321228603409, 4299.226139294926, 4367.323064924942, 4444.377787109807, 4447.555244475527, 4397.098594788061, 4407.140607581523, 4409.757463339515, 4446.3108218226225, 4469.351943968107, 4429.313456414261, 4445.777711114431, 4452.888677783049, 4502.369668246448, 4503.572160644766, 4570.10882877839, 4689.882752931204, 4745.928811067837, 4780.282957556359, 4789.664723469358, 5200.0, 5216.504432078947, 5218.8695282617855, 5218.921716174261, 5232.2674825524455, 5203.895922081537, 5231.189165679326, 5245.580353571705, 5250.632455728062, 5252.553532949704, 4662.184117779375, 4833.589144922721, 4864.391951006124, 4882.902341953212, 4885.877853053631, 5327.600429967768, 5359.892802144013, 5377.381601115843, 5381.7578208980685, 5386.784528618811, 4839.201531747292, 5154.690718556899, 5165.070287348238, 5166.689998600096, 5173.456787037382, 4985.127602669519, 5024.57291130258, 5060.51925067118, 5071.518205770446, 5078.923816142761, 5044.596432285409, 5055.848324550269, 5094.388673359221, 5095.617828662791, 5143.614228932845, 4908.901821963541, 5026.0, 5047.545720885065, 5063.291139240509, 5071.644984851099, 4279.0, 4294.033842385438, 4296.011917258986, 4325.545817689097, 4338.848140315074, 3740.0275928258848, 3753.4369844522994, 3762.8494860205287, 3796.145867179918, 3800.1829606634706, 4339.500957389878, 4393.0994146199955, 4432.091421258634, 4487.080148569536, 4493.977530112328, 5184.429712731597, 5206.97396513015, 5207.843764687065, 5214.895702085937, 5297.7880884764945, 4472.351509031172, 4492.213862574036, 4493.123840851003, 4493.820247190141, 4538.2738761797955, 4530.909381812346, 4596.333531637893, 4654.325122857167, 4686.226772582554, 4716.787744551503, 4839.032193561372, 4867.9269810952865, 4883.755812209446, 4887.022595480918, 4911.9754401227765, 5189.76646050921, 5214.739263036757, 5216.895662086813, 5217.165253559412, 5219.712915789668, 4630.4443466784205, 4651.604613607881, 4821.180399332052, 4842.491538388418, 4899.216125419915, 5029.44676085623, 5059.696418214919, 5064.898702026013, 5066.594672426123, 5167.095758242217, 5164.8192313268855, 5177.663451875616, 5183.196604526304, 5186.611004174627, 5191.11751002338, 4845.53967373099, 4957.082939656031, 5033.0688822567945, 5040.042391945519, 5062.696238225718, 5015.623828212972, 5049.293098966221, 5054.772535235849, 5055.494450555062, 5105.617078719037, 4760.833370832004, 4979.0, 4991.201407774739, 4996.675216110941, 5040.117979353525, 4997.650164488451, 5069.721165335942, 5077.136886729191, 5082.390113186441, 5097.362829646294, 4953.133201689762, 4959.925601115914, 4965.4289756677, 4968.378952630921, 5015.824446144367], "value": 4732.03702373913, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.9112133180023, 600.6576251536624, 602.1178972804843, 608.0271565495206, 630.8233694565522, 27462.86268568657, 30101.24746881329, 39587.40618890719, 41425.378619320734, 41541.58458415415, 42819.3577096343, 43195.78402107985, 43255.35116973248, 43375.56624433755, 43403.34894976578, 7840.372770178386, 8025.23760242776, 8027.839443211133, 8028.237317454832, 8032.0, 7753.612319384037, 7842.960785196066, 7878.330341920915, 7881.17247688993, 7883.605819709021, 7860.174681658429, 7941.761747147595, 7953.403494737918, 7959.840803183933, 7960.840783184332, 7884.290413862751, 7935.444518883681, 7935.920640793604, 7936.603169841543, 7940.364770818378, 7885.842283154305, 7935.285824275843, 7945.4438189326775, 7946.443748937577, 7959.124496305401, 38821.61178388236, 39153.21693566141, 39260.411093833616, 39336.21327573433, 39395.4090688637, 3190.489521676544, 3250.951235731466, 3292.901212963615, 3307.7353811695007, 3774.75464094833, 29485.41029179426, 30011.69988300133, 30154.837037258658, 30706.38587228265, 31002.0, 3531.770434921722, 3564.8930532084078, 3588.910277243064, 3592.8562857485667, 3630.5824830144343, 265322.0, 265497.0, 266209.9999999981, 266375.0, 266621.0, 47807.760961195665, 54591.18113228305, 56098.158527622116, 57032.71869125189, 57227.14159287614, 57644.0, 58564.707176463846, 58646.0, 58783.412165878646, 58891.705541472016, 15115.470958516618, 15271.770923436157, 15288.541343759705, 15294.770578441332, 15304.540863774104, 9714.0, 11350.318980861175, 11624.709382265342, 11684.47419866108, 11903.940480297542, 17092.48722538326, 17105.23026463812, 17125.0, 17147.57131071708, 17159.399421020455, 5832.300123985149, 5918.704064796743, 6041.78853740117, 6103.6948152592195, 6279.560430769802, 833.9457935234191, 917.7934964632905, 926.7127190570944, 955.0020228860857, 1038.2939601071344, 26935.86532067327, 28582.28544286368, 28585.28536786597, 28834.0, 29263.414731705674, 976.2775546095838, 998.4458625462793, 1015.9542820573092, 1066.3921564708041, 1089.5315014543821, 14697.85302146965, 15444.382224711111, 15825.366985320688, 16830.495085147464, 16946.40687575929, 386404.0, 389623.0, 391152.0, 391718.0, 391736.0, 49816.501834981915, 50842.0, 50883.0, 50911.23633145506, 50957.235641465406, 1071.212658695858, 1140.520981187903, 1180.4805885410392, 1198.526582000105, 1219.426869371394, 26346.0, 28907.132786016453, 29649.703502964694, 29760.70239297666, 29962.850185749805, 43194.0, 43258.35112473252, 43631.78184109059, 43668.0, 43740.0, 242111.0, 242759.0, 243295.0, 243602.0, 243678.0, 21979.670304945117, 23053.077876884738, 24660.260192194262, 25509.23472295834, 25734.227973160836, 41526.58473415348, 41609.0471405216, 42080.3687944675, 42640.0, 42903.785481072395, 36371.45442818413, 36398.27203455863, 36631.45052824156, 36779.63220367762, 36834.63165368312, 35497.645023549434, 36890.8155459221, 36980.44529332008, 37193.81403092967, 37319.81340093282, 35742.64257357393, 35779.642203578675, 35885.64114358927, 36439.81780091082, 36742.26515469729, 31486.212844679067, 32617.34765304633, 32944.67055329416, 32973.0, 33130.834345828116, 24906.0, 25126.62310065387, 25356.619650704884, 25433.79561862733, 25571.36071598225], "value": 17673.86060912253, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.786015181119, 375.63188075685827, 384.58080692045667, 386.767939236458, 387.42080589518673, 15666.530004099866, 16531.0, 16790.748138777897, 17059.829401705963, 17152.228149733262, 16009.19954002298, 16323.265453054611, 17124.400645977392, 17136.657266854654, 17160.056196909165, 4890.828820991257, 5000.424951130612, 5066.645334826564, 5070.898582028376, 5089.211172268304, 3612.710983121357, 3789.1663833956486, 5036.84889453317, 5534.169874518814, 5878.265216847894, 5890.587658863881, 5910.172575839386, 5917.319508256563, 5929.525637948954, 5932.555058370639, 5700.287464066992, 5785.190073389729, 5846.678432686201, 5907.6750778707155, 5919.260092488439, 3327.750418718606, 4811.59101476375, 5072.289879416885, 5101.948980510185, 5148.6910785353, 19392.80607193924, 19874.503137421536, 19908.0, 20055.29806456767, 20060.899695501575, 1903.8667293289475, 1988.9909351738204, 2080.583883223361, 2283.6917016202765, 2513.987430062856, 8498.19267169624, 8879.644814207424, 9004.369694121415, 9629.0, 12946.805797913039, 1705.1133410626405, 1760.331074191799, 1780.2167046499499, 1792.9820701792946, 1798.5863251452108, 62534.0, 65309.0, 66497.66751166261, 75422.0, 75481.24518754742, 9768.755781105529, 9962.402255864527, 10235.897641023494, 10277.047361001385, 10334.556140859353, 14073.87409007277, 14187.929060354632, 14194.787078193835, 14195.574132776033, 14204.786928196085, 7438.330550250504, 7479.925200748032, 7539.962300188464, 7553.811154721176, 7665.770026899202, 7216.530925489827, 7265.12818461788, 7334.706611735471, 7366.0, 7381.520201186906, 4370.213361594943, 4462.665300102441, 4462.709923854939, 4514.6614003949835, 4567.794449249792, 1672.991635041817, 1789.91945362459, 1790.2302010135506, 1811.4746723450053, 1833.4408005558166, 627.2263811614082, 826.8387664405383, 869.1472545550918, 959.5154447004358, 998.1515711645044, 16337.754933676004, 16615.50153495397, 16845.83154168467, 16941.491755247363, 17188.65622687539, 865.6667183134539, 910.1171863292595, 920.963161473547, 942.2132519346286, 956.818204541135, 9235.399699019543, 9628.229741620653, 9664.516774161264, 9681.9031809681, 9837.409755414697, 339356.0, 339768.0, 342057.0, 347889.0, 353033.0, 68640.31359686339, 75368.62315688496, 76732.61633691796, 78051.0, 78221.21778782253, 932.2309094996655, 950.6815216902277, 979.774651830083, 988.9604415823286, 995.6017592962872, 15014.924925375302, 15495.612609684396, 15646.374145034071, 15811.288492017657, 15946.760798588262, 32715.34569308648, 35262.823685881405, 35938.46092308565, 36096.0, 37052.44421333736, 39897.40153897636, 47709.52290477051, 49554.0, 49897.501024990735, 50234.49765502445, 7502.0, 7510.62446877643, 7552.282533159341, 7575.545467271982, 7729.9227007729205, 8193.426460147972, 10429.217808664229, 11830.704232394259, 11912.0, 12143.939280303543, 9564.904350956402, 9697.6605818796, 9957.800843983225, 10179.236557258087, 10192.796144077225, 10107.444090575089, 10252.282340236112, 10320.0, 10445.843312350473, 10448.634297799541, 9307.441553506811, 9574.547166538752, 9860.753481163028, 9913.950430247802, 10269.589216431259, 7442.96278518604, 7510.586917719578, 7520.586367749826, 7611.809704757426, 7627.275408836152, 9765.365251258645, 10110.49447527606, 10198.235132364955, 10536.631217907336, 10606.575736970435], "value": 8176.180192304273, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1225.963221103366, 1399.706061727037, 1427.9214643194623, 1524.4207201263519, 1770.1503278426355, 6316.936830631692, 6961.7911462656075, 7100.431965442765, 7125.643717814101, 7387.26127387261, 7105.5026148169645, 7235.782926512213, 7242.6378681066, 7249.565026098438, 7250.564966102024, 2081.1155259014936, 2106.410205142555, 2106.536561956375, 2109.4620871677776, 2109.9789002110015, 2037.6128535578266, 2043.2439997201056, 2077.2937201351538, 2111.788821117884, 2114.302280247515, 2099.6220680277543, 2121.321177223289, 2130.4141361125735, 2136.6154092263464, 2176.336217453676, 2086.353230498543, 2087.488565301496, 2093.518490747129, 2093.6336141175234, 2094.0890712540095, 1977.0947552760629, 2050.0569737920573, 2053.117159621362, 2053.887036213008, 2054.681524363726, 7073.893891591631, 7182.748603798842, 7230.638468076628, 7243.384312333458, 7245.818854528627, 4282.892927676802, 4453.198424283628, 4454.510003899569, 4455.064436468346, 4462.866114016585, 2809.9016534421403, 2909.8836046558113, 2951.911442656724, 2968.554716792477, 2969.228000719807, 943.2831048403194, 957.0477375011839, 975.9707208783748, 991.2714155095998, 1007.8639383683255, 9845.310828242025, 9911.702648920544, 9932.255080868963, 9963.950180249125, 9988.750281242954, 3910.9608903911167, 3999.6000399960353, 4007.0984028593334, 4202.873913782591, 4212.389203565466, 7541.585212813348, 7564.735234266775, 7617.542947423061, 7625.199354067743, 7631.084269887538, 4379.934300985487, 4380.8685739427865, 4382.364557139261, 4382.69321147523, 4385.978070109692, 3620.728445366555, 3987.4816273884207, 4083.0608959938786, 4098.7130900836655, 4099.098198396348, 3347.0795531229105, 3357.4292370297107, 3406.1314364837303, 3424.07549961509, 3479.2867462170193, 1008.702432782331, 1074.8172810622214, 1075.7203127186988, 1077.3482043363808, 1080.4981076303943, 856.3577317012241, 859.1923591823665, 866.1165611076666, 866.6273502393905, 881.8412685716632, 5301.125314323093, 5318.787248510016, 5350.545203657733, 5595.804146854841, 5617.045102332613, 848.3722045686271, 876.9693060742843, 902.8239493298744, 928.4475736936512, 935.4013431403907, 3629.6733294003666, 3640.8361623726996, 3693.4644476550748, 3706.5366829146355, 3741.5884252732176, 8655.307575393954, 8862.335324850663, 9024.729258122266, 9029.23251523628, 9035.819283614292, 8362.16378362171, 8667.263282620921, 8720.8691869622, 8909.465432074096, 8951.149640784115, 6839.726410943506, 7037.683304251321, 7044.731948249364, 7045.225025247219, 7046.506744527834, 5215.921761173509, 5239.633225674166, 5257.185136303879, 5482.342118945752, 5524.281843360337, 8201.589920503831, 8208.753737387888, 8308.70919517814, 8452.788680283042, 8478.02502712196, 7962.6814927404575, 8522.446041007315, 8550.444221125606, 8552.315814734931, 8589.613467393858, 5779.624324418899, 6180.81457556274, 6289.465395441256, 6466.967665161644, 6482.513811464065, 7209.495335326476, 7266.0, 7288.599127047851, 7297.270272972661, 7312.744053958086, 6282.780102696383, 6460.644664543307, 6473.2232132144445, 6550.312217217123, 6571.145751052524, 5984.790532331347, 6141.0, 6241.344658810759, 6311.116443697978, 6385.106085148176, 6158.3841615838055, 6193.876122477615, 6199.535034872493, 6217.253929528486, 6218.875622487615, 4296.2266791977745, 4659.370984917128, 4673.158831410379, 4718.056388722201, 4723.976380118077, 4661.184292748823, 4667.8599642010795, 4689.460712018162, 4695.882602934954, 4782.0435912818275], "value": 3982.592180281502, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.616946477973, 301.71487943893015, 306.4147478316415, 308.76225306513976, 308.76533834285937, 4894.681845680028, 4906.901861962759, 4923.581495572872, 4940.209566469365, 4948.109340318746, 4814.157522433569, 4858.757062146888, 4862.2706594010915, 4863.878403039926, 4870.0, 3599.8560057597665, 3694.501242332291, 3719.572249191337, 3784.7539909905904, 3849.557300910389, 3782.7352085354037, 3813.2564149990762, 3820.5606355269083, 3833.175867188554, 3855.7879316637573, 3587.515685382479, 3792.677622402099, 3804.676602488778, 3805.0487378155462, 3807.02920755207, 3675.375186218336, 3788.6211378862167, 3799.3731034379434, 3800.5676367124784, 3802.923941521182, 3358.8488518016748, 3361.3949489091956, 3375.1899544109237, 3377.9662203377898, 3386.102682789063, 4636.629069674418, 4637.536246375369, 4658.371119898804, 4661.906761864744, 4688.156131896258, 4231.196072746168, 4337.63130133939, 4360.433143691332, 4379.1022840317655, 4379.4525684289465, 5042.1176294148745, 5051.19180931053, 5071.3407257056715, 5071.797128114871, 5099.898002039976, 3670.284294562561, 3684.5946945835935, 3688.61269566697, 3691.298653255873, 3701.2597480504005, 5161.845144645629, 5191.6884986900905, 5250.474952504757, 5304.469553044703, 5331.386890507563, 3735.43968404736, 3741.7006639468777, 3764.3600587900123, 3764.830582623734, 3766.548014238254, 3773.603771603997, 3788.677962373174, 3815.569161564413, 3846.7114966377635, 3852.2488114817343, 4308.46144231971, 4327.783610819446, 4335.588119128678, 4338.958649924059, 4351.43431353922, 4891.413030436299, 5024.874378140576, 5037.848864534069, 5056.63470862865, 5058.494150584912, 1300.0379719007867, 1316.453671726242, 1321.359140816703, 1338.8125662407272, 1339.852616212216, 846.95341756204, 858.8368210040072, 888.2494292322976, 898.9460632362079, 904.4166512599337, 4372.256716358227, 4426.535213802505, 4513.50351461339, 4585.426821647294, 4585.518520555361, 5276.894462110737, 5280.81517146898, 5302.92045619316, 5306.46935306474, 5312.123499622519, 4348.804078878334, 4427.889302767392, 4473.642108631302, 4587.311903214544, 4590.0, 2731.713170117149, 2743.053646491957, 2755.2698534888273, 2756.517609418384, 2789.0337312194856, 4869.245266983623, 4901.264810278415, 4905.754712264373, 4919.827806026843, 4946.851594452172, 4974.253861920669, 5345.786168553214, 5348.9732551337775, 5373.194020896819, 5386.946130538723, 4891.779869905863, 4897.094037603055, 4919.926201107058, 4932.630052746058, 4941.802327906916, 5268.394134674561, 5295.27903431394, 5301.25782390458, 5315.335583052119, 5327.280817089798, 4902.828401005948, 5185.196294574347, 5191.923230707747, 5192.636515443883, 5213.270142180174, 4945.826896058621, 4961.677490963076, 4966.950330496648, 4968.403791545038, 4972.513743128436, 3701.6113308102263, 3701.611330810334, 3706.3699171140433, 3707.1844194277214, 3734.682551983003, 5165.199394093921, 5300.416954134965, 5326.467353264643, 5332.30680011596, 5332.68003919766, 5135.460776618401, 5147.327118686517, 5151.639385242997, 5163.3545806774155, 5166.095933211598, 5160.664556803796, 5164.889548747037, 5165.7933682653775, 5177.870553236199, 5181.766820493162, 4862.82980095695, 4875.707937396522, 5048.848534543969, 5055.0, 5070.8225212117395, 5049.9495005049475, 5158.406783219828, 5168.53483186515, 5178.0, 5181.0, 5038.420581633159, 5038.974805125951, 5046.116929537243, 5055.797768089235, 5060.1903695408555], "value": 3853.29121791332, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.5453891353881, 713.9362350098352, 719.5466855880793, 722.7145277615342, 746.4550877859159, 12625.873741262585, 12907.096503244777, 13135.802962955539, 13168.407421666025, 13465.259410732406, 11833.29000259985, 11884.227525210856, 11885.524579016828, 11902.2263552869, 11907.52369905205, 628.6228263042184, 781.0744268042359, 801.4229754576695, 814.4828034198297, 814.5601375257354, 811.0470197517923, 811.9594020298991, 817.1746535998655, 818.2226884459757, 818.4271010292789, 861.6725644255174, 866.2766589897443, 866.5927014303298, 867.1371984875058, 867.2151702709027, 663.3499170812582, 673.3703986772359, 678.6437120511771, 681.3731367142241, 854.4616891358436, 597.6742675242003, 614.8678034222663, 616.9043798211285, 618.6226401894841, 619.0188551146439, 11413.0, 11501.712457188554, 11729.296242225408, 11757.706057348549, 11766.529338826436, 12224.327661978588, 12695.238285702795, 12706.428210730539, 12810.167339122927, 13026.934865325613, 11498.905744467693, 11663.76672466546, 11738.06095512357, 11767.2939623622, 11800.055995520337, 4119.649829764474, 4196.244675958326, 4211.263028969918, 4293.935590966138, 4303.634191093761, 52737.94524109496, 53081.2037819433, 53101.0, 53331.20003199955, 53538.73230633822, 10163.390196588081, 10352.430616316175, 10536.051755341903, 10899.83650245247, 10960.123190144928, 18896.81103188978, 18966.905165474083, 18973.0, 18995.62008759817, 19019.0, 6746.055552222692, 6799.286074962157, 6913.688884000232, 6958.965205173941, 7093.32613401726, 3700.50043244164, 3811.6950643948417, 3874.5544262410185, 3984.30274701926, 3995.9400608990886, 2841.886324547036, 2926.678065412803, 2955.600993865801, 2957.940841183164, 2960.259935016246, 540.608059157108, 564.892670392624, 597.1430996520007, 597.6951754605183, 597.8953683105439, 407.2974119643591, 522.3966318901674, 571.7541457173372, 583.8919799837043, 599.6029251843195, 8049.078050764222, 8051.0, 8252.092269850311, 8385.45494542865, 8411.621477033548, 581.7498475655424, 581.7672930827703, 584.801167603017, 589.2104579863004, 608.2457752387008, 4034.576369481221, 4139.110091330318, 4175.352820312795, 4178.456800615901, 4227.957720422756, 99169.50415248022, 100184.0, 100230.49884750675, 100236.49881750545, 104621.47689261504, 67307.66346168336, 67450.66274668595, 80123.0, 85903.57048214719, 85941.0, 68498.0, 72009.0, 72349.63825180946, 72584.91122633165, 72834.0, 8257.0, 8383.634139643977, 8470.068292487944, 8535.61589728476, 8619.094995025433, 39695.0, 41303.58696413117, 44021.77989110034, 45154.322685159095, 45224.0, 53714.46285537095, 59564.0, 59838.70080649743, 60174.0, 60834.0, 9493.0981556752, 9618.0, 9735.22118230554, 9791.510424478605, 9846.409215447096, 11942.16404851652, 12198.573049943565, 12297.877021229673, 12612.55856045034, 13120.60638180856, 11092.116049827264, 11331.773364532828, 11378.487968041292, 11399.943000285277, 11479.311241325548, 11329.490172942073, 11356.545738170711, 11496.597619083626, 11897.940510297392, 11923.284602923852, 11231.213815033196, 11414.885851141382, 11451.14116441287, 12001.219920705125, 12002.519899203933, 8806.60370283326, 9149.908500914906, 9316.0, 9460.479673617741, 9658.0, 9416.340856140005, 9562.3225496861, 9622.47076410804, 9660.37207581505, 9666.468344240853], "value": 6513.540437971279, "unit": "score"}], "name": "dromaeo_css", "value": 6394.391096883022, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 109.0, 116.0, 115.0, 114.0, 114.0, 115.0, 115.0, 114.0, 116.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 131.0, 141.0, 189.0, 130.0, 155.0, 164.0, 129.0, 186.0, 129.0], "value": 151.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 162.0, 162.0, 162.0, 163.0, 161.0, 161.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 101.0, 76.0, 76.0, 75.0, 78.0, 112.0, 74.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 117.0, 85.0, 85.0, 84.0, 116.0, 84.0, 85.0, 125.0], "value": 95.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 145.0, 147.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 66.0, 64.0, 72.0, 65.0, 66.0, 66.0, 63.0, 65.0], "value": 65.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 65.0, 64.0, 64.0, 64.0, 65.0, 65.0, 64.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 95.0, 88.0, 82.0, 84.0, 90.0, 85.0, 91.0, 117.0, 84.0], "value": 89.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 136.0, 133.0, 130.0, 137.0, 131.0, 136.0, 133.0, 144.0, 140.0], "value": 135.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 176.0, 168.0, 171.0, 168.0, 172.0, 170.0, 168.0, 168.0, 167.0], "value": 170.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 67.0, 67.0, 67.0, 66.0, 68.0, 67.0, 66.0, 66.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1554.6, "alertThreshold": 2.0}]} 13:52:10 INFO - Return code: 0 13:52:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:52:10 ERROR - # TBPL SUCCESS # 13:52:10 INFO - Running post-action listener: _resource_record_post_action 13:52:10 INFO - ##### 13:52:10 INFO - ##### Finished run-tests step (success) 13:52:10 INFO - ##### 13:52:10 INFO - Running post-run listener: _resource_record_post_run 13:52:10 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 12288; Write bytes: 534986752; Read time: 236; Write time: 556812 13:52:10 INFO - TinderboxPrint: CPU usage
13.1% 13:52:10 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 236 13:52:10 INFO - TinderboxPrint: I/O write bytes / time
534,986,752 / 556,812 13:52:10 INFO - TinderboxPrint: CPU idle
8,316.3 (86.9%) 13:52:10 INFO - TinderboxPrint: CPU user
1,211.0 (12.7%) 13:52:10 INFO - TinderboxPrint: Swap in / out
0 / 0 13:52:10 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 249880576; Read time: 0; Write time: 314408 13:52:10 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 12288; Write bytes: 285106176; Read time: 236; Write time: 242404 13:52:11 INFO - Running post-run listener: _upload_blobber_files 13:52:11 INFO - Blob upload gear active. 13:52:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:52: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 13:52: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'] 13:52: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 13:52:11 INFO - (blobuploader) - INFO - Open directory for files ... 13:52:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:52:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:52:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:52:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:52:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:52:16 INFO - (blobuploader) - INFO - Done attempting. 13:52:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:52:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:52:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:52:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:52:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:52:17 INFO - (blobuploader) - INFO - Done attempting. 13:52:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:52:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:52:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:52:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:52:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:52:17 INFO - (blobuploader) - INFO - Done attempting. 13:52:17 INFO - (blobuploader) - INFO - Iteration through files over. 13:52:17 INFO - Return code: 0 13:52:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:52:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:52:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/25cfebb6dfaf7f903549d614d673e0e3af663fb8dcd4ec88567c1f897e0c384bc31673655949fe2381cf40df12d0106ce2eb83cca3fcb6a00adfce60d13d9449", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/39a7528d14eb729d9b910839705061d7cc9beee96b4733541a6e4e62d8fe20f2554eef994e1c2022fa1a4d0ef0ae7bb5d3275cfa7e05b15e0d4d96ae537032d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2ebf1f8860a79238084e1199a17a35b4ab229e3ac614824e3ac21fe2e7f40af5454d36aac39a42fc948fe33c429001d536cafe018050b6dcaf3133b890696b52"} 13:52:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:52:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:52:17 INFO - Contents: 13:52:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/25cfebb6dfaf7f903549d614d673e0e3af663fb8dcd4ec88567c1f897e0c384bc31673655949fe2381cf40df12d0106ce2eb83cca3fcb6a00adfce60d13d9449", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/39a7528d14eb729d9b910839705061d7cc9beee96b4733541a6e4e62d8fe20f2554eef994e1c2022fa1a4d0ef0ae7bb5d3275cfa7e05b15e0d4d96ae537032d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2ebf1f8860a79238084e1199a17a35b4ab229e3ac614824e3ac21fe2e7f40af5454d36aac39a42fc948fe33c429001d536cafe018050b6dcaf3133b890696b52"} 13:52:17 INFO - Running post-run listener: copy_logs_to_upload_dir 13:52:17 INFO - Copying logs to upload dir... 13:52:17 INFO - mkdir: /builds/slave/test/build/upload/logs 13:52:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.673043 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-02 13:52:17.428622) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 13:52:17.431966) ========= 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=32c5991c409366f7fec8a718000001d2-1464898236.696220-1917848186 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/25cfebb6dfaf7f903549d614d673e0e3af663fb8dcd4ec88567c1f897e0c384bc31673655949fe2381cf40df12d0106ce2eb83cca3fcb6a00adfce60d13d9449", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/39a7528d14eb729d9b910839705061d7cc9beee96b4733541a6e4e62d8fe20f2554eef994e1c2022fa1a4d0ef0ae7bb5d3275cfa7e05b15e0d4d96ae537032d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2ebf1f8860a79238084e1199a17a35b4ab229e3ac614824e3ac21fe2e7f40af5454d36aac39a42fc948fe33c429001d536cafe018050b6dcaf3133b890696b52"} build_url:https://queue.taskcluster.net/v1/task/Q3RLhiEXTteVBXPJleGvxA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011275 build_url: 'https://queue.taskcluster.net/v1/task/Q3RLhiEXTteVBXPJleGvxA/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/25cfebb6dfaf7f903549d614d673e0e3af663fb8dcd4ec88567c1f897e0c384bc31673655949fe2381cf40df12d0106ce2eb83cca3fcb6a00adfce60d13d9449", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/39a7528d14eb729d9b910839705061d7cc9beee96b4733541a6e4e62d8fe20f2554eef994e1c2022fa1a4d0ef0ae7bb5d3275cfa7e05b15e0d4d96ae537032d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2ebf1f8860a79238084e1199a17a35b4ab229e3ac614824e3ac21fe2e7f40af5454d36aac39a42fc948fe33c429001d536cafe018050b6dcaf3133b890696b52"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 13:52:17.458077) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 13:52:17.458476) ========= 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=32c5991c409366f7fec8a718000001d2-1464898236.696220-1917848186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004436 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 13:52:17.543924) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 13:52:17.544291) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 13:52:17.544661) ========= ========= Total master_lag: 0.16 =========