builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-009 starttime: 1463262049.0 results: success (0) buildid: 20160514130527 builduid: 2ff7712dfe204a41a0a665e4771196ee revision: 403912ca555eb65f814b18ecf38ad8e8e98569f5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-14 14:40:49.003667) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-14 14:40:49.004181) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-14 14:40:49.004460) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-14 14:40:49.045043) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 14:40:49.045310) ========= 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=aa52b8aba932b19cc50b5275000001de-1463239279.16202-299725333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-14 14:40:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-05-14 14:40:49 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092114 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 14:40:49.151460) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 14:40:49.151803) ========= 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=aa52b8aba932b19cc50b5275000001de-1463239279.16202-299725333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018282 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 14:40:49.203493) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 14:40:49.203814) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 403912ca555eb65f814b18ecf38ad8e8e98569f5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 403912ca555eb65f814b18ecf38ad8e8e98569f5 --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=aa52b8aba932b19cc50b5275000001de-1463239279.16202-299725333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-14 14:40:49,581 truncating revision to first 12 chars 2016-05-14 14:40:49,582 Setting DEBUG logging. 2016-05-14 14:40:49,582 attempt 1/10 2016-05-14 14:40:49,582 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/403912ca555e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-14 14:40:49,857 unpacking tar archive at: mozilla-central-403912ca555e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.568952 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 14:40:49.785699) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-14 14:40:49.786018) ========= script_repo_revision: 403912ca555eb65f814b18ecf38ad8e8e98569f5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-14 14:40:49.786400) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-14 14:40:49.786665) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-14 14:40:49.794021) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-14 14:40:49.794288) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=aa52b8aba932b19cc50b5275000001de-1463239279.16202-299725333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:40:50 INFO - MultiFileLogger online at 20160514 14:40:50 in /builds/slave/test 14:40:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 14:40:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:40:50 INFO - {'append_to_log': False, 14:40:50 INFO - 'base_work_dir': '/builds/slave/test', 14:40:50 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 14:40:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:40:50 INFO - 'branch': 'Firefox-Non-PGO', 14:40:50 INFO - 'buildbot_json_path': 'buildprops.json', 14:40:50 INFO - 'config_files': ('talos/linux_config.py',), 14:40:50 INFO - 'default_actions': ('clobber', 14:40:50 INFO - 'read-buildbot-config', 14:40:50 INFO - 'download-and-extract', 14:40:50 INFO - 'populate-webroot', 14:40:50 INFO - 'create-virtualenv', 14:40:50 INFO - 'install', 14:40:50 INFO - 'run-tests'), 14:40:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:40:50 INFO - 'download_minidump_stackwalk': True, 14:40:50 INFO - 'download_symbols': 'ondemand', 14:40:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:40:50 INFO - 'tooltool.py': '/tools/tooltool.py', 14:40:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:40:50 INFO - '/tools/misc-python/virtualenv.py')}, 14:40:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:40:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:40:50 INFO - 'installer_path': 'installer.exe', 14:40:50 INFO - 'log_level': 'info', 14:40:50 INFO - 'log_name': 'talos', 14:40:50 INFO - 'log_to_console': True, 14:40:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:40:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:40:50 INFO - 'opt_config_files': (), 14:40:50 INFO - 'pip_index': False, 14:40:50 INFO - 'sps_profile': False, 14:40:50 INFO - 'sps_profile_interval': 0, 14:40:50 INFO - 'suite': 'dromaeojs-e10s', 14:40:50 INFO - 'system_bits': '32', 14:40:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:40:50 INFO - 'title': 'talos-linux64-ix-009', 14:40:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:40:50 INFO - 'use_talos_json': True, 14:40:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:40:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:40:50 INFO - 'work_dir': 'build'} 14:40:50 INFO - ##### 14:40:50 INFO - ##### Running clobber step. 14:40:50 INFO - ##### 14:40:50 INFO - Running pre-action listener: _resource_record_pre_action 14:40:50 INFO - Running main action method: clobber 14:40:50 INFO - rmtree: /builds/slave/test/build 14:40:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:40:50 INFO - Running post-action listener: _resource_record_post_action 14:40:50 INFO - ##### 14:40:50 INFO - ##### Finished clobber step (success) 14:40:50 INFO - ##### 14:40:50 INFO - ##### 14:40:50 INFO - ##### Running read-buildbot-config step. 14:40:50 INFO - ##### 14:40:50 INFO - Running pre-action listener: _resource_record_pre_action 14:40:50 INFO - Running main action method: read_buildbot_config 14:40:50 INFO - Using buildbot properties: 14:40:50 INFO - { 14:40:50 INFO - "project": "", 14:40:50 INFO - "product": "firefox", 14:40:50 INFO - "script_repo_revision": "production", 14:40:50 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 14:40:50 INFO - "repository": "", 14:40:50 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 14:40:50 INFO - "buildid": "20160514130527", 14:40:50 INFO - "pgo_build": "False", 14:40:50 INFO - "basedir": "/builds/slave/test", 14:40:50 INFO - "buildnumber": 351, 14:40:50 INFO - "slavename": "talos-linux64-ix-009", 14:40:50 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:40:50 INFO - "platform": "ubuntu64_hw", 14:40:50 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 14:40:50 INFO - "branch": "mozilla-central", 14:40:50 INFO - "repo_path": "mozilla-central", 14:40:50 INFO - "revision": "403912ca555eb65f814b18ecf38ad8e8e98569f5", 14:40:50 INFO - "stage_platform": "linux64", 14:40:50 INFO - "builduid": "2ff7712dfe204a41a0a665e4771196ee", 14:40:50 INFO - "slavebuilddir": "test" 14:40:50 INFO - } 14:40:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/UAXmI3VEQA6LyDbc6-lcvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 14:40:50 INFO - Running post-action listener: _resource_record_post_action 14:40:50 INFO - ##### 14:40:50 INFO - ##### Finished read-buildbot-config step (success) 14:40:50 INFO - ##### 14:40:50 INFO - ##### 14:40:50 INFO - ##### Running download-and-extract step. 14:40:50 INFO - ##### 14:40:50 INFO - Running pre-action listener: _resource_record_pre_action 14:40:50 INFO - Running main action method: download_and_extract 14:40:50 INFO - mkdir: /builds/slave/test/build/tests 14:40:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:40:50 INFO - https://queue.taskcluster.net/v1/task/UAXmI3VEQA6LyDbc6-lcvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:40:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAXmI3VEQA6LyDbc6-lcvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:40:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAXmI3VEQA6LyDbc6-lcvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:40:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAXmI3VEQA6LyDbc6-lcvw/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 14:40:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAXmI3VEQA6LyDbc6-lcvw/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 14:40:53 INFO - Downloaded 1361 bytes. 14:40:53 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:40:53 INFO - Using the following test package requirements: 14:40:53 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:40:53 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:40:53 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:40:53 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:40:53 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:40:53 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:40:53 INFO - u'jsshell-linux-x86_64.zip'], 14:40:53 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:40:53 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:40:53 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:40:53 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:40:53 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:40:53 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:40:53 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:40:53 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:40:53 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:40:53 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:40:53 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:40:53 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:40:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:40:53 INFO - https://queue.taskcluster.net/v1/task/UAXmI3VEQA6LyDbc6-lcvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:40:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAXmI3VEQA6LyDbc6-lcvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:40:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAXmI3VEQA6LyDbc6-lcvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:40:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAXmI3VEQA6LyDbc6-lcvw/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 14:40:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAXmI3VEQA6LyDbc6-lcvw/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 14:40:55 INFO - Downloaded 22447955 bytes. 14:40:55 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'] 14:40:55 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 14:40:56 INFO - Return code: 0 14:40:56 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 14:40:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:40:56 INFO - https://queue.taskcluster.net/v1/task/UAXmI3VEQA6LyDbc6-lcvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:40:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAXmI3VEQA6LyDbc6-lcvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:40:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAXmI3VEQA6LyDbc6-lcvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:40:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAXmI3VEQA6LyDbc6-lcvw/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 14:40:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAXmI3VEQA6LyDbc6-lcvw/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 14:40:57 INFO - Downloaded 22447955 bytes. 14:40:57 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'] 14:40:57 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 14:40:59 INFO - Return code: 0 14:40:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:40:59 INFO - https://queue.taskcluster.net/v1/task/UAXmI3VEQA6LyDbc6-lcvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:40:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAXmI3VEQA6LyDbc6-lcvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:40:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAXmI3VEQA6LyDbc6-lcvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:40:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAXmI3VEQA6LyDbc6-lcvw/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 14:40:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAXmI3VEQA6LyDbc6-lcvw/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 14:41:00 INFO - Downloaded 10840194 bytes. 14:41:00 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'] 14:41:00 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 14:41:00 INFO - Return code: 0 14:41:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:00 INFO - https://queue.taskcluster.net/v1/task/UAXmI3VEQA6LyDbc6-lcvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:41:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAXmI3VEQA6LyDbc6-lcvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:41:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAXmI3VEQA6LyDbc6-lcvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:41:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAXmI3VEQA6LyDbc6-lcvw/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 14:41:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAXmI3VEQA6LyDbc6-lcvw/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 14:41:01 INFO - Downloaded 54736994 bytes. 14:41:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UAXmI3VEQA6LyDbc6-lcvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:41:01 INFO - mkdir: /builds/slave/test/properties 14:41:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:41:01 INFO - Writing to file /builds/slave/test/properties/build_url 14:41:01 INFO - Contents: 14:41:01 INFO - build_url:https://queue.taskcluster.net/v1/task/UAXmI3VEQA6LyDbc6-lcvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:41:02 INFO - Running post-action listener: _resource_record_post_action 14:41:02 INFO - Running post-action listener: set_extra_try_arguments 14:41:02 INFO - ##### 14:41:02 INFO - ##### Finished download-and-extract step (success) 14:41:02 INFO - ##### 14:41:02 INFO - ##### 14:41:02 INFO - ##### Running populate-webroot step. 14:41:02 INFO - ##### 14:41:02 INFO - Running pre-action listener: _resource_record_pre_action 14:41:02 INFO - Running main action method: populate_webroot 14:41:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:41:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:41:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:41:02 INFO - '--tppagecycles', 14:41:02 INFO - '7'], 14:41:02 INFO - 'tests': ['tsvgm']}}, 14:41:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:41:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:41:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:41:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:41:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:41:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:41:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:41:02 INFO - 'talos_options': ['--disable-e10s'], 14:41:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:41:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:41:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:41:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:41:02 INFO - 'talos_options': ['--disable-e10s'], 14:41:02 INFO - 'tests': ['damp', 'tps']}, 14:41:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:41:02 INFO - 'tests': ['damp', 'tps']}, 14:41:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:41:02 INFO - 'tests': ['dromaeo_dom']}, 14:41:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:41:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:41:02 INFO - 'tests': ['a11yr', 14:41:02 INFO - 'ts_paint', 14:41:02 INFO - 'tpaint', 14:41:02 INFO - 'sessionrestore', 14:41:02 INFO - 'sessionrestore_no_auto_restore', 14:41:02 INFO - 'tabpaint']}, 14:41:02 INFO - 'other-e10s': {'tests': ['a11yr', 14:41:02 INFO - 'ts_paint', 14:41:02 INFO - 'tpaint', 14:41:02 INFO - 'sessionrestore', 14:41:02 INFO - 'sessionrestore_no_auto_restore', 14:41:02 INFO - 'tabpaint']}, 14:41:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:41:02 INFO - 'ts_paint', 14:41:02 INFO - 'tpaint', 14:41:02 INFO - 'sessionrestore', 14:41:02 INFO - 'sessionrestore_no_auto_restore', 14:41:02 INFO - 'tabpaint']}, 14:41:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:41:02 INFO - 'ts_paint', 14:41:02 INFO - 'tpaint', 14:41:02 INFO - 'sessionrestore', 14:41:02 INFO - 'sessionrestore_no_auto_restore', 14:41:02 INFO - 'tabpaint']}, 14:41:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:41:02 INFO - 'tests': ['a11yr', 14:41:02 INFO - 'ts_paint', 14:41:02 INFO - 'tpaint', 14:41:02 INFO - 'sessionrestore', 14:41:02 INFO - 'sessionrestore_no_auto_restore', 14:41:02 INFO - 'tabpaint']}, 14:41:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:41:02 INFO - 'tests': ['a11yr', 14:41:02 INFO - 'ts_paint', 14:41:02 INFO - 'tpaint', 14:41:02 INFO - 'sessionrestore', 14:41:02 INFO - 'sessionrestore_no_auto_restore', 14:41:02 INFO - 'tabpaint']}, 14:41:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:41:02 INFO - 'tests': ['tsvgx', 14:41:02 INFO - 'tsvgr_opacity', 14:41:02 INFO - 'tart', 14:41:02 INFO - 'tscrollx', 14:41:02 INFO - 'cart']}, 14:41:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:41:02 INFO - 'tsvgr_opacity', 14:41:02 INFO - 'tart', 14:41:02 INFO - 'tscrollx', 14:41:02 INFO - 'cart']}, 14:41:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:41:02 INFO - 'talos_options': ['--disable-e10s'], 14:41:02 INFO - 'tests': ['tp5o']}, 14:41:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:41:02 INFO - 'tests': ['tp5o']}, 14:41:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:41:02 INFO - 'talos_options': ['--disable-e10s', 14:41:02 INFO - '--xperf_path', 14:41:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:41:02 INFO - 'tests': ['tp5n']}, 14:41:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:41:02 INFO - 'talos_options': ['--xperf_path', 14:41:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:41:02 INFO - 'tests': ['tp5n']}}, 14:41:02 INFO - 'talos.zip': {'path': '', 14:41:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:41:02 INFO - Running post-action listener: _resource_record_post_action 14:41:02 INFO - ##### 14:41:02 INFO - ##### Finished populate-webroot step (success) 14:41:02 INFO - ##### 14:41:02 INFO - ##### 14:41:02 INFO - ##### Running create-virtualenv step. 14:41:02 INFO - ##### 14:41:02 INFO - Running pre-action listener: _resource_record_pre_action 14:41:02 INFO - Running main action method: create_virtualenv 14:41:02 INFO - Creating virtualenv /builds/slave/test/build/venv 14:41:02 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 14:41:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:41:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:41:02 INFO - Using real prefix '/usr' 14:41:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:41:03 INFO - Installing distribute.............................................................................................................................................................................................done. 14:41:05 INFO - Installing pip.................done. 14:41:05 INFO - Return code: 0 14:41:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:41: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')]} 14:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:41:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41: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')]} 14:41:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:41:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0660e6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e28e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2771b20>, '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 0x2772a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2772eb0>, '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': 'aa52b8aba932b19cc50b5275000001de-1463239279.16202-299725333', '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 14:41: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', 'pip>=1.5'] in /builds/slave/test/build 14:41: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 pip>=1.5 14:41:05 INFO - Using env: {'DISPLAY': ':0', 14:41:05 INFO - 'HOME': '/home/cltbld', 14:41:05 INFO - 'LANG': 'en_US.UTF-8', 14:41:05 INFO - 'LANGUAGE': 'en_US:en', 14:41:05 INFO - 'LOGNAME': 'cltbld', 14:41:05 INFO - 'MAIL': '/var/mail/cltbld', 14:41:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:05 INFO - 'MOZ_NO_REMOTE': '1', 14:41:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:41:05 INFO - 'NO_EM_RESTART': '1', 14:41:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:41:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:05 INFO - 'PWD': '/builds/slave/test', 14:41:05 INFO - 'SHELL': '/bin/bash', 14:41:05 INFO - 'SHLVL': '1', 14:41:05 INFO - 'TERM': 'linux', 14:41:05 INFO - 'TMOUT': '86400', 14:41:05 INFO - 'USER': 'cltbld', 14:41:05 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1463239279.16202-299725333', 14:41:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:05 INFO - '_': '/tools/buildbot/bin/python'} 14:41:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:41:05 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 14:41:05 INFO - Cleaning up... 14:41:05 INFO - Return code: 0 14:41:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:41: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')]} 14:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:41:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41: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')]} 14:41:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:41:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41: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', '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 0x7f0660e6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e28e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2771b20>, '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 0x2772a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2772eb0>, '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': 'aa52b8aba932b19cc50b5275000001de-1463239279.16202-299725333', '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 14:41: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', 'psutil>=3.1.1'] in /builds/slave/test/build 14:41: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 psutil>=3.1.1 14:41:05 INFO - Using env: {'DISPLAY': ':0', 14:41:05 INFO - 'HOME': '/home/cltbld', 14:41:05 INFO - 'LANG': 'en_US.UTF-8', 14:41:05 INFO - 'LANGUAGE': 'en_US:en', 14:41:05 INFO - 'LOGNAME': 'cltbld', 14:41:05 INFO - 'MAIL': '/var/mail/cltbld', 14:41:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:05 INFO - 'MOZ_NO_REMOTE': '1', 14:41:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:41:05 INFO - 'NO_EM_RESTART': '1', 14:41:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:41:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:05 INFO - 'PWD': '/builds/slave/test', 14:41:05 INFO - 'SHELL': '/bin/bash', 14:41:05 INFO - 'SHLVL': '1', 14:41:05 INFO - 'TERM': 'linux', 14:41:05 INFO - 'TMOUT': '86400', 14:41:05 INFO - 'USER': 'cltbld', 14:41:05 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1463239279.16202-299725333', 14:41:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:05 INFO - '_': '/tools/buildbot/bin/python'} 14:41:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:41:05 INFO - Downloading/unpacking psutil>=3.1.1 14:41: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 14:41: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 14:41: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 14:41: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 14:41: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 14:41: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 14:41:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:41:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:41:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:41:07 INFO - Installing collected packages: psutil 14:41:07 INFO - Running setup.py install for psutil 14:41:07 INFO - building 'psutil._psutil_linux' extension 14:41:07 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 14:41:07 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 14:41:07 INFO - building 'psutil._psutil_posix' extension 14:41:07 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 14:41:07 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 14:41:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:41:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:41:08 INFO - Successfully installed psutil 14:41:08 INFO - Cleaning up... 14:41:08 INFO - Return code: 0 14:41:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:41:08 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')]} 14:41:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:41:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:08 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')]} 14:41:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:41:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:08 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 0x7f0660e6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e28e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2771b20>, '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 0x2772a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2772eb0>, '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': 'aa52b8aba932b19cc50b5275000001de-1463239279.16202-299725333', '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 14:41:08 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 14:41:08 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 14:41:08 INFO - Using env: {'DISPLAY': ':0', 14:41:08 INFO - 'HOME': '/home/cltbld', 14:41:08 INFO - 'LANG': 'en_US.UTF-8', 14:41:08 INFO - 'LANGUAGE': 'en_US:en', 14:41:08 INFO - 'LOGNAME': 'cltbld', 14:41:08 INFO - 'MAIL': '/var/mail/cltbld', 14:41:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:08 INFO - 'MOZ_NO_REMOTE': '1', 14:41:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:41:08 INFO - 'NO_EM_RESTART': '1', 14:41:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:41:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:08 INFO - 'PWD': '/builds/slave/test', 14:41:08 INFO - 'SHELL': '/bin/bash', 14:41:08 INFO - 'SHLVL': '1', 14:41:08 INFO - 'TERM': 'linux', 14:41:08 INFO - 'TMOUT': '86400', 14:41:08 INFO - 'USER': 'cltbld', 14:41:08 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1463239279.16202-299725333', 14:41:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:08 INFO - '_': '/tools/buildbot/bin/python'} 14:41:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:41:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:41: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 14:41: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 14:41: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 14:41: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 14:41: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 14:41: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 14:41:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:41:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:41:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:41:10 INFO - Installing collected packages: mozsystemmonitor 14:41:10 INFO - Running setup.py install for mozsystemmonitor 14:41:10 INFO - Successfully installed mozsystemmonitor 14:41:10 INFO - Cleaning up... 14:41:10 INFO - Return code: 0 14:41:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:41:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:41:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:41:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0660e6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e28e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2771b20>, '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 0x2772a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2772eb0>, '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': 'aa52b8aba932b19cc50b5275000001de-1463239279.16202-299725333', '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 14:41:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:41:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:41:10 INFO - Using env: {'DISPLAY': ':0', 14:41:10 INFO - 'HOME': '/home/cltbld', 14:41:10 INFO - 'LANG': 'en_US.UTF-8', 14:41:10 INFO - 'LANGUAGE': 'en_US:en', 14:41:10 INFO - 'LOGNAME': 'cltbld', 14:41:10 INFO - 'MAIL': '/var/mail/cltbld', 14:41:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:10 INFO - 'MOZ_NO_REMOTE': '1', 14:41:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:41:10 INFO - 'NO_EM_RESTART': '1', 14:41:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:41:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:10 INFO - 'PWD': '/builds/slave/test', 14:41:10 INFO - 'SHELL': '/bin/bash', 14:41:10 INFO - 'SHLVL': '1', 14:41:10 INFO - 'TERM': 'linux', 14:41:10 INFO - 'TMOUT': '86400', 14:41:10 INFO - 'USER': 'cltbld', 14:41:10 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1463239279.16202-299725333', 14:41:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:10 INFO - '_': '/tools/buildbot/bin/python'} 14:41:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:41:10 INFO - Downloading/unpacking blobuploader==1.2.4 14:41: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 14:41: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 14:41: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 14:41: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 14:41: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 14:41: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 14:41:12 INFO - Downloading blobuploader-1.2.4.tar.gz 14:41:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:41:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:41:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:41:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:41:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:41:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:41:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:41:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:41:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:41:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:41:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:41:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:41:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:41:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:41:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:41:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:41:13 INFO - Downloading docopt-0.6.1.tar.gz 14:41:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:41:13 INFO - Installing collected packages: blobuploader, requests, docopt 14:41:13 INFO - Running setup.py install for blobuploader 14:41:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:41:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:41:13 INFO - Running setup.py install for requests 14:41:13 INFO - Running setup.py install for docopt 14:41:13 INFO - Successfully installed blobuploader requests docopt 14:41:13 INFO - Cleaning up... 14:41:13 INFO - Return code: 0 14:41:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:41:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:41:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:41:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0660e6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e28e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2771b20>, '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 0x2772a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2772eb0>, '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': 'aa52b8aba932b19cc50b5275000001de-1463239279.16202-299725333', '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 14:41:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:41:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:41:13 INFO - Using env: {'DISPLAY': ':0', 14:41:13 INFO - 'HOME': '/home/cltbld', 14:41:13 INFO - 'LANG': 'en_US.UTF-8', 14:41:13 INFO - 'LANGUAGE': 'en_US:en', 14:41:13 INFO - 'LOGNAME': 'cltbld', 14:41:13 INFO - 'MAIL': '/var/mail/cltbld', 14:41:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:13 INFO - 'MOZ_NO_REMOTE': '1', 14:41:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:41:13 INFO - 'NO_EM_RESTART': '1', 14:41:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:41:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:13 INFO - 'PWD': '/builds/slave/test', 14:41:13 INFO - 'SHELL': '/bin/bash', 14:41:13 INFO - 'SHLVL': '1', 14:41:13 INFO - 'TERM': 'linux', 14:41:13 INFO - 'TMOUT': '86400', 14:41:13 INFO - 'USER': 'cltbld', 14:41:13 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1463239279.16202-299725333', 14:41:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:13 INFO - '_': '/tools/buildbot/bin/python'} 14:41:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:41:14 INFO - Running setup.py (path:/tmp/pip-5iZ1Fs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:41:14 INFO - Running setup.py (path:/tmp/pip-VfjhBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:41:14 INFO - Running setup.py (path:/tmp/pip-fwnFnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:41:14 INFO - Running setup.py (path:/tmp/pip-2fh_5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:41:14 INFO - Running setup.py (path:/tmp/pip-qlU3rW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:41:14 INFO - Running setup.py (path:/tmp/pip-hMHUQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:41:14 INFO - Running setup.py (path:/tmp/pip-gwNcSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:41:14 INFO - Running setup.py (path:/tmp/pip-mYDEwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:41:14 INFO - Running setup.py (path:/tmp/pip-DFBtc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:41:14 INFO - Running setup.py (path:/tmp/pip-l2hXmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:41:14 INFO - Running setup.py (path:/tmp/pip-BSxnCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:41:14 INFO - Running setup.py (path:/tmp/pip-G21g4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:41:15 INFO - Running setup.py (path:/tmp/pip-YKtVDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:41:15 INFO - Running setup.py (path:/tmp/pip-ASnLKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:41:15 INFO - Running setup.py (path:/tmp/pip-pVegwP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:41:15 INFO - Running setup.py (path:/tmp/pip-4T5yAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:41:15 INFO - Running setup.py (path:/tmp/pip-UNeMB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:41:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:41:15 INFO - Running setup.py install for manifestparser 14:41:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:41:15 INFO - Running setup.py install for mozcrash 14:41:15 INFO - Running setup.py install for mozdebug 14:41:15 INFO - Running setup.py install for mozdevice 14:41:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:41:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:41:15 INFO - Running setup.py install for mozfile 14:41:15 INFO - Running setup.py install for mozhttpd 14:41:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:41:15 INFO - Running setup.py install for mozinfo 14:41:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:41:16 INFO - Running setup.py install for mozInstall 14:41:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:41:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:41:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:41:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:41:16 INFO - Running setup.py install for mozleak 14:41:16 INFO - Running setup.py install for mozlog 14:41:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:41:16 INFO - Running setup.py install for moznetwork 14:41:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:41:16 INFO - Running setup.py install for mozprocess 14:41:16 INFO - Running setup.py install for mozprofile 14:41:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:41:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:41:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:41:16 INFO - Running setup.py install for mozrunner 14:41:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:41:16 INFO - Running setup.py install for mozscreenshot 14:41:16 INFO - Running setup.py install for moztest 14:41:17 INFO - Running setup.py install for mozversion 14:41:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:41:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:41:17 INFO - Cleaning up... 14:41:17 INFO - Return code: 0 14:41:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:41:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:41:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:41:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:17 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 0x7f0660e6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e28e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2771b20>, '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 0x2772a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2772eb0>, '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': 'aa52b8aba932b19cc50b5275000001de-1463239279.16202-299725333', '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 14:41:17 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 14:41:17 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 14:41:17 INFO - Using env: {'DISPLAY': ':0', 14:41:17 INFO - 'HOME': '/home/cltbld', 14:41:17 INFO - 'LANG': 'en_US.UTF-8', 14:41:17 INFO - 'LANGUAGE': 'en_US:en', 14:41:17 INFO - 'LOGNAME': 'cltbld', 14:41:17 INFO - 'MAIL': '/var/mail/cltbld', 14:41:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:17 INFO - 'MOZ_NO_REMOTE': '1', 14:41:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:41:17 INFO - 'NO_EM_RESTART': '1', 14:41:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:41:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:17 INFO - 'PWD': '/builds/slave/test', 14:41:17 INFO - 'SHELL': '/bin/bash', 14:41:17 INFO - 'SHLVL': '1', 14:41:17 INFO - 'TERM': 'linux', 14:41:17 INFO - 'TMOUT': '86400', 14:41:17 INFO - 'USER': 'cltbld', 14:41:17 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1463239279.16202-299725333', 14:41:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:17 INFO - '_': '/tools/buildbot/bin/python'} 14:41:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:41:17 INFO - Running setup.py (path:/tmp/pip-UUThN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:41:17 INFO - Running setup.py (path:/tmp/pip-sBhZKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:41:17 INFO - Running setup.py (path:/tmp/pip-d_OoRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:41:17 INFO - Running setup.py (path:/tmp/pip-EDhKe_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:41:17 INFO - Running setup.py (path:/tmp/pip-2mMWSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:41:17 INFO - Running setup.py (path:/tmp/pip-KId8uH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:41:17 INFO - Running setup.py (path:/tmp/pip-HaUYmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:41:17 INFO - Running setup.py (path:/tmp/pip-QFPrfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:41:17 INFO - Running setup.py (path:/tmp/pip-GnH_L0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:41:18 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)) 14:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:41:18 INFO - Running setup.py (path:/tmp/pip-cB5Qkq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:41:18 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)) 14:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:41:18 INFO - Running setup.py (path:/tmp/pip-uAAzms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:41:18 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)) 14:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:41:18 INFO - Running setup.py (path:/tmp/pip-naOPlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:41:18 INFO - Running setup.py (path:/tmp/pip-OH_Sql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:41:18 INFO - Running setup.py (path:/tmp/pip-v5WOfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:41:18 INFO - Running setup.py (path:/tmp/pip-wX21dD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:41:18 INFO - Running setup.py (path:/tmp/pip-y5Z11x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:41:18 INFO - Running setup.py (path:/tmp/pip-kZn7ML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:41:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:41:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:41:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:41:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:41:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:41:20 INFO - Downloading blessings-1.6.tar.gz 14:41:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:41:20 INFO - Installing collected packages: blessings 14:41:20 INFO - Running setup.py install for blessings 14:41:20 INFO - Successfully installed blessings 14:41:20 INFO - Cleaning up... 14:41:20 INFO - Return code: 0 14:41:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:41:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:41:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:41:20 INFO - Reading from file tmpfile_stdout 14:41:20 INFO - Current package versions: 14:41:20 INFO - argparse == 1.2.1 14:41:20 INFO - blessings == 1.6 14:41:20 INFO - blobuploader == 1.2.4 14:41:20 INFO - docopt == 0.6.1 14:41:20 INFO - manifestparser == 1.1 14:41:20 INFO - mozInstall == 1.12 14:41:20 INFO - mozcrash == 0.17 14:41:20 INFO - mozdebug == 0.1 14:41:20 INFO - mozdevice == 0.48 14:41:20 INFO - mozfile == 1.2 14:41:20 INFO - mozhttpd == 0.7 14:41:20 INFO - mozinfo == 0.9 14:41:20 INFO - mozleak == 0.1 14:41:20 INFO - mozlog == 3.2 14:41:20 INFO - moznetwork == 0.27 14:41:20 INFO - mozprocess == 0.22 14:41:20 INFO - mozprofile == 0.28 14:41:20 INFO - mozrunner == 6.11 14:41:20 INFO - mozscreenshot == 0.1 14:41:20 INFO - mozsystemmonitor == 0.3 14:41:20 INFO - moztest == 0.7 14:41:20 INFO - mozversion == 1.4 14:41:20 INFO - psutil == 3.1.1 14:41:20 INFO - requests == 1.2.3 14:41:20 INFO - wsgiref == 0.1.2 14:41:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:41:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:41:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:41:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0660e6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e28e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2771b20>, '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 0x2772a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2772eb0>, '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': 'aa52b8aba932b19cc50b5275000001de-1463239279.16202-299725333', '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 14:41:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:41:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:41:20 INFO - Using env: {'DISPLAY': ':0', 14:41:20 INFO - 'HOME': '/home/cltbld', 14:41:20 INFO - 'LANG': 'en_US.UTF-8', 14:41:20 INFO - 'LANGUAGE': 'en_US:en', 14:41:20 INFO - 'LOGNAME': 'cltbld', 14:41:20 INFO - 'MAIL': '/var/mail/cltbld', 14:41:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:20 INFO - 'MOZ_NO_REMOTE': '1', 14:41:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:41:20 INFO - 'NO_EM_RESTART': '1', 14:41:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:41:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:20 INFO - 'PWD': '/builds/slave/test', 14:41:20 INFO - 'SHELL': '/bin/bash', 14:41:20 INFO - 'SHLVL': '1', 14:41:20 INFO - 'TERM': 'linux', 14:41:20 INFO - 'TMOUT': '86400', 14:41:20 INFO - 'USER': 'cltbld', 14:41:20 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1463239279.16202-299725333', 14:41:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:20 INFO - '_': '/tools/buildbot/bin/python'} 14:41:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:41:21 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)) 14:41:21 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)) 14:41:21 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)) 14:41:21 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)) 14:41:21 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)) 14:41:21 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)) 14:41:21 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)) 14:41:21 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)) 14:41:21 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)) 14:41:21 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)) 14:41:21 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)) 14:41:21 INFO - Cleaning up... 14:41:21 INFO - Return code: 0 14:41:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:41:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:41:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:41:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0660e6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e28e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2771b20>, '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 0x2772a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2772eb0>, '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': 'aa52b8aba932b19cc50b5275000001de-1463239279.16202-299725333', '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 14:41:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:41:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:41:21 INFO - Using env: {'DISPLAY': ':0', 14:41:21 INFO - 'HOME': '/home/cltbld', 14:41:21 INFO - 'LANG': 'en_US.UTF-8', 14:41:21 INFO - 'LANGUAGE': 'en_US:en', 14:41:21 INFO - 'LOGNAME': 'cltbld', 14:41:21 INFO - 'MAIL': '/var/mail/cltbld', 14:41:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:21 INFO - 'MOZ_NO_REMOTE': '1', 14:41:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:41:21 INFO - 'NO_EM_RESTART': '1', 14:41:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:41:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:21 INFO - 'PWD': '/builds/slave/test', 14:41:21 INFO - 'SHELL': '/bin/bash', 14:41:21 INFO - 'SHLVL': '1', 14:41:21 INFO - 'TERM': 'linux', 14:41:21 INFO - 'TMOUT': '86400', 14:41:21 INFO - 'USER': 'cltbld', 14:41:21 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1463239279.16202-299725333', 14:41:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:21 INFO - '_': '/tools/buildbot/bin/python'} 14:41:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:41:21 INFO - Downloading/unpacking jsonschema 14:41:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:41:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:41:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:41:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:41:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:41:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:41:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:41:23 INFO - Downloading/unpacking functools32 (from jsonschema) 14:41:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:41:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:41:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:41:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:41:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:41:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:41:23 INFO - Downloading functools32-3.2.3-2.tar.gz 14:41:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:41:23 INFO - warning: no files found matching '*.txt' 14:41:23 INFO - no previously-included directories found matching 'build' 14:41:23 INFO - no previously-included directories found matching 'dist' 14:41:23 INFO - no previously-included directories found matching '.git*' 14:41:23 INFO - Installing collected packages: jsonschema, functools32 14:41:23 INFO - Running setup.py install for functools32 14:41:23 INFO - warning: no files found matching '*.txt' 14:41:23 INFO - no previously-included directories found matching 'build' 14:41:23 INFO - no previously-included directories found matching 'dist' 14:41:23 INFO - no previously-included directories found matching '.git*' 14:41:23 INFO - Successfully installed jsonschema functools32 14:41:23 INFO - Cleaning up... 14:41:23 INFO - Return code: 0 14:41:23 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:41:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:41:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:41:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:23 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 0x7f0660e6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e28e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2771b20>, '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 0x2772a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2772eb0>, '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': 'aa52b8aba932b19cc50b5275000001de-1463239279.16202-299725333', '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 14:41:23 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 14:41:23 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 14:41:23 INFO - Using env: {'DISPLAY': ':0', 14:41:23 INFO - 'HOME': '/home/cltbld', 14:41:23 INFO - 'LANG': 'en_US.UTF-8', 14:41:23 INFO - 'LANGUAGE': 'en_US:en', 14:41:23 INFO - 'LOGNAME': 'cltbld', 14:41:23 INFO - 'MAIL': '/var/mail/cltbld', 14:41:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:23 INFO - 'MOZ_NO_REMOTE': '1', 14:41:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:41:23 INFO - 'NO_EM_RESTART': '1', 14:41:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:41:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:23 INFO - 'PWD': '/builds/slave/test', 14:41:23 INFO - 'SHELL': '/bin/bash', 14:41:23 INFO - 'SHLVL': '1', 14:41:23 INFO - 'TERM': 'linux', 14:41:23 INFO - 'TMOUT': '86400', 14:41:23 INFO - 'USER': 'cltbld', 14:41:23 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1463239279.16202-299725333', 14:41:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:23 INFO - '_': '/tools/buildbot/bin/python'} 14:41:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:41:23 INFO - Downloading/unpacking flake8 14:41:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:41:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:41:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:41:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:41:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:41:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:41:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:41:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:41:25 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 14:41:25 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 14:41:25 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 14:41:25 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 14:41:25 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 14:41:25 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 14:41:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:41:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:41:26 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 14:41:26 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 14:41:26 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 14:41:26 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 14:41:26 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 14:41:26 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 14:41:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:41:26 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 14:41:26 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 14:41:26 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 14:41:26 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 14:41:26 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 14:41:26 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 14:41:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:41:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:41:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:41:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:41:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:41:26 INFO - no previously-included directories found matching 'docs/_build' 14:41:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:41:26 INFO - Running setup.py install for pep8 14:41:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:41:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:41:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:41:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:41:26 INFO - no previously-included directories found matching 'docs/_build' 14:41:26 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:41:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:41:26 INFO - Cleaning up... 14:41:26 INFO - Return code: 0 14:41:26 INFO - Running post-action listener: _resource_record_post_action 14:41:26 INFO - Running post-action listener: _start_resource_monitoring 14:41:26 INFO - Starting resource monitoring. 14:41:26 INFO - ##### 14:41:26 INFO - ##### Finished create-virtualenv step (success) 14:41:26 INFO - ##### 14:41:26 INFO - ##### 14:41:26 INFO - ##### Running install step. 14:41:26 INFO - ##### 14:41:26 INFO - Running pre-action listener: _resource_record_pre_action 14:41:26 INFO - Running main action method: install 14:41:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:41:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:41:27 INFO - Reading from file tmpfile_stdout 14:41:27 INFO - Detecting whether we're running mozinstall >=1.0... 14:41:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:41:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:41:27 INFO - Reading from file tmpfile_stdout 14:41:27 INFO - Output received: 14:41:27 INFO - Usage: mozinstall [options] installer 14:41:27 INFO - Options: 14:41:27 INFO - -h, --help show this help message and exit 14:41:27 INFO - -d DEST, --destination=DEST 14:41:27 INFO - Directory to install application into. [default: 14:41:27 INFO - "/builds/slave/test"] 14:41:27 INFO - --app=APP Application being installed. [default: firefox] 14:41:27 INFO - mkdir: /builds/slave/test/build/application 14:41:27 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'] 14:41:27 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 14:41:42 INFO - Reading from file tmpfile_stdout 14:41:42 INFO - Output received: 14:41:42 INFO - /builds/slave/test/build/application/firefox/firefox 14:41:42 INFO - Running post-action listener: _resource_record_post_action 14:41:42 INFO - ##### 14:41:42 INFO - ##### Finished install step (success) 14:41:42 INFO - ##### 14:41:42 INFO - ##### 14:41:42 INFO - ##### Running run-tests step. 14:41:42 INFO - ##### 14:41:42 INFO - Running pre-action listener: _resource_record_pre_action 14:41:42 INFO - Running main action method: run_tests 14:41:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:41:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:41:42 INFO - Python 2.7.3 14:41:42 INFO - Return code: 0 14:41:42 INFO - grabbing minidump binary from tooltool 14:41:42 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')]} 14:41:42 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 0x2771b20>, '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 0x2772a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2772eb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:41:42 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 14:41:42 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 14:41:42 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 14:41:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:41:43 INFO - Return code: 0 14:41:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:41:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:41:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:41:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:41:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:41:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:41:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:41:43 INFO - Return code: 0 14:41:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UAXmI3VEQA6LyDbc6-lcvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:41:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UAXmI3VEQA6LyDbc6-lcvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:41:43 INFO - Using env: {'DISPLAY': ':0', 14:41:43 INFO - 'HOME': '/home/cltbld', 14:41:43 INFO - 'LANG': 'en_US.UTF-8', 14:41:43 INFO - 'LANGUAGE': 'en_US:en', 14:41:43 INFO - 'LOGNAME': 'cltbld', 14:41:43 INFO - 'MAIL': '/var/mail/cltbld', 14:41:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:41:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:41:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:43 INFO - 'MOZ_NO_REMOTE': '1', 14:41:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:41:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:41:43 INFO - 'NO_EM_RESTART': '1', 14:41:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:41:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:43 INFO - 'PWD': '/builds/slave/test', 14:41:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:41:43 INFO - 'SHELL': '/bin/bash', 14:41:43 INFO - 'SHLVL': '1', 14:41:43 INFO - 'TERM': 'linux', 14:41:43 INFO - 'TMOUT': '86400', 14:41:43 INFO - 'USER': 'cltbld', 14:41:43 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1463239279.16202-299725333', 14:41:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:43 INFO - '_': '/tools/buildbot/bin/python'} 14:41:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UAXmI3VEQA6LyDbc6-lcvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:41:44 INFO - mozversion application_buildid: 20160514130527 14:41:44 INFO - mozversion application_changeset: 403912ca555eb65f814b18ecf38ad8e8e98569f5 14:41:44 INFO - mozversion application_display_name: Nightly 14:41:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:41:44 INFO - mozversion application_name: Firefox 14:41:44 INFO - mozversion application_remotingname: firefox 14:41:44 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:41:44 INFO - mozversion application_vendor: Mozilla 14:41:44 INFO - mozversion application_version: 49.0a1 14:41:44 INFO - mozversion platform_buildid: 20160514130527 14:41:44 INFO - mozversion platform_changeset: 403912ca555eb65f814b18ecf38ad8e8e98569f5 14:41:44 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:41:44 INFO - mozversion platform_version: 49.0a1 14:41:44 INFO - using testdate: 1463262104 14:41:44 INFO - actual date: 1463262104 14:41:44 INFO - starting webserver on 'localhost:48154' 14:41:44 INFO - SUITE-START | Running 2 tests 14:41:44 INFO - TEST-START | dromaeo_css 14:41:44 INFO - operating with platform_type : linux_ 14:41:44 INFO - Initialising browser for dromaeo_css test... 14:41:44 INFO - TEST-INFO | started process 27077 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwIMpq6/profile http://localhost:48154/getInfo.html) 14:41:48 INFO - PROCESS | 27077 | JavaScript error: resource://app/components/nsBrowserGlue.js, line 1275: ReferenceError: E10SUINotification is not defined 14:41:48 INFO - PROCESS | 27077 | 14:41:48 INFO - PROCESS | 27077 | (process:27142): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:41:49 INFO - PROCESS | 27077 | __metrics Screen width/height:1600/1200 14:41:49 INFO - PROCESS | 27077 | colorDepth:24 14:41:49 INFO - PROCESS | 27077 | Browser inner width/height: 1024/697 14:41:49 INFO - PROCESS | 27077 | __metrics 14:41:50 ERROR - PROCESS | 27077 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 14:41:50 INFO - TEST-INFO | 27077: exit 0 14:41:50 INFO - Browser initialized. 14:41:50 INFO - Running cycle 1/1 for dromaeo_css test... 14:41:50 INFO - TEST-INFO | started process 27193 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwIMpq6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:41:52 INFO - PROCESS | 27193 | 14:41:52 INFO - PROCESS | 27193 | (process:27251): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:42:02 INFO - PROCESS | 27193 | RSS: Main: 165117952 14:42:02 INFO - PROCESS | 27193 | 14:42:52 INFO - PROCESS | 27193 | 1463262172451 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] 14:45:04 INFO - PROCESS | 27193 | Cycle 1(1): loaded http://localhost:48154/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48154/tests/dromaeo/cssquery-ext.html) 14:45:06 INFO - PROCESS | 27193 | RSS: Main: 167641088 14:45:06 INFO - PROCESS | 27193 | 14:48:08 INFO - PROCESS | 27193 | Cycle 1(1): loaded http://localhost:48154/tests/dromaeo/cssquery-ext.html (next: http://localhost:48154/tests/dromaeo/cssquery-jquery.html) 14:48:08 INFO - PROCESS | 27193 | RSS: Main: 167800832 14:48:08 INFO - PROCESS | 27193 | 14:51:10 INFO - PROCESS | 27193 | Cycle 1(1): loaded http://localhost:48154/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48154/tests/dromaeo/cssquery-mootools.html) 14:51:11 INFO - PROCESS | 27193 | RSS: Main: 168280064 14:51:11 INFO - PROCESS | 27193 | 14:54:13 INFO - PROCESS | 27193 | Cycle 1(1): loaded http://localhost:48154/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48154/tests/dromaeo/cssquery-prototype.html) 14:54:13 INFO - PROCESS | 27193 | RSS: Main: 165916672 14:54:13 INFO - PROCESS | 27193 | 14:57:16 INFO - PROCESS | 27193 | Cycle 1(1): loaded http://localhost:48154/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48154/tests/dromaeo/cssquery-yui.html) 14:57:17 INFO - PROCESS | 27193 | RSS: Main: 167239680 14:57:17 INFO - PROCESS | 27193 | 15:00:19 INFO - PROCESS | 27193 | Cycle 1(1): loaded http://localhost:48154/tests/dromaeo/cssquery-yui.html (next: http://localhost:48154/tests/dromaeo/cssquery-dojo.html) 15:00:20 INFO - PROCESS | 27193 | RSS: Main: 169246720 15:00:20 INFO - PROCESS | 27193 | 15:00:20 INFO - PROCESS | 27193 | __start_tp_report 15:00:20 INFO - PROCESS | 27193 | _x_x_mozilla_page_load 15:00:20 INFO - PROCESS | 27193 | _x_x_mozilla_page_load_details 15:00:20 INFO - PROCESS | 27193 | |i|pagename|runs| 15:00:20 INFO - PROCESS | 27193 | |0;dojo.html;2702.37845295582;2738.30173305807;2748.8350698958056;2751.477219328326;2752.2018614601766;4867.805287788488;4899.632527560439;4926.901461970768;4928.260760885864;4929.4577596464405;4806.182948898687;4861.9513804861945;4877.51224877513;4896.069746748115;4918.213085906255;4452.710573812708;4485.439320084989;4535.206338890681;4541.477730061052;4586.610138138246;4503.1218912312115;4617.492075871652;4632.2819962905805;4658.021815418766;4684.55496727812;4491.528389519086;4503.144402563503;4508.819647214107;4553.704009239405;4563.2501759289535;4491.910161796745;4494.4606647202545;4517.819287228507;4535.750533720644;4565.132624801277;4489.326601009842;4514.774261286922;4519.186546421643;4522.140793249272;4560.749158796265;4636.420447444069;4703.882402939919;4734.83428080019;4754.66717329787;4759.4764575896625;5183.429822719498;5188.273641690166;5204.869878253036;5225.634205605609;5247.921281180786;5123.205903085028;5193.584513238932;5232.241325007891;5247.816326428595;5249.448807875195;4847.321375007502;4861.246506791453;4881.487443818419;4902.264660300983;4927.039227350704;5350.0904846176245;5354.116570765858;5354.170103633943;5381.838544843661;5406.026915155231;5014.348134742533;5093.0577843099145;5106.744662766847;5133.537981581676;5145.485451454824;5197.0905091609575;5214.0614689355525;5217.713025783542;5228.895422091537;5254.7635356409055;5024.824131155392;5093.541581257705;5102.923456148161;5107.157319042316;5136.871578210575;5173.663711858792;5207.869803254873;5237.921431178535;5258.027264955996;5263.368395792453;4313.870583882426;4530.411046563926;4531.932021019687;4536.727796332165;4580.038191979655;3810.599887011879;3824.847006119724;3844.058205739612;3858.5562660294427;3887.591802860659;4436.711613745097;4471.374007638933;4478.0148367359125;4483.529229430928;4518.118966801442;5196.792128314825;5197.22041693749;5205.869853253699;5218.425973142951;5276.657017293864;4521.502634710179;4525.117602067631;4526.366308716782;4558.49856515783;4559.270516717309;4689.109069276827;4752.809887604457;4765.690230135099;4768.237082066853;4807.879803004883;4826.758662066813;4888.193448081027;4928.310036594951;4934.407871055496;4952.5542701157065;5245.396779370269;5257.132573125545;5265.157574788015;5267.2625832384265;5268.841934741964;4908.576512811244;4912.6561140719805;4930.753462326941;4940.901181976412;4952.727599982036;5058.924116138187;5131.538161565477;5144.536991670768;5153.922691159711;5182.067227898863;5212.452692467236;5269.077911365573;5270.683758974474;5283.392409872914;5325.866853328698;4979.651424400257;5085.720285384339;5092.41437234708;5111.361079865017;5111.616628752784;4946.752662366939;4986.451490336132;5006.324146240357;5045.84862454127;5108.489151084862;4895.828645997373;4902.730349830794;4914.189158788903;4959.528844759742;4965.900681986268;5030.044291584587;5073.061483625541;5086.669366491166;5087.542121209109;5131.79472821083;4896.167651499325;4915.86935004958;4921.458639549575;4929.630277729113;4990.101781679333 15:00:20 INFO - PROCESS | 27193 | |1;ext.html;557.4676184244045;596.3470000349618;609.2049874913237;615.2709039787852;637.3085202555227;37550.81224593877;41773.37339939903;41794.37308440376;42012.36981445281;42086.158276834445;41563.376549351786;41623.37564936528;42090.368644470356;42130;42193.36709949353;7815.179406162356;7927.3658107351275;7941.08677502086;7950.204979502032;7978.800529986739;7822.9608851955945;7920.049594048723;7930.048394192676;7947.245011723906;7948.443608947376;7890.842183156334;7906.723264685737;7954.602269886512;7956.403269754792;7961.52230866147;7852.057753069611;7888.763337099867;7912.09010963735;7924.20757924203;7944.682212711485;7866.0560732711865;7918.326942209919;7928.127905930343;7950.363970882373;7976.122626511079;38874;39227.215455690726;39290.60709392898;39326.60673393258;39368.80315598432;3320.335932813423;3372.409828280041;3432.3650124727005;3433.9828300858335;3471.791692498433;31475.685243147505;31847.203819904455;31950;32088.839555802304;32705.836470817732;3607.729420293462;3618.6743193112484;3618.873339433107;3662.285854258421;3663.8351274192723;271435.6428217866;273105;273295;273603;274125;57886;58454.12318815221;58467.41532584705;58566.41433585695;58575.70712146497;35178.82410587931;35840.820795896376;35989.64010359915;38365.616343836766;38462.230755385295;15886.76169857453;16033.43882964114;16035;16061.759073613905;16114.274857631435;12153.149279550347;12176.330301833485;12191;12248.81626775599;12271.570495032809;20040.89979550093;20069;20132.597348052957;20252;20360.796392036187;7515.173330933593;7549.245075492517;7567.281108294703;7674.42441816866;7718.92281077182;826.5247482697473;876.3733930239781;904.0010788079078;907.5915837872983;1124.42092322454;29444.705552944626;30018.099457016324;30045.399092018037;30056;30481.542776858365;994.1897353656747;997.1275134257525;1019.169376957777;1036.4713995862164;1043.0404028293988;15862.524124276059;15957.760633590506;16241.675166496603;16257.756133658004;16721.581960451087;382742;386226;386301;386350;388103;52999.20501192485;53177.202341964905;53312.46687533153;53367.46632533625;53589.732051339495;1190.6368557589844;1216.2459275249225;1280.2638482872385;1302.8176055352258;1313.0414797198098;26973.325666858487;28336.291592710346;28426.857865711365;28457.146285611463;29051;45957.77021114873;46779.53220467888;46863.531364685914;46899.53100468952;47101;346380;348849;349737;349803;349875;26789.464210716065;26807.329816754736;27470.90116395402;27547.31131721723;27547.86226068857;44498.220071198084;44702;45083.32375014312;45293.32060019037;45303.77348113238;38255.64863298367;38291;39028.804855976676;39051.2189756209;39857.40213896736;37762.811185943894;37948.24103517859;38209.80895095507;38481.23037539289;38698.80650596729;32507.34985300328;37245;37572.62427375691;37763;38315.42526862155;33276.500852486744;34219.4867076989;34800.65199347974;35153.47269791007;35190.29619407649;25386.365340866625;25625.871870640527;25659.486810264065;25856.22431327063;26368 15:00:20 INFO - PROCESS | 27193 | |2;jquery.html;376.59704116595236;384.8383678854879;386.1890030935036;394.8262764383673;404.46408508725943;13313.80029299559;16316.836831631681;16419.507414777574;17353.739693904587;18074.72887906681;16824.411145609905;17226.741598876026;17809.287628494843;17946.19242134104;18010.369637062704;5075.264086707425;5126.666766660164;5277.102892508283;5309.442508536606;5405.18922161675;5235.502627250406;5240.44975277596;5248.947510524903;5271.341082364705;5283.07546179419;4986.276989836471;5215.426303106655;5224.1902505111575;5272.551833094191;5276.604254680914;5196.194589838543;5250.264962905197;5261.631685781997;5298.36419629645;5298.549623282026;4603.056373443436;4730.361401210827;4742.881427964328;4745.667803253774;4763.618910487153;15923.761143582855;16000.519984400487;18881.81118188828;21178.258760943292;21375.572488550297;2055.2806517718677;2155.741311042669;2323.814094872423;2343.6484527320868;2492.763187497185;13560.321983900863;13768.518101866386;13830.101043432145;14104.365303561364;14206.644833879132;1812.2932056497975;1831.4414103698366;1835.8806677565915;1850.8889466632045;1898.0889173196804;61494.038284419614;71528.2847171532;72819;74197.62901185514;75118.24881751167;10188;10193.388396696222;10476.423796691102;10961.945190273998;11137.443127843575;11255.099592032619;11691.181617286878;14429.278536073154;14518.637034074021;14558.85441145596;7241.746538871114;7457.931792080648;7880.763577092696;7894.881576776353;7943.205679432126;7703.8844417333785;7708.768736937789;7768.145503994556;7812.68749250035;7865.213478652204;6216.409441103088;6226.782062627877;6257.7184026718905;6371.649559274284;6399.712012959428;1646.2838665180684;1676.9413070542473;1684.1916328881114;1703.1058694185651;1729.4898005088528;851.1998721202174;901.9503927284062;950.9096635819586;962.2494454325637;990.4601991914424;17094.316227351017;17660.138374643826;17974.37089701854;18076.096195190188;18168.63662726738;839.5298632765671;911.8176364727082;923.7552048707098;944.7685317097217;956.2111258211864;9762.36544624597;9807.852882206773;10475.738106547245;10601.787964240826;10667.466626668636;303190;306660;311048;419723;426251;80249.59875200587;85879.57060214659;87222.56388718016;87625.56187219023;87701;957.8467445208594;964.6382606522554;966.5070813884829;1008.8890222075565;1012.8025035118228;16152.757708634144;16574.337026518806;16580;16602.086885220946;16644.3342266308;29802.701972979994;37751.05622359463;38475;39532.20935581215;40959.59040409677;47987;48193;52255;54241.45758542522;54905;6045.21412216409;10243.692689219335;11159.776804464027;11539.711507212387;11690.181687281809;11717.76564468723;12063.276203427471;12251.69370765738;12682.429290681757;12967.157134786208;10410.427426491313;11128.888711112786;11248.26886252391;11249.156313276373;11308.49111789988;4916.7541622919425;9541.284403669613;10727.517261723397;10885.673429797118;11097.889021110008;10784.676459706221;11009.229353945148;11038.724031898946;11474.655760327203;11494.655160345203;11625.709357266136;11753.764924701629;11795.764084718428;11806.1145414096;11829.822552661544;11256.606018789304;11355.829662554903;11427.657170284905;11478.196526243417;11582 15:00:20 INFO - PROCESS | 27193 | |3;mootools.html;1523.9466618668348;1551.9689606207876;1758.4812480318305;1879.2295158984818;1894.2423030787675;6870.896936545943;7547.24527547245;7562.281583249583;8073.677052917891;8074.4347895647325;7452.254774522545;7612.69549218032;7698.769036928901;7701.807454813633;7785.221477852226;2240.663900414939;2276.9658455123185;2277.8633282003134;2277.9976810203457;2284.8057915077156;2236.1167338901123;2250.336150835499;2282.2696737044153;2301.838871279011;2305.8616483010987;2196.5497073100055;2204.754313812699;2209.4586826227596;2232.6985856909355;2248.4940888300166;2179.4660308224506;2202.812760915324;2225.2434172381386;2237.0157130862367;2246.034205291724;2205.6801763744165;2229.6209644360497;2245.8764767937755;2251.515924076315;2252.425631463966;7689;7746.18665040174;7752.573608451533;7753.069631644183;7760.06879174497;4814.903701925942;4886.926696099561;4901.705897646153;4901.995091006335;4921.990991846698;2841.7300356466103;2993.207870307311;3079.44569977404;3096.055703010581;3131.874725010997;952.3476418653245;954.1984732824461;976.6484065736329;977.4135518688801;992.9056739609725;11292.604758833402;11337.489812958354;11356.318620882774;11369.317840929489;11461.713457163554;4410.4927933287445;4412.36020776992;4526.502084770673;4542.636589072867;4677.22825733757;9585.616575337048;9603.855942160873;9623.663171788954;9632.95183524078;9674.70975870725;5021.347224860745;5031.4213865405945;5032.119379108642;5032.823851165192;5041.218611115283;3992.121733218687;4287.7641729705165;4440.378347031418;4514.706544074625;4586.6789324747615;3788.6969042476535;3890.6498415142773;3894.6884249259992;3901.6293452122004;4114.958850411457;1264.386772415378;1288.9226646401246;1293.5537239652306;1300.4538094000354;1306.5949555637783;776.6272189349144;810.5906517208772;924.7826760711228;928.3084102343662;965.5510187762724;5523.861903452445;5616.66300022;5718.913406452843;5747.252857128547;5870.207521984563;937.2080591899834;954.8138113068024;958.2812890332251;973.1630797514132;977.4868194198103;3812.237552489458;3950.3481925482547;3966.900827479336;3968.6428221460205;3978.5822488638855;9818.705438836847;10048.648297309705;10092.545835437422;10101.646442374482;10174.745631359126;9936.652217172365;10001.549930253155;10060.144887684482;10063.094321511098;10102.242331825142;7310.195878453366;7550.584717840462;7552.9244707552225;7557.659905304275;7698.730544430918;5253.894922101613;5456.372517160577;5510.9448905510435;5524.972375138099;5559.971405290034;8937.73186804397;8980.955095224743;9010.14403631654;9068.863967040368;9092.818143636958;8794.120587941155;9130.49782261982;9182.816343672956;9428.952855235955;9515;6368.203974503187;6866;7048.894266586108;7050.682719277543;7285.198628151005;7876.56678882667;7914.327282180849;7923.6830526778285;7969.083555390972;7989.400794940519;6981.825454363681;7062;7295.598742069024;7337.559746415232;7356.448266379936;7126.536775109601;7137;7169.175544812413;7217;7254.45591580623;6292.905606415816;6522.315156908457;6525.3800888915475;6610.173728283965;6627.768028119185;4842.443119041355;4930.457649658463;4931.901361972812;4986.80052797884;5044.672096313728;4714.882127946828;4896.069746748107;4934.629902757236;4944.233643785219;4980.377452818398 15:00:20 INFO - PROCESS | 27193 | |4;prototype.html;314.34772846343833;320.22665263388916;320.96469388367274;325.29086591231106;325.66456549753764;5127.12838817401;5177.867390228905;5194.844154675366;5199.532042116213;5228.111221092414;5017.64876458648;5040.6471546991725;5063.9493605063935;5071.31537242473;5076.46697096805;3826.9043273918164;3919.627635374635;4005.0988527581208;4022.3162062449455;4024.5170579530495;3998.1803730235233;4014.558398576154;4017.758934463927;4029.770919869439;4031.717779755418;3987.1228329767405;3998.9400158997637;4004.319265724819;4015.0765323975356;4018.5378681451716;3718.6653201211752;3938.7045971552247;3940.330143875548;3993.6405723485027;4027.8993025174314;3448.413769659164;3458.9654103459147;3494.755367124302;3506.421440462321;3512.982435087834;4873.756312184377;4905.852824415238;4914.582260507861;4918.2376731606655;4952.331435256267;4250.404943307939;4516.54834516549;4534.206513860061;4551.2262915304145;4584.991301913574;5309.920351194735;5322.627416080876;5328.20076988451;5342.492463215988;5373.919391209135;3757.098296408842;3763.7929913854728;3766.773993560395;3768.6042965488778;3768.6419790119894;5349.358077030743;5589.826136511338;5590;5601.943980560183;5620.48246973319;3873;3879.2823327683905;3890.2997460456822;3903.8243279052513;3923.1172986077904;3939.153082087365;3954.268460334847;3962.1481381503113;3967.960320396759;3989.6209860063245;4481.708688935209;4495.842645507391;4501.144782491317;4510.819567217341;4518.728876267434;5172.818951336685;5306.124489459273;5308.203769434538;5331.333583302087;5384.6769193848495;1369.705513314642;1379.296558755042;1386.7919812028074;1390.7218556288783;1394.8674875886775;882.2589025218847;890.6081324217324;899.8875140607424;906.8775715278485;910.5083255042204;4629.907401851944;4649.767511624405;4656.278276867091;4659.720416774937;4663.463701674283;5355.464453554613;5421.213923981;5424.213489044146;5425.403205647375;5457.8071827981075;4438.201123797748;4585;4626.21354369758;4638.8608341749805;4645.490215679917;2861.5135426977463;2910.359720861407;2911.3740545782757;2937.647482302095;2944.3816798472562;5123;5141.997310524412;5143.819966301162;5153.639245252872;5193.610479214074;5383.031054410244;5596.888062238732;5645.153227015899;5711.628744131701;5713.200151978726;5235.214717792362;5235.303818533383;5235.3717553893775;5258.290130832365;5267.473252674702;5561.082421400423;5571.303587051619;5590.888182236414;5601.80393686219;5606.85982850432;5227.607929405386;5450.400455949763;5514.283143191359;5529.25828364064;5545.750441230073;5243.134882744304;5289.788408463618;5293.761780719799;5319.989202051598;5321.308229930084;3773.415120656303;3848.172118243812;3872.5546562145714;3877.1276462795645;3883.9707477517914;5502.284702988746;5519.586031047767;5553.611247212656;5574.108142697149;5618.971905140448;5399.730013499231;5403.378611459732;5408.783648654167;5419.539339156216;5422.728863556727;5179.533841954242;5340.866478337917;5394.595405344537;5411.269478620336;5420.701861397661;5260.579153667621;5277.2875661785165;5278.2610434539965;5333.479958212046;5347.518723314764;5233.7383130842545;5328.280682107866;5429.5656347492895;5445.863853403696;5481.314835645544;5296.947030529645;5308.177232528964;5317.936412717395;5321.600879934098;5340.839774806762 15:00:20 INFO - PROCESS | 27193 | |5;yui.html;689.4381079420272;739.6782399656148;805.66162211871;821;824.4064273722921;10380.896191038088;12242.81635775463;12329.260244385332;12749.872501274984;13759.31203439829;13436.66408339792;13783.17300961943;13817.585472435818;13856.237906915116;13968.231747253896;887.4852585500411;889.595234168455;890.6481939633873;891.687909231767;892.4779004282502;882.8719835623831;883.902770695223;889.8576227803553;891.1534042659467;891.6032365597312;934.8364036293656;936.9109934556207;940.5955439161158;940.6331530703031;944.5230158769846;896.0546623312403;929.4237572704899;931.6133804471136;934.9158575728183;935.4106912645024;676.1075380497745;677.7255211639244;678.1082876018021;680.6630717794674;681.495693187043;13538;13553.119047261995;13560.11859229147;13574.185548867099;13600.659983500393;11326;11499.597514086967;11710.765784684343;11752.764944701144;11948.820767688492;10352.120069794077;10417.531211095518;10467.738306542322;10496.055355018085;10672.359658420442;3344.7491438142238;3363.327334533103;3383.780054296463;3482.460218666111;3504.1064528545057;52783.208251876255;52802;52930.73534632341;53067.734661326445;53505.19742203831;9584.047390266322;9805.656802011896;9913.45475998827;9915.702528924145;10140.492975351202;15997;17651.470455886345;17884.195211215527;17957.820421795877;17989.280428782702;7017.087778588751;7081.398081163055;7131.358177763922;7165.570065796069;7167.605781682058;3820.84716611338;3866.284737323604;3899.6880249579967;3960.5643379228263;4004.439378487014;3010.1421094987822;3089.073278016586;3092.8608212630484;3094.6131733533307;3099.1477343730203;566.0688167963676;569.9458551437607;570.1277046119444;576.5560518400808;586.1383765864173;552.9170624406371;588.8527868032992;594.8364199844991;621.8725161341914;636.5671343486381;8246.463979841412;8354.373421993374;8457.365697572706;8474.915250847413;8673.913260867437;595.3510673366052;621.5431657731564;628.1237673445518;628.4815027602247;639.7792761497276;4017.4978127734034;4051.47330846988;4055.878323650295;4092.140650463436;4098.303288440972;57808.71095644495;58113.709431452575;59002;59029.11456328158;59269.70365148147;52192.47807521952;53274;53406.46593534093;53865;54558;44069.11861762811;45943.540564594594;48432.27351589729;48618.75690621524;49449;8229.46508476947;8394.328453723565;8574.442661227;8665.696700615448;8688;31341.68658313479;32872.671273286964;32930.67069329276;33160.66839331672;33424.66575334215;41725.582744173385;43034.35448468338;43565.78217108894;44062.77968610136;44759;10886.782264354826;11130.833037504606;11150.163737719866;11153.330800152016;11284.605038823602;11912.328767123288;12127.45426455794;12471.434532917456;12479.251244925334;12592.559260425842;10598.735031623963;10929.726756831144;10975.725606859573;11149.72125696864;11195.768465468629;11138.777224455303;11250.437478126225;11285.37930413835;12044.397780110785;12124.09069319787;11379.487923043649;11424.028957538701;11901.464434100659;11968.521259149536;11972.880271197177;9385.953070234606;9574.521273936136;9620.95189524048;9675.9032409675;9915.454649994032;9010;9426.148101064631;9511.286653501153;9620;9781.608735650494 15:00:20 INFO - PROCESS | 27193 | __end_tp_report 15:00:20 INFO - PROCESS | 27193 | __start_cc_report 15:00:20 INFO - PROCESS | 27193 | _x_x_mozilla_cycle_collect,369 15:00:20 INFO - PROCESS | 27193 | __end_cc_report 15:00:20 INFO - PROCESS | 27193 | __startTimestamp1463263220183__endTimestamp 15:00:20 INFO - PROCESS | 27193 | 15:00:20 INFO - PROCESS | 27193 | ------- Summary: start ------- 15:00:20 INFO - PROCESS | 27193 | Number of tests: 6 15:00:20 INFO - PROCESS | 27193 | 15:00:20 INFO - PROCESS | 27193 | [#0] dojo.html Cycles:165 Average:4822.18 Median:4927.04 stddev:494.36 (10.0%) stddev-sans-first:467.07 15:00:20 INFO - PROCESS | 27193 | Values: 2702.4 2738.3 2748.8 2751.5 2752.2 4867.8 4899.6 4926.9 4928.3 4929.5 4806.2 4862.0 4877.5 4896.1 4918.2 4452.7 4485.4 4535.2 4541.5 4586.6 4503.1 4617.5 4632.3 4658.0 4684.6 4491.5 4503.1 4508.8 4553.7 4563.3 4491.9 4494.5 4517.8 4535.8 4565.1 4489.3 4514.8 4519.2 4522.1 4560.7 4636.4 4703.9 4734.8 4754.7 4759.5 5183.4 5188.3 5204.9 5225.6 5247.9 5123.2 5193.6 5232.2 5247.8 5249.4 4847.3 4861.2 4881.5 4902.3 4927.0 5350.1 5354.1 5354.2 5381.8 5406.0 5014.3 5093.1 5106.7 5133.5 5145.5 5197.1 5214.1 5217.7 5228.9 5254.8 5024.8 5093.5 5102.9 5107.2 5136.9 5173.7 5207.9 5237.9 5258.0 5263.4 4313.9 4530.4 4531.9 4536.7 4580.0 3810.6 3824.8 3844.1 3858.6 3887.6 4436.7 4471.4 4478.0 4483.5 4518.1 5196.8 5197.2 5205.9 5218.4 5276.7 4521.5 4525.1 4526.4 4558.5 4559.3 4689.1 4752.8 4765.7 4768.2 4807.9 4826.8 4888.2 4928.3 4934.4 4952.6 5245.4 5257.1 5265.2 5267.3 5268.8 4908.6 4912.7 4930.8 4940.9 4952.7 5058.9 5131.5 5144.5 5153.9 5182.1 5212.5 5269.1 5270.7 5283.4 5325.9 4979.7 5085.7 5092.4 5111.4 5111.6 4946.8 4986.5 5006.3 5045.8 5108.5 4895.8 4902.7 4914.2 4959.5 4965.9 5030.0 5073.1 5086.7 5087.5 5131.8 4896.2 4915.9 4921.5 4929.6 4990.1 15:00:20 INFO - PROCESS | 27193 | 15:00:20 INFO - PROCESS | 27193 | [#1] ext.html Cycles:180 Average:49571.95 Median:210498.82 stddev:89184.71 (42.4%) stddev-sans-first:89358.97 15:00:20 INFO - PROCESS | 27193 | Values: 557.5 596.3 609.2 615.3 637.3 37550.8 41773.4 41794.4 42012.4 42086.2 41563.4 41623.4 42090.4 42130.0 42193.4 7815.2 7927.4 7941.1 7950.2 7978.8 7823.0 7920.0 7930.0 7947.2 7948.4 7890.8 7906.7 7954.6 7956.4 7961.5 7852.1 7888.8 7912.1 7924.2 7944.7 7866.1 7918.3 7928.1 7950.4 7976.1 38874.0 39227.2 39290.6 39326.6 39368.8 3320.3 3372.4 3432.4 3434.0 3471.8 31475.7 31847.2 31950.0 32088.8 32705.8 3607.7 3618.7 3618.9 3662.3 3663.8 271435.6 273105.0 273295.0 273603.0 274125.0 57886.0 58454.1 58467.4 58566.4 58575.7 35178.8 35840.8 35989.6 38365.6 38462.2 15886.8 16033.4 16035.0 16061.8 16114.3 12153.1 12176.3 12191.0 12248.8 12271.6 20040.9 20069.0 20132.6 20252.0 20360.8 7515.2 7549.2 7567.3 7674.4 7718.9 826.5 876.4 904.0 907.6 1124.4 29444.7 30018.1 30045.4 30056.0 30481.5 994.2 997.1 1019.2 1036.5 1043.0 15862.5 15957.8 16241.7 16257.8 16721.6 382742.0 386226.0 386301.0 386350.0 388103.0 52999.2 53177.2 53312.5 53367.5 53589.7 1190.6 1216.2 1280.3 1302.8 1313.0 26973.3 28336.3 28426.9 28457.1 29051.0 45957.8 46779.5 46863.5 46899.5 47101.0 346380.0 348849.0 349737.0 349803.0 349875.0 26789.5 26807.3 27470.9 27547.3 27547.9 44498.2 44702.0 45083.3 45293.3 45303.8 38255.6 38291.0 39028.8 39051.2 39857.4 37762.8 37948.2 38209.8 38481.2 38698.8 32507.3 37245.0 37572.6 37763.0 38315.4 33276.5 34219.5 34800.7 35153.5 35190.3 25386.4 25625.9 25659.5 25856.2 26368.0 15:00:20 INFO - PROCESS | 27193 | 15:00:20 INFO - PROCESS | 27193 | [#2] jquery.html Cycles:180 Average:24099.97 Median:2418.21 stddev:59558.17 (2462.9%) stddev-sans-first:59698.61 15:00:20 INFO - PROCESS | 27193 | Values: 376.6 384.8 386.2 394.8 404.5 13313.8 16316.8 16419.5 17353.7 18074.7 16824.4 17226.7 17809.3 17946.2 18010.4 5075.3 5126.7 5277.1 5309.4 5405.2 5235.5 5240.4 5248.9 5271.3 5283.1 4986.3 5215.4 5224.2 5272.6 5276.6 5196.2 5250.3 5261.6 5298.4 5298.5 4603.1 4730.4 4742.9 4745.7 4763.6 15923.8 16000.5 18881.8 21178.3 21375.6 2055.3 2155.7 2323.8 2343.6 2492.8 13560.3 13768.5 13830.1 14104.4 14206.6 1812.3 1831.4 1835.9 1850.9 1898.1 61494.0 71528.3 72819.0 74197.6 75118.2 10188.0 10193.4 10476.4 10961.9 11137.4 11255.1 11691.2 14429.3 14518.6 14558.9 7241.7 7457.9 7880.8 7894.9 7943.2 7703.9 7708.8 7768.1 7812.7 7865.2 6216.4 6226.8 6257.7 6371.6 6399.7 1646.3 1676.9 1684.2 1703.1 1729.5 851.2 902.0 950.9 962.2 990.5 17094.3 17660.1 17974.4 18076.1 18168.6 839.5 911.8 923.8 944.8 956.2 9762.4 9807.9 10475.7 10601.8 10667.5 303190.0 306660.0 311048.0 419723.0 426251.0 80249.6 85879.6 87222.6 87625.6 87701.0 957.8 964.6 966.5 1008.9 1012.8 16152.8 16574.3 16580.0 16602.1 16644.3 29802.7 37751.1 38475.0 39532.2 40959.6 47987.0 48193.0 52255.0 54241.5 54905.0 6045.2 10243.7 11159.8 11539.7 11690.2 11717.8 12063.3 12251.7 12682.4 12967.2 10410.4 11128.9 11248.3 11249.2 11308.5 4916.8 9541.3 10727.5 10885.7 11097.9 10784.7 11009.2 11038.7 11474.7 11494.7 11625.7 11753.8 11795.8 11806.1 11829.8 11256.6 11355.8 11427.7 11478.2 11582.0 15:00:20 INFO - PROCESS | 27193 | 15:00:20 INFO - PROCESS | 27193 | [#3] mootools.html Cycles:180 Average:5370.22 Median:5037.02 stddev:2960.95 (58.8%) stddev-sans-first:2955.15 15:00:20 INFO - PROCESS | 27193 | Values: 1523.9 1552.0 1758.5 1879.2 1894.2 6870.9 7547.2 7562.3 8073.7 8074.4 7452.3 7612.7 7698.8 7701.8 7785.2 2240.7 2277.0 2277.9 2278.0 2284.8 2236.1 2250.3 2282.3 2301.8 2305.9 2196.5 2204.8 2209.5 2232.7 2248.5 2179.5 2202.8 2225.2 2237.0 2246.0 2205.7 2229.6 2245.9 2251.5 2252.4 7689.0 7746.2 7752.6 7753.1 7760.1 4814.9 4886.9 4901.7 4902.0 4922.0 2841.7 2993.2 3079.4 3096.1 3131.9 952.3 954.2 976.6 977.4 992.9 11292.6 11337.5 11356.3 11369.3 11461.7 4410.5 4412.4 4526.5 4542.6 4677.2 9585.6 9603.9 9623.7 9633.0 9674.7 5021.3 5031.4 5032.1 5032.8 5041.2 3992.1 4287.8 4440.4 4514.7 4586.7 3788.7 3890.6 3894.7 3901.6 4115.0 1264.4 1288.9 1293.6 1300.5 1306.6 776.6 810.6 924.8 928.3 965.6 5523.9 5616.7 5718.9 5747.3 5870.2 937.2 954.8 958.3 973.2 977.5 3812.2 3950.3 3966.9 3968.6 3978.6 9818.7 10048.6 10092.5 10101.6 10174.7 9936.7 10001.5 10060.1 10063.1 10102.2 7310.2 7550.6 7552.9 7557.7 7698.7 5253.9 5456.4 5510.9 5525.0 5560.0 8937.7 8981.0 9010.1 9068.9 9092.8 8794.1 9130.5 9182.8 9429.0 9515.0 6368.2 6866.0 7048.9 7050.7 7285.2 7876.6 7914.3 7923.7 7969.1 7989.4 6981.8 7062.0 7295.6 7337.6 7356.4 7126.5 7137.0 7169.2 7217.0 7254.5 6292.9 6522.3 6525.4 6610.2 6627.8 4842.4 4930.5 4931.9 4986.8 5044.7 4714.9 4896.1 4934.6 4944.2 4980.4 15:00:20 INFO - PROCESS | 27193 | 15:00:20 INFO - PROCESS | 27193 | [#4] prototype.html Cycles:180 Average:4444.97 Median:5125.06 stddev:1298.44 (25.3%) stddev-sans-first:1264.52 15:00:20 INFO - PROCESS | 27193 | Values: 314.3 320.2 321.0 325.3 325.7 5127.1 5177.9 5194.8 5199.5 5228.1 5017.6 5040.6 5063.9 5071.3 5076.5 3826.9 3919.6 4005.1 4022.3 4024.5 3998.2 4014.6 4017.8 4029.8 4031.7 3987.1 3998.9 4004.3 4015.1 4018.5 3718.7 3938.7 3940.3 3993.6 4027.9 3448.4 3459.0 3494.8 3506.4 3513.0 4873.8 4905.9 4914.6 4918.2 4952.3 4250.4 4516.5 4534.2 4551.2 4585.0 5309.9 5322.6 5328.2 5342.5 5373.9 3757.1 3763.8 3766.8 3768.6 3768.6 5349.4 5589.8 5590.0 5601.9 5620.5 3873.0 3879.3 3890.3 3903.8 3923.1 3939.2 3954.3 3962.1 3968.0 3989.6 4481.7 4495.8 4501.1 4510.8 4518.7 5172.8 5306.1 5308.2 5331.3 5384.7 1369.7 1379.3 1386.8 1390.7 1394.9 882.3 890.6 899.9 906.9 910.5 4629.9 4649.8 4656.3 4659.7 4663.5 5355.5 5421.2 5424.2 5425.4 5457.8 4438.2 4585.0 4626.2 4638.9 4645.5 2861.5 2910.4 2911.4 2937.6 2944.4 5123.0 5142.0 5143.8 5153.6 5193.6 5383.0 5596.9 5645.2 5711.6 5713.2 5235.2 5235.3 5235.4 5258.3 5267.5 5561.1 5571.3 5590.9 5601.8 5606.9 5227.6 5450.4 5514.3 5529.3 5545.8 5243.1 5289.8 5293.8 5320.0 5321.3 3773.4 3848.2 3872.6 3877.1 3884.0 5502.3 5519.6 5553.6 5574.1 5619.0 5399.7 5403.4 5408.8 5419.5 5422.7 5179.5 5340.9 5394.6 5411.3 5420.7 5260.6 5277.3 5278.3 5333.5 5347.5 5233.7 5328.3 5429.6 5445.9 5481.3 5296.9 5308.2 5317.9 5321.6 5340.8 15:00:20 INFO - PROCESS | 27193 | 15:00:20 INFO - PROCESS | 27193 | [#5] yui.html Cycles:180 Average:13887.79 Median:50820.74 stddev:16414.47 (32.3%) stddev-sans-first:16430.59 15:00:20 INFO - PROCESS | 27193 | Values: 689.4 739.7 805.7 821.0 824.4 10380.9 12242.8 12329.3 12749.9 13759.3 13436.7 13783.2 13817.6 13856.2 13968.2 887.5 889.6 890.6 891.7 892.5 882.9 883.9 889.9 891.2 891.6 934.8 936.9 940.6 940.6 944.5 896.1 929.4 931.6 934.9 935.4 676.1 677.7 678.1 680.7 681.5 13538.0 13553.1 13560.1 13574.2 13600.7 11326.0 11499.6 11710.8 11752.8 11948.8 10352.1 10417.5 10467.7 10496.1 10672.4 3344.7 3363.3 3383.8 3482.5 3504.1 52783.2 52802.0 52930.7 53067.7 53505.2 9584.0 9805.7 9913.5 9915.7 10140.5 15997.0 17651.5 17884.2 17957.8 17989.3 7017.1 7081.4 7131.4 7165.6 7167.6 3820.8 3866.3 3899.7 3960.6 4004.4 3010.1 3089.1 3092.9 3094.6 3099.1 566.1 569.9 570.1 576.6 586.1 552.9 588.9 594.8 621.9 636.6 8246.5 8354.4 8457.4 8474.9 8673.9 595.4 621.5 628.1 628.5 639.8 4017.5 4051.5 4055.9 4092.1 4098.3 57808.7 58113.7 59002.0 59029.1 59269.7 52192.5 53274.0 53406.5 53865.0 54558.0 44069.1 45943.5 48432.3 48618.8 49449.0 8229.5 8394.3 8574.4 8665.7 8688.0 31341.7 32872.7 32930.7 33160.7 33424.7 41725.6 43034.4 43565.8 44062.8 44759.0 10886.8 11130.8 11150.2 11153.3 11284.6 11912.3 12127.5 12471.4 12479.3 12592.6 10598.7 10929.7 10975.7 11149.7 11195.8 11138.8 11250.4 11285.4 12044.4 12124.1 11379.5 11424.0 11901.5 11968.5 11972.9 9386.0 9574.5 9621.0 9675.9 9915.5 9010.0 9426.1 9511.3 9620.0 9781.6 15:00:20 INFO - PROCESS | 27193 | -------- Summary: end -------- 15:00:20 INFO - PROCESS | 27193 | 15:00:20 INFO - TEST-INFO | 27193: exit 0 15:00:20 INFO - TEST-OK | dromaeo_css | took 1116795ms 15:00:20 INFO - TEST-START | kraken 15:00:20 INFO - operating with platform_type : linux_ 15:00:20 INFO - Initialising browser for kraken test... 15:00:20 INFO - TEST-INFO | started process 27421 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYeLMy6/profile http://localhost:48154/getInfo.html) 15:00:24 INFO - PROCESS | 27421 | JavaScript error: resource://app/components/nsBrowserGlue.js, line 1275: ReferenceError: E10SUINotification is not defined 15:00:24 INFO - PROCESS | 27421 | 15:00:24 INFO - PROCESS | 27421 | (process:27489): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:00:25 INFO - PROCESS | 27421 | __metrics Screen width/height:1600/1200 15:00:25 INFO - PROCESS | 27421 | colorDepth:24 15:00:25 INFO - PROCESS | 27421 | Browser inner width/height: 1024/697 15:00:25 INFO - PROCESS | 27421 | __metrics 15:00:26 ERROR - PROCESS | 27421 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 15:00:27 INFO - TEST-INFO | 27421: exit 0 15:00:27 INFO - Browser initialized. 15:00:27 INFO - Running cycle 1/1 for kraken test... 15:00:27 INFO - TEST-INFO | started process 27540 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYeLMy6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:00:29 INFO - PROCESS | 27540 | 15:00:29 INFO - PROCESS | 27540 | (process:27602): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:00:39 INFO - PROCESS | 27540 | RSS: Main: 164630528 15:00:39 INFO - PROCESS | 27540 | 15:00:41 INFO - PROCESS | 27540 | Cycle 1(1): loaded http://localhost:48154/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48154/tests/kraken/driver.html?testName=audio-beat-detection) 15:00:42 INFO - PROCESS | 27540 | RSS: Main: 168120320 15:00:42 INFO - PROCESS | 27540 | 15:00:45 INFO - PROCESS | 27540 | Cycle 1(1): loaded http://localhost:48154/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48154/tests/kraken/driver.html?testName=audio-dft) 15:00:46 INFO - PROCESS | 27540 | RSS: Main: 168329216 15:00:46 INFO - PROCESS | 27540 | 15:00:49 INFO - PROCESS | 27540 | Cycle 1(1): loaded http://localhost:48154/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48154/tests/kraken/driver.html?testName=audio-fft) 15:00:49 INFO - PROCESS | 27540 | RSS: Main: 163876864 15:00:49 INFO - PROCESS | 27540 | 15:00:52 INFO - PROCESS | 27540 | Cycle 1(1): loaded http://localhost:48154/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48154/tests/kraken/driver.html?testName=audio-oscillator) 15:00:52 INFO - PROCESS | 27540 | RSS: Main: 164339712 15:00:52 INFO - PROCESS | 27540 | 15:00:55 INFO - PROCESS | 27540 | Cycle 1(1): loaded http://localhost:48154/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48154/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:00:55 INFO - PROCESS | 27540 | RSS: Main: 164732928 15:00:55 INFO - PROCESS | 27540 | 15:00:58 INFO - PROCESS | 27540 | Cycle 1(1): loaded http://localhost:48154/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48154/tests/kraken/driver.html?testName=imaging-darkroom) 15:00:59 INFO - PROCESS | 27540 | RSS: Main: 164573184 15:00:59 INFO - PROCESS | 27540 | 15:01:03 INFO - PROCESS | 27540 | Cycle 1(1): loaded http://localhost:48154/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48154/tests/kraken/driver.html?testName=imaging-desaturate) 15:01:03 INFO - PROCESS | 27540 | RSS: Main: 163115008 15:01:03 INFO - PROCESS | 27540 | 15:01:06 INFO - PROCESS | 27540 | Cycle 1(1): loaded http://localhost:48154/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48154/tests/kraken/driver.html?testName=json-parse-financial) 15:01:07 INFO - PROCESS | 27540 | RSS: Main: 163966976 15:01:07 INFO - PROCESS | 27540 | 15:01:09 INFO - PROCESS | 27540 | Cycle 1(1): loaded http://localhost:48154/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48154/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:01:09 INFO - PROCESS | 27540 | RSS: Main: 164098048 15:01:09 INFO - PROCESS | 27540 | 15:01:11 INFO - PROCESS | 27540 | Cycle 1(1): loaded http://localhost:48154/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48154/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:01:12 INFO - PROCESS | 27540 | RSS: Main: 164335616 15:01:12 INFO - PROCESS | 27540 | 15:01:14 INFO - PROCESS | 27540 | Cycle 1(1): loaded http://localhost:48154/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48154/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:01:15 INFO - PROCESS | 27540 | RSS: Main: 165236736 15:01:15 INFO - PROCESS | 27540 | 15:01:18 INFO - PROCESS | 27540 | Cycle 1(1): loaded http://localhost:48154/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48154/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:01:18 INFO - PROCESS | 27540 | RSS: Main: 164966400 15:01:18 INFO - PROCESS | 27540 | 15:01:21 INFO - PROCESS | 27540 | Cycle 1(1): loaded http://localhost:48154/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48154/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:01:22 INFO - PROCESS | 27540 | RSS: Main: 164790272 15:01:22 INFO - PROCESS | 27540 | 15:01:24 INFO - PROCESS | 27540 | Cycle 1(1): loaded http://localhost:48154/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48154/tests/kraken/driver.html?testName=ai-astar) 15:01:24 INFO - PROCESS | 27540 | RSS: Main: 166469632 15:01:24 INFO - PROCESS | 27540 | 15:01:24 INFO - PROCESS | 27540 | __start_tp_report 15:01:24 INFO - PROCESS | 27540 | _x_x_mozilla_page_load 15:01:24 INFO - PROCESS | 27540 | _x_x_mozilla_page_load_details 15:01:24 INFO - PROCESS | 27540 | |i|pagename|runs| 15:01:24 INFO - PROCESS | 27540 | |0;ai-astar;110;114;106;115;114;113;107;113;113;113 15:01:24 INFO - PROCESS | 27540 | |1;audio-beat-detection;167;132;162;204;132;165;163;133;191;135 15:01:24 INFO - PROCESS | 27540 | |2;audio-dft;162;166;171;169;161;165;162;163;161;162 15:01:24 INFO - PROCESS | 27540 | |3;audio-fft;74;76;78;170;76;77;76;75;168;77 15:01:24 INFO - PROCESS | 27540 | |4;audio-oscillator;93;93;181;93;93;92;148;94;93;152 15:01:24 INFO - PROCESS | 27540 | |5;imaging-gaussian-blur;117;118;123;117;118;117;118;117;118;118 15:01:24 INFO - PROCESS | 27540 | |6;imaging-darkroom;148;147;146;147;147;146;147;148;147;148 15:01:24 INFO - PROCESS | 27540 | |7;imaging-desaturate;96;95;95;95;96;95;95;95;95;95 15:01:24 INFO - PROCESS | 27540 | |8;json-parse-financial;63;66;64;63;63;62;63;63;63;64 15:01:24 INFO - PROCESS | 27540 | |9;json-stringify-tinderbox;64;67;64;65;64;64;64;64;63;63 15:01:24 INFO - PROCESS | 27540 | |10;stanford-crypto-aes;82;82;81;81;88;85;84;83;140;83 15:01:24 INFO - PROCESS | 27540 | |11;stanford-crypto-ccm;132;136;129;129;129;132;133;130;146;128 15:01:24 INFO - PROCESS | 27540 | |12;stanford-crypto-pbkdf2;168;168;170;167;168;168;167;168;168;167 15:01:24 INFO - PROCESS | 27540 | |13;stanford-crypto-sha256-iterative;68;67;66;67;65;65;65;66;70;67 15:01:24 INFO - PROCESS | 27540 | __end_tp_report 15:01:24 INFO - PROCESS | 27540 | __start_cc_report 15:01:24 INFO - PROCESS | 27540 | _x_x_mozilla_cycle_collect,965 15:01:24 INFO - PROCESS | 27540 | __end_cc_report 15:01:24 INFO - PROCESS | 27540 | __startTimestamp1463263284401__endTimestamp 15:01:24 INFO - PROCESS | 27540 | 15:01:24 INFO - PROCESS | 27540 | ------- Summary: start ------- 15:01:24 INFO - PROCESS | 27540 | Number of tests: 14 15:01:24 INFO - PROCESS | 27540 | 15:01:24 INFO - PROCESS | 27540 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.00 stddev:3.08 (2.7%) stddev-sans-first:3.20 15:01:24 INFO - PROCESS | 27540 | Values: 110.0 114.0 106.0 115.0 114.0 113.0 107.0 113.0 113.0 113.0 15:01:24 INFO - PROCESS | 27540 | 15:01:24 INFO - PROCESS | 27540 | [#1] audio-beat-detection Cycles:10 Average:158.40 Median:164.00 stddev:25.56 (15.6%) stddev-sans-first:26.92 15:01:24 INFO - PROCESS | 27540 | Values: 167.0 132.0 162.0 204.0 132.0 165.0 163.0 133.0 191.0 135.0 15:01:24 INFO - PROCESS | 27540 | 15:01:24 INFO - PROCESS | 27540 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.00 stddev:3.49 (2.1%) stddev-sans-first:3.61 15:01:24 INFO - PROCESS | 27540 | Values: 162.0 166.0 171.0 169.0 161.0 165.0 162.0 163.0 161.0 162.0 15:01:24 INFO - PROCESS | 27540 | 15:01:24 INFO - PROCESS | 27540 | [#3] audio-fft Cycles:10 Average:94.70 Median:76.00 stddev:39.18 (51.5%) stddev-sans-first:40.83 15:01:24 INFO - PROCESS | 27540 | Values: 74.0 76.0 78.0 170.0 76.0 77.0 76.0 75.0 168.0 77.0 15:01:24 INFO - PROCESS | 27540 | 15:01:24 INFO - PROCESS | 27540 | [#4] audio-oscillator Cycles:10 Average:113.20 Median:93.00 stddev:33.62 (36.1%) stddev-sans-first:34.85 15:01:24 INFO - PROCESS | 27540 | Values: 93.0 93.0 181.0 93.0 93.0 92.0 148.0 94.0 93.0 152.0 15:01:24 INFO - PROCESS | 27540 | 15:01:24 INFO - PROCESS | 27540 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:1.79 (1.5%) stddev-sans-first:1.86 15:01:24 INFO - PROCESS | 27540 | Values: 117.0 118.0 123.0 117.0 118.0 117.0 118.0 117.0 118.0 118.0 15:01:24 INFO - PROCESS | 27540 | 15:01:24 INFO - PROCESS | 27540 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 15:01:24 INFO - PROCESS | 27540 | Values: 148.0 147.0 146.0 147.0 147.0 146.0 147.0 148.0 147.0 148.0 15:01:24 INFO - PROCESS | 27540 | 15:01:24 INFO - PROCESS | 27540 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 15:01:24 INFO - PROCESS | 27540 | Values: 96.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 15:01:24 INFO - PROCESS | 27540 | 15:01:24 INFO - PROCESS | 27540 | [#8] json-parse-financial Cycles:10 Average:63.40 Median:63.00 stddev:1.07 (1.7%) stddev-sans-first:1.13 15:01:24 INFO - PROCESS | 27540 | Values: 63.0 66.0 64.0 63.0 63.0 62.0 63.0 63.0 63.0 64.0 15:01:24 INFO - PROCESS | 27540 | 15:01:24 INFO - PROCESS | 27540 | [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:1.14 (1.8%) stddev-sans-first:1.20 15:01:24 INFO - PROCESS | 27540 | Values: 64.0 67.0 64.0 65.0 64.0 64.0 64.0 64.0 63.0 63.0 15:01:24 INFO - PROCESS | 27540 | 15:01:24 INFO - PROCESS | 27540 | [#10] stanford-crypto-aes Cycles:10 Average:88.90 Median:83.00 stddev:18.08 (21.8%) stddev-sans-first:19.00 15:01:24 INFO - PROCESS | 27540 | Values: 82.0 82.0 81.0 81.0 88.0 85.0 84.0 83.0 140.0 83.0 15:01:24 INFO - PROCESS | 27540 | 15:01:24 INFO - PROCESS | 27540 | [#11] stanford-crypto-ccm Cycles:10 Average:132.40 Median:132.00 stddev:5.36 (4.1%) stddev-sans-first:5.68 15:01:24 INFO - PROCESS | 27540 | Values: 132.0 136.0 129.0 129.0 129.0 132.0 133.0 130.0 146.0 128.0 15:01:24 INFO - PROCESS | 27540 | 15:01:24 INFO - PROCESS | 27540 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.90 Median:168.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 15:01:24 INFO - PROCESS | 27540 | Values: 168.0 168.0 170.0 167.0 168.0 168.0 167.0 168.0 168.0 167.0 15:01:24 INFO - PROCESS | 27540 | 15:01:24 INFO - PROCESS | 27540 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:1.58 (2.4%) stddev-sans-first:1.59 15:01:24 INFO - PROCESS | 27540 | Values: 68.0 67.0 66.0 67.0 65.0 65.0 65.0 66.0 70.0 67.0 15:01:24 INFO - PROCESS | 27540 | -------- Summary: end -------- 15:01:24 INFO - PROCESS | 27540 | 15:01:25 INFO - TEST-INFO | 27540: exit 0 15:01:25 INFO - TEST-OK | kraken | took 64512ms 15:01:25 INFO - SUITE-END | took 1181s 15:01:25 INFO - Completed test suite (00:19:41) 15:01:25 INFO - javascript benchmark 15:01:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6633.8475030404425, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2702.37845295582, 2738.30173305807, 2748.8350698958056, 2751.477219328326, 2752.2018614601766, 4867.805287788488, 4899.632527560439, 4926.901461970768, 4928.260760885864, 4929.4577596464405, 4806.182948898687, 4861.9513804861945, 4877.51224877513, 4896.069746748115, 4918.213085906255, 4452.710573812708, 4485.439320084989, 4535.206338890681, 4541.477730061052, 4586.610138138246, 4503.1218912312115, 4617.492075871652, 4632.2819962905805, 4658.021815418766, 4684.55496727812, 4491.528389519086, 4503.144402563503, 4508.819647214107, 4553.704009239405, 4563.2501759289535, 4491.910161796745, 4494.4606647202545, 4517.819287228507, 4535.750533720644, 4565.132624801277, 4489.326601009842, 4514.774261286922, 4519.186546421643, 4522.140793249272, 4560.749158796265, 4636.420447444069, 4703.882402939919, 4734.83428080019, 4754.66717329787, 4759.4764575896625, 5183.429822719498, 5188.273641690166, 5204.869878253036, 5225.634205605609, 5247.921281180786, 5123.205903085028, 5193.584513238932, 5232.241325007891, 5247.816326428595, 5249.448807875195, 4847.321375007502, 4861.246506791453, 4881.487443818419, 4902.264660300983, 4927.039227350704, 5350.0904846176245, 5354.116570765858, 5354.170103633943, 5381.838544843661, 5406.026915155231, 5014.348134742533, 5093.0577843099145, 5106.744662766847, 5133.537981581676, 5145.485451454824, 5197.0905091609575, 5214.0614689355525, 5217.713025783542, 5228.895422091537, 5254.7635356409055, 5024.824131155392, 5093.541581257705, 5102.923456148161, 5107.157319042316, 5136.871578210575, 5173.663711858792, 5207.869803254873, 5237.921431178535, 5258.027264955996, 5263.368395792453, 4313.870583882426, 4530.411046563926, 4531.932021019687, 4536.727796332165, 4580.038191979655, 3810.599887011879, 3824.847006119724, 3844.058205739612, 3858.5562660294427, 3887.591802860659, 4436.711613745097, 4471.374007638933, 4478.0148367359125, 4483.529229430928, 4518.118966801442, 5196.792128314825, 5197.22041693749, 5205.869853253699, 5218.425973142951, 5276.657017293864, 4521.502634710179, 4525.117602067631, 4526.366308716782, 4558.49856515783, 4559.270516717309, 4689.109069276827, 4752.809887604457, 4765.690230135099, 4768.237082066853, 4807.879803004883, 4826.758662066813, 4888.193448081027, 4928.310036594951, 4934.407871055496, 4952.5542701157065, 5245.396779370269, 5257.132573125545, 5265.157574788015, 5267.2625832384265, 5268.841934741964, 4908.576512811244, 4912.6561140719805, 4930.753462326941, 4940.901181976412, 4952.727599982036, 5058.924116138187, 5131.538161565477, 5144.536991670768, 5153.922691159711, 5182.067227898863, 5212.452692467236, 5269.077911365573, 5270.683758974474, 5283.392409872914, 5325.866853328698, 4979.651424400257, 5085.720285384339, 5092.41437234708, 5111.361079865017, 5111.616628752784, 4946.752662366939, 4986.451490336132, 5006.324146240357, 5045.84862454127, 5108.489151084862, 4895.828645997373, 4902.730349830794, 4914.189158788903, 4959.528844759742, 4965.900681986268, 5030.044291584587, 5073.061483625541, 5086.669366491166, 5087.542121209109, 5131.79472821083, 4896.167651499325, 4915.86935004958, 4921.458639549575, 4929.630277729113, 4990.101781679333], "value": 4791.095958653119, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.4676184244045, 596.3470000349618, 609.2049874913237, 615.2709039787852, 637.3085202555227, 37550.81224593877, 41773.37339939903, 41794.37308440376, 42012.36981445281, 42086.158276834445, 41563.376549351786, 41623.37564936528, 42090.368644470356, 42130.0, 42193.36709949353, 7815.179406162356, 7927.3658107351275, 7941.08677502086, 7950.204979502032, 7978.800529986739, 7822.9608851955945, 7920.049594048723, 7930.048394192676, 7947.245011723906, 7948.443608947376, 7890.842183156334, 7906.723264685737, 7954.602269886512, 7956.403269754792, 7961.52230866147, 7852.057753069611, 7888.763337099867, 7912.09010963735, 7924.20757924203, 7944.682212711485, 7866.0560732711865, 7918.326942209919, 7928.127905930343, 7950.363970882373, 7976.122626511079, 38874.0, 39227.215455690726, 39290.60709392898, 39326.60673393258, 39368.80315598432, 3320.335932813423, 3372.409828280041, 3432.3650124727005, 3433.9828300858335, 3471.791692498433, 31475.685243147505, 31847.203819904455, 31950.0, 32088.839555802304, 32705.836470817732, 3607.729420293462, 3618.6743193112484, 3618.873339433107, 3662.285854258421, 3663.8351274192723, 271435.6428217866, 273105.0, 273295.0, 273603.0, 274125.0, 57886.0, 58454.12318815221, 58467.41532584705, 58566.41433585695, 58575.70712146497, 35178.82410587931, 35840.820795896376, 35989.64010359915, 38365.616343836766, 38462.230755385295, 15886.76169857453, 16033.43882964114, 16035.0, 16061.759073613905, 16114.274857631435, 12153.149279550347, 12176.330301833485, 12191.0, 12248.81626775599, 12271.570495032809, 20040.89979550093, 20069.0, 20132.597348052957, 20252.0, 20360.796392036187, 7515.173330933593, 7549.245075492517, 7567.281108294703, 7674.42441816866, 7718.92281077182, 826.5247482697473, 876.3733930239781, 904.0010788079078, 907.5915837872983, 1124.42092322454, 29444.705552944626, 30018.099457016324, 30045.399092018037, 30056.0, 30481.542776858365, 994.1897353656747, 997.1275134257525, 1019.169376957777, 1036.4713995862164, 1043.0404028293988, 15862.524124276059, 15957.760633590506, 16241.675166496603, 16257.756133658004, 16721.581960451087, 382742.0, 386226.0, 386301.0, 386350.0, 388103.0, 52999.20501192485, 53177.202341964905, 53312.46687533153, 53367.46632533625, 53589.732051339495, 1190.6368557589844, 1216.2459275249225, 1280.2638482872385, 1302.8176055352258, 1313.0414797198098, 26973.325666858487, 28336.291592710346, 28426.857865711365, 28457.146285611463, 29051.0, 45957.77021114873, 46779.53220467888, 46863.531364685914, 46899.53100468952, 47101.0, 346380.0, 348849.0, 349737.0, 349803.0, 349875.0, 26789.464210716065, 26807.329816754736, 27470.90116395402, 27547.31131721723, 27547.86226068857, 44498.220071198084, 44702.0, 45083.32375014312, 45293.32060019037, 45303.77348113238, 38255.64863298367, 38291.0, 39028.804855976676, 39051.2189756209, 39857.40213896736, 37762.811185943894, 37948.24103517859, 38209.80895095507, 38481.23037539289, 38698.80650596729, 32507.34985300328, 37245.0, 37572.62427375691, 37763.0, 38315.42526862155, 33276.500852486744, 34219.4867076989, 34800.65199347974, 35153.47269791007, 35190.29619407649, 25386.365340866625, 25625.871870640527, 25659.486810264065, 25856.22431327063, 26368.0], "value": 18316.2378191089, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.59704116595236, 384.8383678854879, 386.1890030935036, 394.8262764383673, 404.46408508725943, 13313.80029299559, 16316.836831631681, 16419.507414777574, 17353.739693904587, 18074.72887906681, 16824.411145609905, 17226.741598876026, 17809.287628494843, 17946.19242134104, 18010.369637062704, 5075.264086707425, 5126.666766660164, 5277.102892508283, 5309.442508536606, 5405.18922161675, 5235.502627250406, 5240.44975277596, 5248.947510524903, 5271.341082364705, 5283.07546179419, 4986.276989836471, 5215.426303106655, 5224.1902505111575, 5272.551833094191, 5276.604254680914, 5196.194589838543, 5250.264962905197, 5261.631685781997, 5298.36419629645, 5298.549623282026, 4603.056373443436, 4730.361401210827, 4742.881427964328, 4745.667803253774, 4763.618910487153, 15923.761143582855, 16000.519984400487, 18881.81118188828, 21178.258760943292, 21375.572488550297, 2055.2806517718677, 2155.741311042669, 2323.814094872423, 2343.6484527320868, 2492.763187497185, 13560.321983900863, 13768.518101866386, 13830.101043432145, 14104.365303561364, 14206.644833879132, 1812.2932056497975, 1831.4414103698366, 1835.8806677565915, 1850.8889466632045, 1898.0889173196804, 61494.038284419614, 71528.2847171532, 72819.0, 74197.62901185514, 75118.24881751167, 10188.0, 10193.388396696222, 10476.423796691102, 10961.945190273998, 11137.443127843575, 11255.099592032619, 11691.181617286878, 14429.278536073154, 14518.637034074021, 14558.85441145596, 7241.746538871114, 7457.931792080648, 7880.763577092696, 7894.881576776353, 7943.205679432126, 7703.8844417333785, 7708.768736937789, 7768.145503994556, 7812.68749250035, 7865.213478652204, 6216.409441103088, 6226.782062627877, 6257.7184026718905, 6371.649559274284, 6399.712012959428, 1646.2838665180684, 1676.9413070542473, 1684.1916328881114, 1703.1058694185651, 1729.4898005088528, 851.1998721202174, 901.9503927284062, 950.9096635819586, 962.2494454325637, 990.4601991914424, 17094.316227351017, 17660.138374643826, 17974.37089701854, 18076.096195190188, 18168.63662726738, 839.5298632765671, 911.8176364727082, 923.7552048707098, 944.7685317097217, 956.2111258211864, 9762.36544624597, 9807.852882206773, 10475.738106547245, 10601.787964240826, 10667.466626668636, 303190.0, 306660.0, 311048.0, 419723.0, 426251.0, 80249.59875200587, 85879.57060214659, 87222.56388718016, 87625.56187219023, 87701.0, 957.8467445208594, 964.6382606522554, 966.5070813884829, 1008.8890222075565, 1012.8025035118228, 16152.757708634144, 16574.337026518806, 16580.0, 16602.086885220946, 16644.3342266308, 29802.701972979994, 37751.05622359463, 38475.0, 39532.20935581215, 40959.59040409677, 47987.0, 48193.0, 52255.0, 54241.45758542522, 54905.0, 6045.21412216409, 10243.692689219335, 11159.776804464027, 11539.711507212387, 11690.181687281809, 11717.76564468723, 12063.276203427471, 12251.69370765738, 12682.429290681757, 12967.157134786208, 10410.427426491313, 11128.888711112786, 11248.26886252391, 11249.156313276373, 11308.49111789988, 4916.7541622919425, 9541.284403669613, 10727.517261723397, 10885.673429797118, 11097.889021110008, 10784.676459706221, 11009.229353945148, 11038.724031898946, 11474.655760327203, 11494.655160345203, 11625.709357266136, 11753.764924701629, 11795.764084718428, 11806.1145414096, 11829.822552661544, 11256.606018789304, 11355.829662554903, 11427.657170284905, 11478.196526243417, 11582.0], "value": 8742.09169894629, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1523.9466618668348, 1551.9689606207876, 1758.4812480318305, 1879.2295158984818, 1894.2423030787675, 6870.896936545943, 7547.24527547245, 7562.281583249583, 8073.677052917891, 8074.4347895647325, 7452.254774522545, 7612.69549218032, 7698.769036928901, 7701.807454813633, 7785.221477852226, 2240.663900414939, 2276.9658455123185, 2277.8633282003134, 2277.9976810203457, 2284.8057915077156, 2236.1167338901123, 2250.336150835499, 2282.2696737044153, 2301.838871279011, 2305.8616483010987, 2196.5497073100055, 2204.754313812699, 2209.4586826227596, 2232.6985856909355, 2248.4940888300166, 2179.4660308224506, 2202.812760915324, 2225.2434172381386, 2237.0157130862367, 2246.034205291724, 2205.6801763744165, 2229.6209644360497, 2245.8764767937755, 2251.515924076315, 2252.425631463966, 7689.0, 7746.18665040174, 7752.573608451533, 7753.069631644183, 7760.06879174497, 4814.903701925942, 4886.926696099561, 4901.705897646153, 4901.995091006335, 4921.990991846698, 2841.7300356466103, 2993.207870307311, 3079.44569977404, 3096.055703010581, 3131.874725010997, 952.3476418653245, 954.1984732824461, 976.6484065736329, 977.4135518688801, 992.9056739609725, 11292.604758833402, 11337.489812958354, 11356.318620882774, 11369.317840929489, 11461.713457163554, 4410.4927933287445, 4412.36020776992, 4526.502084770673, 4542.636589072867, 4677.22825733757, 9585.616575337048, 9603.855942160873, 9623.663171788954, 9632.95183524078, 9674.70975870725, 5021.347224860745, 5031.4213865405945, 5032.119379108642, 5032.823851165192, 5041.218611115283, 3992.121733218687, 4287.7641729705165, 4440.378347031418, 4514.706544074625, 4586.6789324747615, 3788.6969042476535, 3890.6498415142773, 3894.6884249259992, 3901.6293452122004, 4114.958850411457, 1264.386772415378, 1288.9226646401246, 1293.5537239652306, 1300.4538094000354, 1306.5949555637783, 776.6272189349144, 810.5906517208772, 924.7826760711228, 928.3084102343662, 965.5510187762724, 5523.861903452445, 5616.66300022, 5718.913406452843, 5747.252857128547, 5870.207521984563, 937.2080591899834, 954.8138113068024, 958.2812890332251, 973.1630797514132, 977.4868194198103, 3812.237552489458, 3950.3481925482547, 3966.900827479336, 3968.6428221460205, 3978.5822488638855, 9818.705438836847, 10048.648297309705, 10092.545835437422, 10101.646442374482, 10174.745631359126, 9936.652217172365, 10001.549930253155, 10060.144887684482, 10063.094321511098, 10102.242331825142, 7310.195878453366, 7550.584717840462, 7552.9244707552225, 7557.659905304275, 7698.730544430918, 5253.894922101613, 5456.372517160577, 5510.9448905510435, 5524.972375138099, 5559.971405290034, 8937.73186804397, 8980.955095224743, 9010.14403631654, 9068.863967040368, 9092.818143636958, 8794.120587941155, 9130.49782261982, 9182.816343672956, 9428.952855235955, 9515.0, 6368.203974503187, 6866.0, 7048.894266586108, 7050.682719277543, 7285.198628151005, 7876.56678882667, 7914.327282180849, 7923.6830526778285, 7969.083555390972, 7989.400794940519, 6981.825454363681, 7062.0, 7295.598742069024, 7337.559746415232, 7356.448266379936, 7126.536775109601, 7137.0, 7169.175544812413, 7217.0, 7254.45591580623, 6292.905606415816, 6522.315156908457, 6525.3800888915475, 6610.173728283965, 6627.768028119185, 4842.443119041355, 4930.457649658463, 4931.901361972812, 4986.80052797884, 5044.672096313728, 4714.882127946828, 4896.069746748107, 4934.629902757236, 4944.233643785219, 4980.377452818398], "value": 4356.791092403773, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.34772846343833, 320.22665263388916, 320.96469388367274, 325.29086591231106, 325.66456549753764, 5127.12838817401, 5177.867390228905, 5194.844154675366, 5199.532042116213, 5228.111221092414, 5017.64876458648, 5040.6471546991725, 5063.9493605063935, 5071.31537242473, 5076.46697096805, 3826.9043273918164, 3919.627635374635, 4005.0988527581208, 4022.3162062449455, 4024.5170579530495, 3998.1803730235233, 4014.558398576154, 4017.758934463927, 4029.770919869439, 4031.717779755418, 3987.1228329767405, 3998.9400158997637, 4004.319265724819, 4015.0765323975356, 4018.5378681451716, 3718.6653201211752, 3938.7045971552247, 3940.330143875548, 3993.6405723485027, 4027.8993025174314, 3448.413769659164, 3458.9654103459147, 3494.755367124302, 3506.421440462321, 3512.982435087834, 4873.756312184377, 4905.852824415238, 4914.582260507861, 4918.2376731606655, 4952.331435256267, 4250.404943307939, 4516.54834516549, 4534.206513860061, 4551.2262915304145, 4584.991301913574, 5309.920351194735, 5322.627416080876, 5328.20076988451, 5342.492463215988, 5373.919391209135, 3757.098296408842, 3763.7929913854728, 3766.773993560395, 3768.6042965488778, 3768.6419790119894, 5349.358077030743, 5589.826136511338, 5590.0, 5601.943980560183, 5620.48246973319, 3873.0, 3879.2823327683905, 3890.2997460456822, 3903.8243279052513, 3923.1172986077904, 3939.153082087365, 3954.268460334847, 3962.1481381503113, 3967.960320396759, 3989.6209860063245, 4481.708688935209, 4495.842645507391, 4501.144782491317, 4510.819567217341, 4518.728876267434, 5172.818951336685, 5306.124489459273, 5308.203769434538, 5331.333583302087, 5384.6769193848495, 1369.705513314642, 1379.296558755042, 1386.7919812028074, 1390.7218556288783, 1394.8674875886775, 882.2589025218847, 890.6081324217324, 899.8875140607424, 906.8775715278485, 910.5083255042204, 4629.907401851944, 4649.767511624405, 4656.278276867091, 4659.720416774937, 4663.463701674283, 5355.464453554613, 5421.213923981, 5424.213489044146, 5425.403205647375, 5457.8071827981075, 4438.201123797748, 4585.0, 4626.21354369758, 4638.8608341749805, 4645.490215679917, 2861.5135426977463, 2910.359720861407, 2911.3740545782757, 2937.647482302095, 2944.3816798472562, 5123.0, 5141.997310524412, 5143.819966301162, 5153.639245252872, 5193.610479214074, 5383.031054410244, 5596.888062238732, 5645.153227015899, 5711.628744131701, 5713.200151978726, 5235.214717792362, 5235.303818533383, 5235.3717553893775, 5258.290130832365, 5267.473252674702, 5561.082421400423, 5571.303587051619, 5590.888182236414, 5601.80393686219, 5606.85982850432, 5227.607929405386, 5450.400455949763, 5514.283143191359, 5529.25828364064, 5545.750441230073, 5243.134882744304, 5289.788408463618, 5293.761780719799, 5319.989202051598, 5321.308229930084, 3773.415120656303, 3848.172118243812, 3872.5546562145714, 3877.1276462795645, 3883.9707477517914, 5502.284702988746, 5519.586031047767, 5553.611247212656, 5574.108142697149, 5618.971905140448, 5399.730013499231, 5403.378611459732, 5408.783648654167, 5419.539339156216, 5422.728863556727, 5179.533841954242, 5340.866478337917, 5394.595405344537, 5411.269478620336, 5420.701861397661, 5260.579153667621, 5277.2875661785165, 5278.2610434539965, 5333.479958212046, 5347.518723314764, 5233.7383130842545, 5328.280682107866, 5429.5656347492895, 5445.863853403696, 5481.314835645544, 5296.947030529645, 5308.177232528964, 5317.936412717395, 5321.600879934098, 5340.839774806762], "value": 4033.9291291225636, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [689.4381079420272, 739.6782399656148, 805.66162211871, 821.0, 824.4064273722921, 10380.896191038088, 12242.81635775463, 12329.260244385332, 12749.872501274984, 13759.31203439829, 13436.66408339792, 13783.17300961943, 13817.585472435818, 13856.237906915116, 13968.231747253896, 887.4852585500411, 889.595234168455, 890.6481939633873, 891.687909231767, 892.4779004282502, 882.8719835623831, 883.902770695223, 889.8576227803553, 891.1534042659467, 891.6032365597312, 934.8364036293656, 936.9109934556207, 940.5955439161158, 940.6331530703031, 944.5230158769846, 896.0546623312403, 929.4237572704899, 931.6133804471136, 934.9158575728183, 935.4106912645024, 676.1075380497745, 677.7255211639244, 678.1082876018021, 680.6630717794674, 681.495693187043, 13538.0, 13553.119047261995, 13560.11859229147, 13574.185548867099, 13600.659983500393, 11326.0, 11499.597514086967, 11710.765784684343, 11752.764944701144, 11948.820767688492, 10352.120069794077, 10417.531211095518, 10467.738306542322, 10496.055355018085, 10672.359658420442, 3344.7491438142238, 3363.327334533103, 3383.780054296463, 3482.460218666111, 3504.1064528545057, 52783.208251876255, 52802.0, 52930.73534632341, 53067.734661326445, 53505.19742203831, 9584.047390266322, 9805.656802011896, 9913.45475998827, 9915.702528924145, 10140.492975351202, 15997.0, 17651.470455886345, 17884.195211215527, 17957.820421795877, 17989.280428782702, 7017.087778588751, 7081.398081163055, 7131.358177763922, 7165.570065796069, 7167.605781682058, 3820.84716611338, 3866.284737323604, 3899.6880249579967, 3960.5643379228263, 4004.439378487014, 3010.1421094987822, 3089.073278016586, 3092.8608212630484, 3094.6131733533307, 3099.1477343730203, 566.0688167963676, 569.9458551437607, 570.1277046119444, 576.5560518400808, 586.1383765864173, 552.9170624406371, 588.8527868032992, 594.8364199844991, 621.8725161341914, 636.5671343486381, 8246.463979841412, 8354.373421993374, 8457.365697572706, 8474.915250847413, 8673.913260867437, 595.3510673366052, 621.5431657731564, 628.1237673445518, 628.4815027602247, 639.7792761497276, 4017.4978127734034, 4051.47330846988, 4055.878323650295, 4092.140650463436, 4098.303288440972, 57808.71095644495, 58113.709431452575, 59002.0, 59029.11456328158, 59269.70365148147, 52192.47807521952, 53274.0, 53406.46593534093, 53865.0, 54558.0, 44069.11861762811, 45943.540564594594, 48432.27351589729, 48618.75690621524, 49449.0, 8229.46508476947, 8394.328453723565, 8574.442661227, 8665.696700615448, 8688.0, 31341.68658313479, 32872.671273286964, 32930.67069329276, 33160.66839331672, 33424.66575334215, 41725.582744173385, 43034.35448468338, 43565.78217108894, 44062.77968610136, 44759.0, 10886.782264354826, 11130.833037504606, 11150.163737719866, 11153.330800152016, 11284.605038823602, 11912.328767123288, 12127.45426455794, 12471.434532917456, 12479.251244925334, 12592.559260425842, 10598.735031623963, 10929.726756831144, 10975.725606859573, 11149.72125696864, 11195.768465468629, 11138.777224455303, 11250.437478126225, 11285.37930413835, 12044.397780110785, 12124.09069319787, 11379.487923043649, 11424.028957538701, 11901.464434100659, 11968.521259149536, 11972.880271197177, 9385.953070234606, 9574.521273936136, 9620.95189524048, 9675.9032409675, 9915.454649994032, 9010.0, 9426.148101064631, 9511.286653501153, 9620.0, 9781.608735650494], "value": 6320.684698721146, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1586.1000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 114.0, 106.0, 115.0, 114.0, 113.0, 107.0, 113.0, 113.0, 113.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 132.0, 162.0, 204.0, 132.0, 165.0, 163.0, 133.0, 191.0, 135.0], "value": 158.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 166.0, 171.0, 169.0, 161.0, 165.0, 162.0, 163.0, 161.0, 162.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 78.0, 170.0, 76.0, 77.0, 76.0, 75.0, 168.0, 77.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 181.0, 93.0, 93.0, 92.0, 148.0, 94.0, 93.0, 152.0], "value": 113.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 123.0, 117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 146.0, 147.0, 147.0, 146.0, 147.0, 148.0, 147.0, 148.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 64.0, 63.0, 63.0, 62.0, 63.0, 63.0, 63.0, 64.0], "value": 63.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 67.0, 64.0, 65.0, 64.0, 64.0, 64.0, 64.0, 63.0, 63.0], "value": 64.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 81.0, 81.0, 88.0, 85.0, 84.0, 83.0, 140.0, 83.0], "value": 88.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 136.0, 129.0, 129.0, 129.0, 132.0, 133.0, 130.0, 146.0, 128.0], "value": 132.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 168.0, 170.0, 167.0, 168.0, 168.0, 167.0, 168.0, 168.0, 167.0], "value": 167.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 66.0, 67.0, 65.0, 65.0, 65.0, 66.0, 70.0, 67.0], "value": 66.6, "unit": "score"}]}]} 15:01:25 INFO - Return code: 0 15:01:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:01:25 ERROR - # TBPL SUCCESS # 15:01:25 INFO - Running post-action listener: _resource_record_post_action 15:01:25 INFO - ##### 15:01:25 INFO - ##### Finished run-tests step (success) 15:01:25 INFO - ##### 15:01:25 INFO - Running post-run listener: _resource_record_post_run 15:01:25 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 529735680; Read time: 16; Write time: 794504 15:01:25 INFO - TinderboxPrint: CPU usage
13.5% 15:01:25 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 15:01:25 INFO - TinderboxPrint: I/O write bytes / time
529,735,680 / 794,504 15:01:25 INFO - TinderboxPrint: CPU idle
8,272.3 (86.5%) 15:01:25 INFO - TinderboxPrint: CPU user
1,229.5 (12.9%) 15:01:25 INFO - TinderboxPrint: Swap in / out
0 / 0 15:01:25 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 243466240; Read time: 0; Write time: 567600 15:01:25 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 286269440; Read time: 16; Write time: 226904 15:01:26 INFO - Running post-run listener: _upload_blobber_files 15:01:26 INFO - Blob upload gear active. 15:01:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:01:26 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 15:01:26 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:01:26 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:01:26 INFO - (blobuploader) - INFO - Open directory for files ... 15:01:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:01:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:01:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:01:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:01:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:01:27 INFO - (blobuploader) - INFO - Done attempting. 15:01:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:01:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:01:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:01:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:01:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:01:31 INFO - (blobuploader) - INFO - Done attempting. 15:01:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:01:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:01:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:01:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:01:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:01:32 INFO - (blobuploader) - INFO - Done attempting. 15:01:32 INFO - (blobuploader) - INFO - Iteration through files over. 15:01:32 INFO - Return code: 0 15:01:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:01:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:01:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5b4b2f4a2abe5bfeb8197cc22b9552eb37f94c046fcac3735ba32dcc17d3419a9bb94d0225496753efae0b0cf83d549b72a7327809e61d676340553ba4c6dc62", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2463ab686c01fa1365b12503955e600ba6b5fe97b2e1727f0f64f3e9590fa7fffe06d3f2809bff2d9a28465a97e2a893061037174c628fc09885ebe8e0c6e82e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c87063f84bbe21f52009fb263c8ec9b35d6edd90eb0f0084e9fba6a6cf1af467a6e8ccd4c7f6c9e176c0fdd157d021e89c2e2213bead8aac690904028a3014d0"} 15:01:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:01:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:01:32 INFO - Contents: 15:01:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5b4b2f4a2abe5bfeb8197cc22b9552eb37f94c046fcac3735ba32dcc17d3419a9bb94d0225496753efae0b0cf83d549b72a7327809e61d676340553ba4c6dc62", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2463ab686c01fa1365b12503955e600ba6b5fe97b2e1727f0f64f3e9590fa7fffe06d3f2809bff2d9a28465a97e2a893061037174c628fc09885ebe8e0c6e82e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c87063f84bbe21f52009fb263c8ec9b35d6edd90eb0f0084e9fba6a6cf1af467a6e8ccd4c7f6c9e176c0fdd157d021e89c2e2213bead8aac690904028a3014d0"} 15:01:32 INFO - Running post-run listener: copy_logs_to_upload_dir 15:01:32 INFO - Copying logs to upload dir... 15:01:32 INFO - mkdir: /builds/slave/test/build/upload/logs 15:01:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.239488 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-14 15:01:32.048865) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-14 15:01:32.052150) ========= 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=aa52b8aba932b19cc50b5275000001de-1463239279.16202-299725333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5b4b2f4a2abe5bfeb8197cc22b9552eb37f94c046fcac3735ba32dcc17d3419a9bb94d0225496753efae0b0cf83d549b72a7327809e61d676340553ba4c6dc62", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2463ab686c01fa1365b12503955e600ba6b5fe97b2e1727f0f64f3e9590fa7fffe06d3f2809bff2d9a28465a97e2a893061037174c628fc09885ebe8e0c6e82e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c87063f84bbe21f52009fb263c8ec9b35d6edd90eb0f0084e9fba6a6cf1af467a6e8ccd4c7f6c9e176c0fdd157d021e89c2e2213bead8aac690904028a3014d0"} build_url:https://queue.taskcluster.net/v1/task/UAXmI3VEQA6LyDbc6-lcvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011379 build_url: 'https://queue.taskcluster.net/v1/task/UAXmI3VEQA6LyDbc6-lcvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5b4b2f4a2abe5bfeb8197cc22b9552eb37f94c046fcac3735ba32dcc17d3419a9bb94d0225496753efae0b0cf83d549b72a7327809e61d676340553ba4c6dc62", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2463ab686c01fa1365b12503955e600ba6b5fe97b2e1727f0f64f3e9590fa7fffe06d3f2809bff2d9a28465a97e2a893061037174c628fc09885ebe8e0c6e82e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c87063f84bbe21f52009fb263c8ec9b35d6edd90eb0f0084e9fba6a6cf1af467a6e8ccd4c7f6c9e176c0fdd157d021e89c2e2213bead8aac690904028a3014d0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-14 15:01:32.076751) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 15:01:32.077091) ========= 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=aa52b8aba932b19cc50b5275000001de-1463239279.16202-299725333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004435 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 15:01:32.162568) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-14 15:01:32.162894) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-14 15:01:32.163187) ========= ========= Total master_lag: 0.17 =========