builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-057 starttime: 1458838095.85 results: success (0) buildid: 20160324081657 builduid: c87e66b86668489884ae4e135c6a712b revision: 24c5fbde4488e06ef79905e1c520027cddcd1189 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-24 09:48:15.854395) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-24 09:48:15.854950) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-24 09:48:15.855289) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1458838087.909555-193430851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006445 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-24 09:48:15.878978) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-24 09:48:15.879334) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-24 09:48:15.893165) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 09:48:15.893599) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1458838087.909555-193430851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004520 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 09:48:15.943544) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-24 09:48:15.943894) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-24 09:48:15.944278) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 09:48:15.944620) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1458838087.909555-193430851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-24 09:48:16-- 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% 97.5M=0s 2016-03-24 09:48:16 (97.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.190207 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 09:48:16.148163) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 09:48:16.148545) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1458838087.909555-193430851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014668 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 09:48:16.198308) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-24 09:48:16.198664) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 24c5fbde4488e06ef79905e1c520027cddcd1189 --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 24c5fbde4488e06ef79905e1c520027cddcd1189 --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=934fc3100db09dcb9af4d4b6000001ab-1458838087.909555-193430851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-24 09:48:17,054 truncating revision to first 12 chars 2016-03-24 09:48:17,054 Setting DEBUG logging. 2016-03-24 09:48:17,054 attempt 1/10 2016-03-24 09:48:17,054 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/24c5fbde4488?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-24 09:48:18,773 unpacking tar archive at: mozilla-central-24c5fbde4488/testing/mozharness/ program finished with exit code 0 elapsedTime=1.999998 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-24 09:48:18.213042) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-24 09:48:18.213421) ========= echo 24c5fbde4488e06ef79905e1c520027cddcd1189 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'24c5fbde4488e06ef79905e1c520027cddcd1189'] 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=934fc3100db09dcb9af4d4b6000001ab-1458838087.909555-193430851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 24c5fbde4488e06ef79905e1c520027cddcd1189 program finished with exit code 0 elapsedTime=0.004723 script_repo_revision: '24c5fbde4488e06ef79905e1c520027cddcd1189' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-24 09:48:18.264239) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-24 09:48:18.264544) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-24 09:48:18.274520) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 25 secs) (at 2016-03-24 09:48:18.274975) ========= /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=934fc3100db09dcb9af4d4b6000001ab-1458838087.909555-193430851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:48:19 INFO - MultiFileLogger online at 20160324 09:48:19 in /builds/slave/test 09:48:19 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 09:48:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:48:19 INFO - {'append_to_log': False, 09:48:19 INFO - 'base_work_dir': '/builds/slave/test', 09:48:19 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:48:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:48:19 INFO - 'branch': 'Firefox-Non-PGO', 09:48:19 INFO - 'buildbot_json_path': 'buildprops.json', 09:48:19 INFO - 'config_files': ('talos/linux_config.py',), 09:48:19 INFO - 'default_actions': ('clobber', 09:48:19 INFO - 'read-buildbot-config', 09:48:19 INFO - 'download-and-extract', 09:48:19 INFO - 'populate-webroot', 09:48:19 INFO - 'create-virtualenv', 09:48:19 INFO - 'install', 09:48:19 INFO - 'run-tests'), 09:48:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:48:19 INFO - 'download_minidump_stackwalk': True, 09:48:19 INFO - 'download_symbols': 'ondemand', 09:48:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:48:19 INFO - 'tooltool.py': '/tools/tooltool.py', 09:48:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:48:19 INFO - '/tools/misc-python/virtualenv.py')}, 09:48:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:48:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:48:19 INFO - 'installer_path': 'installer.exe', 09:48:19 INFO - 'log_level': 'info', 09:48:19 INFO - 'log_name': 'talos', 09:48:19 INFO - 'log_to_console': True, 09:48:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:48:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:48:19 INFO - 'opt_config_files': (), 09:48:19 INFO - 'pip_index': False, 09:48:19 INFO - 'sps_profile': False, 09:48:19 INFO - 'sps_profile_interval': 0, 09:48:19 INFO - 'suite': 'dromaeojs-e10s', 09:48:19 INFO - 'system_bits': '32', 09:48:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:48:19 INFO - 'title': 'talos-linux64-ix-057', 09:48:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:48:19 INFO - 'use_talos_json': True, 09:48:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:48:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:48:19 INFO - 'work_dir': 'build'} 09:48:19 INFO - ##### 09:48:19 INFO - ##### Running clobber step. 09:48:19 INFO - ##### 09:48:19 INFO - Running pre-action listener: _resource_record_pre_action 09:48:19 INFO - Running main action method: clobber 09:48:19 INFO - rmtree: /builds/slave/test/build 09:48:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:48:19 INFO - Running post-action listener: _resource_record_post_action 09:48:19 INFO - ##### 09:48:19 INFO - ##### Running read-buildbot-config step. 09:48:19 INFO - ##### 09:48:19 INFO - Running pre-action listener: _resource_record_pre_action 09:48:19 INFO - Running main action method: read_buildbot_config 09:48:19 INFO - Using buildbot properties: 09:48:19 INFO - { 09:48:19 INFO - "project": "", 09:48:19 INFO - "product": "firefox", 09:48:19 INFO - "script_repo_revision": "production", 09:48:19 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 09:48:19 INFO - "repository": "", 09:48:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 09:48:19 INFO - "buildid": "20160324081657", 09:48:19 INFO - "pgo_build": "False", 09:48:19 INFO - "basedir": "/builds/slave/test", 09:48:19 INFO - "buildnumber": 13, 09:48:19 INFO - "slavename": "talos-linux64-ix-057", 09:48:19 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:48:19 INFO - "platform": "ubuntu64_hw", 09:48:19 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 09:48:19 INFO - "branch": "mozilla-central", 09:48:19 INFO - "repo_path": "mozilla-central", 09:48:19 INFO - "revision": "24c5fbde4488e06ef79905e1c520027cddcd1189", 09:48:19 INFO - "stage_platform": "linux64", 09:48:19 INFO - "builduid": "c87e66b86668489884ae4e135c6a712b", 09:48:19 INFO - "slavebuilddir": "test" 09:48:19 INFO - } 09:48:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/Qpj0W5K1SL69qRmG5lqQ0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 09:48:19 INFO - Running post-action listener: _resource_record_post_action 09:48:19 INFO - ##### 09:48:19 INFO - ##### Running download-and-extract step. 09:48:19 INFO - ##### 09:48:19 INFO - Running pre-action listener: _resource_record_pre_action 09:48:19 INFO - Running main action method: download_and_extract 09:48:19 INFO - mkdir: /builds/slave/test/build/tests 09:48:19 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')]} 09:48:19 INFO - https://queue.taskcluster.net/v1/task/Qpj0W5K1SL69qRmG5lqQ0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:48:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qpj0W5K1SL69qRmG5lqQ0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:48:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qpj0W5K1SL69qRmG5lqQ0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:48:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qpj0W5K1SL69qRmG5lqQ0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:48:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qpj0W5K1SL69qRmG5lqQ0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:48:20 INFO - Downloaded 1361 bytes. 09:48:20 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:48:20 INFO - Using the following test package requirements: 09:48:20 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 09:48:20 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:48:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:48:20 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:48:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:48:20 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:48:20 INFO - u'jsshell-linux-x86_64.zip'], 09:48:20 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:48:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:48:20 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 09:48:20 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:48:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:48:20 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:48:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:48:20 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:48:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:48:20 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:48:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:48:20 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:48: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')]} 09:48:20 INFO - https://queue.taskcluster.net/v1/task/Qpj0W5K1SL69qRmG5lqQ0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:48:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qpj0W5K1SL69qRmG5lqQ0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:48:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qpj0W5K1SL69qRmG5lqQ0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:48:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qpj0W5K1SL69qRmG5lqQ0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:48:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qpj0W5K1SL69qRmG5lqQ0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:48:21 INFO - Downloaded 22068399 bytes. 09:48:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:48:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:48:22 INFO - Return code: 0 09:48:22 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:22 INFO - https://queue.taskcluster.net/v1/task/Qpj0W5K1SL69qRmG5lqQ0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:48:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qpj0W5K1SL69qRmG5lqQ0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:48:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qpj0W5K1SL69qRmG5lqQ0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:48:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qpj0W5K1SL69qRmG5lqQ0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:48:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qpj0W5K1SL69qRmG5lqQ0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:48:24 INFO - Downloaded 22068399 bytes. 09:48:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:48:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:48:25 INFO - Return code: 0 09:48:25 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')]} 09:48:25 INFO - https://queue.taskcluster.net/v1/task/Qpj0W5K1SL69qRmG5lqQ0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:48:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qpj0W5K1SL69qRmG5lqQ0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:48:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qpj0W5K1SL69qRmG5lqQ0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:48:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qpj0W5K1SL69qRmG5lqQ0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:48:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qpj0W5K1SL69qRmG5lqQ0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:48:26 INFO - Downloaded 10847187 bytes. 09:48:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:48:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:48:26 INFO - Return code: 0 09:48:26 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')]} 09:48:26 INFO - https://queue.taskcluster.net/v1/task/Qpj0W5K1SL69qRmG5lqQ0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:48:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qpj0W5K1SL69qRmG5lqQ0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:48:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qpj0W5K1SL69qRmG5lqQ0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:48:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qpj0W5K1SL69qRmG5lqQ0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:48:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qpj0W5K1SL69qRmG5lqQ0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:48:28 INFO - Downloaded 54268063 bytes. 09:48:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Qpj0W5K1SL69qRmG5lqQ0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:48:28 INFO - mkdir: /builds/slave/test/properties 09:48:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:48:28 INFO - Writing to file /builds/slave/test/properties/build_url 09:48:28 INFO - Contents: 09:48:28 INFO - build_url:https://queue.taskcluster.net/v1/task/Qpj0W5K1SL69qRmG5lqQ0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:48:28 INFO - Running post-action listener: _resource_record_post_action 09:48:28 INFO - Running post-action listener: set_extra_try_arguments 09:48:28 INFO - ##### 09:48:28 INFO - ##### Running populate-webroot step. 09:48:28 INFO - ##### 09:48:28 INFO - Running pre-action listener: _resource_record_pre_action 09:48:28 INFO - Running main action method: populate_webroot 09:48:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:48:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:48:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:48:29 INFO - '--tppagecycles', 09:48:29 INFO - '7'], 09:48:29 INFO - 'tests': ['tsvgm']}}, 09:48:29 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:48:29 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:48:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:48:29 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:48:29 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:48:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:48:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:48:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:29 INFO - 'talos_options': ['--e10s'], 09:48:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:48:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:29 INFO - 'tests': ['damp', 'tps']}, 09:48:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:29 INFO - 'talos_options': ['--e10s'], 09:48:29 INFO - 'tests': ['damp', 'tps']}, 09:48:29 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:48:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:48:29 INFO - 'other': {'tests': ['a11yr', 09:48:29 INFO - 'ts_paint', 09:48:29 INFO - 'tpaint', 09:48:29 INFO - 'sessionrestore', 09:48:29 INFO - 'sessionrestore_no_auto_restore', 09:48:29 INFO - 'tabpaint']}, 09:48:29 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:48:29 INFO - 'tests': ['a11yr', 09:48:29 INFO - 'ts_paint', 09:48:29 INFO - 'tpaint', 09:48:29 INFO - 'sessionrestore', 09:48:29 INFO - 'sessionrestore_no_auto_restore', 09:48:29 INFO - 'tabpaint']}, 09:48:29 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:48:29 INFO - 'tests': ['a11yr', 09:48:29 INFO - 'ts_paint', 09:48:29 INFO - 'tpaint', 09:48:29 INFO - 'sessionrestore', 09:48:29 INFO - 'sessionrestore_no_auto_restore', 09:48:29 INFO - 'tabpaint']}, 09:48:29 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:48:29 INFO - 'tests': ['a11yr', 09:48:29 INFO - 'ts_paint', 09:48:29 INFO - 'tpaint', 09:48:29 INFO - 'sessionrestore', 09:48:29 INFO - 'sessionrestore_no_auto_restore', 09:48:29 INFO - 'tabpaint']}, 09:48:29 INFO - 'other_l64': {'tests': ['a11yr', 09:48:29 INFO - 'ts_paint', 09:48:29 INFO - 'tpaint', 09:48:29 INFO - 'sessionrestore', 09:48:29 INFO - 'sessionrestore_no_auto_restore', 09:48:29 INFO - 'tabpaint']}, 09:48:29 INFO - 'other_nol64': {'tests': ['a11yr', 09:48:29 INFO - 'ts_paint', 09:48:29 INFO - 'tpaint', 09:48:29 INFO - 'sessionrestore', 09:48:29 INFO - 'sessionrestore_no_auto_restore', 09:48:29 INFO - 'tabpaint']}, 09:48:29 INFO - 'svgr': {'tests': ['tsvgx', 09:48:29 INFO - 'tsvgr_opacity', 09:48:29 INFO - 'tart', 09:48:29 INFO - 'tscrollx', 09:48:29 INFO - 'cart']}, 09:48:29 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:48:29 INFO - 'tests': ['tsvgx', 09:48:29 INFO - 'tsvgr_opacity', 09:48:29 INFO - 'tart', 09:48:29 INFO - 'tscrollx', 09:48:29 INFO - 'cart']}, 09:48:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:29 INFO - 'tests': ['tp5o']}, 09:48:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:29 INFO - 'talos_options': ['--e10s'], 09:48:29 INFO - 'tests': ['tp5o']}, 09:48:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:29 INFO - 'talos_options': ['--xperf_path', 09:48:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:48:29 INFO - 'tests': ['tp5n']}, 09:48:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:29 INFO - 'talos_options': ['--e10s', 09:48:29 INFO - '--xperf_path', 09:48:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:48:29 INFO - 'tests': ['tp5n']}}, 09:48:29 INFO - 'talos.zip': {'path': '', 09:48:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:48:29 INFO - Running post-action listener: _resource_record_post_action 09:48:29 INFO - ##### 09:48:29 INFO - ##### Running create-virtualenv step. 09:48:29 INFO - ##### 09:48:29 INFO - Running pre-action listener: _resource_record_pre_action 09:48:29 INFO - Running main action method: create_virtualenv 09:48:29 INFO - Creating virtualenv /builds/slave/test/build/venv 09:48:29 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 09:48:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:48:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:48:29 INFO - Using real prefix '/usr' 09:48:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:48:29 INFO - Installing distribute.............................................................................................................................................................................................done. 09:48:31 INFO - Installing pip.................done. 09:48:31 INFO - Return code: 0 09:48:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:48:31 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')]} 09:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:31 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')]} 09:48:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:31 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 0x7f0ad9622f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271b410>, '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 0x271c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271c7a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1458838087.909555-193430851', '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 09:48:31 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 09:48:31 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 09:48:31 INFO - Using env: {'DISPLAY': ':0', 09:48:31 INFO - 'HOME': '/home/cltbld', 09:48:31 INFO - 'LANG': 'en_US.UTF-8', 09:48:31 INFO - 'LANGUAGE': 'en_US:en', 09:48:31 INFO - 'LOGNAME': 'cltbld', 09:48:31 INFO - 'MAIL': '/var/mail/cltbld', 09:48:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:31 INFO - 'MOZ_NO_REMOTE': '1', 09:48:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:31 INFO - 'NO_EM_RESTART': '1', 09:48:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:31 INFO - 'PWD': '/builds/slave/test', 09:48:31 INFO - 'SHELL': '/bin/bash', 09:48:31 INFO - 'SHLVL': '1', 09:48:31 INFO - 'TERM': 'linux', 09:48:31 INFO - 'TMOUT': '86400', 09:48:31 INFO - 'USER': 'cltbld', 09:48:31 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1458838087.909555-193430851', 09:48:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:31 INFO - '_': '/tools/buildbot/bin/python'} 09:48:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:31 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 09:48:31 INFO - Cleaning up... 09:48:31 INFO - Return code: 0 09:48:31 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:48:31 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')]} 09:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:31 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')]} 09:48:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0ad9622f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271b410>, '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 0x271c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271c7a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1458838087.909555-193430851', '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 09:48:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:48:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:48:31 INFO - Using env: {'DISPLAY': ':0', 09:48:31 INFO - 'HOME': '/home/cltbld', 09:48:31 INFO - 'LANG': 'en_US.UTF-8', 09:48:31 INFO - 'LANGUAGE': 'en_US:en', 09:48:31 INFO - 'LOGNAME': 'cltbld', 09:48:31 INFO - 'MAIL': '/var/mail/cltbld', 09:48:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:31 INFO - 'MOZ_NO_REMOTE': '1', 09:48:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:31 INFO - 'NO_EM_RESTART': '1', 09:48:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:31 INFO - 'PWD': '/builds/slave/test', 09:48:31 INFO - 'SHELL': '/bin/bash', 09:48:31 INFO - 'SHLVL': '1', 09:48:31 INFO - 'TERM': 'linux', 09:48:31 INFO - 'TMOUT': '86400', 09:48:31 INFO - 'USER': 'cltbld', 09:48:31 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1458838087.909555-193430851', 09:48:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:31 INFO - '_': '/tools/buildbot/bin/python'} 09:48:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:32 INFO - Downloading/unpacking psutil>=0.7.1 09:48:32 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 09:48:32 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 09:48:32 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 09:48:32 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 09:48:32 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 09:48:32 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 09:48:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:48:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:48:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:48:33 INFO - Installing collected packages: psutil 09:48:33 INFO - Running setup.py install for psutil 09:48:34 INFO - building 'psutil._psutil_linux' extension 09:48:34 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 09:48:34 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 09:48:34 INFO - building 'psutil._psutil_posix' extension 09:48:34 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 09:48:34 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 09:48:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:48:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:48:34 INFO - Successfully installed psutil 09:48:34 INFO - Cleaning up... 09:48:34 INFO - Return code: 0 09:48:34 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:48:34 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')]} 09:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:34 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')]} 09:48:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0ad9622f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271b410>, '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 0x271c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271c7a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1458838087.909555-193430851', '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 09:48:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:48:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:48:34 INFO - Using env: {'DISPLAY': ':0', 09:48:34 INFO - 'HOME': '/home/cltbld', 09:48:34 INFO - 'LANG': 'en_US.UTF-8', 09:48:34 INFO - 'LANGUAGE': 'en_US:en', 09:48:34 INFO - 'LOGNAME': 'cltbld', 09:48:34 INFO - 'MAIL': '/var/mail/cltbld', 09:48:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:34 INFO - 'MOZ_NO_REMOTE': '1', 09:48:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:34 INFO - 'NO_EM_RESTART': '1', 09:48:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:34 INFO - 'PWD': '/builds/slave/test', 09:48:34 INFO - 'SHELL': '/bin/bash', 09:48:34 INFO - 'SHLVL': '1', 09:48:34 INFO - 'TERM': 'linux', 09:48:34 INFO - 'TMOUT': '86400', 09:48:34 INFO - 'USER': 'cltbld', 09:48:34 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1458838087.909555-193430851', 09:48:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:34 INFO - '_': '/tools/buildbot/bin/python'} 09:48:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:34 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:48:34 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 09:48:34 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 09:48:34 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 09:48:34 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 09:48:34 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 09:48:34 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 09:48:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:48:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:48:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:48:36 INFO - Installing collected packages: mozsystemmonitor 09:48:36 INFO - Running setup.py install for mozsystemmonitor 09:48:36 INFO - Successfully installed mozsystemmonitor 09:48:36 INFO - Cleaning up... 09:48:36 INFO - Return code: 0 09:48:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:48:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:36 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 0x7f0ad9622f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271b410>, '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 0x271c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271c7a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1458838087.909555-193430851', '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 09:48:36 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 09:48:36 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 09:48:36 INFO - Using env: {'DISPLAY': ':0', 09:48:36 INFO - 'HOME': '/home/cltbld', 09:48:36 INFO - 'LANG': 'en_US.UTF-8', 09:48:36 INFO - 'LANGUAGE': 'en_US:en', 09:48:36 INFO - 'LOGNAME': 'cltbld', 09:48:36 INFO - 'MAIL': '/var/mail/cltbld', 09:48:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:36 INFO - 'MOZ_NO_REMOTE': '1', 09:48:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:36 INFO - 'NO_EM_RESTART': '1', 09:48:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:36 INFO - 'PWD': '/builds/slave/test', 09:48:36 INFO - 'SHELL': '/bin/bash', 09:48:36 INFO - 'SHLVL': '1', 09:48:36 INFO - 'TERM': 'linux', 09:48:36 INFO - 'TMOUT': '86400', 09:48:36 INFO - 'USER': 'cltbld', 09:48:36 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1458838087.909555-193430851', 09:48:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:36 INFO - '_': '/tools/buildbot/bin/python'} 09:48:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:36 INFO - Downloading/unpacking blobuploader==1.2.4 09:48:36 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 09:48:36 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 09:48:36 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 09:48:36 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 09:48:36 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 09:48:36 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 09:48:38 INFO - Downloading blobuploader-1.2.4.tar.gz 09:48:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:48:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:48:38 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 09:48:38 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 09:48:38 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 09:48:38 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 09:48:38 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 09:48:38 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 09:48:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:48:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:48:39 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 09:48:39 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 09:48:39 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 09:48:39 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 09:48:39 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 09:48:39 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 09:48:39 INFO - Downloading docopt-0.6.1.tar.gz 09:48:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:48:39 INFO - Installing collected packages: blobuploader, requests, docopt 09:48:39 INFO - Running setup.py install for blobuploader 09:48:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:48:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:48:39 INFO - Running setup.py install for requests 09:48:40 INFO - Running setup.py install for docopt 09:48:40 INFO - Successfully installed blobuploader requests docopt 09:48:40 INFO - Cleaning up... 09:48:40 INFO - Return code: 0 09:48:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:48:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:40 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 0x7f0ad9622f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271b410>, '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 0x271c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271c7a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1458838087.909555-193430851', '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 09:48:40 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 09:48:40 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 09:48:40 INFO - Using env: {'DISPLAY': ':0', 09:48:40 INFO - 'HOME': '/home/cltbld', 09:48:40 INFO - 'LANG': 'en_US.UTF-8', 09:48:40 INFO - 'LANGUAGE': 'en_US:en', 09:48:40 INFO - 'LOGNAME': 'cltbld', 09:48:40 INFO - 'MAIL': '/var/mail/cltbld', 09:48:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:40 INFO - 'MOZ_NO_REMOTE': '1', 09:48:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:40 INFO - 'NO_EM_RESTART': '1', 09:48:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:40 INFO - 'PWD': '/builds/slave/test', 09:48:40 INFO - 'SHELL': '/bin/bash', 09:48:40 INFO - 'SHLVL': '1', 09:48:40 INFO - 'TERM': 'linux', 09:48:40 INFO - 'TMOUT': '86400', 09:48:40 INFO - 'USER': 'cltbld', 09:48:40 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1458838087.909555-193430851', 09:48:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:40 INFO - '_': '/tools/buildbot/bin/python'} 09:48:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:48:40 INFO - Running setup.py (path:/tmp/pip-4tpfTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:48:40 INFO - Running setup.py (path:/tmp/pip-xlyqlW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:48:40 INFO - Running setup.py (path:/tmp/pip-xF0kK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:48:40 INFO - Running setup.py (path:/tmp/pip-4nSYsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:48:40 INFO - Running setup.py (path:/tmp/pip-mPo5m8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:48:40 INFO - Running setup.py (path:/tmp/pip-Xo0Roq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:48:40 INFO - Running setup.py (path:/tmp/pip-sexvTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:48:40 INFO - Running setup.py (path:/tmp/pip-bQO_79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:48:40 INFO - Running setup.py (path:/tmp/pip-FWaA1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:48:41 INFO - Running setup.py (path:/tmp/pip-ixmAQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:48:41 INFO - Running setup.py (path:/tmp/pip-EV2UMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:48:41 INFO - Running setup.py (path:/tmp/pip-foRF47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:48:41 INFO - Running setup.py (path:/tmp/pip-KQPmoW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:48:41 INFO - Running setup.py (path:/tmp/pip-LD8CCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:41 INFO - Running setup.py (path:/tmp/pip-naZCBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:48:41 INFO - Running setup.py (path:/tmp/pip-LVK79g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:48:41 INFO - Running setup.py (path:/tmp/pip-m2TYzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:48:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:48:41 INFO - Running setup.py install for manifestparser 09:48:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:48:41 INFO - Running setup.py install for mozcrash 09:48:41 INFO - Running setup.py install for mozdebug 09:48:41 INFO - Running setup.py install for mozdevice 09:48:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:48:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:48:42 INFO - Running setup.py install for mozfile 09:48:42 INFO - Running setup.py install for mozhttpd 09:48:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:48:42 INFO - Running setup.py install for mozinfo 09:48:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:48:42 INFO - Running setup.py install for mozInstall 09:48:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:48:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:48:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:48:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:48:42 INFO - Running setup.py install for mozleak 09:48:42 INFO - Running setup.py install for mozlog 09:48:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:48:42 INFO - Running setup.py install for moznetwork 09:48:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:48:42 INFO - Running setup.py install for mozprocess 09:48:42 INFO - Running setup.py install for mozprofile 09:48:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:48:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:48:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:48:42 INFO - Running setup.py install for mozrunner 09:48:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:48:43 INFO - Running setup.py install for mozscreenshot 09:48:43 INFO - Running setup.py install for moztest 09:48:43 INFO - Running setup.py install for mozversion 09:48:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:48:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:48:43 INFO - Cleaning up... 09:48:43 INFO - Return code: 0 09:48:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:43 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 0x7f0ad9622f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271b410>, '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 0x271c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271c7a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1458838087.909555-193430851', '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 09:48:43 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 09:48:43 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 09:48:43 INFO - Using env: {'DISPLAY': ':0', 09:48:43 INFO - 'HOME': '/home/cltbld', 09:48:43 INFO - 'LANG': 'en_US.UTF-8', 09:48:43 INFO - 'LANGUAGE': 'en_US:en', 09:48:43 INFO - 'LOGNAME': 'cltbld', 09:48:43 INFO - 'MAIL': '/var/mail/cltbld', 09:48:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:43 INFO - 'MOZ_NO_REMOTE': '1', 09:48:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:43 INFO - 'NO_EM_RESTART': '1', 09:48:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:43 INFO - 'PWD': '/builds/slave/test', 09:48:43 INFO - 'SHELL': '/bin/bash', 09:48:43 INFO - 'SHLVL': '1', 09:48:43 INFO - 'TERM': 'linux', 09:48:43 INFO - 'TMOUT': '86400', 09:48:43 INFO - 'USER': 'cltbld', 09:48:43 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1458838087.909555-193430851', 09:48:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:43 INFO - '_': '/tools/buildbot/bin/python'} 09:48:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:48:43 INFO - Running setup.py (path:/tmp/pip-prrF00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:48:43 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)) 09:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:48:43 INFO - Running setup.py (path:/tmp/pip-N8bGa0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:48:43 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)) 09:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:48:43 INFO - Running setup.py (path:/tmp/pip-YPOAra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:48:43 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)) 09:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:48:43 INFO - Running setup.py (path:/tmp/pip-ZSSxgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:48:43 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)) 09:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:48:43 INFO - Running setup.py (path:/tmp/pip-v3pNAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:48:44 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)) 09:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:48:44 INFO - Running setup.py (path:/tmp/pip-QMIR9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:48:44 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)) 09:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:48:44 INFO - Running setup.py (path:/tmp/pip-MGziSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:48:44 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)) 09:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:48:44 INFO - Running setup.py (path:/tmp/pip-FMdrDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:48:44 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)) 09:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:48:44 INFO - Running setup.py (path:/tmp/pip-hix6po-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:48:44 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)) 09:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:48:44 INFO - Running setup.py (path:/tmp/pip-ZHf06V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:48:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:48:44 INFO - Running setup.py (path:/tmp/pip-XqLqXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:48:44 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)) 09:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:48:44 INFO - Running setup.py (path:/tmp/pip-dXKvti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:48:44 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)) 09:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:48:44 INFO - Running setup.py (path:/tmp/pip-2cNy9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:48:44 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)) 09:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:48:44 INFO - Running setup.py (path:/tmp/pip-N2IfWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:48:44 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)) 09:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:44 INFO - Running setup.py (path:/tmp/pip-c6enYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:44 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)) 09:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:48:44 INFO - Running setup.py (path:/tmp/pip-56TR8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:48:44 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)) 09:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:48:44 INFO - Running setup.py (path:/tmp/pip-zFAxSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:48:44 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)) 09:48:44 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)) 09:48:44 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)) 09:48:44 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)) 09:48:44 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)) 09:48:44 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)) 09:48:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:46 INFO - Downloading blessings-1.6.tar.gz 09:48:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:48:46 INFO - Installing collected packages: blessings 09:48:46 INFO - Running setup.py install for blessings 09:48:46 INFO - Successfully installed blessings 09:48:46 INFO - Cleaning up... 09:48:46 INFO - Return code: 0 09:48:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:48:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:48:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:48:47 INFO - Reading from file tmpfile_stdout 09:48:47 INFO - Current package versions: 09:48:47 INFO - argparse == 1.2.1 09:48:47 INFO - blessings == 1.6 09:48:47 INFO - blobuploader == 1.2.4 09:48:47 INFO - docopt == 0.6.1 09:48:47 INFO - manifestparser == 1.1 09:48:47 INFO - mozInstall == 1.12 09:48:47 INFO - mozcrash == 0.17 09:48:47 INFO - mozdebug == 0.1 09:48:47 INFO - mozdevice == 0.48 09:48:47 INFO - mozfile == 1.2 09:48:47 INFO - mozhttpd == 0.7 09:48:47 INFO - mozinfo == 0.9 09:48:47 INFO - mozleak == 0.1 09:48:47 INFO - mozlog == 3.1 09:48:47 INFO - moznetwork == 0.27 09:48:47 INFO - mozprocess == 0.22 09:48:47 INFO - mozprofile == 0.28 09:48:47 INFO - mozrunner == 6.11 09:48:47 INFO - mozscreenshot == 0.1 09:48:47 INFO - mozsystemmonitor == 0.0 09:48:47 INFO - moztest == 0.7 09:48:47 INFO - mozversion == 1.4 09:48:47 INFO - psutil == 3.1.1 09:48:47 INFO - requests == 1.2.3 09:48:47 INFO - wsgiref == 0.1.2 09:48:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:48:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:47 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 0x7f0ad9622f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271b410>, '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 0x271c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271c7a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1458838087.909555-193430851', '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 09:48:47 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 09:48:47 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 09:48:47 INFO - Using env: {'DISPLAY': ':0', 09:48:47 INFO - 'HOME': '/home/cltbld', 09:48:47 INFO - 'LANG': 'en_US.UTF-8', 09:48:47 INFO - 'LANGUAGE': 'en_US:en', 09:48:47 INFO - 'LOGNAME': 'cltbld', 09:48:47 INFO - 'MAIL': '/var/mail/cltbld', 09:48:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:47 INFO - 'MOZ_NO_REMOTE': '1', 09:48:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:47 INFO - 'NO_EM_RESTART': '1', 09:48:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:47 INFO - 'PWD': '/builds/slave/test', 09:48:47 INFO - 'SHELL': '/bin/bash', 09:48:47 INFO - 'SHLVL': '1', 09:48:47 INFO - 'TERM': 'linux', 09:48:47 INFO - 'TMOUT': '86400', 09:48:47 INFO - 'USER': 'cltbld', 09:48:47 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1458838087.909555-193430851', 09:48:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:47 INFO - '_': '/tools/buildbot/bin/python'} 09:48:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:47 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)) 09:48:47 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)) 09:48:47 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)) 09:48:47 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)) 09:48:47 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)) 09:48:47 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)) 09:48:47 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)) 09:48:47 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)) 09:48:47 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)) 09:48:47 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)) 09:48:47 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)) 09:48:47 INFO - Cleaning up... 09:48:47 INFO - Return code: 0 09:48:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:48:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0ad9622f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271b410>, '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 0x271c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271c7a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1458838087.909555-193430851', '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 09:48:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:48:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:48:47 INFO - Using env: {'DISPLAY': ':0', 09:48:47 INFO - 'HOME': '/home/cltbld', 09:48:47 INFO - 'LANG': 'en_US.UTF-8', 09:48:47 INFO - 'LANGUAGE': 'en_US:en', 09:48:47 INFO - 'LOGNAME': 'cltbld', 09:48:47 INFO - 'MAIL': '/var/mail/cltbld', 09:48:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:47 INFO - 'MOZ_NO_REMOTE': '1', 09:48:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:47 INFO - 'NO_EM_RESTART': '1', 09:48:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:47 INFO - 'PWD': '/builds/slave/test', 09:48:47 INFO - 'SHELL': '/bin/bash', 09:48:47 INFO - 'SHLVL': '1', 09:48:47 INFO - 'TERM': 'linux', 09:48:47 INFO - 'TMOUT': '86400', 09:48:47 INFO - 'USER': 'cltbld', 09:48:47 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1458838087.909555-193430851', 09:48:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:47 INFO - '_': '/tools/buildbot/bin/python'} 09:48:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:47 INFO - Downloading/unpacking jsonschema 09:48:47 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 09:48:47 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 09:48:47 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 09:48:47 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 09:48:47 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 09:48:47 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 09:48:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:48:49 INFO - Downloading/unpacking functools32 (from jsonschema) 09:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:49 INFO - Downloading functools32-3.2.3-2.tar.gz 09:48:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:48:49 INFO - warning: no files found matching '*.txt' 09:48:49 INFO - no previously-included directories found matching 'build' 09:48:49 INFO - no previously-included directories found matching 'dist' 09:48:49 INFO - no previously-included directories found matching '.git*' 09:48:49 INFO - Installing collected packages: jsonschema, functools32 09:48:49 INFO - Running setup.py install for functools32 09:48:49 INFO - warning: no files found matching '*.txt' 09:48:49 INFO - no previously-included directories found matching 'build' 09:48:49 INFO - no previously-included directories found matching 'dist' 09:48:49 INFO - no previously-included directories found matching '.git*' 09:48:49 INFO - Successfully installed jsonschema functools32 09:48:49 INFO - Cleaning up... 09:48:49 INFO - Return code: 0 09:48:49 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0ad9622f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271b410>, '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 0x271c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271c7a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1458838087.909555-193430851', '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 09:48:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:48:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:48:49 INFO - Using env: {'DISPLAY': ':0', 09:48:49 INFO - 'HOME': '/home/cltbld', 09:48:49 INFO - 'LANG': 'en_US.UTF-8', 09:48:49 INFO - 'LANGUAGE': 'en_US:en', 09:48:49 INFO - 'LOGNAME': 'cltbld', 09:48:49 INFO - 'MAIL': '/var/mail/cltbld', 09:48:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:49 INFO - 'MOZ_NO_REMOTE': '1', 09:48:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:49 INFO - 'NO_EM_RESTART': '1', 09:48:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:49 INFO - 'PWD': '/builds/slave/test', 09:48:49 INFO - 'SHELL': '/bin/bash', 09:48:49 INFO - 'SHLVL': '1', 09:48:49 INFO - 'TERM': 'linux', 09:48:49 INFO - 'TMOUT': '86400', 09:48:49 INFO - 'USER': 'cltbld', 09:48:49 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1458838087.909555-193430851', 09:48:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:49 INFO - '_': '/tools/buildbot/bin/python'} 09:48:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:50 INFO - Downloading/unpacking flake8 09:48:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:48:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:48:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:48:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:48:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:48:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:48:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:48:52 INFO - no previously-included directories found matching 'docs/_build' 09:48:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:48:52 INFO - Running setup.py install for pep8 09:48:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:48:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:48:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:48:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:48:52 INFO - no previously-included directories found matching 'docs/_build' 09:48:52 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:48:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:48:52 INFO - Cleaning up... 09:48:53 INFO - Return code: 0 09:48:53 INFO - Running post-action listener: _resource_record_post_action 09:48:53 INFO - Running post-action listener: _start_resource_monitoring 09:48:53 INFO - Starting resource monitoring. 09:48:53 INFO - ##### 09:48:53 INFO - ##### Running install step. 09:48:53 INFO - ##### 09:48:53 INFO - Running pre-action listener: _resource_record_pre_action 09:48:53 INFO - Running main action method: install 09:48:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:48:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:48:53 INFO - Reading from file tmpfile_stdout 09:48:53 INFO - Detecting whether we're running mozinstall >=1.0... 09:48:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:48:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:48:53 INFO - Reading from file tmpfile_stdout 09:48:53 INFO - Output received: 09:48:53 INFO - Usage: mozinstall [options] installer 09:48:53 INFO - Options: 09:48:53 INFO - -h, --help show this help message and exit 09:48:53 INFO - -d DEST, --destination=DEST 09:48:53 INFO - Directory to install application into. [default: 09:48:53 INFO - "/builds/slave/test"] 09:48:53 INFO - --app=APP Application being installed. [default: firefox] 09:48:53 INFO - mkdir: /builds/slave/test/build/application 09:48:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:48:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:49:09 INFO - Reading from file tmpfile_stdout 09:49:09 INFO - Output received: 09:49:09 INFO - /builds/slave/test/build/application/firefox/firefox 09:49:09 INFO - Running post-action listener: _resource_record_post_action 09:49:09 INFO - ##### 09:49:09 INFO - ##### Running run-tests step. 09:49:09 INFO - ##### 09:49:09 INFO - Running pre-action listener: _resource_record_pre_action 09:49:09 INFO - Running main action method: run_tests 09:49:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:49:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:49:09 INFO - Python 2.7.3 09:49:09 INFO - Return code: 0 09:49:09 INFO - grabbing minidump binary from tooltool 09:49:09 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')]} 09:49:09 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271b410>, '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 0x271c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271c7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:49:09 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 09:49:09 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 09:49:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:49:09 INFO - Return code: 0 09:49:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:49:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:49:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:49:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:49:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:49:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:49:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:49:10 INFO - Return code: 0 09:49:10 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/Qpj0W5K1SL69qRmG5lqQ0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 09:49:10 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/Qpj0W5K1SL69qRmG5lqQ0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 09:49:10 INFO - Using env: {'DISPLAY': ':0', 09:49:10 INFO - 'HOME': '/home/cltbld', 09:49:10 INFO - 'LANG': 'en_US.UTF-8', 09:49:10 INFO - 'LANGUAGE': 'en_US:en', 09:49:10 INFO - 'LOGNAME': 'cltbld', 09:49:10 INFO - 'MAIL': '/var/mail/cltbld', 09:49:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:49:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:49:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:10 INFO - 'MOZ_NO_REMOTE': '1', 09:49:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:49:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:10 INFO - 'NO_EM_RESTART': '1', 09:49:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:10 INFO - 'PWD': '/builds/slave/test', 09:49:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:49:10 INFO - 'SHELL': '/bin/bash', 09:49:10 INFO - 'SHLVL': '1', 09:49:10 INFO - 'TERM': 'linux', 09:49:10 INFO - 'TMOUT': '86400', 09:49:10 INFO - 'USER': 'cltbld', 09:49:10 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1458838087.909555-193430851', 09:49:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:10 INFO - '_': '/tools/buildbot/bin/python'} 09:49:10 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/Qpj0W5K1SL69qRmG5lqQ0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 09:49:10 INFO - mozversion application_buildid: 20160324081657 09:49:10 INFO - mozversion application_changeset: 24c5fbde4488e06ef79905e1c520027cddcd1189 09:49:10 INFO - mozversion application_display_name: Nightly 09:49:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:49:10 INFO - mozversion application_name: Firefox 09:49:10 INFO - mozversion application_remotingname: firefox 09:49:10 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:49:10 INFO - mozversion application_vendor: Mozilla 09:49:10 INFO - mozversion application_version: 48.0a1 09:49:10 INFO - mozversion platform_buildid: 20160324081657 09:49:10 INFO - mozversion platform_changeset: 24c5fbde4488e06ef79905e1c520027cddcd1189 09:49:10 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:49:10 INFO - mozversion platform_version: 48.0a1 09:49:10 INFO - using testdate: 1458838150 09:49:10 INFO - actual date: 1458838150 09:49:10 INFO - starting webserver on 'localhost:59533' 09:49:10 INFO - SUITE-START | Running 2 tests 09:49:10 INFO - TEST-START | dromaeo_css 09:49:10 INFO - operating with platform_type : linux_ 09:49:10 INFO - Initialising browser for dromaeo_css test... 09:49:10 INFO - TEST-INFO | started process 14535 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOc0gVr/profile http://localhost:59533/getInfo.html) 09:49:14 INFO - PROCESS | 14535 | 09:49:14 INFO - PROCESS | 14535 | (process:14618): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:49:14 INFO - PROCESS | 14535 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 09:49:15 INFO - PROCESS | 14535 | __metrics Screen width/height:1600/1200 09:49:15 INFO - PROCESS | 14535 | colorDepth:24 09:49:15 INFO - PROCESS | 14535 | Browser inner width/height: 1024/697 09:49:15 INFO - PROCESS | 14535 | __metrics 09:49:16 ERROR - PROCESS | 14535 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 09:49:16 INFO - TEST-INFO | 14535: exit 0 09:49:16 INFO - Browser initialized. 09:49:16 INFO - Running cycle 1/1 for dromaeo_css test... 09:49:16 INFO - TEST-INFO | started process 14669 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOc0gVr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:49:18 INFO - PROCESS | 14669 | 09:49:18 INFO - PROCESS | 14669 | (process:14732): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:49:28 INFO - PROCESS | 14669 | RSS: Main: 164880384 09:49:28 INFO - PROCESS | 14669 | 09:50:18 INFO - PROCESS | 14669 | 1458838218448 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] 09:52:30 INFO - PROCESS | 14669 | Cycle 1(1): loaded http://localhost:59533/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59533/tests/dromaeo/cssquery-ext.html) 09:52:31 INFO - PROCESS | 14669 | RSS: Main: 169029632 09:52:31 INFO - PROCESS | 14669 | 09:55:33 INFO - PROCESS | 14669 | Cycle 1(1): loaded http://localhost:59533/tests/dromaeo/cssquery-ext.html (next: http://localhost:59533/tests/dromaeo/cssquery-jquery.html) 09:55:34 INFO - PROCESS | 14669 | RSS: Main: 165879808 09:55:34 INFO - PROCESS | 14669 | 09:58:35 INFO - PROCESS | 14669 | Cycle 1(1): loaded http://localhost:59533/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59533/tests/dromaeo/cssquery-mootools.html) 09:58:36 INFO - PROCESS | 14669 | RSS: Main: 166707200 09:58:36 INFO - PROCESS | 14669 | 10:01:38 INFO - PROCESS | 14669 | Cycle 1(1): loaded http://localhost:59533/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59533/tests/dromaeo/cssquery-prototype.html) 10:01:38 INFO - PROCESS | 14669 | RSS: Main: 164233216 10:01:38 INFO - PROCESS | 14669 | 10:04:41 INFO - PROCESS | 14669 | Cycle 1(1): loaded http://localhost:59533/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59533/tests/dromaeo/cssquery-yui.html) 10:04:41 INFO - PROCESS | 14669 | RSS: Main: 165470208 10:04:41 INFO - PROCESS | 14669 | 10:07:44 INFO - PROCESS | 14669 | Cycle 1(1): loaded http://localhost:59533/tests/dromaeo/cssquery-yui.html (next: http://localhost:59533/tests/dromaeo/cssquery-dojo.html) 10:07:44 INFO - PROCESS | 14669 | RSS: Main: 167735296 10:07:44 INFO - PROCESS | 14669 | 10:07:44 INFO - PROCESS | 14669 | __start_tp_report 10:07:44 INFO - PROCESS | 14669 | _x_x_mozilla_page_load 10:07:44 INFO - PROCESS | 14669 | _x_x_mozilla_page_load_details 10:07:44 INFO - PROCESS | 14669 | |i|pagename|runs| 10:07:44 INFO - PROCESS | 14669 | |0;dojo.html;2679;2709.9729002709973;2740.698523162453;2757.9172624821263;2762.2818067302496;4862.076205520949;4885.560299573038;4887.218045112782;4895.388076490439;4901.975490122553;4735.976320118403;4867.51324867514;4919.532644398785;4934.851954441372;4997.4003119625695;4389.385486031958;4481.619062379702;4509.323601459791;4566.794494247751;4613.400257966477;4446.510883802779;4469.374287599739;4537.0925814837;4539.137563862872;4554.6128579070655;4408.977955110204;4439.378487011821;4440.289553671397;4482.2156122678725;4493.078918821667;4507.57178068083;4508.729476231437;4519.457665080178;4524.502304746476;4540.704854184501;4420.977895110504;4464.129494748526;4464.486584042844;4480.6191473724775;4485.551444855521;4755.667103302771;4769.76151192439;4780.330753694486;4781.928271075936;4789.904201915977;5187.429382767892;5223.451537588537;5229.320188375525;5241.318628578299;5250.369955605313;5241.109011468059;5246.498850368787;5275.472452754732;5290.0477913975465;5307.65500242483;4884.609231261491;4901.803927842882;4938.358013458227;4959.2809042688605;4991;5344.225087362311;5436.728163591804;5448.754806033738;5456.181572764117;5462.672239665632;5143.6656617320505;5158.45836187195;5223.347081614798;5247.2653828464045;5267.920981185285;5181.896362072813;5268.367795864444;5280.392754833243;5289.603279754034;5329.733513324396;5199.48005199477;5200.635955483155;5212.947870521246;5224.268602395668;5224.477552244745;5074;5158.329417175743;5180.782516108711;5196.818111366084;5198.2202669599865;4472.195004899149;4499.932501012488;4505.166544189336;4525.456945166601;4554.997900461959;3862.343401621731;3941.1132495188926;3948.6643635290748;3970.5830887756947;4023.2154729827403;4537.659675524349;4569.451665800058;4612.76936153191;4643;4653.581177694024;5274.472552744694;5306.867328316745;5318.149096144675;5333.679979201261;5339.145736682112;4505.053938672915;4577.656675749332;4586.220342541776;4597.885052873705;4627.514111018362;4720.811167553328;4769.189237829508;4781.904361912742;4805.495422980606;4822.807087716452;4911.533404326583;4940.407151141886;4940.654154209315;4941.481144479778;4996.625253105959;5166.354205724285;5222.582193424593;5323.627346085892;5334.333208348957;5382.192671099367;4916.0905232532095;4956.430010548689;4973.378327709036;4978;5023.34696489454;5232.136697444879;5241.31862857826;5243.8164664236565;5254.789808407774;5294.761735721825;5116.795328186831;5182.53357197854;5305.1776974569;5330.9733451332495;5332.68003919766;5061.822836200715;5069;5074.67014644047;5093.134167191661;5093.898122037613;5056.165732654071;5094.439611642642;5098;5118.539331460186;5121.769520371667;4908.533689299511;4982.526659967298;5017.84946451607;5035.370578677665;5092.0579692756955;5120.359955005624;5141.203113517411;5148;5151.484851514819;5158;5018.071656743514;5029.798808047637;5035.219540971156;5047.041062198171;5091.0581542414775 10:07:44 INFO - PROCESS | 14669 | |1;ext.html;493.7827355963374;525.6031696069467;530.8062557166634;537.8305833662396;551.9944800551995;27828.165155045357;35898.82050589746;36336.45495317566;36351.4547281791;36405.271894562095;38644.42033369495;38982.610173898254;38991;39138.80430597843;39176.60823391765;7613.885791713143;7764.961175194117;7765.689372425096;7770.9611451942665;7780.494267872598;7551.735689250877;7725.381969442459;7732.188120247378;7734.381249500055;7748.651310691004;7699.26856948589;7714.305712485875;7720.575368354738;7778.144404115543;7780.416468764837;7728.0726312842535;7837.7648670539975;7900.723474678416;7915.841683166362;7917.524948503079;7837;7930.524168549906;7976.202379762035;8001.199880011952;8005.95997020017;38613.42079868804;39188.412173817414;39326.410103848466;39352.80323598392;39526.40710389346;2983.6890335203375;3047.162030441624;3098.1789825695982;3132.201288671397;3185;29689.70310296891;29995.250118746986;30335.848320758254;30401;30478.54282185769;3403.642617525149;3425;3470.3753324401596;3485.233248685285;3585.3008663310666;244242;244471.77641117873;244964;245529;246061;56654.15018774722;56905.71547142238;56932;56950.14574781382;56991.14513282304;65080.67459662671;65214.673926630065;65469.67265163739;65918.34081659219;65923.34076659268;14251.85748142526;14377.065490743069;14408.927955360366;14417.639559010899;14495.492657756928;10686.038256556792;10746.408947507805;10770.730731731614;10781.191410644233;11135.888641113646;20221.595568088556;20739.377818665464;20770;20825.166993320097;20842.583148337253;7245.456590755714;7512.962435187789;7613;7637.770866874002;7708.650986077414;888.9377743558018;959.3476436023572;968.3415277611151;982.2534873496195;1052.1557269958869;27676.446471070867;27770.444591108066;28074.85962570174;28260.293492662848;28355.57466638002;951.9381240219363;982.5332966840693;1000.4397537379091;1016.3139880580578;1107.3743335015852;13250.403731832092;13338.93330533341;13383.665408364674;13501.66245843842;13539.39072741729;365283;367587;368238;370667;371984;48939;50106.242031847025;50261;50380.244296335586;50425.747871260406;1157.1321508868348;1193.2184419205435;1209.6431552691977;1232.7842627540144;1239.5971309324325;25590;25819.612705809803;25891.870540647174;26153.869230653723;26486.205413837615;39057.218855623294;39639.603603964744;39658;39745.40381894216;39794.80102599468;267425;269961;270582;272353;272455;31472.685273146977;31661.683383166794;31935.201619958756;32026;32071.358572828878;40732.389014165405;40763;41199.58800412077;41707.7914610425;41714;33793.83103084469;34434.31131377308;34644;35207.64792352044;35275.47086793752;34313;34726.65273347234;34782.65217347896;35266;35333.823330883184;34907.30185396328;35109;35209;35463.82268088643;35626.46560301546;31452.842735786173;32164;32197;32358;32410.675893240765;24652.137175198783;25294.494110118063;25434.745652543977;25445.61831572565;32396 10:07:44 INFO - PROCESS | 14669 | |2;jquery.html;351.5974209530088;354.5178557162259;357.1873986680302;361.1296774772798;369.06258104414786;15416;15614.985025973318;15761.684766304666;16207.594810129753;16283.185840707976;15530.22348882557;15609.375624974988;15742.29159687814;15840.683186336266;15860.84139158608;4886.218205087187;4958.082754690376;5012.69923804571;5078.974605126988;5088;4988.152014157602;4995.475475075119;5060.51925067118;5068.72122033288;5091.083604951107;5017.774200160983;5029.823956161535;5037;5038.823641172559;5047.091523525783;4786.425628924534;5032.421271553745;5033.6728112672745;5047.268146118829;5081.79672813087;4481.9103617927785;4498.865034048984;4510.909781804378;4521.615662668677;4545.954540454586;19154.808451915444;19595.11821968015;19672.311469098513;19707.605847883104;19718;1873.5409824592925;1946.4549926020595;2037.7249071375322;2064.2465500092358;2429.6962879640046;12203.633890983196;12353.444095015746;12782.360881955958;12895.419706113154;13125.54060607874;1733.3240036385819;1776.1030679506896;1807.9276828926827;1817.7636907202111;1881.5202123458566;41539;50247.49752502465;50496.747516262185;57381.42618573844;59536;8730.607122679494;8749.912500875038;9052.683156089506;9084;9110.407823491452;11971.16201865861;12031.87968120325;12041.939790300992;12103.576374826838;12107.091968102428;6718.731250750013;6817.897731534031;6849.212340580797;6944.270851560514;7056;7046.260142685047;7077.964610176916;7137.179224389158;7150.713971441188;7157.964210178916;5658.066419040812;5688.464114689094;5704.4295570443455;5728.341240757366;5824.213731146326;1698.8725845561632;1707.5389644796085;1723.5087999919963;1742.2856628782138;1747.4233502943998;881.4711173295971;983.2134292565919;1004.8241557727368;1018.2007124407453;1019.0980981831133;16189;16291;16511.83488165103;16727.243877404115;16988.235529401205;879.7800549862534;882.342654722236;892.455602082729;937.4703292639637;983.2576404814463;9093.909060909438;9458.148766611039;9528.380655257386;9652.951735241279;9729.805403892024;356953;362128;365254;387168;399282;41832.58167418348;60543.69728151331;61290;61868;64645;908.7182973278304;918.3892711347013;922.8431166701677;937.6530683646957;942.1002942190329;14421.567352979428;14540.85459145395;14691.706165876409;14723.852761472677;14929.253537322873;31207.531887022167;31538.526922095727;32035.519467208476;32233.35533289368;32446;40261;41496.37755433731;41918;41973;42176;7284.880530752689;7435.256474352522;7554.546727196386;7582.090149182133;7588.089429268523;5965.015772397679;6618.966905165636;10804.567817287221;10813.837792433276;11487.25332853362;9643.662471813734;9796.9020309796;9880.962498937795;9926.602935882484;10099.495025248561;9981.700548983543;10045.447500387256;10136.44249566281;10146.188304935735;10154.086132248132;10103.89896101059;10172.898271017195;10222.080012798884;10285.074343309137;10411.635592754217;7178.784636460915;7345.192028876926;7468.439867009887;7483.513571617827;7487.438442116972;9515.476648784383;10358.015988481082;10393.636222732168;10428.374297541868;10448.42533660656 10:07:44 INFO - PROCESS | 14669 | |3;mootools.html;1452.7094581083784;1471.8013068235791;1644.2847361397794;1775.2277759174767;1814.2470874587054;6819.693113809878;7524.586147761871;7591.658375373107;7836.8040798980055;7838.020247469073;7606.885896711554;7648.885266720989;7664.08031036275;7669.769906902788;7695.807604809883;2247.4606094537276;2271.000759665742;2271.545690861826;2274.7725227477285;2276.84062115652;2214.944626384337;2223.1440895255364;2264.558411109834;2265.603519384101;2267.4784799496124;2246.865188088712;2253.7746225377496;2275.8634481931053;2280.8631482111045;2281.555096756125;2218.0684112672716;2243.3606422169687;2243.6298010828195;2245.65192395179;2248.246837309487;2237.474193564511;2239.5185035217505;2243.091547923094;2245.719285089364;2247.820174386045;7729.265719756614;7732.536047837148;7740.303372696428;7747.767566973;7748.535087894745;4517.548245175456;4658.557437043475;4659.673822832403;4661.46393164787;4682.227432473638;3033.2568520712566;3118.984405077983;3254.332861763333;3261.0379937918133;3288.5724855768835;1021.596469394585;1037.6264544763878;1853.7404763333145;1866.0856180471608;1867.411765293928;10487.423191724452;10511.106555942753;10512.894871051269;10551.525181366856;10573.682789516326;4007.6793856491413;4137.668986481074;4160.43834082395;4206.326987681956;4212.53662097169;8289.295409890106;8298.170182981774;8318.70884519039;8340.124286949904;8347.499150051017;4610.792514336863;4641.74470404131;4647.837325693585;4652.209124448784;4671.182543054952;3805.1438426353848;4178.35235538492;4222.852200172979;4319.287317592625;4334.696571239983;3437.8796742113905;3462.5844898612327;3487.982560087234;3523.418635925095;3533.5583052118486;1044.1072882685346;1054.2304117993908;1072.9892701073045;1077.106002018323;1093.1801149138146;953.3088510829593;973.9366941148803;978.9314747967574;1063.31416236527;1255.9686007849878;7240.239774823673;7275.854482910418;7282;7297.343239108506;7310.488265821342;474.7673639916416;484.45740770336744;488.9584385327287;490.16182328219145;492.5370152057055;5750.971245143831;5814.389489103668;5822.0684690449325;5824.708764561755;5929.525637948954;9343.34596578233;9503.809923801486;9516.048395160567;9532.380395274286;9652.565634546463;9065.093490650883;9214.354995150275;9386.85919711205;9404.24766018717;9425.05749425052;7102.538335008208;7204.387627051655;7283.927160728431;7288.890666640004;7321.377682897013;7027.262137475696;7041.612711300722;7158.856822863409;7174.246704096204;7350.411967042517;8264.173582641688;8331.708390206313;8424.326053915795;8484.787880303042;8501.787455313666;8460.534670593177;8577.699780507652;8604.612792424481;8657.22085012352;8873.866891996497;5956.106584012433;6705.798826035227;6808.829779255559;6964.895526567207;7168.641567921687;7247.782566523013;7271.8909216360735;7299.379552738077;7312.634368281671;7352.338289553752;6290.82364186709;6426.4537514311805;6468.838279043061;6510.023496475377;6666.733330666719;6365.39528744787;6399.8080057598345;6477.4170324671;6492.837679058061;6513.023046543057;6906.171259448898;6961.686724097326;6982.406495447944;6990.370866622028;7071.186813516511;6391.169148010915;6496.350364963466;6560.606363618198;6564.868702625825;6589.044588534732;6560.212774467094;6596.109525214227;6611.735530578723;6664.8000559983275;6681.465482761465 10:07:44 INFO - PROCESS | 14669 | |4;prototype.html;311.8409611098339;317.8521987275917;327.3583775799433;328.25158638304646;328.5088792255577;5615.5507559395255;5674.375818659949;5687.061634830258;5700.600957932947;5710.942890571098;5547.417521160281;5569.387367389594;5608.803691870786;5617.960677274707;5621.718914054291;4109.321961876301;4194.370844373353;4309.008927946574;4350.434443522346;4370.97814510927;4300.161468513641;4305.526392096866;4311.417958575584;4323.870283891489;4328.805203765838;4279.657627389817;4285.485741710983;4289.764062976535;4293.914121717579;4294.312909934411;4290.2706539888295;4295.91408171838;4297.076128632343;4299.677524185668;4302.376155457472;3750.718696097804;3762.360398732222;3767.0017445377;3771.07608635886;3772.849086036555;5402.864928376783;5416.864578385533;5423.647462914898;5428.891422171534;5440.727963601804;4860.854174374775;4944.777485013183;4982.053409852117;4988.426330971948;4997.9750101249265;5899.351071382144;5957.374475680034;5962.135490353918;5968.67172305523;5973.641581505123;4120.896977575585;4123.752574845519;4128.669706423479;4134.91730165398;4136.772477513736;6232.158658581124;6264.3422440643535;6280.120783090371;6285.717142728588;6290.779822706229;4232.25935461293;4234.343676730112;4234.6823988201;4235.195312890541;4235.512916014636;4291.313389857608;4299.011227417712;4305.590968857953;4310.612044915973;4328.307470804656;4722.95277047232;4867.415910090812;4882.609391248691;4900.852974410702;4955.380577427822;5897.557683173779;5935.643861368331;5945.3757355477055;5951.166836642873;5963.940360596425;1474.1523623916291;1479.2307999840023;1480.592836969842;1481.2593703148425;1481.5703446000755;958.8897276813256;974.2400927276735;985.0789511806483;988.3378136648463;994.8010397920444;5165.690058596496;5171.81898633546;5201.895962080737;5207.71357575337;5220.112580861262;6149.292831324455;6201.162843016225;6203.596766210182;6205.193324867739;6211.937880621226;5006.249062640633;5191.792328306901;5197.168453047494;5201.7919283229;5204.661696989683;3296.456084746038;3362.899113026613;3363.5627368442433;3367.2423704666253;3371.258323168899;5711.8000869969355;5716.485516303553;5738.196652468658;5768.94231057684;5780.508656764138;6352.587081839758;6397.328280530571;6404.007378856285;6414.1340918976275;6433.967830160819;5696.088625819932;5766.625169363978;5769.769209231667;5771.740271687784;5774.971125144431;6115.388461153849;6269.373062693694;6278.15244941927;6294.748210071546;6296.685165741603;6111.54163437735;6114.449699527064;6124.418180272867;6131.816045518642;6132.816015519542;5768.855778605568;5771.509421699203;5774.971125144348;5779.826605201851;5782;4168.478940132483;4188.162367526446;4191.203671302443;4193.475815523059;4199.328107502785;6220.34686357944;6221.377862213742;6245.313015568375;6258.812235632939;6263.874722505616;5839.532837373085;5954.374790647093;5978.880422391615;6052.092186172109;6080.087986802015;5940.257467816523;5946.702664866652;5971.462568368867;5983.431574000463;5988.4909782668965;5866.67733274674;5889.52883769306;5892.469677729025;5892.852678683067;5910.231669882888;5992;6016.849578760566;6019.036954087325;6020.157177994996;6041.486473649789;5695.088785794253;5860;5877.73550190251;5889.587728858939;5925.288965324189 10:07:44 INFO - PROCESS | 14669 | |5;yui.html;767.7005967672612;769.39986810288;776.7359097906711;782.9960850195752;794.6622685358722;12168.269903805778;12379.442925068382;12387.566435174747;12414.317212553306;12441.315727634976;11757.647270581874;12510.874891251086;12772.808407873867;13268.93365533171;13275.40260688269;656.4879394072631;817.3338728935928;817.4278005396217;829.5852073963018;835.3442547600135;830.9073568257752;832.950022998619;837.7109897085526;838.3963546246723;842.0442797424905;868.4008034456236;869.6390997735964;871.255076909243;871.2811930157613;875.2778957360172;864.515871112176;865.1089377940731;865.3250464637624;870.0646804684989;870.4907629037021;634.5684934244712;635.0918186992599;635.1711017122653;635.1774452084561;639.3191251317332;12726.681832954158;12825.102242843004;12835.486580536768;12838.486460541568;12856.871431285754;12858.678533036655;12983.156094853899;13003.934980325037;13091.214527128403;13331.133476324008;9881.505924703808;9965.40207587547;9980.401175929395;10112.494375281207;10350;3325.88359407422;3361.277325375056;3370.9494357584654;3383.610884748261;3390.6439823818637;42329.788351058356;43198.99999999969;43326.35010474845;43438.99999999969;43642.34536481955;9287.560789596146;9437.19783818383;9535.427874327563;9646.276529260334;9746.31775775689;17032;17278.827211727723;17339.739903901453;17348.653026939643;17354.652906941792;6705.497087718343;6746.9325306746305;6763.425108865801;6834;6939.167299923941;3743.9438408423894;3787.450819631138;3805.82873770681;3877.612238776156;3889.124946886928;2798.230486616156;2905.7820663450325;2929.838858862783;2942.5439056946207;2951.5867778511024;519.9480051994846;527.941926388097;529.1348644965432;539.4711397815396;553.8255449533465;485.9295402166666;616.2450997527992;621.7171187109855;632.2792017100509;650.612885333226;7765.922340776633;8092.069412017576;8119.797005074803;8147.470414423044;8192.713255036164;630.1335663462738;639.8432384065841;649.6459429610874;651.7002178997619;660.131926516629;3779.527559055118;3780.3951367781024;3902.6292502212245;3961.5246170459154;3982.143839074613;48535.27197092046;48707;48772.51227487751;48784.51215487799;53019.902711188704;42961.48904365059;43018.56981430146;43429.56570434255;44752.10495790131;44848;42377.78811105925;43625.34561981573;43972.12055758867;43987.34018989718;44218.77890610591;8311.625976830936;8322.084570697098;8438.493690378597;8555.443896146731;8736.25741811953;33410;33460.66539334576;33838.32323353568;34055.48916766201;34759.652403476655;37751.81124094362;42530;42756.78621606872;42986.35520467133;44154;10084.596616135272;10527.315724477885;10671.679849604525;10804.189685773756;10815;11362.715932101764;11377.586723982937;11842;11897.107716921439;12116.818247726114;11017.1186305097;11504.94247528757;11506.309621422406;11587.942060289644;11847.407629618658;11094.167937404565;11107.83338249943;11285;11333.433328333715;11744.76510469803;10381.9480902595;10786.838197426889;11136.443177841238;11609.3614851184;11624.07007439386;9116.726498205064;9311.534423278674;9317.673881414117;9540.427574345562;9911.752206194902;8429.34779901466;9403.905960940303;9424.811503770023;9541.809163816824;9615.5672994714 10:07:44 INFO - PROCESS | 14669 | __end_tp_report 10:07:44 INFO - PROCESS | 14669 | __start_cc_report 10:07:44 INFO - PROCESS | 14669 | _x_x_mozilla_cycle_collect,362 10:07:44 INFO - PROCESS | 14669 | __end_cc_report 10:07:44 INFO - PROCESS | 14669 | __startTimestamp1458839264614__endTimestamp 10:07:44 INFO - PROCESS | 14669 | 10:07:44 INFO - PROCESS | 14669 | ------- Summary: start ------- 10:07:44 INFO - PROCESS | 14669 | Number of tests: 6 10:07:44 INFO - PROCESS | 14669 | 10:07:44 INFO - PROCESS | 14669 | [#0] dojo.html Cycles:165 Average:4856.77 Median:4982.53 stddev:508.67 (10.2%) stddev-sans-first:480.69 10:07:44 INFO - PROCESS | 14669 | Values: 2679.0 2710.0 2740.7 2757.9 2762.3 4862.1 4885.6 4887.2 4895.4 4902.0 4736.0 4867.5 4919.5 4934.9 4997.4 4389.4 4481.6 4509.3 4566.8 4613.4 4446.5 4469.4 4537.1 4539.1 4554.6 4409.0 4439.4 4440.3 4482.2 4493.1 4507.6 4508.7 4519.5 4524.5 4540.7 4421.0 4464.1 4464.5 4480.6 4485.6 4755.7 4769.8 4780.3 4781.9 4789.9 5187.4 5223.5 5229.3 5241.3 5250.4 5241.1 5246.5 5275.5 5290.0 5307.7 4884.6 4901.8 4938.4 4959.3 4991.0 5344.2 5436.7 5448.8 5456.2 5462.7 5143.7 5158.5 5223.3 5247.3 5267.9 5181.9 5268.4 5280.4 5289.6 5329.7 5199.5 5200.6 5212.9 5224.3 5224.5 5074.0 5158.3 5180.8 5196.8 5198.2 4472.2 4499.9 4505.2 4525.5 4555.0 3862.3 3941.1 3948.7 3970.6 4023.2 4537.7 4569.5 4612.8 4643.0 4653.6 5274.5 5306.9 5318.1 5333.7 5339.1 4505.1 4577.7 4586.2 4597.9 4627.5 4720.8 4769.2 4781.9 4805.5 4822.8 4911.5 4940.4 4940.7 4941.5 4996.6 5166.4 5222.6 5323.6 5334.3 5382.2 4916.1 4956.4 4973.4 4978.0 5023.3 5232.1 5241.3 5243.8 5254.8 5294.8 5116.8 5182.5 5305.2 5331.0 5332.7 5061.8 5069.0 5074.7 5093.1 5093.9 5056.2 5094.4 5098.0 5118.5 5121.8 4908.5 4982.5 5017.8 5035.4 5092.1 5120.4 5141.2 5148.0 5151.5 5158.0 5018.1 5029.8 5035.2 5047.0 5091.1 10:07:44 INFO - PROCESS | 14669 | 10:07:44 INFO - PROCESS | 14669 | [#1] ext.html Cycles:180 Average:45723.91 Median:35304.65 stddev:78685.32 (222.9%) stddev-sans-first:78832.77 10:07:44 INFO - PROCESS | 14669 | Values: 493.8 525.6 530.8 537.8 552.0 27828.2 35898.8 36336.5 36351.5 36405.3 38644.4 38982.6 38991.0 39138.8 39176.6 7613.9 7765.0 7765.7 7771.0 7780.5 7551.7 7725.4 7732.2 7734.4 7748.7 7699.3 7714.3 7720.6 7778.1 7780.4 7728.1 7837.8 7900.7 7915.8 7917.5 7837.0 7930.5 7976.2 8001.2 8006.0 38613.4 39188.4 39326.4 39352.8 39526.4 2983.7 3047.2 3098.2 3132.2 3185.0 29689.7 29995.3 30335.8 30401.0 30478.5 3403.6 3425.0 3470.4 3485.2 3585.3 244242.0 244471.8 244964.0 245529.0 246061.0 56654.2 56905.7 56932.0 56950.1 56991.1 65080.7 65214.7 65469.7 65918.3 65923.3 14251.9 14377.1 14408.9 14417.6 14495.5 10686.0 10746.4 10770.7 10781.2 11135.9 20221.6 20739.4 20770.0 20825.2 20842.6 7245.5 7513.0 7613.0 7637.8 7708.7 888.9 959.3 968.3 982.3 1052.2 27676.4 27770.4 28074.9 28260.3 28355.6 951.9 982.5 1000.4 1016.3 1107.4 13250.4 13338.9 13383.7 13501.7 13539.4 365283.0 367587.0 368238.0 370667.0 371984.0 48939.0 50106.2 50261.0 50380.2 50425.7 1157.1 1193.2 1209.6 1232.8 1239.6 25590.0 25819.6 25891.9 26153.9 26486.2 39057.2 39639.6 39658.0 39745.4 39794.8 267425.0 269961.0 270582.0 272353.0 272455.0 31472.7 31661.7 31935.2 32026.0 32071.4 40732.4 40763.0 41199.6 41707.8 41714.0 33793.8 34434.3 34644.0 35207.6 35275.5 34313.0 34726.7 34782.7 35266.0 35333.8 34907.3 35109.0 35209.0 35463.8 35626.5 31452.8 32164.0 32197.0 32358.0 32410.7 24652.1 25294.5 25434.7 25445.6 32396.0 10:07:44 INFO - PROCESS | 14669 | 10:07:44 INFO - PROCESS | 14669 | [#2] jquery.html Cycles:180 Average:22236.82 Median:42074.50 stddev:61199.66 (145.5%) stddev-sans-first:61349.28 10:07:44 INFO - PROCESS | 14669 | Values: 351.6 354.5 357.2 361.1 369.1 15416.0 15615.0 15761.7 16207.6 16283.2 15530.2 15609.4 15742.3 15840.7 15860.8 4886.2 4958.1 5012.7 5079.0 5088.0 4988.2 4995.5 5060.5 5068.7 5091.1 5017.8 5029.8 5037.0 5038.8 5047.1 4786.4 5032.4 5033.7 5047.3 5081.8 4481.9 4498.9 4510.9 4521.6 4546.0 19154.8 19595.1 19672.3 19707.6 19718.0 1873.5 1946.5 2037.7 2064.2 2429.7 12203.6 12353.4 12782.4 12895.4 13125.5 1733.3 1776.1 1807.9 1817.8 1881.5 41539.0 50247.5 50496.7 57381.4 59536.0 8730.6 8749.9 9052.7 9084.0 9110.4 11971.2 12031.9 12041.9 12103.6 12107.1 6718.7 6817.9 6849.2 6944.3 7056.0 7046.3 7078.0 7137.2 7150.7 7158.0 5658.1 5688.5 5704.4 5728.3 5824.2 1698.9 1707.5 1723.5 1742.3 1747.4 881.5 983.2 1004.8 1018.2 1019.1 16189.0 16291.0 16511.8 16727.2 16988.2 879.8 882.3 892.5 937.5 983.3 9093.9 9458.1 9528.4 9653.0 9729.8 356953.0 362128.0 365254.0 387168.0 399282.0 41832.6 60543.7 61290.0 61868.0 64645.0 908.7 918.4 922.8 937.7 942.1 14421.6 14540.9 14691.7 14723.9 14929.3 31207.5 31538.5 32035.5 32233.4 32446.0 40261.0 41496.4 41918.0 41973.0 42176.0 7284.9 7435.3 7554.5 7582.1 7588.1 5965.0 6619.0 10804.6 10813.8 11487.3 9643.7 9796.9 9881.0 9926.6 10099.5 9981.7 10045.4 10136.4 10146.2 10154.1 10103.9 10172.9 10222.1 10285.1 10411.6 7178.8 7345.2 7468.4 7483.5 7487.4 9515.5 10358.0 10393.6 10428.4 10448.4 10:07:44 INFO - PROCESS | 14669 | 10:07:44 INFO - PROCESS | 14669 | [#3] mootools.html Cycles:180 Average:5374.44 Median:6395.49 stddev:2788.96 (43.6%) stddev-sans-first:2781.21 10:07:44 INFO - PROCESS | 14669 | Values: 1452.7 1471.8 1644.3 1775.2 1814.2 6819.7 7524.6 7591.7 7836.8 7838.0 7606.9 7648.9 7664.1 7669.8 7695.8 2247.5 2271.0 2271.5 2274.8 2276.8 2214.9 2223.1 2264.6 2265.6 2267.5 2246.9 2253.8 2275.9 2280.9 2281.6 2218.1 2243.4 2243.6 2245.7 2248.2 2237.5 2239.5 2243.1 2245.7 2247.8 7729.3 7732.5 7740.3 7747.8 7748.5 4517.5 4658.6 4659.7 4661.5 4682.2 3033.3 3119.0 3254.3 3261.0 3288.6 1021.6 1037.6 1853.7 1866.1 1867.4 10487.4 10511.1 10512.9 10551.5 10573.7 4007.7 4137.7 4160.4 4206.3 4212.5 8289.3 8298.2 8318.7 8340.1 8347.5 4610.8 4641.7 4647.8 4652.2 4671.2 3805.1 4178.4 4222.9 4319.3 4334.7 3437.9 3462.6 3488.0 3523.4 3533.6 1044.1 1054.2 1073.0 1077.1 1093.2 953.3 973.9 978.9 1063.3 1256.0 7240.2 7275.9 7282.0 7297.3 7310.5 474.8 484.5 489.0 490.2 492.5 5751.0 5814.4 5822.1 5824.7 5929.5 9343.3 9503.8 9516.0 9532.4 9652.6 9065.1 9214.4 9386.9 9404.2 9425.1 7102.5 7204.4 7283.9 7288.9 7321.4 7027.3 7041.6 7158.9 7174.2 7350.4 8264.2 8331.7 8424.3 8484.8 8501.8 8460.5 8577.7 8604.6 8657.2 8873.9 5956.1 6705.8 6808.8 6964.9 7168.6 7247.8 7271.9 7299.4 7312.6 7352.3 6290.8 6426.5 6468.8 6510.0 6666.7 6365.4 6399.8 6477.4 6492.8 6513.0 6906.2 6961.7 6982.4 6990.4 7071.2 6391.2 6496.4 6560.6 6564.9 6589.0 6560.2 6596.1 6611.7 6664.8 6681.5 10:07:44 INFO - PROCESS | 14669 | 10:07:44 INFO - PROCESS | 14669 | [#4] prototype.html Cycles:180 Average:4920.66 Median:5648.05 stddev:1470.29 (26.0%) stddev-sans-first:1433.14 10:07:44 INFO - PROCESS | 14669 | Values: 311.8 317.9 327.4 328.3 328.5 5615.6 5674.4 5687.1 5700.6 5710.9 5547.4 5569.4 5608.8 5618.0 5621.7 4109.3 4194.4 4309.0 4350.4 4371.0 4300.2 4305.5 4311.4 4323.9 4328.8 4279.7 4285.5 4289.8 4293.9 4294.3 4290.3 4295.9 4297.1 4299.7 4302.4 3750.7 3762.4 3767.0 3771.1 3772.8 5402.9 5416.9 5423.6 5428.9 5440.7 4860.9 4944.8 4982.1 4988.4 4998.0 5899.4 5957.4 5962.1 5968.7 5973.6 4120.9 4123.8 4128.7 4134.9 4136.8 6232.2 6264.3 6280.1 6285.7 6290.8 4232.3 4234.3 4234.7 4235.2 4235.5 4291.3 4299.0 4305.6 4310.6 4328.3 4723.0 4867.4 4882.6 4900.9 4955.4 5897.6 5935.6 5945.4 5951.2 5963.9 1474.2 1479.2 1480.6 1481.3 1481.6 958.9 974.2 985.1 988.3 994.8 5165.7 5171.8 5201.9 5207.7 5220.1 6149.3 6201.2 6203.6 6205.2 6211.9 5006.2 5191.8 5197.2 5201.8 5204.7 3296.5 3362.9 3363.6 3367.2 3371.3 5711.8 5716.5 5738.2 5768.9 5780.5 6352.6 6397.3 6404.0 6414.1 6434.0 5696.1 5766.6 5769.8 5771.7 5775.0 6115.4 6269.4 6278.2 6294.7 6296.7 6111.5 6114.4 6124.4 6131.8 6132.8 5768.9 5771.5 5775.0 5779.8 5782.0 4168.5 4188.2 4191.2 4193.5 4199.3 6220.3 6221.4 6245.3 6258.8 6263.9 5839.5 5954.4 5978.9 6052.1 6080.1 5940.3 5946.7 5971.5 5983.4 5988.5 5866.7 5889.5 5892.5 5892.9 5910.2 5992.0 6016.8 6019.0 6020.2 6041.5 5695.1 5860.0 5877.7 5889.6 5925.3 10:07:44 INFO - PROCESS | 14669 | 10:07:44 INFO - PROCESS | 14669 | [#5] yui.html Cycles:180 Average:12853.91 Median:43807.23 stddev:14288.02 (32.6%) stddev-sans-first:14299.27 10:07:44 INFO - PROCESS | 14669 | Values: 767.7 769.4 776.7 783.0 794.7 12168.3 12379.4 12387.6 12414.3 12441.3 11757.6 12510.9 12772.8 13268.9 13275.4 656.5 817.3 817.4 829.6 835.3 830.9 833.0 837.7 838.4 842.0 868.4 869.6 871.3 871.3 875.3 864.5 865.1 865.3 870.1 870.5 634.6 635.1 635.2 635.2 639.3 12726.7 12825.1 12835.5 12838.5 12856.9 12858.7 12983.2 13003.9 13091.2 13331.1 9881.5 9965.4 9980.4 10112.5 10350.0 3325.9 3361.3 3370.9 3383.6 3390.6 42329.8 43199.0 43326.4 43439.0 43642.3 9287.6 9437.2 9535.4 9646.3 9746.3 17032.0 17278.8 17339.7 17348.7 17354.7 6705.5 6746.9 6763.4 6834.0 6939.2 3743.9 3787.5 3805.8 3877.6 3889.1 2798.2 2905.8 2929.8 2942.5 2951.6 519.9 527.9 529.1 539.5 553.8 485.9 616.2 621.7 632.3 650.6 7765.9 8092.1 8119.8 8147.5 8192.7 630.1 639.8 649.6 651.7 660.1 3779.5 3780.4 3902.6 3961.5 3982.1 48535.3 48707.0 48772.5 48784.5 53019.9 42961.5 43018.6 43429.6 44752.1 44848.0 42377.8 43625.3 43972.1 43987.3 44218.8 8311.6 8322.1 8438.5 8555.4 8736.3 33410.0 33460.7 33838.3 34055.5 34759.7 37751.8 42530.0 42756.8 42986.4 44154.0 10084.6 10527.3 10671.7 10804.2 10815.0 11362.7 11377.6 11842.0 11897.1 12116.8 11017.1 11504.9 11506.3 11587.9 11847.4 11094.2 11107.8 11285.0 11333.4 11744.8 10381.9 10786.8 11136.4 11609.4 11624.1 9116.7 9311.5 9317.7 9540.4 9911.8 8429.3 9403.9 9424.8 9541.8 9615.6 10:07:44 INFO - PROCESS | 14669 | -------- Summary: end -------- 10:07:44 INFO - PROCESS | 14669 | 10:07:45 INFO - TEST-INFO | 14669: exit 0 10:07:45 INFO - TEST-OK | dromaeo_css | took 1115019ms 10:07:45 INFO - TEST-START | kraken 10:07:45 INFO - operating with platform_type : linux_ 10:07:45 INFO - Initialising browser for kraken test... 10:07:45 INFO - TEST-INFO | started process 14907 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpji95bi/profile http://localhost:59533/getInfo.html) 10:07:49 INFO - PROCESS | 14907 | 10:07:49 INFO - PROCESS | 14907 | (process:14982): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:07:49 INFO - PROCESS | 14907 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 10:07:50 INFO - PROCESS | 14907 | __metrics Screen width/height:1600/1200 10:07:50 INFO - PROCESS | 14907 | colorDepth:24 10:07:50 INFO - PROCESS | 14907 | Browser inner width/height: 1024/697 10:07:50 INFO - PROCESS | 14907 | __metrics 10:07:50 ERROR - PROCESS | 14907 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 10:07:51 INFO - TEST-INFO | 14907: exit 0 10:07:51 INFO - Browser initialized. 10:07:51 INFO - Running cycle 1/1 for kraken test... 10:07:51 INFO - TEST-INFO | started process 15033 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpji95bi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:07:53 INFO - PROCESS | 15033 | 10:07:53 INFO - PROCESS | 15033 | (process:15095): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:08:03 INFO - PROCESS | 15033 | RSS: Main: 164356096 10:08:03 INFO - PROCESS | 15033 | 10:08:06 INFO - PROCESS | 15033 | Cycle 1(1): loaded http://localhost:59533/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59533/tests/kraken/driver.html?testName=audio-beat-detection) 10:08:06 INFO - PROCESS | 15033 | RSS: Main: 168751104 10:08:06 INFO - PROCESS | 15033 | 10:08:09 INFO - PROCESS | 15033 | Cycle 1(1): loaded http://localhost:59533/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59533/tests/kraken/driver.html?testName=audio-dft) 10:08:10 INFO - PROCESS | 15033 | RSS: Main: 172703744 10:08:10 INFO - PROCESS | 15033 | 10:08:13 INFO - PROCESS | 15033 | Cycle 1(1): loaded http://localhost:59533/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59533/tests/kraken/driver.html?testName=audio-fft) 10:08:13 INFO - PROCESS | 15033 | RSS: Main: 162553856 10:08:13 INFO - PROCESS | 15033 | 10:08:15 INFO - PROCESS | 15033 | Cycle 1(1): loaded http://localhost:59533/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59533/tests/kraken/driver.html?testName=audio-oscillator) 10:08:16 INFO - PROCESS | 15033 | RSS: Main: 163131392 10:08:16 INFO - PROCESS | 15033 | 10:08:18 INFO - PROCESS | 15033 | Cycle 1(1): loaded http://localhost:59533/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59533/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:08:19 INFO - PROCESS | 15033 | RSS: Main: 164417536 10:08:19 INFO - PROCESS | 15033 | 10:08:22 INFO - PROCESS | 15033 | Cycle 1(1): loaded http://localhost:59533/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59533/tests/kraken/driver.html?testName=imaging-darkroom) 10:08:23 INFO - PROCESS | 15033 | RSS: Main: 164380672 10:08:23 INFO - PROCESS | 15033 | 10:08:26 INFO - PROCESS | 15033 | Cycle 1(1): loaded http://localhost:59533/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59533/tests/kraken/driver.html?testName=imaging-desaturate) 10:08:27 INFO - PROCESS | 15033 | RSS: Main: 164929536 10:08:27 INFO - PROCESS | 15033 | 10:08:30 INFO - PROCESS | 15033 | Cycle 1(1): loaded http://localhost:59533/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59533/tests/kraken/driver.html?testName=json-parse-financial) 10:08:30 INFO - PROCESS | 15033 | RSS: Main: 165314560 10:08:30 INFO - PROCESS | 15033 | 10:08:32 INFO - PROCESS | 15033 | Cycle 1(1): loaded http://localhost:59533/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59533/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:08:33 INFO - PROCESS | 15033 | RSS: Main: 165797888 10:08:33 INFO - PROCESS | 15033 | 10:08:35 INFO - PROCESS | 15033 | Cycle 1(1): loaded http://localhost:59533/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59533/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:08:35 INFO - PROCESS | 15033 | RSS: Main: 166129664 10:08:35 INFO - PROCESS | 15033 | 10:08:37 INFO - PROCESS | 15033 | Cycle 1(1): loaded http://localhost:59533/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59533/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:08:38 INFO - PROCESS | 15033 | RSS: Main: 166133760 10:08:38 INFO - PROCESS | 15033 | 10:08:41 INFO - PROCESS | 15033 | Cycle 1(1): loaded http://localhost:59533/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59533/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:08:41 INFO - PROCESS | 15033 | RSS: Main: 166543360 10:08:41 INFO - PROCESS | 15033 | 10:08:44 INFO - PROCESS | 15033 | Cycle 1(1): loaded http://localhost:59533/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59533/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:08:44 INFO - PROCESS | 15033 | RSS: Main: 166100992 10:08:44 INFO - PROCESS | 15033 | 10:08:46 INFO - PROCESS | 15033 | Cycle 1(1): loaded http://localhost:59533/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59533/tests/kraken/driver.html?testName=ai-astar) 10:08:46 INFO - PROCESS | 15033 | RSS: Main: 167501824 10:08:46 INFO - PROCESS | 15033 | 10:08:46 INFO - PROCESS | 15033 | __start_tp_report 10:08:46 INFO - PROCESS | 15033 | _x_x_mozilla_page_load 10:08:46 INFO - PROCESS | 15033 | _x_x_mozilla_page_load_details 10:08:46 INFO - PROCESS | 15033 | |i|pagename|runs| 10:08:46 INFO - PROCESS | 15033 | |0;ai-astar;111;106;112;111;112;125;112;110;114;111 10:08:46 INFO - PROCESS | 15033 | |1;audio-beat-detection;168;130;158;171;139;157;158;141;184;137 10:08:46 INFO - PROCESS | 15033 | |2;audio-dft;164;165;162;163;166;171;165;164;167;166 10:08:46 INFO - PROCESS | 15033 | |3;audio-fft;76;75;75;74;74;74;74;73;143;76 10:08:46 INFO - PROCESS | 15033 | |4;audio-oscillator;93;95;146;94;95;94;145;94;96;138 10:08:46 INFO - PROCESS | 15033 | |5;imaging-gaussian-blur;118;118;117;120;118;117;119;118;118;118 10:08:46 INFO - PROCESS | 15033 | |6;imaging-darkroom;147;147;146;146;146;146;148;148;148;146 10:08:46 INFO - PROCESS | 15033 | |7;imaging-desaturate;98;97;95;96;97;97;96;96;96;96 10:08:46 INFO - PROCESS | 15033 | |8;json-parse-financial;65;65;64;66;67;64;71;65;74;64 10:08:46 INFO - PROCESS | 15033 | |9;json-stringify-tinderbox;64;64;65;64;64;65;65;65;64;64 10:08:46 INFO - PROCESS | 15033 | |10;stanford-crypto-aes;82;85;87;88;86;83;84;84;85;81 10:08:46 INFO - PROCESS | 15033 | |11;stanford-crypto-ccm;121;118;114;117;117;117;134;125;120;120 10:08:46 INFO - PROCESS | 15033 | |12;stanford-crypto-pbkdf2;143;136;146;141;149;145;143;143;140;142 10:08:46 INFO - PROCESS | 15033 | |13;stanford-crypto-sha256-iterative;67;68;72;70;71;70;65;66;70;72 10:08:46 INFO - PROCESS | 15033 | __end_tp_report 10:08:46 INFO - PROCESS | 15033 | __start_cc_report 10:08:46 INFO - PROCESS | 15033 | _x_x_mozilla_cycle_collect,902 10:08:46 INFO - PROCESS | 15033 | __end_cc_report 10:08:46 INFO - PROCESS | 15033 | __startTimestamp1458839326919__endTimestamp 10:08:46 INFO - PROCESS | 15033 | 10:08:46 INFO - PROCESS | 15033 | ------- Summary: start ------- 10:08:46 INFO - PROCESS | 15033 | Number of tests: 14 10:08:46 INFO - PROCESS | 15033 | 10:08:46 INFO - PROCESS | 15033 | [#0] ai-astar Cycles:10 Average:112.40 Median:112.00 stddev:4.88 (4.4%) stddev-sans-first:5.15 10:08:46 INFO - PROCESS | 15033 | Values: 111.0 106.0 112.0 111.0 112.0 125.0 112.0 110.0 114.0 111.0 10:08:46 INFO - PROCESS | 15033 | 10:08:46 INFO - PROCESS | 15033 | [#1] audio-beat-detection Cycles:10 Average:154.30 Median:158.00 stddev:17.27 (10.9%) stddev-sans-first:17.59 10:08:46 INFO - PROCESS | 15033 | Values: 168.0 130.0 158.0 171.0 139.0 157.0 158.0 141.0 184.0 137.0 10:08:46 INFO - PROCESS | 15033 | 10:08:46 INFO - PROCESS | 15033 | [#2] audio-dft Cycles:10 Average:165.30 Median:165.50 stddev:2.50 (1.5%) stddev-sans-first:2.60 10:08:46 INFO - PROCESS | 15033 | Values: 164.0 165.0 162.0 163.0 166.0 171.0 165.0 164.0 167.0 166.0 10:08:46 INFO - PROCESS | 15033 | 10:08:46 INFO - PROCESS | 15033 | [#3] audio-fft Cycles:10 Average:81.40 Median:74.50 stddev:21.67 (29.1%) stddev-sans-first:22.89 10:08:46 INFO - PROCESS | 15033 | Values: 76.0 75.0 75.0 74.0 74.0 74.0 74.0 73.0 143.0 76.0 10:08:46 INFO - PROCESS | 15033 | 10:08:46 INFO - PROCESS | 15033 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:94.00 stddev:23.57 (25.1%) stddev-sans-first:24.27 10:08:46 INFO - PROCESS | 15033 | Values: 93.0 95.0 146.0 94.0 95.0 94.0 145.0 94.0 96.0 138.0 10:08:46 INFO - PROCESS | 15033 | 10:08:46 INFO - PROCESS | 15033 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.88 (0.7%) stddev-sans-first:0.93 10:08:46 INFO - PROCESS | 15033 | Values: 118.0 118.0 117.0 120.0 118.0 117.0 119.0 118.0 118.0 118.0 10:08:46 INFO - PROCESS | 15033 | 10:08:46 INFO - PROCESS | 15033 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 10:08:46 INFO - PROCESS | 15033 | Values: 147.0 147.0 146.0 146.0 146.0 146.0 148.0 148.0 148.0 146.0 10:08:46 INFO - PROCESS | 15033 | 10:08:46 INFO - PROCESS | 15033 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.84 (0.9%) stddev-sans-first:0.67 10:08:46 INFO - PROCESS | 15033 | Values: 98.0 97.0 95.0 96.0 97.0 97.0 96.0 96.0 96.0 96.0 10:08:46 INFO - PROCESS | 15033 | 10:08:46 INFO - PROCESS | 15033 | [#8] json-parse-financial Cycles:10 Average:66.50 Median:65.50 stddev:3.37 (5.2%) stddev-sans-first:3.54 10:08:46 INFO - PROCESS | 15033 | Values: 65.0 65.0 64.0 66.0 67.0 64.0 71.0 65.0 74.0 64.0 10:08:46 INFO - PROCESS | 15033 | 10:08:46 INFO - PROCESS | 15033 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 10:08:46 INFO - PROCESS | 15033 | Values: 64.0 64.0 65.0 64.0 64.0 65.0 65.0 65.0 64.0 64.0 10:08:46 INFO - PROCESS | 15033 | 10:08:46 INFO - PROCESS | 15033 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:85.00 stddev:2.17 (2.6%) stddev-sans-first:2.11 10:08:46 INFO - PROCESS | 15033 | Values: 82.0 85.0 87.0 88.0 86.0 83.0 84.0 84.0 85.0 81.0 10:08:46 INFO - PROCESS | 15033 | 10:08:46 INFO - PROCESS | 15033 | [#11] stanford-crypto-ccm Cycles:10 Average:120.30 Median:120.00 stddev:5.66 (4.7%) stddev-sans-first:6.00 10:08:46 INFO - PROCESS | 15033 | Values: 121.0 118.0 114.0 117.0 117.0 117.0 134.0 125.0 120.0 120.0 10:08:46 INFO - PROCESS | 15033 | 10:08:46 INFO - PROCESS | 15033 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.80 Median:143.00 stddev:3.52 (2.5%) stddev-sans-first:3.73 10:08:46 INFO - PROCESS | 15033 | Values: 143.0 136.0 146.0 141.0 149.0 145.0 143.0 143.0 140.0 142.0 10:08:46 INFO - PROCESS | 15033 | 10:08:46 INFO - PROCESS | 15033 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:70.00 stddev:2.47 (3.5%) stddev-sans-first:2.50 10:08:46 INFO - PROCESS | 15033 | Values: 67.0 68.0 72.0 70.0 71.0 70.0 65.0 66.0 70.0 72.0 10:08:46 INFO - PROCESS | 15033 | -------- Summary: end -------- 10:08:46 INFO - PROCESS | 15033 | 10:08:47 INFO - TEST-INFO | 15033: exit 0 10:08:47 INFO - TEST-OK | kraken | took 62611ms 10:08:47 INFO - SUITE-END | took 1177s 10:08:48 INFO - Completed test suite (00:19:37) 10:08:48 INFO - javascript benchmark 10:08:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2679.0, 2709.9729002709973, 2740.698523162453, 2757.9172624821263, 2762.2818067302496, 4862.076205520949, 4885.560299573038, 4887.218045112782, 4895.388076490439, 4901.975490122553, 4735.976320118403, 4867.51324867514, 4919.532644398785, 4934.851954441372, 4997.4003119625695, 4389.385486031958, 4481.619062379702, 4509.323601459791, 4566.794494247751, 4613.400257966477, 4446.510883802779, 4469.374287599739, 4537.0925814837, 4539.137563862872, 4554.6128579070655, 4408.977955110204, 4439.378487011821, 4440.289553671397, 4482.2156122678725, 4493.078918821667, 4507.57178068083, 4508.729476231437, 4519.457665080178, 4524.502304746476, 4540.704854184501, 4420.977895110504, 4464.129494748526, 4464.486584042844, 4480.6191473724775, 4485.551444855521, 4755.667103302771, 4769.76151192439, 4780.330753694486, 4781.928271075936, 4789.904201915977, 5187.429382767892, 5223.451537588537, 5229.320188375525, 5241.318628578299, 5250.369955605313, 5241.109011468059, 5246.498850368787, 5275.472452754732, 5290.0477913975465, 5307.65500242483, 4884.609231261491, 4901.803927842882, 4938.358013458227, 4959.2809042688605, 4991.0, 5344.225087362311, 5436.728163591804, 5448.754806033738, 5456.181572764117, 5462.672239665632, 5143.6656617320505, 5158.45836187195, 5223.347081614798, 5247.2653828464045, 5267.920981185285, 5181.896362072813, 5268.367795864444, 5280.392754833243, 5289.603279754034, 5329.733513324396, 5199.48005199477, 5200.635955483155, 5212.947870521246, 5224.268602395668, 5224.477552244745, 5074.0, 5158.329417175743, 5180.782516108711, 5196.818111366084, 5198.2202669599865, 4472.195004899149, 4499.932501012488, 4505.166544189336, 4525.456945166601, 4554.997900461959, 3862.343401621731, 3941.1132495188926, 3948.6643635290748, 3970.5830887756947, 4023.2154729827403, 4537.659675524349, 4569.451665800058, 4612.76936153191, 4643.0, 4653.581177694024, 5274.472552744694, 5306.867328316745, 5318.149096144675, 5333.679979201261, 5339.145736682112, 4505.053938672915, 4577.656675749332, 4586.220342541776, 4597.885052873705, 4627.514111018362, 4720.811167553328, 4769.189237829508, 4781.904361912742, 4805.495422980606, 4822.807087716452, 4911.533404326583, 4940.407151141886, 4940.654154209315, 4941.481144479778, 4996.625253105959, 5166.354205724285, 5222.582193424593, 5323.627346085892, 5334.333208348957, 5382.192671099367, 4916.0905232532095, 4956.430010548689, 4973.378327709036, 4978.0, 5023.34696489454, 5232.136697444879, 5241.31862857826, 5243.8164664236565, 5254.789808407774, 5294.761735721825, 5116.795328186831, 5182.53357197854, 5305.1776974569, 5330.9733451332495, 5332.68003919766, 5061.822836200715, 5069.0, 5074.67014644047, 5093.134167191661, 5093.898122037613, 5056.165732654071, 5094.439611642642, 5098.0, 5118.539331460186, 5121.769520371667, 4908.533689299511, 4982.526659967298, 5017.84946451607, 5035.370578677665, 5092.0579692756955, 5120.359955005624, 5141.203113517411, 5148.0, 5151.484851514819, 5158.0, 5018.071656743514, 5029.798808047637, 5035.219540971156, 5047.041062198171, 5091.0581542414775], "unit": "score", "name": "dojo.html", "value": 4824.196553603355}, {"lowerIsBetter": false, "replicates": [493.7827355963374, 525.6031696069467, 530.8062557166634, 537.8305833662396, 551.9944800551995, 27828.165155045357, 35898.82050589746, 36336.45495317566, 36351.4547281791, 36405.271894562095, 38644.42033369495, 38982.610173898254, 38991.0, 39138.80430597843, 39176.60823391765, 7613.885791713143, 7764.961175194117, 7765.689372425096, 7770.9611451942665, 7780.494267872598, 7551.735689250877, 7725.381969442459, 7732.188120247378, 7734.381249500055, 7748.651310691004, 7699.26856948589, 7714.305712485875, 7720.575368354738, 7778.144404115543, 7780.416468764837, 7728.0726312842535, 7837.7648670539975, 7900.723474678416, 7915.841683166362, 7917.524948503079, 7837.0, 7930.524168549906, 7976.202379762035, 8001.199880011952, 8005.95997020017, 38613.42079868804, 39188.412173817414, 39326.410103848466, 39352.80323598392, 39526.40710389346, 2983.6890335203375, 3047.162030441624, 3098.1789825695982, 3132.201288671397, 3185.0, 29689.70310296891, 29995.250118746986, 30335.848320758254, 30401.0, 30478.54282185769, 3403.642617525149, 3425.0, 3470.3753324401596, 3485.233248685285, 3585.3008663310666, 244242.0, 244471.77641117873, 244964.0, 245529.0, 246061.0, 56654.15018774722, 56905.71547142238, 56932.0, 56950.14574781382, 56991.14513282304, 65080.67459662671, 65214.673926630065, 65469.67265163739, 65918.34081659219, 65923.34076659268, 14251.85748142526, 14377.065490743069, 14408.927955360366, 14417.639559010899, 14495.492657756928, 10686.038256556792, 10746.408947507805, 10770.730731731614, 10781.191410644233, 11135.888641113646, 20221.595568088556, 20739.377818665464, 20770.0, 20825.166993320097, 20842.583148337253, 7245.456590755714, 7512.962435187789, 7613.0, 7637.770866874002, 7708.650986077414, 888.9377743558018, 959.3476436023572, 968.3415277611151, 982.2534873496195, 1052.1557269958869, 27676.446471070867, 27770.444591108066, 28074.85962570174, 28260.293492662848, 28355.57466638002, 951.9381240219363, 982.5332966840693, 1000.4397537379091, 1016.3139880580578, 1107.3743335015852, 13250.403731832092, 13338.93330533341, 13383.665408364674, 13501.66245843842, 13539.39072741729, 365283.0, 367587.0, 368238.0, 370667.0, 371984.0, 48939.0, 50106.242031847025, 50261.0, 50380.244296335586, 50425.747871260406, 1157.1321508868348, 1193.2184419205435, 1209.6431552691977, 1232.7842627540144, 1239.5971309324325, 25590.0, 25819.612705809803, 25891.870540647174, 26153.869230653723, 26486.205413837615, 39057.218855623294, 39639.603603964744, 39658.0, 39745.40381894216, 39794.80102599468, 267425.0, 269961.0, 270582.0, 272353.0, 272455.0, 31472.685273146977, 31661.683383166794, 31935.201619958756, 32026.0, 32071.358572828878, 40732.389014165405, 40763.0, 41199.58800412077, 41707.7914610425, 41714.0, 33793.83103084469, 34434.31131377308, 34644.0, 35207.64792352044, 35275.47086793752, 34313.0, 34726.65273347234, 34782.65217347896, 35266.0, 35333.823330883184, 34907.30185396328, 35109.0, 35209.0, 35463.82268088643, 35626.46560301546, 31452.842735786173, 32164.0, 32197.0, 32358.0, 32410.675893240765, 24652.137175198783, 25294.494110118063, 25434.745652543977, 25445.61831572565, 32396.0], "unit": "score", "name": "ext.html", "value": 17559.762289689315}, {"lowerIsBetter": false, "replicates": [351.5974209530088, 354.5178557162259, 357.1873986680302, 361.1296774772798, 369.06258104414786, 15416.0, 15614.985025973318, 15761.684766304666, 16207.594810129753, 16283.185840707976, 15530.22348882557, 15609.375624974988, 15742.29159687814, 15840.683186336266, 15860.84139158608, 4886.218205087187, 4958.082754690376, 5012.69923804571, 5078.974605126988, 5088.0, 4988.152014157602, 4995.475475075119, 5060.51925067118, 5068.72122033288, 5091.083604951107, 5017.774200160983, 5029.823956161535, 5037.0, 5038.823641172559, 5047.091523525783, 4786.425628924534, 5032.421271553745, 5033.6728112672745, 5047.268146118829, 5081.79672813087, 4481.9103617927785, 4498.865034048984, 4510.909781804378, 4521.615662668677, 4545.954540454586, 19154.808451915444, 19595.11821968015, 19672.311469098513, 19707.605847883104, 19718.0, 1873.5409824592925, 1946.4549926020595, 2037.7249071375322, 2064.2465500092358, 2429.6962879640046, 12203.633890983196, 12353.444095015746, 12782.360881955958, 12895.419706113154, 13125.54060607874, 1733.3240036385819, 1776.1030679506896, 1807.9276828926827, 1817.7636907202111, 1881.5202123458566, 41539.0, 50247.49752502465, 50496.747516262185, 57381.42618573844, 59536.0, 8730.607122679494, 8749.912500875038, 9052.683156089506, 9084.0, 9110.407823491452, 11971.16201865861, 12031.87968120325, 12041.939790300992, 12103.576374826838, 12107.091968102428, 6718.731250750013, 6817.897731534031, 6849.212340580797, 6944.270851560514, 7056.0, 7046.260142685047, 7077.964610176916, 7137.179224389158, 7150.713971441188, 7157.964210178916, 5658.066419040812, 5688.464114689094, 5704.4295570443455, 5728.341240757366, 5824.213731146326, 1698.8725845561632, 1707.5389644796085, 1723.5087999919963, 1742.2856628782138, 1747.4233502943998, 881.4711173295971, 983.2134292565919, 1004.8241557727368, 1018.2007124407453, 1019.0980981831133, 16189.0, 16291.0, 16511.83488165103, 16727.243877404115, 16988.235529401205, 879.7800549862534, 882.342654722236, 892.455602082729, 937.4703292639637, 983.2576404814463, 9093.909060909438, 9458.148766611039, 9528.380655257386, 9652.951735241279, 9729.805403892024, 356953.0, 362128.0, 365254.0, 387168.0, 399282.0, 41832.58167418348, 60543.69728151331, 61290.0, 61868.0, 64645.0, 908.7182973278304, 918.3892711347013, 922.8431166701677, 937.6530683646957, 942.1002942190329, 14421.567352979428, 14540.85459145395, 14691.706165876409, 14723.852761472677, 14929.253537322873, 31207.531887022167, 31538.526922095727, 32035.519467208476, 32233.35533289368, 32446.0, 40261.0, 41496.37755433731, 41918.0, 41973.0, 42176.0, 7284.880530752689, 7435.256474352522, 7554.546727196386, 7582.090149182133, 7588.089429268523, 5965.015772397679, 6618.966905165636, 10804.567817287221, 10813.837792433276, 11487.25332853362, 9643.662471813734, 9796.9020309796, 9880.962498937795, 9926.602935882484, 10099.495025248561, 9981.700548983543, 10045.447500387256, 10136.44249566281, 10146.188304935735, 10154.086132248132, 10103.89896101059, 10172.898271017195, 10222.080012798884, 10285.074343309137, 10411.635592754217, 7178.784636460915, 7345.192028876926, 7468.439867009887, 7483.513571617827, 7487.438442116972, 9515.476648784383, 10358.015988481082, 10393.636222732168, 10428.374297541868, 10448.42533660656], "unit": "score", "name": "jquery.html", "value": 7878.370627643181}, {"lowerIsBetter": false, "replicates": [1452.7094581083784, 1471.8013068235791, 1644.2847361397794, 1775.2277759174767, 1814.2470874587054, 6819.693113809878, 7524.586147761871, 7591.658375373107, 7836.8040798980055, 7838.020247469073, 7606.885896711554, 7648.885266720989, 7664.08031036275, 7669.769906902788, 7695.807604809883, 2247.4606094537276, 2271.000759665742, 2271.545690861826, 2274.7725227477285, 2276.84062115652, 2214.944626384337, 2223.1440895255364, 2264.558411109834, 2265.603519384101, 2267.4784799496124, 2246.865188088712, 2253.7746225377496, 2275.8634481931053, 2280.8631482111045, 2281.555096756125, 2218.0684112672716, 2243.3606422169687, 2243.6298010828195, 2245.65192395179, 2248.246837309487, 2237.474193564511, 2239.5185035217505, 2243.091547923094, 2245.719285089364, 2247.820174386045, 7729.265719756614, 7732.536047837148, 7740.303372696428, 7747.767566973, 7748.535087894745, 4517.548245175456, 4658.557437043475, 4659.673822832403, 4661.46393164787, 4682.227432473638, 3033.2568520712566, 3118.984405077983, 3254.332861763333, 3261.0379937918133, 3288.5724855768835, 1021.596469394585, 1037.6264544763878, 1853.7404763333145, 1866.0856180471608, 1867.411765293928, 10487.423191724452, 10511.106555942753, 10512.894871051269, 10551.525181366856, 10573.682789516326, 4007.6793856491413, 4137.668986481074, 4160.43834082395, 4206.326987681956, 4212.53662097169, 8289.295409890106, 8298.170182981774, 8318.70884519039, 8340.124286949904, 8347.499150051017, 4610.792514336863, 4641.74470404131, 4647.837325693585, 4652.209124448784, 4671.182543054952, 3805.1438426353848, 4178.35235538492, 4222.852200172979, 4319.287317592625, 4334.696571239983, 3437.8796742113905, 3462.5844898612327, 3487.982560087234, 3523.418635925095, 3533.5583052118486, 1044.1072882685346, 1054.2304117993908, 1072.9892701073045, 1077.106002018323, 1093.1801149138146, 953.3088510829593, 973.9366941148803, 978.9314747967574, 1063.31416236527, 1255.9686007849878, 7240.239774823673, 7275.854482910418, 7282.0, 7297.343239108506, 7310.488265821342, 474.7673639916416, 484.45740770336744, 488.9584385327287, 490.16182328219145, 492.5370152057055, 5750.971245143831, 5814.389489103668, 5822.0684690449325, 5824.708764561755, 5929.525637948954, 9343.34596578233, 9503.809923801486, 9516.048395160567, 9532.380395274286, 9652.565634546463, 9065.093490650883, 9214.354995150275, 9386.85919711205, 9404.24766018717, 9425.05749425052, 7102.538335008208, 7204.387627051655, 7283.927160728431, 7288.890666640004, 7321.377682897013, 7027.262137475696, 7041.612711300722, 7158.856822863409, 7174.246704096204, 7350.411967042517, 8264.173582641688, 8331.708390206313, 8424.326053915795, 8484.787880303042, 8501.787455313666, 8460.534670593177, 8577.699780507652, 8604.612792424481, 8657.22085012352, 8873.866891996497, 5956.106584012433, 6705.798826035227, 6808.829779255559, 6964.895526567207, 7168.641567921687, 7247.782566523013, 7271.8909216360735, 7299.379552738077, 7312.634368281671, 7352.338289553752, 6290.82364186709, 6426.4537514311805, 6468.838279043061, 6510.023496475377, 6666.733330666719, 6365.39528744787, 6399.8080057598345, 6477.4170324671, 6492.837679058061, 6513.023046543057, 6906.171259448898, 6961.686724097326, 6982.406495447944, 6990.370866622028, 7071.186813516511, 6391.169148010915, 6496.350364963466, 6560.606363618198, 6564.868702625825, 6589.044588534732, 6560.212774467094, 6596.109525214227, 6611.735530578723, 6664.8000559983275, 6681.465482761465], "unit": "score", "name": "mootools.html", "value": 4366.788805688007}, {"lowerIsBetter": false, "replicates": [311.8409611098339, 317.8521987275917, 327.3583775799433, 328.25158638304646, 328.5088792255577, 5615.5507559395255, 5674.375818659949, 5687.061634830258, 5700.600957932947, 5710.942890571098, 5547.417521160281, 5569.387367389594, 5608.803691870786, 5617.960677274707, 5621.718914054291, 4109.321961876301, 4194.370844373353, 4309.008927946574, 4350.434443522346, 4370.97814510927, 4300.161468513641, 4305.526392096866, 4311.417958575584, 4323.870283891489, 4328.805203765838, 4279.657627389817, 4285.485741710983, 4289.764062976535, 4293.914121717579, 4294.312909934411, 4290.2706539888295, 4295.91408171838, 4297.076128632343, 4299.677524185668, 4302.376155457472, 3750.718696097804, 3762.360398732222, 3767.0017445377, 3771.07608635886, 3772.849086036555, 5402.864928376783, 5416.864578385533, 5423.647462914898, 5428.891422171534, 5440.727963601804, 4860.854174374775, 4944.777485013183, 4982.053409852117, 4988.426330971948, 4997.9750101249265, 5899.351071382144, 5957.374475680034, 5962.135490353918, 5968.67172305523, 5973.641581505123, 4120.896977575585, 4123.752574845519, 4128.669706423479, 4134.91730165398, 4136.772477513736, 6232.158658581124, 6264.3422440643535, 6280.120783090371, 6285.717142728588, 6290.779822706229, 4232.25935461293, 4234.343676730112, 4234.6823988201, 4235.195312890541, 4235.512916014636, 4291.313389857608, 4299.011227417712, 4305.590968857953, 4310.612044915973, 4328.307470804656, 4722.95277047232, 4867.415910090812, 4882.609391248691, 4900.852974410702, 4955.380577427822, 5897.557683173779, 5935.643861368331, 5945.3757355477055, 5951.166836642873, 5963.940360596425, 1474.1523623916291, 1479.2307999840023, 1480.592836969842, 1481.2593703148425, 1481.5703446000755, 958.8897276813256, 974.2400927276735, 985.0789511806483, 988.3378136648463, 994.8010397920444, 5165.690058596496, 5171.81898633546, 5201.895962080737, 5207.71357575337, 5220.112580861262, 6149.292831324455, 6201.162843016225, 6203.596766210182, 6205.193324867739, 6211.937880621226, 5006.249062640633, 5191.792328306901, 5197.168453047494, 5201.7919283229, 5204.661696989683, 3296.456084746038, 3362.899113026613, 3363.5627368442433, 3367.2423704666253, 3371.258323168899, 5711.8000869969355, 5716.485516303553, 5738.196652468658, 5768.94231057684, 5780.508656764138, 6352.587081839758, 6397.328280530571, 6404.007378856285, 6414.1340918976275, 6433.967830160819, 5696.088625819932, 5766.625169363978, 5769.769209231667, 5771.740271687784, 5774.971125144431, 6115.388461153849, 6269.373062693694, 6278.15244941927, 6294.748210071546, 6296.685165741603, 6111.54163437735, 6114.449699527064, 6124.418180272867, 6131.816045518642, 6132.816015519542, 5768.855778605568, 5771.509421699203, 5774.971125144348, 5779.826605201851, 5782.0, 4168.478940132483, 4188.162367526446, 4191.203671302443, 4193.475815523059, 4199.328107502785, 6220.34686357944, 6221.377862213742, 6245.313015568375, 6258.812235632939, 6263.874722505616, 5839.532837373085, 5954.374790647093, 5978.880422391615, 6052.092186172109, 6080.087986802015, 5940.257467816523, 5946.702664866652, 5971.462568368867, 5983.431574000463, 5988.4909782668965, 5866.67733274674, 5889.52883769306, 5892.469677729025, 5892.852678683067, 5910.231669882888, 5992.0, 6016.849578760566, 6019.036954087325, 6020.157177994996, 6041.486473649789, 5695.088785794253, 5860.0, 5877.73550190251, 5889.587728858939, 5925.288965324189], "unit": "score", "name": "prototype.html", "value": 4444.18378026206}, {"lowerIsBetter": false, "replicates": [767.7005967672612, 769.39986810288, 776.7359097906711, 782.9960850195752, 794.6622685358722, 12168.269903805778, 12379.442925068382, 12387.566435174747, 12414.317212553306, 12441.315727634976, 11757.647270581874, 12510.874891251086, 12772.808407873867, 13268.93365533171, 13275.40260688269, 656.4879394072631, 817.3338728935928, 817.4278005396217, 829.5852073963018, 835.3442547600135, 830.9073568257752, 832.950022998619, 837.7109897085526, 838.3963546246723, 842.0442797424905, 868.4008034456236, 869.6390997735964, 871.255076909243, 871.2811930157613, 875.2778957360172, 864.515871112176, 865.1089377940731, 865.3250464637624, 870.0646804684989, 870.4907629037021, 634.5684934244712, 635.0918186992599, 635.1711017122653, 635.1774452084561, 639.3191251317332, 12726.681832954158, 12825.102242843004, 12835.486580536768, 12838.486460541568, 12856.871431285754, 12858.678533036655, 12983.156094853899, 13003.934980325037, 13091.214527128403, 13331.133476324008, 9881.505924703808, 9965.40207587547, 9980.401175929395, 10112.494375281207, 10350.0, 3325.88359407422, 3361.277325375056, 3370.9494357584654, 3383.610884748261, 3390.6439823818637, 42329.788351058356, 43198.99999999969, 43326.35010474845, 43438.99999999969, 43642.34536481955, 9287.560789596146, 9437.19783818383, 9535.427874327563, 9646.276529260334, 9746.31775775689, 17032.0, 17278.827211727723, 17339.739903901453, 17348.653026939643, 17354.652906941792, 6705.497087718343, 6746.9325306746305, 6763.425108865801, 6834.0, 6939.167299923941, 3743.9438408423894, 3787.450819631138, 3805.82873770681, 3877.612238776156, 3889.124946886928, 2798.230486616156, 2905.7820663450325, 2929.838858862783, 2942.5439056946207, 2951.5867778511024, 519.9480051994846, 527.941926388097, 529.1348644965432, 539.4711397815396, 553.8255449533465, 485.9295402166666, 616.2450997527992, 621.7171187109855, 632.2792017100509, 650.612885333226, 7765.922340776633, 8092.069412017576, 8119.797005074803, 8147.470414423044, 8192.713255036164, 630.1335663462738, 639.8432384065841, 649.6459429610874, 651.7002178997619, 660.131926516629, 3779.527559055118, 3780.3951367781024, 3902.6292502212245, 3961.5246170459154, 3982.143839074613, 48535.27197092046, 48707.0, 48772.51227487751, 48784.51215487799, 53019.902711188704, 42961.48904365059, 43018.56981430146, 43429.56570434255, 44752.10495790131, 44848.0, 42377.78811105925, 43625.34561981573, 43972.12055758867, 43987.34018989718, 44218.77890610591, 8311.625976830936, 8322.084570697098, 8438.493690378597, 8555.443896146731, 8736.25741811953, 33410.0, 33460.66539334576, 33838.32323353568, 34055.48916766201, 34759.652403476655, 37751.81124094362, 42530.0, 42756.78621606872, 42986.35520467133, 44154.0, 10084.596616135272, 10527.315724477885, 10671.679849604525, 10804.189685773756, 10815.0, 11362.715932101764, 11377.586723982937, 11842.0, 11897.107716921439, 12116.818247726114, 11017.1186305097, 11504.94247528757, 11506.309621422406, 11587.942060289644, 11847.407629618658, 11094.167937404565, 11107.83338249943, 11285.0, 11333.433328333715, 11744.76510469803, 10381.9480902595, 10786.838197426889, 11136.443177841238, 11609.3614851184, 11624.07007439386, 9116.726498205064, 9311.534423278674, 9317.673881414117, 9540.427574345562, 9911.752206194902, 8429.34779901466, 9403.905960940303, 9424.811503770023, 9541.809163816824, 9615.5672994714], "unit": "score", "name": "yui.html", "value": 6050.090967192894}], "name": "dromaeo_css", "value": 6541.682154708487}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 106.0, 112.0, 111.0, 112.0, 125.0, 112.0, 110.0, 114.0, 111.0], "unit": "score", "name": "ai-astar", "value": 112.4}, {"lowerIsBetter": true, "replicates": [168.0, 130.0, 158.0, 171.0, 139.0, 157.0, 158.0, 141.0, 184.0, 137.0], "unit": "score", "name": "audio-beat-detection", "value": 154.3}, {"lowerIsBetter": true, "replicates": [164.0, 165.0, 162.0, 163.0, 166.0, 171.0, 165.0, 164.0, 167.0, 166.0], "unit": "score", "name": "audio-dft", "value": 165.3}, {"lowerIsBetter": true, "replicates": [76.0, 75.0, 75.0, 74.0, 74.0, 74.0, 74.0, 73.0, 143.0, 76.0], "unit": "score", "name": "audio-fft", "value": 81.4}, {"lowerIsBetter": true, "replicates": [93.0, 95.0, 146.0, 94.0, 95.0, 94.0, 145.0, 94.0, 96.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 109.0}, {"lowerIsBetter": true, "replicates": [118.0, 118.0, 117.0, 120.0, 118.0, 117.0, 119.0, 118.0, 118.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 118.1}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 148.0, 148.0, 148.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [98.0, 97.0, 95.0, 96.0, 97.0, 97.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 64.0, 66.0, 67.0, 64.0, 71.0, 65.0, 74.0, 64.0], "unit": "score", "name": "json-parse-financial", "value": 66.5}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 65.0, 64.0, 64.0, 65.0, 65.0, 65.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.4}, {"lowerIsBetter": true, "replicates": [82.0, 85.0, 87.0, 88.0, 86.0, 83.0, 84.0, 84.0, 85.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.5}, {"lowerIsBetter": true, "replicates": [121.0, 118.0, 114.0, 117.0, 117.0, 117.0, 134.0, 125.0, 120.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.3}, {"lowerIsBetter": true, "replicates": [143.0, 136.0, 146.0, 141.0, 149.0, 145.0, 143.0, 143.0, 140.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.8}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 72.0, 70.0, 71.0, 70.0, 65.0, 66.0, 70.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.1}], "name": "kraken", "value": 1531.3000000000002}]} 10:08:48 INFO - Return code: 0 10:08:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:08:48 ERROR - # TBPL SUCCESS # 10:08:48 INFO - Running post-action listener: _resource_record_post_action 10:08:48 INFO - Running post-run listener: _resource_record_post_run 10:08:49 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 523747328; Read time: 0; Write time: 464616 10:08:49 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 239382528; Read time: 0; Write time: 264096 10:08:49 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 281464832; Read time: 0; Write time: 199964 10:08:49 INFO - Running post-run listener: _upload_blobber_files 10:08:49 INFO - Blob upload gear active. 10:08:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:08:49 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 10:08:49 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'] 10:08:49 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 10:08:49 INFO - (blobuploader) - INFO - Open directory for files ... 10:08:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:08:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:08:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:08:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:08:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:08:50 INFO - (blobuploader) - INFO - Done attempting. 10:08:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:08:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:08:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:08:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:08:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:08:51 INFO - (blobuploader) - INFO - Done attempting. 10:08:51 INFO - (blobuploader) - INFO - Iteration through files over. 10:08:51 INFO - Return code: 0 10:08:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:08:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:08:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/45245a955a652f050de1bf8d17aeb47359e6ca7d6e4a8bd6b226fc1afedbf7c8a3eb30cbe2043489c04c2589df29dfbcda59adaa65e60c4129bab2cbb0ef2c8d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/005d9c2ecf4d8dac88212ba4d158ba7c64cf0c48186544903cc3543fdf3bc15bbf4fa74d4462f1c3b26d7730073fb0b776f001980a64c417da9d876b61b34726"} 10:08:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:08:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:08:51 INFO - Contents: 10:08:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/45245a955a652f050de1bf8d17aeb47359e6ca7d6e4a8bd6b226fc1afedbf7c8a3eb30cbe2043489c04c2589df29dfbcda59adaa65e60c4129bab2cbb0ef2c8d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/005d9c2ecf4d8dac88212ba4d158ba7c64cf0c48186544903cc3543fdf3bc15bbf4fa74d4462f1c3b26d7730073fb0b776f001980a64c417da9d876b61b34726"} 10:08:51 INFO - Running post-run listener: copy_logs_to_upload_dir 10:08:51 INFO - Copying logs to upload dir... 10:08:51 INFO - mkdir: /builds/slave/test/build/upload/logs 10:08:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.308497 ========= master_lag: 113.21 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 25 secs) (at 2016-03-24 10:10:43.789765) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-24 10:10:43.794329) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1458838087.909555-193430851 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/45245a955a652f050de1bf8d17aeb47359e6ca7d6e4a8bd6b226fc1afedbf7c8a3eb30cbe2043489c04c2589df29dfbcda59adaa65e60c4129bab2cbb0ef2c8d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/005d9c2ecf4d8dac88212ba4d158ba7c64cf0c48186544903cc3543fdf3bc15bbf4fa74d4462f1c3b26d7730073fb0b776f001980a64c417da9d876b61b34726"} build_url:https://queue.taskcluster.net/v1/task/Qpj0W5K1SL69qRmG5lqQ0A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011331 build_url: 'https://queue.taskcluster.net/v1/task/Qpj0W5K1SL69qRmG5lqQ0A/artifacts/public/build/firefox-48.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/45245a955a652f050de1bf8d17aeb47359e6ca7d6e4a8bd6b226fc1afedbf7c8a3eb30cbe2043489c04c2589df29dfbcda59adaa65e60c4129bab2cbb0ef2c8d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/005d9c2ecf4d8dac88212ba4d158ba7c64cf0c48186544903cc3543fdf3bc15bbf4fa74d4462f1c3b26d7730073fb0b776f001980a64c417da9d876b61b34726"}' ========= master_lag: 0.55 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-24 10:10:44.358680) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-03-24 10:10:44.359067) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1458838087.909555-193430851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004701 ========= master_lag: 4.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-03-24 10:10:48.440738) ========= ========= Started reboot skipped (results: 3, elapsed: 5 secs) (at 2016-03-24 10:10:48.441025) ========= ========= Finished reboot skipped (results: 3, elapsed: 5 secs) (at 2016-03-24 10:10:53.905919) ========= ========= Total master_lag: 118.01 =========