builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-037 starttime: 1458091813.03 results: success (0) buildid: 20160315170242 builduid: 64b174d4b0a346dba7ee2e19714a018a revision: 55e4902a0ea4abe5f7d50a17a3b540b378b344ba ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-15 18:30:13.031040) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-15 18:30:13.031459) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-15 18:30:13.031756) ========= 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=aa08bb06ff6271ef470a76a4000001be-1458091168.268648-229101067 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006367 basedir: '/builds/slave/test' ========= master_lag: 0.31 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-15 18:30:13.344788) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-15 18:30:13.345126) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-15 18:30:13.361959) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 18:30:13.362253) ========= 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=aa08bb06ff6271ef470a76a4000001be-1458091168.268648-229101067 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004559 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 18:30:13.411215) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-15 18:30:13.411514) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-15 18:30:13.411882) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 18:30:13.412157) ========= 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=aa08bb06ff6271ef470a76a4000001be-1458091168.268648-229101067 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-15 18:30:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 217M=0s 2016-03-15 18:30:13 (217 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.144035 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 18:30:13.568376) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 18:30:13.568698) ========= 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=aa08bb06ff6271ef470a76a4000001be-1458091168.268648-229101067 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015722 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 18:30:13.618364) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 18:30:13.618717) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 55e4902a0ea4abe5f7d50a17a3b540b378b344ba --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 55e4902a0ea4abe5f7d50a17a3b540b378b344ba --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=aa08bb06ff6271ef470a76a4000001be-1458091168.268648-229101067 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-15 18:30:13,746 truncating revision to first 12 chars 2016-03-15 18:30:13,746 Setting DEBUG logging. 2016-03-15 18:30:13,746 attempt 1/10 2016-03-15 18:30:13,746 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/55e4902a0ea4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-15 18:30:14,007 unpacking tar archive at: mozilla-central-55e4902a0ea4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.564042 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 18:30:14.195431) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-15 18:30:14.195799) ========= echo 55e4902a0ea4abe5f7d50a17a3b540b378b344ba in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'55e4902a0ea4abe5f7d50a17a3b540b378b344ba'] 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=aa08bb06ff6271ef470a76a4000001be-1458091168.268648-229101067 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 55e4902a0ea4abe5f7d50a17a3b540b378b344ba program finished with exit code 0 elapsedTime=0.004453 script_repo_revision: '55e4902a0ea4abe5f7d50a17a3b540b378b344ba' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-15 18:30:14.246308) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-15 18:30:14.246609) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-15 18:30:14.256189) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-03-15 18:30:14.256476) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=aa08bb06ff6271ef470a76a4000001be-1458091168.268648-229101067 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:30:14 INFO - MultiFileLogger online at 20160315 18:30:14 in /builds/slave/test 18:30:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 18:30:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:30:14 INFO - {'append_to_log': False, 18:30:14 INFO - 'base_work_dir': '/builds/slave/test', 18:30:14 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 18:30:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:30:14 INFO - 'branch': 'Firefox-Non-PGO', 18:30:14 INFO - 'buildbot_json_path': 'buildprops.json', 18:30:14 INFO - 'config_files': ('talos/linux_config.py',), 18:30:14 INFO - 'default_actions': ('clobber', 18:30:14 INFO - 'read-buildbot-config', 18:30:14 INFO - 'download-and-extract', 18:30:14 INFO - 'populate-webroot', 18:30:14 INFO - 'create-virtualenv', 18:30:14 INFO - 'install', 18:30:14 INFO - 'run-tests'), 18:30:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:30:14 INFO - 'download_minidump_stackwalk': True, 18:30:14 INFO - 'download_symbols': 'ondemand', 18:30:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:30:14 INFO - 'tooltool.py': '/tools/tooltool.py', 18:30:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:30:14 INFO - '/tools/misc-python/virtualenv.py')}, 18:30:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:30:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:30:14 INFO - 'installer_path': 'installer.exe', 18:30:14 INFO - 'log_level': 'info', 18:30:14 INFO - 'log_name': 'talos', 18:30:14 INFO - 'log_to_console': True, 18:30:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:30:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:30:14 INFO - 'opt_config_files': (), 18:30:14 INFO - 'pip_index': False, 18:30:14 INFO - 'sps_profile': False, 18:30:14 INFO - 'sps_profile_interval': 0, 18:30:14 INFO - 'suite': 'dromaeojs', 18:30:14 INFO - 'system_bits': '32', 18:30:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:30:14 INFO - 'title': 'talos-linux64-ix-037', 18:30:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:30:14 INFO - 'use_talos_json': True, 18:30:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:30:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:30:14 INFO - 'work_dir': 'build'} 18:30:14 INFO - ##### 18:30:14 INFO - ##### Running clobber step. 18:30:14 INFO - ##### 18:30:14 INFO - Running pre-action listener: _resource_record_pre_action 18:30:14 INFO - Running main action method: clobber 18:30:14 INFO - rmtree: /builds/slave/test/build 18:30:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:30:15 INFO - Running post-action listener: _resource_record_post_action 18:30:15 INFO - ##### 18:30:15 INFO - ##### Running read-buildbot-config step. 18:30:15 INFO - ##### 18:30:15 INFO - Running pre-action listener: _resource_record_pre_action 18:30:15 INFO - Running main action method: read_buildbot_config 18:30:15 INFO - Using buildbot properties: 18:30:15 INFO - { 18:30:15 INFO - "project": "", 18:30:15 INFO - "product": "firefox", 18:30:15 INFO - "script_repo_revision": "production", 18:30:15 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 18:30:15 INFO - "repository": "", 18:30:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 18:30:15 INFO - "buildid": "20160315170242", 18:30:15 INFO - "pgo_build": "False", 18:30:15 INFO - "basedir": "/builds/slave/test", 18:30:15 INFO - "buildnumber": 512, 18:30:15 INFO - "slavename": "talos-linux64-ix-037", 18:30:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:30:15 INFO - "platform": "ubuntu64_hw", 18:30:15 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 18:30:15 INFO - "branch": "mozilla-central", 18:30:15 INFO - "repo_path": "mozilla-central", 18:30:15 INFO - "revision": "55e4902a0ea4abe5f7d50a17a3b540b378b344ba", 18:30:15 INFO - "stage_platform": "linux64", 18:30:15 INFO - "builduid": "64b174d4b0a346dba7ee2e19714a018a", 18:30:15 INFO - "slavebuilddir": "test" 18:30:15 INFO - } 18:30:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/Lksn9GWDQH6qrPc0bUbJAw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 18:30:15 INFO - Running post-action listener: _resource_record_post_action 18:30:15 INFO - ##### 18:30:15 INFO - ##### Running download-and-extract step. 18:30:15 INFO - ##### 18:30:15 INFO - Running pre-action listener: _resource_record_pre_action 18:30:15 INFO - Running main action method: download_and_extract 18:30:15 INFO - mkdir: /builds/slave/test/build/tests 18:30:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:30:15 INFO - https://queue.taskcluster.net/v1/task/Lksn9GWDQH6qrPc0bUbJAw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:30:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lksn9GWDQH6qrPc0bUbJAw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:30:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lksn9GWDQH6qrPc0bUbJAw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:30:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lksn9GWDQH6qrPc0bUbJAw/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 18:30:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lksn9GWDQH6qrPc0bUbJAw/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 18:30:16 INFO - Downloaded 1361 bytes. 18:30:16 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:30:16 INFO - Using the following test package requirements: 18:30:16 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:30:16 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:30:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:30:16 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:30:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:30:16 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:30:16 INFO - u'jsshell-linux-x86_64.zip'], 18:30:16 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:30:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:30:16 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:30:16 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:30:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:30:16 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:30:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:30:16 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:30:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:30:16 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:30:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:30:16 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:30:16 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')]} 18:30:16 INFO - https://queue.taskcluster.net/v1/task/Lksn9GWDQH6qrPc0bUbJAw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:30:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lksn9GWDQH6qrPc0bUbJAw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:30:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lksn9GWDQH6qrPc0bUbJAw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:30:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lksn9GWDQH6qrPc0bUbJAw/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 18:30:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lksn9GWDQH6qrPc0bUbJAw/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 18:30:18 INFO - Downloaded 21991996 bytes. 18:30:18 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'] 18:30:18 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 18:30:19 INFO - Return code: 0 18:30:19 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 18:30: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')]} 18:30:19 INFO - https://queue.taskcluster.net/v1/task/Lksn9GWDQH6qrPc0bUbJAw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:30:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lksn9GWDQH6qrPc0bUbJAw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:30:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lksn9GWDQH6qrPc0bUbJAw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:30:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lksn9GWDQH6qrPc0bUbJAw/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 18:30:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lksn9GWDQH6qrPc0bUbJAw/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 18:30:22 INFO - Downloaded 21991996 bytes. 18:30:22 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'] 18:30:22 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 18:30:23 INFO - Return code: 0 18:30:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:30:23 INFO - https://queue.taskcluster.net/v1/task/Lksn9GWDQH6qrPc0bUbJAw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:30:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lksn9GWDQH6qrPc0bUbJAw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:30:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lksn9GWDQH6qrPc0bUbJAw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:30:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lksn9GWDQH6qrPc0bUbJAw/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 18:30:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lksn9GWDQH6qrPc0bUbJAw/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 18:30:24 INFO - Downloaded 10845263 bytes. 18:30:24 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'] 18:30:24 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 18:30:25 INFO - Return code: 0 18:30: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')]} 18:30:25 INFO - https://queue.taskcluster.net/v1/task/Lksn9GWDQH6qrPc0bUbJAw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:30:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lksn9GWDQH6qrPc0bUbJAw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:30:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lksn9GWDQH6qrPc0bUbJAw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:30:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lksn9GWDQH6qrPc0bUbJAw/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 18:30:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lksn9GWDQH6qrPc0bUbJAw/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 18:30:26 INFO - Downloaded 54095494 bytes. 18:30:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Lksn9GWDQH6qrPc0bUbJAw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:30:26 INFO - mkdir: /builds/slave/test/properties 18:30:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:30:26 INFO - Writing to file /builds/slave/test/properties/build_url 18:30:26 INFO - Contents: 18:30:26 INFO - build_url:https://queue.taskcluster.net/v1/task/Lksn9GWDQH6qrPc0bUbJAw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:30:27 INFO - Running post-action listener: _resource_record_post_action 18:30:27 INFO - Running post-action listener: set_extra_try_arguments 18:30:27 INFO - ##### 18:30:27 INFO - ##### Running populate-webroot step. 18:30:27 INFO - ##### 18:30:27 INFO - Running pre-action listener: _resource_record_pre_action 18:30:27 INFO - Running main action method: populate_webroot 18:30:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:30:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:30:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:30:27 INFO - '--tppagecycles', 18:30:27 INFO - '7'], 18:30:27 INFO - 'tests': ['tsvgm']}}, 18:30:27 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:30:27 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:30:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:30:27 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 18:30:27 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:30:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:30:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:30:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:30:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:30:27 INFO - 'talos_options': ['--e10s'], 18:30:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:30:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:30:27 INFO - 'tests': ['damp', 'tps']}, 18:30:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:30:27 INFO - 'talos_options': ['--e10s'], 18:30:27 INFO - 'tests': ['damp', 'tps']}, 18:30:27 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:30:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:30:27 INFO - 'other': {'tests': ['a11yr', 18:30:27 INFO - 'ts_paint', 18:30:27 INFO - 'tpaint', 18:30:27 INFO - 'sessionrestore', 18:30:27 INFO - 'sessionrestore_no_auto_restore', 18:30:27 INFO - 'tabpaint']}, 18:30:27 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:30:27 INFO - 'tests': ['a11yr', 18:30:27 INFO - 'ts_paint', 18:30:27 INFO - 'tpaint', 18:30:27 INFO - 'sessionrestore', 18:30:27 INFO - 'sessionrestore_no_auto_restore', 18:30:27 INFO - 'tabpaint']}, 18:30:27 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:30:27 INFO - 'tests': ['a11yr', 18:30:27 INFO - 'ts_paint', 18:30:27 INFO - 'tpaint', 18:30:27 INFO - 'sessionrestore', 18:30:27 INFO - 'sessionrestore_no_auto_restore', 18:30:27 INFO - 'tabpaint']}, 18:30:27 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:30:27 INFO - 'tests': ['a11yr', 18:30:27 INFO - 'ts_paint', 18:30:27 INFO - 'tpaint', 18:30:27 INFO - 'sessionrestore', 18:30:27 INFO - 'sessionrestore_no_auto_restore', 18:30:27 INFO - 'tabpaint']}, 18:30:27 INFO - 'other_l64': {'tests': ['a11yr', 18:30:27 INFO - 'ts_paint', 18:30:27 INFO - 'tpaint', 18:30:27 INFO - 'sessionrestore', 18:30:27 INFO - 'sessionrestore_no_auto_restore', 18:30:27 INFO - 'tabpaint']}, 18:30:27 INFO - 'other_nol64': {'tests': ['a11yr', 18:30:27 INFO - 'ts_paint', 18:30:27 INFO - 'tpaint', 18:30:27 INFO - 'sessionrestore', 18:30:27 INFO - 'sessionrestore_no_auto_restore', 18:30:27 INFO - 'tabpaint']}, 18:30:27 INFO - 'svgr': {'tests': ['tsvgx', 18:30:27 INFO - 'tsvgr_opacity', 18:30:27 INFO - 'tart', 18:30:27 INFO - 'tscrollx', 18:30:27 INFO - 'cart']}, 18:30:27 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:30:27 INFO - 'tests': ['tsvgx', 18:30:27 INFO - 'tsvgr_opacity', 18:30:27 INFO - 'tart', 18:30:27 INFO - 'tscrollx', 18:30:27 INFO - 'cart']}, 18:30:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:30:27 INFO - 'tests': ['tp5o']}, 18:30:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:30:27 INFO - 'talos_options': ['--e10s'], 18:30:27 INFO - 'tests': ['tp5o']}, 18:30:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:30:27 INFO - 'talos_options': ['--xperf_path', 18:30:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:30:27 INFO - 'tests': ['tp5n']}, 18:30:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:30:27 INFO - 'talos_options': ['--e10s', 18:30:27 INFO - '--xperf_path', 18:30:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:30:27 INFO - 'tests': ['tp5n']}}, 18:30:27 INFO - 'talos.zip': {'path': '', 18:30:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:30:27 INFO - Running post-action listener: _resource_record_post_action 18:30:27 INFO - ##### 18:30:27 INFO - ##### Running create-virtualenv step. 18:30:27 INFO - ##### 18:30:27 INFO - Running pre-action listener: _resource_record_pre_action 18:30:27 INFO - Running main action method: create_virtualenv 18:30:27 INFO - Creating virtualenv /builds/slave/test/build/venv 18:30:27 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 18:30:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:30:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:30:27 INFO - Using real prefix '/usr' 18:30:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:30:28 INFO - Installing distribute.............................................................................................................................................................................................done. 18:30:30 INFO - Installing pip.................done. 18:30:30 INFO - Return code: 0 18:30:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:30:30 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')]} 18:30:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:30 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')]} 18:30:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:30 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 0x7f40bc435f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22df410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236e160>, '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 0x236f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x236f4f0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1458091168.268648-229101067', '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 18:30:30 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 18:30:30 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 18:30:30 INFO - Using env: {'DISPLAY': ':0', 18:30:30 INFO - 'HOME': '/home/cltbld', 18:30:30 INFO - 'LANG': 'en_US.UTF-8', 18:30:30 INFO - 'LANGUAGE': 'en_US:en', 18:30:30 INFO - 'LOGNAME': 'cltbld', 18:30:30 INFO - 'MAIL': '/var/mail/cltbld', 18:30:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:30 INFO - 'MOZ_NO_REMOTE': '1', 18:30:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:30 INFO - 'NO_EM_RESTART': '1', 18:30:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:30 INFO - 'PWD': '/builds/slave/test', 18:30:30 INFO - 'SHELL': '/bin/bash', 18:30:30 INFO - 'SHLVL': '1', 18:30:30 INFO - 'TERM': 'linux', 18:30:30 INFO - 'TMOUT': '86400', 18:30:30 INFO - 'USER': 'cltbld', 18:30:30 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1458091168.268648-229101067', 18:30:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:30 INFO - '_': '/tools/buildbot/bin/python'} 18:30:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:30 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 18:30:30 INFO - Cleaning up... 18:30:30 INFO - Return code: 0 18:30:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:30:30 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')]} 18:30:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:30 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')]} 18:30:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:30 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 0x7f40bc435f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22df410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236e160>, '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 0x236f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x236f4f0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1458091168.268648-229101067', '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 18:30:30 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 18:30:30 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 18:30:30 INFO - Using env: {'DISPLAY': ':0', 18:30:30 INFO - 'HOME': '/home/cltbld', 18:30:30 INFO - 'LANG': 'en_US.UTF-8', 18:30:30 INFO - 'LANGUAGE': 'en_US:en', 18:30:30 INFO - 'LOGNAME': 'cltbld', 18:30:30 INFO - 'MAIL': '/var/mail/cltbld', 18:30:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:30 INFO - 'MOZ_NO_REMOTE': '1', 18:30:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:30 INFO - 'NO_EM_RESTART': '1', 18:30:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:30 INFO - 'PWD': '/builds/slave/test', 18:30:30 INFO - 'SHELL': '/bin/bash', 18:30:30 INFO - 'SHLVL': '1', 18:30:30 INFO - 'TERM': 'linux', 18:30:30 INFO - 'TMOUT': '86400', 18:30:30 INFO - 'USER': 'cltbld', 18:30:30 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1458091168.268648-229101067', 18:30:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:30 INFO - '_': '/tools/buildbot/bin/python'} 18:30:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:30 INFO - Downloading/unpacking psutil>=0.7.1 18:30:30 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 18:30:30 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 18:30:30 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 18:30:30 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 18:30:30 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 18:30:30 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 18:30:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:30:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:30:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:30:32 INFO - Installing collected packages: psutil 18:30:32 INFO - Running setup.py install for psutil 18:30:32 INFO - building 'psutil._psutil_linux' extension 18:30:32 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 18:30:32 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 18:30:32 INFO - building 'psutil._psutil_posix' extension 18:30:32 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 18:30:32 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 18:30:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:30:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:30:32 INFO - Successfully installed psutil 18:30:32 INFO - Cleaning up... 18:30:33 INFO - Return code: 0 18:30:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:30:33 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')]} 18:30:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:33 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')]} 18:30:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:33 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 0x7f40bc435f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22df410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236e160>, '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 0x236f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x236f4f0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1458091168.268648-229101067', '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 18:30:33 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 18:30:33 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 18:30:33 INFO - Using env: {'DISPLAY': ':0', 18:30:33 INFO - 'HOME': '/home/cltbld', 18:30:33 INFO - 'LANG': 'en_US.UTF-8', 18:30:33 INFO - 'LANGUAGE': 'en_US:en', 18:30:33 INFO - 'LOGNAME': 'cltbld', 18:30:33 INFO - 'MAIL': '/var/mail/cltbld', 18:30:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:33 INFO - 'MOZ_NO_REMOTE': '1', 18:30:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:33 INFO - 'NO_EM_RESTART': '1', 18:30:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:33 INFO - 'PWD': '/builds/slave/test', 18:30:33 INFO - 'SHELL': '/bin/bash', 18:30:33 INFO - 'SHLVL': '1', 18:30:33 INFO - 'TERM': 'linux', 18:30:33 INFO - 'TMOUT': '86400', 18:30:33 INFO - 'USER': 'cltbld', 18:30:33 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1458091168.268648-229101067', 18:30:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:33 INFO - '_': '/tools/buildbot/bin/python'} 18:30:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:30:33 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 18:30:33 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 18:30:33 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 18:30:33 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 18:30:33 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 18:30:33 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 18:30:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:30:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:30:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:30:35 INFO - Installing collected packages: mozsystemmonitor 18:30:35 INFO - Running setup.py install for mozsystemmonitor 18:30:35 INFO - Successfully installed mozsystemmonitor 18:30:35 INFO - Cleaning up... 18:30:35 INFO - Return code: 0 18:30:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:30:35 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')]} 18:30:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:35 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')]} 18:30:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:35 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 0x7f40bc435f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22df410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236e160>, '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 0x236f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x236f4f0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1458091168.268648-229101067', '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 18:30:35 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 18:30:35 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 18:30:35 INFO - Using env: {'DISPLAY': ':0', 18:30:35 INFO - 'HOME': '/home/cltbld', 18:30:35 INFO - 'LANG': 'en_US.UTF-8', 18:30:35 INFO - 'LANGUAGE': 'en_US:en', 18:30:35 INFO - 'LOGNAME': 'cltbld', 18:30:35 INFO - 'MAIL': '/var/mail/cltbld', 18:30:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:35 INFO - 'MOZ_NO_REMOTE': '1', 18:30:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:35 INFO - 'NO_EM_RESTART': '1', 18:30:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:35 INFO - 'PWD': '/builds/slave/test', 18:30:35 INFO - 'SHELL': '/bin/bash', 18:30:35 INFO - 'SHLVL': '1', 18:30:35 INFO - 'TERM': 'linux', 18:30:35 INFO - 'TMOUT': '86400', 18:30:35 INFO - 'USER': 'cltbld', 18:30:35 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1458091168.268648-229101067', 18:30:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:35 INFO - '_': '/tools/buildbot/bin/python'} 18:30:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:35 INFO - Downloading/unpacking blobuploader==1.2.4 18:30:35 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 18:30:35 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 18:30:35 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 18:30:35 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 18:30:35 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 18:30:35 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 18:30:37 INFO - Downloading blobuploader-1.2.4.tar.gz 18:30:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:30:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:30:37 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 18:30:37 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 18:30:37 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 18:30:37 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 18:30:37 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 18:30:37 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 18:30:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:30:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:30:37 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 18:30:37 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 18:30:37 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 18:30:37 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 18:30:37 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 18:30:37 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 18:30:38 INFO - Downloading docopt-0.6.1.tar.gz 18:30:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:30:38 INFO - Installing collected packages: blobuploader, requests, docopt 18:30:38 INFO - Running setup.py install for blobuploader 18:30:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:30:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:30:38 INFO - Running setup.py install for requests 18:30:38 INFO - Running setup.py install for docopt 18:30:38 INFO - Successfully installed blobuploader requests docopt 18:30:38 INFO - Cleaning up... 18:30:38 INFO - Return code: 0 18:30:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:30:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:30:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:38 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 0x7f40bc435f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22df410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236e160>, '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 0x236f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x236f4f0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1458091168.268648-229101067', '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 18:30:38 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 18:30:38 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 18:30:38 INFO - Using env: {'DISPLAY': ':0', 18:30:38 INFO - 'HOME': '/home/cltbld', 18:30:38 INFO - 'LANG': 'en_US.UTF-8', 18:30:38 INFO - 'LANGUAGE': 'en_US:en', 18:30:38 INFO - 'LOGNAME': 'cltbld', 18:30:38 INFO - 'MAIL': '/var/mail/cltbld', 18:30:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:38 INFO - 'MOZ_NO_REMOTE': '1', 18:30:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:38 INFO - 'NO_EM_RESTART': '1', 18:30:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:38 INFO - 'PWD': '/builds/slave/test', 18:30:38 INFO - 'SHELL': '/bin/bash', 18:30:38 INFO - 'SHLVL': '1', 18:30:38 INFO - 'TERM': 'linux', 18:30:38 INFO - 'TMOUT': '86400', 18:30:38 INFO - 'USER': 'cltbld', 18:30:38 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1458091168.268648-229101067', 18:30:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:38 INFO - '_': '/tools/buildbot/bin/python'} 18:30:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:30:38 INFO - Running setup.py (path:/tmp/pip-jDKbjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:30:38 INFO - Running setup.py (path:/tmp/pip-oTPIiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:30:39 INFO - Running setup.py (path:/tmp/pip-pHyySd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:30:39 INFO - Running setup.py (path:/tmp/pip-SejpRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:30:39 INFO - Running setup.py (path:/tmp/pip-FLCVDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:30:39 INFO - Running setup.py (path:/tmp/pip-I5VWlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:30:39 INFO - Running setup.py (path:/tmp/pip-Wdy7zF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:30:39 INFO - Running setup.py (path:/tmp/pip-qZ7m3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:30:39 INFO - Running setup.py (path:/tmp/pip-sxyLid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:30:39 INFO - Running setup.py (path:/tmp/pip-vqXZ7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:30:39 INFO - Running setup.py (path:/tmp/pip-GkVmFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:30:39 INFO - Running setup.py (path:/tmp/pip-DKakEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:30:39 INFO - Running setup.py (path:/tmp/pip-HFF8Mb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:30:39 INFO - Running setup.py (path:/tmp/pip-5O42hN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:30:39 INFO - Running setup.py (path:/tmp/pip-gvHlg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:30:39 INFO - Running setup.py (path:/tmp/pip-r8HDKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:30:40 INFO - Running setup.py (path:/tmp/pip-TnPZYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:30:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:30:40 INFO - Running setup.py install for manifestparser 18:30:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:30:40 INFO - Running setup.py install for mozcrash 18:30:40 INFO - Running setup.py install for mozdebug 18:30:40 INFO - Running setup.py install for mozdevice 18:30:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:30:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:30:40 INFO - Running setup.py install for mozfile 18:30:40 INFO - Running setup.py install for mozhttpd 18:30:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:30:40 INFO - Running setup.py install for mozinfo 18:30:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:30:40 INFO - Running setup.py install for mozInstall 18:30:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:30:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:30:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:30:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:30:40 INFO - Running setup.py install for mozleak 18:30:41 INFO - Running setup.py install for mozlog 18:30:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:30:41 INFO - Running setup.py install for moznetwork 18:30:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:30:41 INFO - Running setup.py install for mozprocess 18:30:41 INFO - Running setup.py install for mozprofile 18:30:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:30:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:30:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:30:41 INFO - Running setup.py install for mozrunner 18:30:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:30:41 INFO - Running setup.py install for mozscreenshot 18:30:41 INFO - Running setup.py install for moztest 18:30:41 INFO - Running setup.py install for mozversion 18:30:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:30:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:30:41 INFO - Cleaning up... 18:30:41 INFO - Return code: 0 18:30:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:30:41 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')]} 18:30:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:41 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')]} 18:30:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:41 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 0x7f40bc435f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22df410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236e160>, '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 0x236f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x236f4f0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1458091168.268648-229101067', '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 18:30:41 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 18:30:41 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 18:30:41 INFO - Using env: {'DISPLAY': ':0', 18:30:41 INFO - 'HOME': '/home/cltbld', 18:30:41 INFO - 'LANG': 'en_US.UTF-8', 18:30:41 INFO - 'LANGUAGE': 'en_US:en', 18:30:41 INFO - 'LOGNAME': 'cltbld', 18:30:41 INFO - 'MAIL': '/var/mail/cltbld', 18:30:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:41 INFO - 'MOZ_NO_REMOTE': '1', 18:30:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:41 INFO - 'NO_EM_RESTART': '1', 18:30:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:41 INFO - 'PWD': '/builds/slave/test', 18:30:41 INFO - 'SHELL': '/bin/bash', 18:30:41 INFO - 'SHLVL': '1', 18:30:41 INFO - 'TERM': 'linux', 18:30:41 INFO - 'TMOUT': '86400', 18:30:41 INFO - 'USER': 'cltbld', 18:30:41 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1458091168.268648-229101067', 18:30:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:41 INFO - '_': '/tools/buildbot/bin/python'} 18:30:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:30:42 INFO - Running setup.py (path:/tmp/pip-kaUTHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:30:42 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)) 18:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:30:42 INFO - Running setup.py (path:/tmp/pip-W7jNVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:30:42 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)) 18:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:30:42 INFO - Running setup.py (path:/tmp/pip-vaOULv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:30:42 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)) 18:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:30:42 INFO - Running setup.py (path:/tmp/pip-wCMERA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:30:42 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)) 18:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:30:42 INFO - Running setup.py (path:/tmp/pip-YcWybS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:30:42 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)) 18:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:30:42 INFO - Running setup.py (path:/tmp/pip-a3kGV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:30:42 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)) 18:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:30:42 INFO - Running setup.py (path:/tmp/pip-54yIFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:30:42 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)) 18:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:30:42 INFO - Running setup.py (path:/tmp/pip-7h5hdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:30:42 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)) 18:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:30:42 INFO - Running setup.py (path:/tmp/pip-Bqf0Je-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:30:42 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)) 18:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:30:42 INFO - Running setup.py (path:/tmp/pip-gM2eN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:30:42 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)) 18:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:30:42 INFO - Running setup.py (path:/tmp/pip-CX43Dj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:30:42 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)) 18:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:30:42 INFO - Running setup.py (path:/tmp/pip-aQcgx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:30:42 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)) 18:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:30:42 INFO - Running setup.py (path:/tmp/pip-gbsc7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:30:43 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)) 18:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:30:43 INFO - Running setup.py (path:/tmp/pip-KddV7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:30:43 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)) 18:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:30:43 INFO - Running setup.py (path:/tmp/pip-9Cjl0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:30:43 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)) 18:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:30:43 INFO - Running setup.py (path:/tmp/pip-gSo4Qc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:30:43 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)) 18:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:30:43 INFO - Running setup.py (path:/tmp/pip-U1wXpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:30:43 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)) 18:30:43 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)) 18:30:43 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)) 18:30:43 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)) 18:30:43 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)) 18:30:43 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)) 18:30:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:30:43 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 18:30:43 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 18:30:43 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 18:30:43 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 18:30:43 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 18:30:43 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 18:30:45 INFO - Downloading blessings-1.6.tar.gz 18:30:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:30:45 INFO - Installing collected packages: blessings 18:30:45 INFO - Running setup.py install for blessings 18:30:45 INFO - Successfully installed blessings 18:30:45 INFO - Cleaning up... 18:30:45 INFO - Return code: 0 18:30:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:30:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:30:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:30:45 INFO - Reading from file tmpfile_stdout 18:30:45 INFO - Current package versions: 18:30:45 INFO - argparse == 1.2.1 18:30:45 INFO - blessings == 1.6 18:30:45 INFO - blobuploader == 1.2.4 18:30:45 INFO - docopt == 0.6.1 18:30:45 INFO - manifestparser == 1.1 18:30:45 INFO - mozInstall == 1.12 18:30:45 INFO - mozcrash == 0.17 18:30:45 INFO - mozdebug == 0.1 18:30:45 INFO - mozdevice == 0.48 18:30:45 INFO - mozfile == 1.2 18:30:45 INFO - mozhttpd == 0.7 18:30:45 INFO - mozinfo == 0.9 18:30:45 INFO - mozleak == 0.1 18:30:45 INFO - mozlog == 3.1 18:30:45 INFO - moznetwork == 0.27 18:30:45 INFO - mozprocess == 0.22 18:30:45 INFO - mozprofile == 0.28 18:30:45 INFO - mozrunner == 6.11 18:30:45 INFO - mozscreenshot == 0.1 18:30:45 INFO - mozsystemmonitor == 0.0 18:30:45 INFO - moztest == 0.7 18:30:45 INFO - mozversion == 1.4 18:30:45 INFO - psutil == 3.1.1 18:30:45 INFO - requests == 1.2.3 18:30:45 INFO - wsgiref == 0.1.2 18:30:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:30:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:30:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:45 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 0x7f40bc435f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22df410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236e160>, '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 0x236f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x236f4f0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1458091168.268648-229101067', '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 18:30:45 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 18:30:45 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 18:30:45 INFO - Using env: {'DISPLAY': ':0', 18:30:45 INFO - 'HOME': '/home/cltbld', 18:30:45 INFO - 'LANG': 'en_US.UTF-8', 18:30:45 INFO - 'LANGUAGE': 'en_US:en', 18:30:45 INFO - 'LOGNAME': 'cltbld', 18:30:45 INFO - 'MAIL': '/var/mail/cltbld', 18:30:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:45 INFO - 'MOZ_NO_REMOTE': '1', 18:30:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:45 INFO - 'NO_EM_RESTART': '1', 18:30:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:45 INFO - 'PWD': '/builds/slave/test', 18:30:45 INFO - 'SHELL': '/bin/bash', 18:30:45 INFO - 'SHLVL': '1', 18:30:45 INFO - 'TERM': 'linux', 18:30:45 INFO - 'TMOUT': '86400', 18:30:45 INFO - 'USER': 'cltbld', 18:30:45 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1458091168.268648-229101067', 18:30:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:45 INFO - '_': '/tools/buildbot/bin/python'} 18:30:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:45 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)) 18:30:45 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)) 18:30:45 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)) 18:30:45 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)) 18:30:45 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)) 18:30:45 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)) 18:30:45 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)) 18:30:45 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)) 18:30:45 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)) 18:30:45 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)) 18:30:45 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)) 18:30:45 INFO - Cleaning up... 18:30:45 INFO - Return code: 0 18:30:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:30:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:30:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f40bc435f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22df410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236e160>, '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 0x236f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x236f4f0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1458091168.268648-229101067', '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 18:30:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:30:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:30:45 INFO - Using env: {'DISPLAY': ':0', 18:30:45 INFO - 'HOME': '/home/cltbld', 18:30:45 INFO - 'LANG': 'en_US.UTF-8', 18:30:45 INFO - 'LANGUAGE': 'en_US:en', 18:30:45 INFO - 'LOGNAME': 'cltbld', 18:30:45 INFO - 'MAIL': '/var/mail/cltbld', 18:30:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:45 INFO - 'MOZ_NO_REMOTE': '1', 18:30:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:45 INFO - 'NO_EM_RESTART': '1', 18:30:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:45 INFO - 'PWD': '/builds/slave/test', 18:30:45 INFO - 'SHELL': '/bin/bash', 18:30:45 INFO - 'SHLVL': '1', 18:30:45 INFO - 'TERM': 'linux', 18:30:45 INFO - 'TMOUT': '86400', 18:30:45 INFO - 'USER': 'cltbld', 18:30:45 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1458091168.268648-229101067', 18:30:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:45 INFO - '_': '/tools/buildbot/bin/python'} 18:30:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:46 INFO - Downloading/unpacking jsonschema 18:30:46 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 18:30:46 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 18:30:46 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 18:30:46 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 18:30:46 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 18:30:46 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 18:30:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:30:47 INFO - Downloading/unpacking functools32 (from jsonschema) 18:30: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 18:30: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 18:30: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 18:30: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 18:30: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 18:30: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 18:30:48 INFO - Downloading functools32-3.2.3-2.tar.gz 18:30:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:30:48 INFO - warning: no files found matching '*.txt' 18:30:48 INFO - no previously-included directories found matching 'build' 18:30:48 INFO - no previously-included directories found matching 'dist' 18:30:48 INFO - no previously-included directories found matching '.git*' 18:30:48 INFO - Installing collected packages: jsonschema, functools32 18:30:48 INFO - Running setup.py install for functools32 18:30:48 INFO - warning: no files found matching '*.txt' 18:30:48 INFO - no previously-included directories found matching 'build' 18:30:48 INFO - no previously-included directories found matching 'dist' 18:30:48 INFO - no previously-included directories found matching '.git*' 18:30:48 INFO - Successfully installed jsonschema functools32 18:30:48 INFO - Cleaning up... 18:30:48 INFO - Return code: 0 18:30:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:30:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f40bc435f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22df410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236e160>, '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 0x236f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x236f4f0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1458091168.268648-229101067', '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 18:30:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 18:30:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 18:30:48 INFO - Using env: {'DISPLAY': ':0', 18:30:48 INFO - 'HOME': '/home/cltbld', 18:30:48 INFO - 'LANG': 'en_US.UTF-8', 18:30:48 INFO - 'LANGUAGE': 'en_US:en', 18:30:48 INFO - 'LOGNAME': 'cltbld', 18:30:48 INFO - 'MAIL': '/var/mail/cltbld', 18:30:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:48 INFO - 'MOZ_NO_REMOTE': '1', 18:30:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:48 INFO - 'NO_EM_RESTART': '1', 18:30:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:48 INFO - 'PWD': '/builds/slave/test', 18:30:48 INFO - 'SHELL': '/bin/bash', 18:30:48 INFO - 'SHLVL': '1', 18:30:48 INFO - 'TERM': 'linux', 18:30:48 INFO - 'TMOUT': '86400', 18:30:48 INFO - 'USER': 'cltbld', 18:30:48 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1458091168.268648-229101067', 18:30:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:48 INFO - '_': '/tools/buildbot/bin/python'} 18:30:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:48 INFO - Downloading/unpacking flake8 18:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:30:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:30: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 18:30: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 18:30: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 18:30: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 18:30: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 18:30: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 18:30:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:30:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:30: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 18:30: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 18:30: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 18:30: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 18:30: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 18:30: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 18:30:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:30: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 18:30: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 18:30: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 18:30: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 18:30: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 18:30: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 18:30:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:30:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:30:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:30:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:30:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:30:51 INFO - no previously-included directories found matching 'docs/_build' 18:30:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:30:51 INFO - Running setup.py install for pep8 18:30:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:30:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:30:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:30:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:30:51 INFO - no previously-included directories found matching 'docs/_build' 18:30:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:30:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:30:51 INFO - Cleaning up... 18:30:51 INFO - Return code: 0 18:30:51 INFO - Running post-action listener: _resource_record_post_action 18:30:51 INFO - Running post-action listener: _start_resource_monitoring 18:30:51 INFO - Starting resource monitoring. 18:30:51 INFO - ##### 18:30:51 INFO - ##### Running install step. 18:30:51 INFO - ##### 18:30:51 INFO - Running pre-action listener: _resource_record_pre_action 18:30:51 INFO - Running main action method: install 18:30:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:30:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:30:51 INFO - Reading from file tmpfile_stdout 18:30:51 INFO - Detecting whether we're running mozinstall >=1.0... 18:30:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:30:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:30:51 INFO - Reading from file tmpfile_stdout 18:30:51 INFO - Output received: 18:30:51 INFO - Usage: mozinstall [options] installer 18:30:51 INFO - Options: 18:30:51 INFO - -h, --help show this help message and exit 18:30:51 INFO - -d DEST, --destination=DEST 18:30:51 INFO - Directory to install application into. [default: 18:30:51 INFO - "/builds/slave/test"] 18:30:51 INFO - --app=APP Application being installed. [default: firefox] 18:30:51 INFO - mkdir: /builds/slave/test/build/application 18:30:51 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'] 18:30:51 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 18:31:07 INFO - Reading from file tmpfile_stdout 18:31:07 INFO - Output received: 18:31:07 INFO - /builds/slave/test/build/application/firefox/firefox 18:31:07 INFO - Running post-action listener: _resource_record_post_action 18:31:07 INFO - ##### 18:31:07 INFO - ##### Running run-tests step. 18:31:07 INFO - ##### 18:31:07 INFO - Running pre-action listener: _resource_record_pre_action 18:31:07 INFO - Running main action method: run_tests 18:31:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:31:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:31:07 INFO - Python 2.7.3 18:31:07 INFO - Return code: 0 18:31:07 INFO - grabbing minidump binary from tooltool 18:31:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:07 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 0x236e160>, '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 0x236f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x236f4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:31:07 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 18:31:07 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 18:31:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:31:07 INFO - Return code: 0 18:31:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:31:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:31:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:31:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:31:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:31:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:31:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:31:08 INFO - Return code: 0 18:31:08 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Lksn9GWDQH6qrPc0bUbJAw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 18:31:08 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Lksn9GWDQH6qrPc0bUbJAw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 18:31:08 INFO - Using env: {'DISPLAY': ':0', 18:31:08 INFO - 'HOME': '/home/cltbld', 18:31:08 INFO - 'LANG': 'en_US.UTF-8', 18:31:08 INFO - 'LANGUAGE': 'en_US:en', 18:31:08 INFO - 'LOGNAME': 'cltbld', 18:31:08 INFO - 'MAIL': '/var/mail/cltbld', 18:31:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:31:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:31:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:08 INFO - 'MOZ_NO_REMOTE': '1', 18:31:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:31:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:08 INFO - 'NO_EM_RESTART': '1', 18:31:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:08 INFO - 'PWD': '/builds/slave/test', 18:31:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:31:08 INFO - 'SHELL': '/bin/bash', 18:31:08 INFO - 'SHLVL': '1', 18:31:08 INFO - 'TERM': 'linux', 18:31:08 INFO - 'TMOUT': '86400', 18:31:08 INFO - 'USER': 'cltbld', 18:31:08 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1458091168.268648-229101067', 18:31:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:08 INFO - '_': '/tools/buildbot/bin/python'} 18:31:08 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Lksn9GWDQH6qrPc0bUbJAw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 18:31:08 INFO - mozversion application_buildid: 20160315170242 18:31:08 INFO - mozversion application_changeset: 55e4902a0ea4abe5f7d50a17a3b540b378b344ba 18:31:08 INFO - mozversion application_display_name: Nightly 18:31:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:31:08 INFO - mozversion application_name: Firefox 18:31:08 INFO - mozversion application_remotingname: firefox 18:31:08 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:31:08 INFO - mozversion application_vendor: Mozilla 18:31:08 INFO - mozversion application_version: 48.0a1 18:31:08 INFO - mozversion platform_buildid: 20160315170242 18:31:08 INFO - mozversion platform_changeset: 55e4902a0ea4abe5f7d50a17a3b540b378b344ba 18:31:08 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:31:08 INFO - mozversion platform_version: 48.0a1 18:31:08 INFO - using testdate: 1458091868 18:31:08 INFO - actual date: 1458091868 18:31:08 INFO - starting webserver on 'localhost:56018' 18:31:08 INFO - SUITE-START | Running 2 tests 18:31:08 INFO - TEST-START | dromaeo_css 18:31:08 INFO - operating with platform_type : linux_ 18:31:08 INFO - Initialising browser for dromaeo_css test... 18:31:08 INFO - TEST-INFO | started process 12637 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpggvt_J/profile http://localhost:56018/getInfo.html) 18:31:13 INFO - PROCESS | 12637 | __metrics Screen width/height:1600/1200 18:31:13 INFO - PROCESS | 12637 | colorDepth:24 18:31:13 INFO - PROCESS | 12637 | Browser inner width/height: 1024/697 18:31:13 INFO - PROCESS | 12637 | __metrics 18:31:13 ERROR - PROCESS | 12637 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:31:14 INFO - TEST-INFO | 12637: exit 0 18:31:14 INFO - Browser initialized. 18:31:14 INFO - Running cycle 1/1 for dromaeo_css test... 18:31:14 INFO - TEST-INFO | started process 12730 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpggvt_J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:31:26 INFO - PROCESS | 12730 | RSS: Main: 154722304 18:31:26 INFO - PROCESS | 12730 | 18:32:17 INFO - PROCESS | 12730 | 1458091937854 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] 18:34:28 INFO - PROCESS | 12730 | Cycle 1(1): loaded http://localhost:56018/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56018/tests/dromaeo/cssquery-ext.html) 18:34:29 INFO - PROCESS | 12730 | RSS: Main: 241156096 18:34:29 INFO - PROCESS | 12730 | 18:37:32 INFO - PROCESS | 12730 | Cycle 1(1): loaded http://localhost:56018/tests/dromaeo/cssquery-ext.html (next: http://localhost:56018/tests/dromaeo/cssquery-jquery.html) 18:37:32 INFO - PROCESS | 12730 | RSS: Main: 231837696 18:37:32 INFO - PROCESS | 12730 | 18:40:34 INFO - PROCESS | 12730 | Cycle 1(1): loaded http://localhost:56018/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56018/tests/dromaeo/cssquery-mootools.html) 18:40:35 INFO - PROCESS | 12730 | RSS: Main: 230612992 18:40:35 INFO - PROCESS | 12730 | 18:43:37 INFO - PROCESS | 12730 | Cycle 1(1): loaded http://localhost:56018/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56018/tests/dromaeo/cssquery-prototype.html) 18:43:37 INFO - PROCESS | 12730 | RSS: Main: 195280896 18:43:37 INFO - PROCESS | 12730 | 18:46:40 INFO - PROCESS | 12730 | Cycle 1(1): loaded http://localhost:56018/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56018/tests/dromaeo/cssquery-yui.html) 18:46:41 INFO - PROCESS | 12730 | RSS: Main: 200708096 18:46:41 INFO - PROCESS | 12730 | 18:49:43 INFO - PROCESS | 12730 | Cycle 1(1): loaded http://localhost:56018/tests/dromaeo/cssquery-yui.html (next: http://localhost:56018/tests/dromaeo/cssquery-dojo.html) 18:49:44 INFO - PROCESS | 12730 | RSS: Main: 302948352 18:49:44 INFO - PROCESS | 12730 | 18:49:44 INFO - PROCESS | 12730 | __start_tp_report 18:49:44 INFO - PROCESS | 12730 | _x_x_mozilla_page_load 18:49:44 INFO - PROCESS | 12730 | _x_x_mozilla_page_load_details 18:49:44 INFO - PROCESS | 12730 | |i|pagename|runs| 18:49:44 INFO - PROCESS | 12730 | |0;dojo.html;2561.0955021134528;2630.8947642094317;2640.2079376187153;2655.2565281721127;2673.997251030863;4531.456225252966;4569.657275704323;4584.816607335707;4595.770211489425;4648.511906249837;4556.270996640538;4621.699589526678;4661.37071495348;4663.510331415204;4666.766661666911;4208.684348673846;4269.210196113729;4272.914541709171;4307.849225277116;4313.525512193672;4228.154369126171;4269.124829409979;4306.2464068787995;4316.11519638475;4353.738775673454;4185.58144185582;4252.319628859368;4310.3534469829465;4311.50417701962;4328.4156638853665;4238.131183107455;4274.551172126944;4278.828846846122;4300.397944287803;4314.870553883388;4153.169366126786;4240.660747140221;4252.447181866338;4274.700770946035;4291.6137547620865;4496.348029535699;4525.660575456854;4566.54334566544;4598.747068911209;4603.723776573416;4919.458859525449;4970.826021089245;4972.627052971042;4981.850544483671;5018.322526458918;4851.951480485185;4971.304017437562;4992.350994370709;5000.599952003831;5004.174311238641;4629.953700462986;4654.348391225231;4680.251159814414;4709.576138147549;4713;5055.469175736494;5074.2895994560795;5076.132025226332;5083.74581270935;5122.513361230677;4832.251001094836;4839.612830973514;4848.806047758121;4863.076015557032;4866.732329721899;4959.355283813081;4975.527324904128;4975.925361119586;4996.375453068366;5028.321176641107;4926.359573255454;4937.753112344369;4943.555080042814;4945.925811112764;4995.925061124086;4835.492273311252;4861.149298872683;4922.90154196914;4936;4990.226514890198;3870.9419358709642;3883.650471457582;3891.552471465761;3925.430812532167;3934.1738234970403;3436.536067630838;3439.0542600784484;3473.1317170707325;3480.112571294304;3483.6168021517615;4124.340105583093;4183.435236243129;4192.413062171298;4215.241256573846;4266.360045993064;4885.389326334208;4890.779914903766;4892.975535122373;4924.285978533093;4928.162212423897;4171.791410429466;4202.075543380452;4204.831806727697;4210.242156411875;4246.044639956047;4382.605565499057;4397.274449715761;4420.778961051935;4477.552244775561;4510.932336014962;4675.95324046762;4677.415323084614;4704.88237794051;4710.929336059893;4745.762711864324;4755.286706993978;4958.45456999737;4963.528464795839;4986.152354099884;5036.093503169464;4602.585767280827;4646.094011667692;4658.58072773452;4693.2021556336185;4708.81164753406;4848.927266091082;4854.296127061627;4870.805167793249;4877;4922.7538623067985;4859.878503037452;4934.851954441372;4952.8761780955765;4954.256861470808;5001.449840517613;4712.269598212282;4764.571188593043;4771.355866958055;4785.665003449725;4811.446683631427;4751.334813126235;4786.736729479912;4790.880227994328;4792.2332426811545;4830.66185367035;4595.47152077502;4635.096156249499;4725.149473094876;4744.4543877454535;4787.640926930564;4811.182099043241;4829.492903245108;4858.319835223001;4872.829450969199;4888.193448081027;4726.078414709099;4739.834105806281;4740.810367585258;4747.026859493864;4766 18:49:44 INFO - PROCESS | 12730 | |1;ext.html;510.3034358101193;516.855280521454;524.0619291468272;525.8790478190018;544.8065936592508;26917.19248422548;27351.316217094558;35204.94385168446;35280.82359588205;35321.64678353216;38388;38719.806400968024;38893.22213555727;38923.416148757795;38946.61053389472;7793.999999999985;7986;7989.081255655587;7990.320822730075;7993.44045916786;7746.690132394726;7781.182975787546;7848.843023139534;7856.764297071097;7857.960710196441;8048.31589314906;8103.311218546431;8109.553974531398;8117.8782318264975;8123.715669951553;7991.280784729373;8021.799455013613;8054.9597252013955;8061.758147255533;8065.95967020167;7924.80187995299;8046.476978996347;8053.758387248392;8057.274845263954;8063;37455;37899;37937.62062379396;37957.240855183016;37964.43053354202;3017.1250337402125;3160.98419507901;3391.5421418108485;3506.6493350664728;3913.2173565287057;28650.713492865223;28834.567481487793;28840.711592884014;29097.41805163906;29122.56316155238;3569.785812851237;3619.2782369969577;3724.255148970217;3724.515812944327;3766.868159614428;223515;224289;224381.99999999837;224966;226391;42062.15875682469;43194.352084718754;43202.135957280676;43250.351244731355;56348.71825640846;39901.40147897784;40058.19883602312;40275.79862100671;40322.79838600847;40337;13942.093763905314;14089;14111.435542578181;14119.929400353138;14123.011389202657;10933.18001149917;11018.39398833072;11022.724431889266;11028.613998510014;11087.72280692973;14725;14832;14930.701385972437;14962.551123466314;15094.16982065975;5740.292591596763;5921.259842519685;5966.224390829165;5979.222701048836;5980.73086711099;854.7179430787825;878.7934835313696;903.8101998580372;1041.7551875309296;1072.51736718477;27804;29124.708752912622;30570.54144187839;30778.685453046808;31017;985.261054209343;997.3517213811081;1000.8298589239847;1013.5996281468779;1050.1336397472116;14270.215138167501;14688.55934321972;14778.704425911637;15008.924955375373;15024;345832.1667133337;352123;352417;352911;353405;49170;50611.24083138756;50708;50735.49264507381;50817.745911270205;1062.792755412687;1223.908206884505;1257.8867901888873;1269.6127681057367;1303.7066660001424;25651.486970260863;27791.16626501208;28067.157985260474;28241.858790705915;28327.71672283251;37555.81222093872;37969.24061518699;38338.6166138335;38486.80756596199;38594;178745;179322;179645;180376;197355;26786.866065669547;30814.537781932842;31013.379732404774;31070.533941990438;31610.683893160774;34867.47698784571;34888.12779680528;35666.64333356633;36038.819805901854;36127.096822579646;30851.845740771154;31070.844645776626;31096;31199.84400077985;31311.68688313088;30569.388612228075;30766.384672306875;30921.226969325948;30942.22644433907;31176.844115779277;32894.67105329012;33436;33546.832265838515;33823.66176338303;33842.15394615154;27726.861365693043;28998.56502152427;31638.525422118226;31799;31811;24695.25914222576;24956.875215623804;24993;25224.873875631238;25377.492450150523 18:49:44 INFO - PROCESS | 12730 | |2;jquery.html;351.6483516483515;354.89175801380577;359.92081742016757;361.31711066085086;363.1447940101062;15526.223688815557;15842.527657420229;17128.57178570535;17526.912365438187;17652.205650745716;16333.83666163338;16793.83206167938;16823.242954067067;16874.662506749857;16896.324147034135;5026.673266237701;5046.697198168104;5257.263983042377;5262.526372626463;5263.789448422059;5135.383753949532;5183.611229157809;5195.168772996321;5207.687538747668;5225.085610018251;4956.851294461154;5151.536361727443;5177.534021938025;5182.300389447433;5197.714125723083;5142.794288228485;5162.535371816554;5173.844784656466;5192.636515443921;5193.480651934795;4635.096156249533;4638.0491999140095;4638.8608341749805;4639.652026098056;4639.953600463986;18260.81739182618;18388.632227355512;18985.24059037637;19159.137838797287;19191.232350705955;1893.5739458621838;1937.5834195648004;1942.1842826013108;1964.5383334916426;1996.0418998880618;9565.808683826353;9742.707718768448;9745;9858.605655773761;10814.891851081467;1849.2602958816447;1849.2650165787597;1861.6928206845855;1869.3176990398542;1872.9344472943383;42640.57359426397;43910.78044609789;53521.732391338184;57014.71492642552;57674.423255767324;10432.165426765841;10503.579856805794;10515.84226236607;10552.208584356204;10698.251122421356;12033.097517686208;13586.93206533961;13606.455741770416;13608.65978350549;13621.114627549177;7526.736564220226;7733.651985660659;7768.7669369918995;7868;7872.645730942121;7547.433942454338;7550.962245188739;7661.885071723928;7699.422543309162;7752.4573279869865;4448.666350023696;4521.253993091103;4534.682572219913;4599.103174880866;4614.907701845944;1787.6245988342334;1822.3075231412245;1826.8903865767832;1835.6787562176567;1867.6918308479221;820.1716266570687;915.8214148241029;950.14486961735;996.2926322311096;1035.6530562261726;16077.75883361727;16408.75386869198;16444.506664800076;16965.406210782563;16979.575510612085;881.5680316644798;885.198895000026;885.6457417033238;888.8488956877217;931.753085432361;9395.859062114074;9609.279304052085;9755.707328780149;9790.5594248259;9792.87926158253;256599;261278;261311;262868;432368;65609.34390656128;66517.33482665208;70505.6474717623;73463.63268183732;77311;418.8240938805709;422.7653652223046;431.7474277547607;433.14021666991624;433.17696376883544;8122.350211982909;10086.394816311045;10243.692689219335;10396.324238924446;10497.971779110752;33433;33468;34674.826625866706;34710.826445867606;34934.47598285977;41444.58555414528;44093.55906441023;45012;45235.321470178635;45587.316190257836;7537.170911199873;7676.53940763556;7786.571738554434;7799.103103143211;8006.359491240803;11756.764864702487;11907.345096019802;11955.76088478243;12004.639860804189;12167.574134905235;10366.948165259126;10609.787804244026;10769.24615276923;10804.297720648132;10845;10599.841002385125;10606.257561970897;10617.362958222531;10922.235443518877;11123.833142502706;10725.08836748885;10738.946305268737;10840.728981775203;10879.728006799893;11051;7723.652435640522;7942.285194332538;7981.082175549654;8002.83994320122;8216.178382161735;10426.635067772591;10537.841932371173;10895.945520272347;10945.179111566506;11089.168312376765 18:49:44 INFO - PROCESS | 12730 | |3;mootools.html;1324.9138805977605;1430.4278288684525;1451.4266864588485;1619.8299178586249;1824.297645406519;7094.574325540465;7208.1710603280635;7260;7261.673224704888;7291.817704557382;7091.219965803757;7235.095613048369;7242.31198036187;7252.476979834241;7256.600886951215;1938.7479627648386;1987.6819708846588;2230.453538882976;2274.94312642184;2301.2405906050963;2258.7854153855355;2271.738750043741;2273.193016479151;2273.454370950968;2274.2040285899966;2163.3942496101117;2212.1814928476406;2213.701150344699;2215.789499997498;2219.9556008879813;2224.7219097612797;2232.229880691167;2241.047554789216;2242.091952759127;2272.0684519346987;2260.095961615367;2271.2277825539395;2292.472731271817;2293.587154312223;2294.219965211836;7241.094863142107;7300.488965772398;7303.7078516859265;7307.050083489165;7315.085614298213;4602.424696912886;4703.341532185496;4725.881852953669;4733;4735.479097299294;2947.086403214989;3082.1678146900435;3110.766692498049;3132.451820931328;3136.7490600751885;1017.2319898476677;1038.2057725839738;1042.9843552346722;1048.5334026358273;1079.2876701377131;10164.644237451654;10280.48597570126;10298.073173414428;10330.89669103307;10339.896601033894;4097.303458412077;4308.870733877989;4324.827006919688;4346.978265108717;4386.670999675037;7839.960800196077;7880.369570434352;7900.091489478784;7904.841903161904;7904.920950790533;4687;4692.085043416501;4693.225617773098;4698;4698.01341718243;3660.103274697716;4132.834686612562;4157.729747566398;4188.267053265667;4238.449001629769;3348.4140275452187;3414.2830005698584;3419.213580876363;3442.604100528421;3468.8612455502002;1076.6985244131656;1077.7467295185625;1081.643057790927;1082.3992684060265;1090.3022065877844;1201.9579314723942;1205.2226314027403;1222.4010234984971;1247.6132398956352;1269.4922031187598;6839.62382068991;6923.307669233036;6957.130358705162;7009.544379615309;7043.471739619549;476.3141076849326;480.5962991087503;486.8709791905148;489.2538878210686;492.85214435669155;5556.666600003932;5570.359408668055;5607.046802043662;5627.746751396197;5661.716914154275;8927.196552310323;9147.2682185425;9252.722418327461;9394.95302523483;9395.34232603725;9055.909440905638;9119.81760364789;9184.12750788674;9227.492487913096;9248.583813728399;6906.585604863624;6975.197852246955;6984.5460045097925;7062.152541694927;7208;6837.726490940307;6846.657667116724;6866.176058872968;6870.862582748417;6900.413464855544;8084.434089613671;8190.959045204974;8236.83526329458;8320.375971802017;8336.291415229773;8351.415400921876;8466.576671166295;8487.745367638981;8493.150684931457;8607.827843443221;6133.9079913802225;6192.659403732658;6346.650934198663;6353.650549219838;6358.205224346957;6814.625195614289;6821.693023813841;6834.179898412222;6848.897266541106;6850.520463567503;6044.727987240497;6175;6214.9067763982675;6247.250329960434;6273.153124328157;5998.520118390606;6004.039353703386;6014.308354539284;6053.667048312385;6095.969520152371;6568.27748947625;6573.1783527059115;6626.27111017778;6632.867342653023;6635.734570617121;6081.969590152021;6116.877662446637;6136;6155.784547540815;6162.291336496361;6197.721102550487;6250.343713910156;6260.467860231749;6262.15460912771;6262.467690246198 18:49:44 INFO - PROCESS | 12730 | |4;prototype.html;328.11245580704195;328.42361655294945;328.7747892693505;329.12124627245254;335.7045799696267;5367.543758780504;5370.865728356793;5382.730863456822;5387.5151236388665;5397.217403476494;5273.5781137509;5278.340207474066;5297.8940421191555;5325.600579956509;5326.493983071612;3926.3325234710023;4049.5343035550845;4120.896977575555;4145.709800313979;4176.2691528982305;4140.565240649734;4159.896002599929;4162.41726158338;4171.082361880397;4173.061061261207;4112.650424713903;4117.752934823905;4123.484564429446;4127.277726397883;4129.463169787923;3907.785071821049;4022.7787471689194;4099.364598487239;4103.158852435274;4124.608162224584;3586.444101164324;3588.5155504006884;3591.766535175231;3601.45978103284;3602.5316708827945;5117.513836185593;5135.897282054375;5137.614678899097;5146.536811686929;5146.742662866879;4725.929111063302;4730.929036064462;4732.597729193023;4733.526647335273;4739.668223224376;5569.275994120779;5577.079781835992;5580.19087232349;5583.078791999315;5594.272744543184;3947.2894878921784;3975.920481590352;3985.940210896839;3987.202559488114;3987.5813039631003;5661.688607126606;5867.8533036674;5873.2952045754355;5901.940980590182;5907.379725128885;3959.6832253419657;4022.597740225954;4024.3158663027357;4030.153667729751;4032.8185231664647;4076.694247931417;4078.836846526165;4083.4895638045246;4088.3867419887256;4092.386142078712;4692.249240121564;4694.43666759991;4696.976515117402;4704.458987216514;4704.553067458586;5608.691521966331;5619.157126431068;5621.128725047624;5630.662160270397;5633.126865335879;1421.9431222750975;1437.20953475588;1438.7266419380285;1439.100562148657;1439.172475826404;888.3603805260202;911.9361644684941;957.8084383123403;984.778424854402;993.9155171810332;4730.526947305242;4793.496682848251;4870.878228044327;4907.337509436252;4917.164082105979;5815.273090863642;5823;5829.650220986754;5839.065749480148;5842.298924129132;4903.068417000758;4904.583110435653;4905.386826646669;4905.583025442877;4907.3620429343955;3099.1942095055447;3131.765117616188;3134.4828103363147;3135.0281412762115;3140;5463.153211252183;5466.289382380344;5472.151816468454;5474.178873169057;5476.67139971595;5819.6217245879725;5991.071383935497;5991.370906054889;5998.430149135826;6001.969990150022;5441.755121019563;5452.972735136299;5459.918101228484;5464.207689885024;5467.20725494801;5832.037713777179;5832.883342333214;5835.708214589169;5838.94161058384;5843.970780146072;5723.42765723441;5726.284214473191;5726.627769194989;5727.570432217517;5729.369769325454;5439.265699130567;5455.563554915518;5458.181272809111;5459.808906688247;5463.7814487420055;4017.4978127734034;4186.162767446462;4196.412502249748;4197.076643138505;4197.559256278169;5735.168400581976;5744.798932037359;5746.281714785652;5751.338596061507;5755.3381361144;5549.861253468695;5553.333599968029;5554.750036248298;5557.472040156179;5558.555315574664;5502.312210973629;5532.861678458071;5539.972300138635;5542.445755424425;5564.972175139098;5322.201669749414;5477.616566840283;5480.972595137158;5482.39693633692;5483.479069488392;5555.8888822222525;5567.944320556905;5585.720713964367;5604.551635869039;5607.691576963306;5439.184122381516;5439.48324909133;5446.754896029767;5449.128139497661;5461.481159289861 18:49:44 INFO - PROCESS | 12730 | |5;yui.html;689.3761146162722;713.6556017008793;713.9714411423544;780.7891869195315;790.1505881177735;11900;12143.817842732366;12181.57364492243;12229.938850305758;12257;11985.820212696817;12014.819777703342;12028.097892658041;12060.638180854588;12087.879121208785;646.4860435953404;800.3957012455588;805.19078326282;814.4828034198297;828.4780588229407;815.3192084609358;818.0633175014605;821.2608652213027;821.4783612406105;821.9753407397787;869.3045563549167;869.5739087846973;869.7521206456162;870.2559311788425;872.742540950418;685.6811582614083;851.3487182305511;867.0159369116036;868.1145231863527;868.192580899763;633.7243299164832;637.0857819029707;637.3180696654581;637.4454224824433;638.2883085359837;12449.377531123408;12514.18657787241;12525.37373131349;12617.87382126176;12621.621351359474;11853.46659400329;12059.33673647949;12169.14815962883;12417.503299868085;12577.559785407559;9922.851157232648;9968.900310996869;10091;10130.189584833195;10402.375857448576;3351.7821341612716;3351.8603674750457;3355.832208389571;3474.3919814032442;3475.982620086909;44663.33005004928;44793.77603111963;44879.775601121786;45240.09519809618;45788;10076.29465937392;10104.747381315527;10221.182305415548;10246.282760206714;10254.384736915808;17519.912400437915;17566;17568.64862702739;17601.207945642476;17651.117444127998;6587.703553340111;6611.140551728341;6640.9667951660895;6673.933260667428;6903;3675.283319752676;3677.5035370225214;3718.386466233041;3786.110264087937;3816.2749077675708;2821.1818572614125;2859.2851787053237;2859.914202573926;2860.7425331720247;2864.484392809273;434.218406867637;453.57590652739793;505.0505050505027;513.4916432731569;522.8797376603402;597.474222684044;603.1345019896374;616.5087338737277;628.3684896678809;633.395107672172;8087.231712987257;8161.714339998071;8206.056303525052;8220.753377398687;8315.501069935823;553.6567328256507;583.7373182068002;588.4821357205632;610.7709608896664;631.5105793010362;3387.5934887813128;3442.4147894857933;3497.0557949353533;3561.269939662415;3634.2004758953517;53946.730266348415;54879.17681234785;55427.44572554223;57140;57393.42606573881;46130;46187.53812461899;46340.768296158305;46430.767846160554;46673.533264667596;43542;43875.12249755051;44027.77986110049;44386.66839994805;44488.3326750099;8765.342599305206;8806.60370283326;8811.471311721318;8827;8832.514211718417;32295.192620184684;32608.83695581602;32613;33825.830870845486;33981.15047123842;38858.6114138855;38875.6112438872;41277.587224128576;43082.353764694184;43099.353509698005;10878.836817447585;10888.237823352289;10893.727656808325;11111.38887361203;11192.104631629612;12199.451024704087;12201.938990305347;12401.565945191875;12450.315232662291;12827.358632068546;11312.20814542974;11383.146264030396;11654.067674585844;11959.521619135485;11979.28124312544;11004.39475828837;11371.772564548497;11406.942965285121;11746.119041071783;11749.941250293694;11326.433678315887;11481.885181148082;11586.420678966186;11927.224730392496;11989.1008174389;9353.334299724545;9513.952430237805;9608.519574021131;9614.471204083842;9769.413835169913;8776.56117194125;9132.803099521128;9486.620535178516;9528.428294302365;9566.808544492644 18:49:44 INFO - PROCESS | 12730 | __end_tp_report 18:49:44 INFO - PROCESS | 12730 | __start_cc_report 18:49:44 INFO - PROCESS | 12730 | _x_x_mozilla_cycle_collect,812 18:49:44 INFO - PROCESS | 12730 | __end_cc_report 18:49:44 INFO - PROCESS | 12730 | __startTimestamp1458092983997__endTimestamp 18:49:44 INFO - PROCESS | 12730 | 18:49:44 INFO - PROCESS | 12730 | ------- Summary: start ------- 18:49:44 INFO - PROCESS | 12730 | Number of tests: 6 18:49:44 INFO - PROCESS | 12730 | 18:49:44 INFO - PROCESS | 12730 | [#0] dojo.html Cycles:165 Average:4553.22 Median:4708.81 stddev:494.74 (10.5%) stddev-sans-first:470.93 18:49:44 INFO - PROCESS | 12730 | Values: 2561.1 2630.9 2640.2 2655.3 2674.0 4531.5 4569.7 4584.8 4595.8 4648.5 4556.3 4621.7 4661.4 4663.5 4666.8 4208.7 4269.2 4272.9 4307.8 4313.5 4228.2 4269.1 4306.2 4316.1 4353.7 4185.6 4252.3 4310.4 4311.5 4328.4 4238.1 4274.6 4278.8 4300.4 4314.9 4153.2 4240.7 4252.4 4274.7 4291.6 4496.3 4525.7 4566.5 4598.7 4603.7 4919.5 4970.8 4972.6 4981.9 5018.3 4852.0 4971.3 4992.4 5000.6 5004.2 4630.0 4654.3 4680.3 4709.6 4713.0 5055.5 5074.3 5076.1 5083.7 5122.5 4832.3 4839.6 4848.8 4863.1 4866.7 4959.4 4975.5 4975.9 4996.4 5028.3 4926.4 4937.8 4943.6 4945.9 4995.9 4835.5 4861.1 4922.9 4936.0 4990.2 3870.9 3883.7 3891.6 3925.4 3934.2 3436.5 3439.1 3473.1 3480.1 3483.6 4124.3 4183.4 4192.4 4215.2 4266.4 4885.4 4890.8 4893.0 4924.3 4928.2 4171.8 4202.1 4204.8 4210.2 4246.0 4382.6 4397.3 4420.8 4477.6 4510.9 4676.0 4677.4 4704.9 4710.9 4745.8 4755.3 4958.5 4963.5 4986.2 5036.1 4602.6 4646.1 4658.6 4693.2 4708.8 4848.9 4854.3 4870.8 4877.0 4922.8 4859.9 4934.9 4952.9 4954.3 5001.4 4712.3 4764.6 4771.4 4785.7 4811.4 4751.3 4786.7 4790.9 4792.2 4830.7 4595.5 4635.1 4725.1 4744.5 4787.6 4811.2 4829.5 4858.3 4872.8 4888.2 4726.1 4739.8 4740.8 4747.0 4766.0 18:49:44 INFO - PROCESS | 12730 | 18:49:44 INFO - PROCESS | 12730 | [#1] ext.html Cycles:180 Average:40462.50 Median:190349.82 stddev:69049.34 (36.3%) stddev-sans-first:69177.88 18:49:44 INFO - PROCESS | 12730 | Values: 510.3 516.9 524.1 525.9 544.8 26917.2 27351.3 35204.9 35280.8 35321.6 38388.0 38719.8 38893.2 38923.4 38946.6 7794.0 7986.0 7989.1 7990.3 7993.4 7746.7 7781.2 7848.8 7856.8 7858.0 8048.3 8103.3 8109.6 8117.9 8123.7 7991.3 8021.8 8055.0 8061.8 8066.0 7924.8 8046.5 8053.8 8057.3 8063.0 37455.0 37899.0 37937.6 37957.2 37964.4 3017.1 3161.0 3391.5 3506.6 3913.2 28650.7 28834.6 28840.7 29097.4 29122.6 3569.8 3619.3 3724.3 3724.5 3766.9 223515.0 224289.0 224382.0 224966.0 226391.0 42062.2 43194.4 43202.1 43250.4 56348.7 39901.4 40058.2 40275.8 40322.8 40337.0 13942.1 14089.0 14111.4 14119.9 14123.0 10933.2 11018.4 11022.7 11028.6 11087.7 14725.0 14832.0 14930.7 14962.6 15094.2 5740.3 5921.3 5966.2 5979.2 5980.7 854.7 878.8 903.8 1041.8 1072.5 27804.0 29124.7 30570.5 30778.7 31017.0 985.3 997.4 1000.8 1013.6 1050.1 14270.2 14688.6 14778.7 15008.9 15024.0 345832.2 352123.0 352417.0 352911.0 353405.0 49170.0 50611.2 50708.0 50735.5 50817.7 1062.8 1223.9 1257.9 1269.6 1303.7 25651.5 27791.2 28067.2 28241.9 28327.7 37555.8 37969.2 38338.6 38486.8 38594.0 178745.0 179322.0 179645.0 180376.0 197355.0 26786.9 30814.5 31013.4 31070.5 31610.7 34867.5 34888.1 35666.6 36038.8 36127.1 30851.8 31070.8 31096.0 31199.8 31311.7 30569.4 30766.4 30921.2 30942.2 31176.8 32894.7 33436.0 33546.8 33823.7 33842.2 27726.9 28998.6 31638.5 31799.0 31811.0 24695.3 24956.9 24993.0 25224.9 25377.5 18:49:44 INFO - PROCESS | 12730 | 18:49:44 INFO - PROCESS | 12730 | [#2] jquery.html Cycles:180 Average:20596.71 Median:20931.70 stddev:50134.59 (239.5%) stddev-sans-first:50252.19 18:49:44 INFO - PROCESS | 12730 | Values: 351.6 354.9 359.9 361.3 363.1 15526.2 15842.5 17128.6 17526.9 17652.2 16333.8 16793.8 16823.2 16874.7 16896.3 5026.7 5046.7 5257.3 5262.5 5263.8 5135.4 5183.6 5195.2 5207.7 5225.1 4956.9 5151.5 5177.5 5182.3 5197.7 5142.8 5162.5 5173.8 5192.6 5193.5 4635.1 4638.0 4638.9 4639.7 4640.0 18260.8 18388.6 18985.2 19159.1 19191.2 1893.6 1937.6 1942.2 1964.5 1996.0 9565.8 9742.7 9745.0 9858.6 10814.9 1849.3 1849.3 1861.7 1869.3 1872.9 42640.6 43910.8 53521.7 57014.7 57674.4 10432.2 10503.6 10515.8 10552.2 10698.3 12033.1 13586.9 13606.5 13608.7 13621.1 7526.7 7733.7 7768.8 7868.0 7872.6 7547.4 7551.0 7661.9 7699.4 7752.5 4448.7 4521.3 4534.7 4599.1 4614.9 1787.6 1822.3 1826.9 1835.7 1867.7 820.2 915.8 950.1 996.3 1035.7 16077.8 16408.8 16444.5 16965.4 16979.6 881.6 885.2 885.6 888.8 931.8 9395.9 9609.3 9755.7 9790.6 9792.9 256599.0 261278.0 261311.0 262868.0 432368.0 65609.3 66517.3 70505.6 73463.6 77311.0 418.8 422.8 431.7 433.1 433.2 8122.4 10086.4 10243.7 10396.3 10498.0 33433.0 33468.0 34674.8 34710.8 34934.5 41444.6 44093.6 45012.0 45235.3 45587.3 7537.2 7676.5 7786.6 7799.1 8006.4 11756.8 11907.3 11955.8 12004.6 12167.6 10366.9 10609.8 10769.2 10804.3 10845.0 10599.8 10606.3 10617.4 10922.2 11123.8 10725.1 10738.9 10840.7 10879.7 11051.0 7723.7 7942.3 7981.1 8002.8 8216.2 10426.6 10537.8 10895.9 10945.2 11089.2 18:49:44 INFO - PROCESS | 12730 | 18:49:44 INFO - PROCESS | 12730 | [#3] mootools.html Cycles:180 Average:5182.18 Median:6001.28 stddev:2677.09 (44.6%) stddev-sans-first:2668.89 18:49:44 INFO - PROCESS | 12730 | Values: 1324.9 1430.4 1451.4 1619.8 1824.3 7094.6 7208.2 7260.0 7261.7 7291.8 7091.2 7235.1 7242.3 7252.5 7256.6 1938.7 1987.7 2230.5 2274.9 2301.2 2258.8 2271.7 2273.2 2273.5 2274.2 2163.4 2212.2 2213.7 2215.8 2220.0 2224.7 2232.2 2241.0 2242.1 2272.1 2260.1 2271.2 2292.5 2293.6 2294.2 7241.1 7300.5 7303.7 7307.1 7315.1 4602.4 4703.3 4725.9 4733.0 4735.5 2947.1 3082.2 3110.8 3132.5 3136.7 1017.2 1038.2 1043.0 1048.5 1079.3 10164.6 10280.5 10298.1 10330.9 10339.9 4097.3 4308.9 4324.8 4347.0 4386.7 7840.0 7880.4 7900.1 7904.8 7904.9 4687.0 4692.1 4693.2 4698.0 4698.0 3660.1 4132.8 4157.7 4188.3 4238.4 3348.4 3414.3 3419.2 3442.6 3468.9 1076.7 1077.7 1081.6 1082.4 1090.3 1202.0 1205.2 1222.4 1247.6 1269.5 6839.6 6923.3 6957.1 7009.5 7043.5 476.3 480.6 486.9 489.3 492.9 5556.7 5570.4 5607.0 5627.7 5661.7 8927.2 9147.3 9252.7 9395.0 9395.3 9055.9 9119.8 9184.1 9227.5 9248.6 6906.6 6975.2 6984.5 7062.2 7208.0 6837.7 6846.7 6866.2 6870.9 6900.4 8084.4 8191.0 8236.8 8320.4 8336.3 8351.4 8466.6 8487.7 8493.2 8607.8 6133.9 6192.7 6346.7 6353.7 6358.2 6814.6 6821.7 6834.2 6848.9 6850.5 6044.7 6175.0 6214.9 6247.3 6273.2 5998.5 6004.0 6014.3 6053.7 6096.0 6568.3 6573.2 6626.3 6632.9 6635.7 6082.0 6116.9 6136.0 6155.8 6162.3 6197.7 6250.3 6260.5 6262.2 6262.5 18:49:44 INFO - PROCESS | 12730 | 18:49:44 INFO - PROCESS | 12730 | [#4] prototype.html Cycles:180 Average:4644.09 Median:5347.02 stddev:1357.21 (25.4%) stddev-sans-first:1321.79 18:49:44 INFO - PROCESS | 12730 | Values: 328.1 328.4 328.8 329.1 335.7 5367.5 5370.9 5382.7 5387.5 5397.2 5273.6 5278.3 5297.9 5325.6 5326.5 3926.3 4049.5 4120.9 4145.7 4176.3 4140.6 4159.9 4162.4 4171.1 4173.1 4112.7 4117.8 4123.5 4127.3 4129.5 3907.8 4022.8 4099.4 4103.2 4124.6 3586.4 3588.5 3591.8 3601.5 3602.5 5117.5 5135.9 5137.6 5146.5 5146.7 4725.9 4730.9 4732.6 4733.5 4739.7 5569.3 5577.1 5580.2 5583.1 5594.3 3947.3 3975.9 3985.9 3987.2 3987.6 5661.7 5867.9 5873.3 5901.9 5907.4 3959.7 4022.6 4024.3 4030.2 4032.8 4076.7 4078.8 4083.5 4088.4 4092.4 4692.2 4694.4 4697.0 4704.5 4704.6 5608.7 5619.2 5621.1 5630.7 5633.1 1421.9 1437.2 1438.7 1439.1 1439.2 888.4 911.9 957.8 984.8 993.9 4730.5 4793.5 4870.9 4907.3 4917.2 5815.3 5823.0 5829.7 5839.1 5842.3 4903.1 4904.6 4905.4 4905.6 4907.4 3099.2 3131.8 3134.5 3135.0 3140.0 5463.2 5466.3 5472.2 5474.2 5476.7 5819.6 5991.1 5991.4 5998.4 6002.0 5441.8 5453.0 5459.9 5464.2 5467.2 5832.0 5832.9 5835.7 5838.9 5844.0 5723.4 5726.3 5726.6 5727.6 5729.4 5439.3 5455.6 5458.2 5459.8 5463.8 4017.5 4186.2 4196.4 4197.1 4197.6 5735.2 5744.8 5746.3 5751.3 5755.3 5549.9 5553.3 5554.8 5557.5 5558.6 5502.3 5532.9 5540.0 5542.4 5565.0 5322.2 5477.6 5481.0 5482.4 5483.5 5555.9 5567.9 5585.7 5604.6 5607.7 5439.2 5439.5 5446.8 5449.1 5461.5 18:49:44 INFO - PROCESS | 12730 | 18:49:44 INFO - PROCESS | 12730 | [#5] yui.html Cycles:180 Average:13132.23 Median:43951.45 stddev:14964.03 (34.0%) stddev-sans-first:14976.83 18:49:44 INFO - PROCESS | 12730 | Values: 689.4 713.7 714.0 780.8 790.2 11900.0 12143.8 12181.6 12229.9 12257.0 11985.8 12014.8 12028.1 12060.6 12087.9 646.5 800.4 805.2 814.5 828.5 815.3 818.1 821.3 821.5 822.0 869.3 869.6 869.8 870.3 872.7 685.7 851.3 867.0 868.1 868.2 633.7 637.1 637.3 637.4 638.3 12449.4 12514.2 12525.4 12617.9 12621.6 11853.5 12059.3 12169.1 12417.5 12577.6 9922.9 9968.9 10091.0 10130.2 10402.4 3351.8 3351.9 3355.8 3474.4 3476.0 44663.3 44793.8 44879.8 45240.1 45788.0 10076.3 10104.7 10221.2 10246.3 10254.4 17519.9 17566.0 17568.6 17601.2 17651.1 6587.7 6611.1 6641.0 6673.9 6903.0 3675.3 3677.5 3718.4 3786.1 3816.3 2821.2 2859.3 2859.9 2860.7 2864.5 434.2 453.6 505.1 513.5 522.9 597.5 603.1 616.5 628.4 633.4 8087.2 8161.7 8206.1 8220.8 8315.5 553.7 583.7 588.5 610.8 631.5 3387.6 3442.4 3497.1 3561.3 3634.2 53946.7 54879.2 55427.4 57140.0 57393.4 46130.0 46187.5 46340.8 46430.8 46673.5 43542.0 43875.1 44027.8 44386.7 44488.3 8765.3 8806.6 8811.5 8827.0 8832.5 32295.2 32608.8 32613.0 33825.8 33981.2 38858.6 38875.6 41277.6 43082.4 43099.4 10878.8 10888.2 10893.7 11111.4 11192.1 12199.5 12201.9 12401.6 12450.3 12827.4 11312.2 11383.1 11654.1 11959.5 11979.3 11004.4 11371.8 11406.9 11746.1 11749.9 11326.4 11481.9 11586.4 11927.2 11989.1 9353.3 9514.0 9608.5 9614.5 9769.4 8776.6 9132.8 9486.6 9528.4 9566.8 18:49:44 INFO - PROCESS | 12730 | -------- Summary: end -------- 18:49:44 INFO - PROCESS | 12730 | 18:49:44 INFO - TEST-INFO | 12730: exit 0 18:49:44 INFO - TEST-OK | dromaeo_css | took 1116174ms 18:49:44 INFO - TEST-START | kraken 18:49:44 INFO - operating with platform_type : linux_ 18:49:44 INFO - Initialising browser for kraken test... 18:49:44 INFO - TEST-INFO | started process 12909 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuqgzfa/profile http://localhost:56018/getInfo.html) 18:49:49 INFO - PROCESS | 12909 | __metrics Screen width/height:1600/1200 18:49:49 INFO - PROCESS | 12909 | colorDepth:24 18:49:49 INFO - PROCESS | 12909 | Browser inner width/height: 1024/697 18:49:49 INFO - PROCESS | 12909 | __metrics 18:49:50 ERROR - PROCESS | 12909 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:49:51 INFO - TEST-INFO | 12909: exit 0 18:49:51 INFO - Browser initialized. 18:49:51 INFO - Running cycle 1/1 for kraken test... 18:49:51 INFO - TEST-INFO | started process 12990 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuqgzfa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:50:02 INFO - PROCESS | 12990 | RSS: Main: 154345472 18:50:02 INFO - PROCESS | 12990 | 18:50:05 INFO - PROCESS | 12990 | Cycle 1(1): loaded http://localhost:56018/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56018/tests/kraken/driver.html?testName=audio-beat-detection) 18:50:06 INFO - PROCESS | 12990 | RSS: Main: 194838528 18:50:06 INFO - PROCESS | 12990 | 18:50:08 INFO - PROCESS | 12990 | Cycle 1(1): loaded http://localhost:56018/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56018/tests/kraken/driver.html?testName=audio-dft) 18:50:09 INFO - PROCESS | 12990 | RSS: Main: 184565760 18:50:09 INFO - PROCESS | 12990 | 18:50:12 INFO - PROCESS | 12990 | Cycle 1(1): loaded http://localhost:56018/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56018/tests/kraken/driver.html?testName=audio-fft) 18:50:13 INFO - PROCESS | 12990 | RSS: Main: 173572096 18:50:13 INFO - PROCESS | 12990 | 18:50:15 INFO - PROCESS | 12990 | Cycle 1(1): loaded http://localhost:56018/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56018/tests/kraken/driver.html?testName=audio-oscillator) 18:50:15 INFO - PROCESS | 12990 | RSS: Main: 174690304 18:50:15 INFO - PROCESS | 12990 | 18:50:18 INFO - PROCESS | 12990 | Cycle 1(1): loaded http://localhost:56018/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56018/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:50:18 INFO - PROCESS | 12990 | RSS: Main: 173613056 18:50:18 INFO - PROCESS | 12990 | 18:50:21 INFO - PROCESS | 12990 | Cycle 1(1): loaded http://localhost:56018/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56018/tests/kraken/driver.html?testName=imaging-darkroom) 18:50:22 INFO - PROCESS | 12990 | RSS: Main: 175370240 18:50:22 INFO - PROCESS | 12990 | 18:50:25 INFO - PROCESS | 12990 | Cycle 1(1): loaded http://localhost:56018/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56018/tests/kraken/driver.html?testName=imaging-desaturate) 18:50:26 INFO - PROCESS | 12990 | RSS: Main: 175869952 18:50:26 INFO - PROCESS | 12990 | 18:50:29 INFO - PROCESS | 12990 | Cycle 1(1): loaded http://localhost:56018/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56018/tests/kraken/driver.html?testName=json-parse-financial) 18:50:29 INFO - PROCESS | 12990 | RSS: Main: 175886336 18:50:29 INFO - PROCESS | 12990 | 18:50:31 INFO - PROCESS | 12990 | Cycle 1(1): loaded http://localhost:56018/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56018/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:50:31 INFO - PROCESS | 12990 | RSS: Main: 186548224 18:50:31 INFO - PROCESS | 12990 | 18:50:33 INFO - PROCESS | 12990 | Cycle 1(1): loaded http://localhost:56018/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56018/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:50:34 INFO - PROCESS | 12990 | RSS: Main: 182976512 18:50:34 INFO - PROCESS | 12990 | 18:50:36 INFO - PROCESS | 12990 | Cycle 1(1): loaded http://localhost:56018/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56018/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:50:37 INFO - PROCESS | 12990 | RSS: Main: 192729088 18:50:37 INFO - PROCESS | 12990 | 18:50:39 INFO - PROCESS | 12990 | Cycle 1(1): loaded http://localhost:56018/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56018/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:50:40 INFO - PROCESS | 12990 | RSS: Main: 197517312 18:50:40 INFO - PROCESS | 12990 | 18:50:42 INFO - PROCESS | 12990 | Cycle 1(1): loaded http://localhost:56018/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56018/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:50:43 INFO - PROCESS | 12990 | RSS: Main: 197406720 18:50:43 INFO - PROCESS | 12990 | 18:50:45 INFO - PROCESS | 12990 | Cycle 1(1): loaded http://localhost:56018/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56018/tests/kraken/driver.html?testName=ai-astar) 18:50:45 INFO - PROCESS | 12990 | RSS: Main: 257236992 18:50:45 INFO - PROCESS | 12990 | 18:50:45 INFO - PROCESS | 12990 | __start_tp_report 18:50:45 INFO - PROCESS | 12990 | _x_x_mozilla_page_load 18:50:45 INFO - PROCESS | 12990 | _x_x_mozilla_page_load_details 18:50:45 INFO - PROCESS | 12990 | |i|pagename|runs| 18:50:45 INFO - PROCESS | 12990 | |0;ai-astar;111;113;106;112;114;114;104;112;113;112 18:50:45 INFO - PROCESS | 12990 | |1;audio-beat-detection;154;131;157;174;138;152;161;131;172;131 18:50:45 INFO - PROCESS | 12990 | |2;audio-dft;161;161;160;160;162;160;162;161;161;160 18:50:45 INFO - PROCESS | 12990 | |3;audio-fft;73;73;73;151;74;75;74;73;176;73 18:50:45 INFO - PROCESS | 12990 | |4;audio-oscillator;94;93;143;92;94;93;140;92;94;138 18:50:45 INFO - PROCESS | 12990 | |5;imaging-gaussian-blur;116;117;116;116;118;117;117;117;117;117 18:50:45 INFO - PROCESS | 12990 | |6;imaging-darkroom;145;145;145;145;146;145;146;145;146;146 18:50:45 INFO - PROCESS | 12990 | |7;imaging-desaturate;95;95;95;95;95;95;96;95;95;95 18:50:45 INFO - PROCESS | 12990 | |8;json-parse-financial;71;64;64;66;65;66;65;76;64;62 18:50:45 INFO - PROCESS | 12990 | |9;json-stringify-tinderbox;64;64;64;64;65;64;63;63;64;64 18:50:45 INFO - PROCESS | 12990 | |10;stanford-crypto-aes;80;82;82;81;88;81;82;81;81;81 18:50:45 INFO - PROCESS | 12990 | |11;stanford-crypto-ccm;117;117;119;131;122;118;122;126;115;116 18:50:45 INFO - PROCESS | 12990 | |12;stanford-crypto-pbkdf2;142;131;142;142;142;135;142;142;141;142 18:50:45 INFO - PROCESS | 12990 | |13;stanford-crypto-sha256-iterative;68;70;69;69;69;67;66;67;66;66 18:50:45 INFO - PROCESS | 12990 | __end_tp_report 18:50:45 INFO - PROCESS | 12990 | __start_cc_report 18:50:45 INFO - PROCESS | 12990 | _x_x_mozilla_cycle_collect,1124 18:50:45 INFO - PROCESS | 12990 | __end_cc_report 18:50:45 INFO - PROCESS | 12990 | __startTimestamp1458093045341__endTimestamp 18:50:45 INFO - PROCESS | 12990 | 18:50:45 INFO - PROCESS | 12990 | ------- Summary: start ------- 18:50:45 INFO - PROCESS | 12990 | Number of tests: 14 18:50:45 INFO - PROCESS | 12990 | 18:50:45 INFO - PROCESS | 12990 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.50 stddev:3.38 (3.0%) stddev-sans-first:3.59 18:50:45 INFO - PROCESS | 12990 | Values: 111.0 113.0 106.0 112.0 114.0 114.0 104.0 112.0 113.0 112.0 18:50:45 INFO - PROCESS | 12990 | 18:50:45 INFO - PROCESS | 12990 | [#1] audio-beat-detection Cycles:10 Average:150.10 Median:155.50 stddev:16.59 (10.7%) stddev-sans-first:17.54 18:50:45 INFO - PROCESS | 12990 | Values: 154.0 131.0 157.0 174.0 138.0 152.0 161.0 131.0 172.0 131.0 18:50:45 INFO - PROCESS | 12990 | 18:50:45 INFO - PROCESS | 12990 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 18:50:45 INFO - PROCESS | 12990 | Values: 161.0 161.0 160.0 160.0 162.0 160.0 162.0 161.0 161.0 160.0 18:50:45 INFO - PROCESS | 12990 | 18:50:45 INFO - PROCESS | 12990 | [#3] audio-fft Cycles:10 Average:91.50 Median:73.00 stddev:38.41 (52.6%) stddev-sans-first:40.15 18:50:45 INFO - PROCESS | 12990 | Values: 73.0 73.0 73.0 151.0 74.0 75.0 74.0 73.0 176.0 73.0 18:50:45 INFO - PROCESS | 12990 | 18:50:45 INFO - PROCESS | 12990 | [#4] audio-oscillator Cycles:10 Average:107.30 Median:93.00 stddev:22.84 (24.6%) stddev-sans-first:23.71 18:50:45 INFO - PROCESS | 12990 | Values: 94.0 93.0 143.0 92.0 94.0 93.0 140.0 92.0 94.0 138.0 18:50:45 INFO - PROCESS | 12990 | 18:50:45 INFO - PROCESS | 12990 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 18:50:45 INFO - PROCESS | 12990 | Values: 116.0 117.0 116.0 116.0 118.0 117.0 117.0 117.0 117.0 117.0 18:50:45 INFO - PROCESS | 12990 | 18:50:45 INFO - PROCESS | 12990 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 18:50:45 INFO - PROCESS | 12990 | Values: 145.0 145.0 145.0 145.0 146.0 145.0 146.0 145.0 146.0 146.0 18:50:45 INFO - PROCESS | 12990 | 18:50:45 INFO - PROCESS | 12990 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 18:50:45 INFO - PROCESS | 12990 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 18:50:45 INFO - PROCESS | 12990 | 18:50:45 INFO - PROCESS | 12990 | [#8] json-parse-financial Cycles:10 Average:66.30 Median:65.50 stddev:4.14 (6.3%) stddev-sans-first:4.02 18:50:45 INFO - PROCESS | 12990 | Values: 71.0 64.0 64.0 66.0 65.0 66.0 65.0 76.0 64.0 62.0 18:50:45 INFO - PROCESS | 12990 | 18:50:45 INFO - PROCESS | 12990 | [#9] json-stringify-tinderbox Cycles:10 Average:63.90 Median:64.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 18:50:45 INFO - PROCESS | 12990 | Values: 64.0 64.0 64.0 64.0 65.0 64.0 63.0 63.0 64.0 64.0 18:50:45 INFO - PROCESS | 12990 | 18:50:45 INFO - PROCESS | 12990 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:81.50 stddev:2.23 (2.7%) stddev-sans-first:2.26 18:50:45 INFO - PROCESS | 12990 | Values: 80.0 82.0 82.0 81.0 88.0 81.0 82.0 81.0 81.0 81.0 18:50:45 INFO - PROCESS | 12990 | 18:50:45 INFO - PROCESS | 12990 | [#11] stanford-crypto-ccm Cycles:10 Average:120.30 Median:120.50 stddev:5.03 (4.2%) stddev-sans-first:5.20 18:50:45 INFO - PROCESS | 12990 | Values: 117.0 117.0 119.0 131.0 122.0 118.0 122.0 126.0 115.0 116.0 18:50:45 INFO - PROCESS | 12990 | 18:50:45 INFO - PROCESS | 12990 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.10 Median:142.00 stddev:3.87 (2.7%) stddev-sans-first:4.04 18:50:45 INFO - PROCESS | 12990 | Values: 142.0 131.0 142.0 142.0 142.0 135.0 142.0 142.0 141.0 142.0 18:50:45 INFO - PROCESS | 12990 | 18:50:45 INFO - PROCESS | 12990 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.50 stddev:1.49 (2.2%) stddev-sans-first:1.58 18:50:45 INFO - PROCESS | 12990 | Values: 68.0 70.0 69.0 69.0 69.0 67.0 66.0 67.0 66.0 66.0 18:50:45 INFO - PROCESS | 12990 | -------- Summary: end -------- 18:50:45 INFO - PROCESS | 12990 | 18:50:46 INFO - TEST-INFO | 12990: exit 0 18:50:46 INFO - TEST-OK | kraken | took 61523ms 18:50:46 INFO - SUITE-END | took 1177s 18:50:46 INFO - Completed test suite (00:19:37) 18:50:46 INFO - javascript benchmark 18:50:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2561.0955021134528, 2630.8947642094317, 2640.2079376187153, 2655.2565281721127, 2673.997251030863, 4531.456225252966, 4569.657275704323, 4584.816607335707, 4595.770211489425, 4648.511906249837, 4556.270996640538, 4621.699589526678, 4661.37071495348, 4663.510331415204, 4666.766661666911, 4208.684348673846, 4269.210196113729, 4272.914541709171, 4307.849225277116, 4313.525512193672, 4228.154369126171, 4269.124829409979, 4306.2464068787995, 4316.11519638475, 4353.738775673454, 4185.58144185582, 4252.319628859368, 4310.3534469829465, 4311.50417701962, 4328.4156638853665, 4238.131183107455, 4274.551172126944, 4278.828846846122, 4300.397944287803, 4314.870553883388, 4153.169366126786, 4240.660747140221, 4252.447181866338, 4274.700770946035, 4291.6137547620865, 4496.348029535699, 4525.660575456854, 4566.54334566544, 4598.747068911209, 4603.723776573416, 4919.458859525449, 4970.826021089245, 4972.627052971042, 4981.850544483671, 5018.322526458918, 4851.951480485185, 4971.304017437562, 4992.350994370709, 5000.599952003831, 5004.174311238641, 4629.953700462986, 4654.348391225231, 4680.251159814414, 4709.576138147549, 4713.0, 5055.469175736494, 5074.2895994560795, 5076.132025226332, 5083.74581270935, 5122.513361230677, 4832.251001094836, 4839.612830973514, 4848.806047758121, 4863.076015557032, 4866.732329721899, 4959.355283813081, 4975.527324904128, 4975.925361119586, 4996.375453068366, 5028.321176641107, 4926.359573255454, 4937.753112344369, 4943.555080042814, 4945.925811112764, 4995.925061124086, 4835.492273311252, 4861.149298872683, 4922.90154196914, 4936.0, 4990.226514890198, 3870.9419358709642, 3883.650471457582, 3891.552471465761, 3925.430812532167, 3934.1738234970403, 3436.536067630838, 3439.0542600784484, 3473.1317170707325, 3480.112571294304, 3483.6168021517615, 4124.340105583093, 4183.435236243129, 4192.413062171298, 4215.241256573846, 4266.360045993064, 4885.389326334208, 4890.779914903766, 4892.975535122373, 4924.285978533093, 4928.162212423897, 4171.791410429466, 4202.075543380452, 4204.831806727697, 4210.242156411875, 4246.044639956047, 4382.605565499057, 4397.274449715761, 4420.778961051935, 4477.552244775561, 4510.932336014962, 4675.95324046762, 4677.415323084614, 4704.88237794051, 4710.929336059893, 4745.762711864324, 4755.286706993978, 4958.45456999737, 4963.528464795839, 4986.152354099884, 5036.093503169464, 4602.585767280827, 4646.094011667692, 4658.58072773452, 4693.2021556336185, 4708.81164753406, 4848.927266091082, 4854.296127061627, 4870.805167793249, 4877.0, 4922.7538623067985, 4859.878503037452, 4934.851954441372, 4952.8761780955765, 4954.256861470808, 5001.449840517613, 4712.269598212282, 4764.571188593043, 4771.355866958055, 4785.665003449725, 4811.446683631427, 4751.334813126235, 4786.736729479912, 4790.880227994328, 4792.2332426811545, 4830.66185367035, 4595.47152077502, 4635.096156249499, 4725.149473094876, 4744.4543877454535, 4787.640926930564, 4811.182099043241, 4829.492903245108, 4858.319835223001, 4872.829450969199, 4888.193448081027, 4726.078414709099, 4739.834105806281, 4740.810367585258, 4747.026859493864, 4766.0], "unit": "score", "name": "dojo.html", "value": 4521.0081436659875}, {"lowerIsBetter": false, "replicates": [510.3034358101193, 516.855280521454, 524.0619291468272, 525.8790478190018, 544.8065936592508, 26917.19248422548, 27351.316217094558, 35204.94385168446, 35280.82359588205, 35321.64678353216, 38388.0, 38719.806400968024, 38893.22213555727, 38923.416148757795, 38946.61053389472, 7793.999999999985, 7986.0, 7989.081255655587, 7990.320822730075, 7993.44045916786, 7746.690132394726, 7781.182975787546, 7848.843023139534, 7856.764297071097, 7857.960710196441, 8048.31589314906, 8103.311218546431, 8109.553974531398, 8117.8782318264975, 8123.715669951553, 7991.280784729373, 8021.799455013613, 8054.9597252013955, 8061.758147255533, 8065.95967020167, 7924.80187995299, 8046.476978996347, 8053.758387248392, 8057.274845263954, 8063.0, 37455.0, 37899.0, 37937.62062379396, 37957.240855183016, 37964.43053354202, 3017.1250337402125, 3160.98419507901, 3391.5421418108485, 3506.6493350664728, 3913.2173565287057, 28650.713492865223, 28834.567481487793, 28840.711592884014, 29097.41805163906, 29122.56316155238, 3569.785812851237, 3619.2782369969577, 3724.255148970217, 3724.515812944327, 3766.868159614428, 223515.0, 224289.0, 224381.99999999837, 224966.0, 226391.0, 42062.15875682469, 43194.352084718754, 43202.135957280676, 43250.351244731355, 56348.71825640846, 39901.40147897784, 40058.19883602312, 40275.79862100671, 40322.79838600847, 40337.0, 13942.093763905314, 14089.0, 14111.435542578181, 14119.929400353138, 14123.011389202657, 10933.18001149917, 11018.39398833072, 11022.724431889266, 11028.613998510014, 11087.72280692973, 14725.0, 14832.0, 14930.701385972437, 14962.551123466314, 15094.16982065975, 5740.292591596763, 5921.259842519685, 5966.224390829165, 5979.222701048836, 5980.73086711099, 854.7179430787825, 878.7934835313696, 903.8101998580372, 1041.7551875309296, 1072.51736718477, 27804.0, 29124.708752912622, 30570.54144187839, 30778.685453046808, 31017.0, 985.261054209343, 997.3517213811081, 1000.8298589239847, 1013.5996281468779, 1050.1336397472116, 14270.215138167501, 14688.55934321972, 14778.704425911637, 15008.924955375373, 15024.0, 345832.1667133337, 352123.0, 352417.0, 352911.0, 353405.0, 49170.0, 50611.24083138756, 50708.0, 50735.49264507381, 50817.745911270205, 1062.792755412687, 1223.908206884505, 1257.8867901888873, 1269.6127681057367, 1303.7066660001424, 25651.486970260863, 27791.16626501208, 28067.157985260474, 28241.858790705915, 28327.71672283251, 37555.81222093872, 37969.24061518699, 38338.6166138335, 38486.80756596199, 38594.0, 178745.0, 179322.0, 179645.0, 180376.0, 197355.0, 26786.866065669547, 30814.537781932842, 31013.379732404774, 31070.533941990438, 31610.683893160774, 34867.47698784571, 34888.12779680528, 35666.64333356633, 36038.819805901854, 36127.096822579646, 30851.845740771154, 31070.844645776626, 31096.0, 31199.84400077985, 31311.68688313088, 30569.388612228075, 30766.384672306875, 30921.226969325948, 30942.22644433907, 31176.844115779277, 32894.67105329012, 33436.0, 33546.832265838515, 33823.66176338303, 33842.15394615154, 27726.861365693043, 28998.56502152427, 31638.525422118226, 31799.0, 31811.0, 24695.25914222576, 24956.875215623804, 24993.0, 25224.873875631238, 25377.492450150523], "unit": "score", "name": "ext.html", "value": 16556.292378396993}, {"lowerIsBetter": false, "replicates": [351.6483516483515, 354.89175801380577, 359.92081742016757, 361.31711066085086, 363.1447940101062, 15526.223688815557, 15842.527657420229, 17128.57178570535, 17526.912365438187, 17652.205650745716, 16333.83666163338, 16793.83206167938, 16823.242954067067, 16874.662506749857, 16896.324147034135, 5026.673266237701, 5046.697198168104, 5257.263983042377, 5262.526372626463, 5263.789448422059, 5135.383753949532, 5183.611229157809, 5195.168772996321, 5207.687538747668, 5225.085610018251, 4956.851294461154, 5151.536361727443, 5177.534021938025, 5182.300389447433, 5197.714125723083, 5142.794288228485, 5162.535371816554, 5173.844784656466, 5192.636515443921, 5193.480651934795, 4635.096156249533, 4638.0491999140095, 4638.8608341749805, 4639.652026098056, 4639.953600463986, 18260.81739182618, 18388.632227355512, 18985.24059037637, 19159.137838797287, 19191.232350705955, 1893.5739458621838, 1937.5834195648004, 1942.1842826013108, 1964.5383334916426, 1996.0418998880618, 9565.808683826353, 9742.707718768448, 9745.0, 9858.605655773761, 10814.891851081467, 1849.2602958816447, 1849.2650165787597, 1861.6928206845855, 1869.3176990398542, 1872.9344472943383, 42640.57359426397, 43910.78044609789, 53521.732391338184, 57014.71492642552, 57674.423255767324, 10432.165426765841, 10503.579856805794, 10515.84226236607, 10552.208584356204, 10698.251122421356, 12033.097517686208, 13586.93206533961, 13606.455741770416, 13608.65978350549, 13621.114627549177, 7526.736564220226, 7733.651985660659, 7768.7669369918995, 7868.0, 7872.645730942121, 7547.433942454338, 7550.962245188739, 7661.885071723928, 7699.422543309162, 7752.4573279869865, 4448.666350023696, 4521.253993091103, 4534.682572219913, 4599.103174880866, 4614.907701845944, 1787.6245988342334, 1822.3075231412245, 1826.8903865767832, 1835.6787562176567, 1867.6918308479221, 820.1716266570687, 915.8214148241029, 950.14486961735, 996.2926322311096, 1035.6530562261726, 16077.75883361727, 16408.75386869198, 16444.506664800076, 16965.406210782563, 16979.575510612085, 881.5680316644798, 885.198895000026, 885.6457417033238, 888.8488956877217, 931.753085432361, 9395.859062114074, 9609.279304052085, 9755.707328780149, 9790.5594248259, 9792.87926158253, 256599.0, 261278.0, 261311.0, 262868.0, 432368.0, 65609.34390656128, 66517.33482665208, 70505.6474717623, 73463.63268183732, 77311.0, 418.8240938805709, 422.7653652223046, 431.7474277547607, 433.14021666991624, 433.17696376883544, 8122.350211982909, 10086.394816311045, 10243.692689219335, 10396.324238924446, 10497.971779110752, 33433.0, 33468.0, 34674.826625866706, 34710.826445867606, 34934.47598285977, 41444.58555414528, 44093.55906441023, 45012.0, 45235.321470178635, 45587.316190257836, 7537.170911199873, 7676.53940763556, 7786.571738554434, 7799.103103143211, 8006.359491240803, 11756.764864702487, 11907.345096019802, 11955.76088478243, 12004.639860804189, 12167.574134905235, 10366.948165259126, 10609.787804244026, 10769.24615276923, 10804.297720648132, 10845.0, 10599.841002385125, 10606.257561970897, 10617.362958222531, 10922.235443518877, 11123.833142502706, 10725.08836748885, 10738.946305268737, 10840.728981775203, 10879.728006799893, 11051.0, 7723.652435640522, 7942.285194332538, 7981.082175549654, 8002.83994320122, 8216.178382161735, 10426.635067772591, 10537.841932371173, 10895.945520272347, 10945.179111566506, 11089.168312376765], "unit": "score", "name": "jquery.html", "value": 7819.794772559408}, {"lowerIsBetter": false, "replicates": [1324.9138805977605, 1430.4278288684525, 1451.4266864588485, 1619.8299178586249, 1824.297645406519, 7094.574325540465, 7208.1710603280635, 7260.0, 7261.673224704888, 7291.817704557382, 7091.219965803757, 7235.095613048369, 7242.31198036187, 7252.476979834241, 7256.600886951215, 1938.7479627648386, 1987.6819708846588, 2230.453538882976, 2274.94312642184, 2301.2405906050963, 2258.7854153855355, 2271.738750043741, 2273.193016479151, 2273.454370950968, 2274.2040285899966, 2163.3942496101117, 2212.1814928476406, 2213.701150344699, 2215.789499997498, 2219.9556008879813, 2224.7219097612797, 2232.229880691167, 2241.047554789216, 2242.091952759127, 2272.0684519346987, 2260.095961615367, 2271.2277825539395, 2292.472731271817, 2293.587154312223, 2294.219965211836, 7241.094863142107, 7300.488965772398, 7303.7078516859265, 7307.050083489165, 7315.085614298213, 4602.424696912886, 4703.341532185496, 4725.881852953669, 4733.0, 4735.479097299294, 2947.086403214989, 3082.1678146900435, 3110.766692498049, 3132.451820931328, 3136.7490600751885, 1017.2319898476677, 1038.2057725839738, 1042.9843552346722, 1048.5334026358273, 1079.2876701377131, 10164.644237451654, 10280.48597570126, 10298.073173414428, 10330.89669103307, 10339.896601033894, 4097.303458412077, 4308.870733877989, 4324.827006919688, 4346.978265108717, 4386.670999675037, 7839.960800196077, 7880.369570434352, 7900.091489478784, 7904.841903161904, 7904.920950790533, 4687.0, 4692.085043416501, 4693.225617773098, 4698.0, 4698.01341718243, 3660.103274697716, 4132.834686612562, 4157.729747566398, 4188.267053265667, 4238.449001629769, 3348.4140275452187, 3414.2830005698584, 3419.213580876363, 3442.604100528421, 3468.8612455502002, 1076.6985244131656, 1077.7467295185625, 1081.643057790927, 1082.3992684060265, 1090.3022065877844, 1201.9579314723942, 1205.2226314027403, 1222.4010234984971, 1247.6132398956352, 1269.4922031187598, 6839.62382068991, 6923.307669233036, 6957.130358705162, 7009.544379615309, 7043.471739619549, 476.3141076849326, 480.5962991087503, 486.8709791905148, 489.2538878210686, 492.85214435669155, 5556.666600003932, 5570.359408668055, 5607.046802043662, 5627.746751396197, 5661.716914154275, 8927.196552310323, 9147.2682185425, 9252.722418327461, 9394.95302523483, 9395.34232603725, 9055.909440905638, 9119.81760364789, 9184.12750788674, 9227.492487913096, 9248.583813728399, 6906.585604863624, 6975.197852246955, 6984.5460045097925, 7062.152541694927, 7208.0, 6837.726490940307, 6846.657667116724, 6866.176058872968, 6870.862582748417, 6900.413464855544, 8084.434089613671, 8190.959045204974, 8236.83526329458, 8320.375971802017, 8336.291415229773, 8351.415400921876, 8466.576671166295, 8487.745367638981, 8493.150684931457, 8607.827843443221, 6133.9079913802225, 6192.659403732658, 6346.650934198663, 6353.650549219838, 6358.205224346957, 6814.625195614289, 6821.693023813841, 6834.179898412222, 6848.897266541106, 6850.520463567503, 6044.727987240497, 6175.0, 6214.9067763982675, 6247.250329960434, 6273.153124328157, 5998.520118390606, 6004.039353703386, 6014.308354539284, 6053.667048312385, 6095.969520152371, 6568.27748947625, 6573.1783527059115, 6626.27111017778, 6632.867342653023, 6635.734570617121, 6081.969590152021, 6116.877662446637, 6136.0, 6155.784547540815, 6162.291336496361, 6197.721102550487, 6250.343713910156, 6260.467860231749, 6262.15460912771, 6262.467690246198], "unit": "score", "name": "mootools.html", "value": 4218.8380965059005}, {"lowerIsBetter": false, "replicates": [328.11245580704195, 328.42361655294945, 328.7747892693505, 329.12124627245254, 335.7045799696267, 5367.543758780504, 5370.865728356793, 5382.730863456822, 5387.5151236388665, 5397.217403476494, 5273.5781137509, 5278.340207474066, 5297.8940421191555, 5325.600579956509, 5326.493983071612, 3926.3325234710023, 4049.5343035550845, 4120.896977575555, 4145.709800313979, 4176.2691528982305, 4140.565240649734, 4159.896002599929, 4162.41726158338, 4171.082361880397, 4173.061061261207, 4112.650424713903, 4117.752934823905, 4123.484564429446, 4127.277726397883, 4129.463169787923, 3907.785071821049, 4022.7787471689194, 4099.364598487239, 4103.158852435274, 4124.608162224584, 3586.444101164324, 3588.5155504006884, 3591.766535175231, 3601.45978103284, 3602.5316708827945, 5117.513836185593, 5135.897282054375, 5137.614678899097, 5146.536811686929, 5146.742662866879, 4725.929111063302, 4730.929036064462, 4732.597729193023, 4733.526647335273, 4739.668223224376, 5569.275994120779, 5577.079781835992, 5580.19087232349, 5583.078791999315, 5594.272744543184, 3947.2894878921784, 3975.920481590352, 3985.940210896839, 3987.202559488114, 3987.5813039631003, 5661.688607126606, 5867.8533036674, 5873.2952045754355, 5901.940980590182, 5907.379725128885, 3959.6832253419657, 4022.597740225954, 4024.3158663027357, 4030.153667729751, 4032.8185231664647, 4076.694247931417, 4078.836846526165, 4083.4895638045246, 4088.3867419887256, 4092.386142078712, 4692.249240121564, 4694.43666759991, 4696.976515117402, 4704.458987216514, 4704.553067458586, 5608.691521966331, 5619.157126431068, 5621.128725047624, 5630.662160270397, 5633.126865335879, 1421.9431222750975, 1437.20953475588, 1438.7266419380285, 1439.100562148657, 1439.172475826404, 888.3603805260202, 911.9361644684941, 957.8084383123403, 984.778424854402, 993.9155171810332, 4730.526947305242, 4793.496682848251, 4870.878228044327, 4907.337509436252, 4917.164082105979, 5815.273090863642, 5823.0, 5829.650220986754, 5839.065749480148, 5842.298924129132, 4903.068417000758, 4904.583110435653, 4905.386826646669, 4905.583025442877, 4907.3620429343955, 3099.1942095055447, 3131.765117616188, 3134.4828103363147, 3135.0281412762115, 3140.0, 5463.153211252183, 5466.289382380344, 5472.151816468454, 5474.178873169057, 5476.67139971595, 5819.6217245879725, 5991.071383935497, 5991.370906054889, 5998.430149135826, 6001.969990150022, 5441.755121019563, 5452.972735136299, 5459.918101228484, 5464.207689885024, 5467.20725494801, 5832.037713777179, 5832.883342333214, 5835.708214589169, 5838.94161058384, 5843.970780146072, 5723.42765723441, 5726.284214473191, 5726.627769194989, 5727.570432217517, 5729.369769325454, 5439.265699130567, 5455.563554915518, 5458.181272809111, 5459.808906688247, 5463.7814487420055, 4017.4978127734034, 4186.162767446462, 4196.412502249748, 4197.076643138505, 4197.559256278169, 5735.168400581976, 5744.798932037359, 5746.281714785652, 5751.338596061507, 5755.3381361144, 5549.861253468695, 5553.333599968029, 5554.750036248298, 5557.472040156179, 5558.555315574664, 5502.312210973629, 5532.861678458071, 5539.972300138635, 5542.445755424425, 5564.972175139098, 5322.201669749414, 5477.616566840283, 5480.972595137158, 5482.39693633692, 5483.479069488392, 5555.8888822222525, 5567.944320556905, 5585.720713964367, 5604.551635869039, 5607.691576963306, 5439.184122381516, 5439.48324909133, 5446.754896029767, 5449.128139497661, 5461.481159289861], "unit": "score", "name": "prototype.html", "value": 4213.197905612671}, {"lowerIsBetter": false, "replicates": [689.3761146162722, 713.6556017008793, 713.9714411423544, 780.7891869195315, 790.1505881177735, 11900.0, 12143.817842732366, 12181.57364492243, 12229.938850305758, 12257.0, 11985.820212696817, 12014.819777703342, 12028.097892658041, 12060.638180854588, 12087.879121208785, 646.4860435953404, 800.3957012455588, 805.19078326282, 814.4828034198297, 828.4780588229407, 815.3192084609358, 818.0633175014605, 821.2608652213027, 821.4783612406105, 821.9753407397787, 869.3045563549167, 869.5739087846973, 869.7521206456162, 870.2559311788425, 872.742540950418, 685.6811582614083, 851.3487182305511, 867.0159369116036, 868.1145231863527, 868.192580899763, 633.7243299164832, 637.0857819029707, 637.3180696654581, 637.4454224824433, 638.2883085359837, 12449.377531123408, 12514.18657787241, 12525.37373131349, 12617.87382126176, 12621.621351359474, 11853.46659400329, 12059.33673647949, 12169.14815962883, 12417.503299868085, 12577.559785407559, 9922.851157232648, 9968.900310996869, 10091.0, 10130.189584833195, 10402.375857448576, 3351.7821341612716, 3351.8603674750457, 3355.832208389571, 3474.3919814032442, 3475.982620086909, 44663.33005004928, 44793.77603111963, 44879.775601121786, 45240.09519809618, 45788.0, 10076.29465937392, 10104.747381315527, 10221.182305415548, 10246.282760206714, 10254.384736915808, 17519.912400437915, 17566.0, 17568.64862702739, 17601.207945642476, 17651.117444127998, 6587.703553340111, 6611.140551728341, 6640.9667951660895, 6673.933260667428, 6903.0, 3675.283319752676, 3677.5035370225214, 3718.386466233041, 3786.110264087937, 3816.2749077675708, 2821.1818572614125, 2859.2851787053237, 2859.914202573926, 2860.7425331720247, 2864.484392809273, 434.218406867637, 453.57590652739793, 505.0505050505027, 513.4916432731569, 522.8797376603402, 597.474222684044, 603.1345019896374, 616.5087338737277, 628.3684896678809, 633.395107672172, 8087.231712987257, 8161.714339998071, 8206.056303525052, 8220.753377398687, 8315.501069935823, 553.6567328256507, 583.7373182068002, 588.4821357205632, 610.7709608896664, 631.5105793010362, 3387.5934887813128, 3442.4147894857933, 3497.0557949353533, 3561.269939662415, 3634.2004758953517, 53946.730266348415, 54879.17681234785, 55427.44572554223, 57140.0, 57393.42606573881, 46130.0, 46187.53812461899, 46340.768296158305, 46430.767846160554, 46673.533264667596, 43542.0, 43875.12249755051, 44027.77986110049, 44386.66839994805, 44488.3326750099, 8765.342599305206, 8806.60370283326, 8811.471311721318, 8827.0, 8832.514211718417, 32295.192620184684, 32608.83695581602, 32613.0, 33825.830870845486, 33981.15047123842, 38858.6114138855, 38875.6112438872, 41277.587224128576, 43082.353764694184, 43099.353509698005, 10878.836817447585, 10888.237823352289, 10893.727656808325, 11111.38887361203, 11192.104631629612, 12199.451024704087, 12201.938990305347, 12401.565945191875, 12450.315232662291, 12827.358632068546, 11312.20814542974, 11383.146264030396, 11654.067674585844, 11959.521619135485, 11979.28124312544, 11004.39475828837, 11371.772564548497, 11406.942965285121, 11746.119041071783, 11749.941250293694, 11326.433678315887, 11481.885181148082, 11586.420678966186, 11927.224730392496, 11989.1008174389, 9353.334299724545, 9513.952430237805, 9608.519574021131, 9614.471204083842, 9769.413835169913, 8776.56117194125, 9132.803099521128, 9486.620535178516, 9528.428294302365, 9566.808544492644], "unit": "score", "name": "yui.html", "value": 6034.617588604785}], "name": "dromaeo_css", "value": 6304.46805465321}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 106.0, 112.0, 114.0, 114.0, 104.0, 112.0, 113.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.1}, {"lowerIsBetter": true, "replicates": [154.0, 131.0, 157.0, 174.0, 138.0, 152.0, 161.0, 131.0, 172.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 150.1}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 160.0, 160.0, 162.0, 160.0, 162.0, 161.0, 161.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 73.0, 151.0, 74.0, 75.0, 74.0, 73.0, 176.0, 73.0], "unit": "score", "name": "audio-fft", "value": 91.5}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 143.0, 92.0, 94.0, 93.0, 140.0, 92.0, 94.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 107.3}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 116.0, 116.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.8}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [71.0, 64.0, 64.0, 66.0, 65.0, 66.0, 65.0, 76.0, 64.0, 62.0], "unit": "score", "name": "json-parse-financial", "value": 66.3}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 63.0, 63.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 63.9}, {"lowerIsBetter": true, "replicates": [80.0, 82.0, 82.0, 81.0, 88.0, 81.0, 82.0, 81.0, 81.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.9}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 119.0, 131.0, 122.0, 118.0, 122.0, 126.0, 115.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.3}, {"lowerIsBetter": true, "replicates": [142.0, 131.0, 142.0, 142.0, 142.0, 135.0, 142.0, 142.0, 141.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.1}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 69.0, 69.0, 69.0, 67.0, 66.0, 67.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.7}], "name": "kraken", "value": 1518.3}]} 18:50:46 INFO - Return code: 0 18:50:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:50:46 ERROR - # TBPL SUCCESS # 18:50:46 INFO - Running post-action listener: _resource_record_post_action 18:50:46 INFO - Running post-run listener: _resource_record_post_run 18:50:47 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 12288; Write bytes: 533643264; Read time: 148; Write time: 471732 18:50:47 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 247668736; Read time: 0; Write time: 327396 18:50:47 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 12288; Write bytes: 285974528; Read time: 148; Write time: 144336 18:50:47 INFO - Running post-run listener: _upload_blobber_files 18:50:47 INFO - Blob upload gear active. 18:50:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:50:47 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:50:47 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'] 18:50:47 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 18:50:48 INFO - (blobuploader) - INFO - Open directory for files ... 18:50:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:50:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:50:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:50:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:50:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:50:48 INFO - (blobuploader) - INFO - Done attempting. 18:50:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:50:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:50:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:50:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:50:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:50:49 INFO - (blobuploader) - INFO - Done attempting. 18:50:49 INFO - (blobuploader) - INFO - Iteration through files over. 18:50:49 INFO - Return code: 0 18:50:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:50:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:50:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/44d8f6cffa29bbe5e14e4362d4f2ebee1cf2dd6e4de837698069f3fd419c99c40917bb6388394d4c59b23dad6ace9e57385c8c35661be94df8b2b50029632b6d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7bfbb1fbedb9f54e340d69998f02190b24b42360a1d75afd98775836b00b89a29bef79aad38dd0589ed5d8564d40bedd98445e9c996e366ef46ae5599787330b"} 18:50:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:50:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:50:49 INFO - Contents: 18:50:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/44d8f6cffa29bbe5e14e4362d4f2ebee1cf2dd6e4de837698069f3fd419c99c40917bb6388394d4c59b23dad6ace9e57385c8c35661be94df8b2b50029632b6d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7bfbb1fbedb9f54e340d69998f02190b24b42360a1d75afd98775836b00b89a29bef79aad38dd0589ed5d8564d40bedd98445e9c996e366ef46ae5599787330b"} 18:50:49 INFO - Running post-run listener: copy_logs_to_upload_dir 18:50:49 INFO - Copying logs to upload dir... 18:50:49 INFO - mkdir: /builds/slave/test/build/upload/logs 18:50:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.383839 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-03-15 18:50:49.660966) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-15 18:50:49.664139) ========= 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=aa08bb06ff6271ef470a76a4000001be-1458091168.268648-229101067 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/44d8f6cffa29bbe5e14e4362d4f2ebee1cf2dd6e4de837698069f3fd419c99c40917bb6388394d4c59b23dad6ace9e57385c8c35661be94df8b2b50029632b6d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7bfbb1fbedb9f54e340d69998f02190b24b42360a1d75afd98775836b00b89a29bef79aad38dd0589ed5d8564d40bedd98445e9c996e366ef46ae5599787330b"} build_url:https://queue.taskcluster.net/v1/task/Lksn9GWDQH6qrPc0bUbJAw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011360 build_url: 'https://queue.taskcluster.net/v1/task/Lksn9GWDQH6qrPc0bUbJAw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/44d8f6cffa29bbe5e14e4362d4f2ebee1cf2dd6e4de837698069f3fd419c99c40917bb6388394d4c59b23dad6ace9e57385c8c35661be94df8b2b50029632b6d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7bfbb1fbedb9f54e340d69998f02190b24b42360a1d75afd98775836b00b89a29bef79aad38dd0589ed5d8564d40bedd98445e9c996e366ef46ae5599787330b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-15 18:50:49.689022) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 18:50:49.689352) ========= 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=aa08bb06ff6271ef470a76a4000001be-1458091168.268648-229101067 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 18:50:49.773635) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-15 18:50:49.773963) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-15 18:50:49.774284) ========= ========= Total master_lag: 0.57 =========