builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1460644336.75 results: success (0) buildid: 20160414043009 builduid: 5932c9d202b54d4bb055a02eae7a328e revision: 91115264629dfaacf2d60d52a3eff89c18c5af0d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 07:32:16.746459) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 07:32:16.747531) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 07:32:16.748131) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 07:32:16.774263) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 07:32:16.774571) ========= 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=337fe3f4b1febe37b85fccc40000019e-1460643267.380907-168060158 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-14 07:32:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-04-14 07:32:17 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.155300 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 07:32:16.953233) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 07:32:16.953570) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1460643267.380907-168060158 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018292 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 07:32:17.007460) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 07:32:17.007807) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 91115264629dfaacf2d60d52a3eff89c18c5af0d --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 91115264629dfaacf2d60d52a3eff89c18c5af0d --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=337fe3f4b1febe37b85fccc40000019e-1460643267.380907-168060158 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-14 07:32:17,370 truncating revision to first 12 chars 2016-04-14 07:32:17,370 Setting DEBUG logging. 2016-04-14 07:32:17,370 attempt 1/10 2016-04-14 07:32:17,370 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/91115264629d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-14 07:32:17,894 unpacking tar archive at: mozilla-central-91115264629d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.823899 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 07:32:17.845416) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 07:32:17.845728) ========= script_repo_revision: 91115264629dfaacf2d60d52a3eff89c18c5af0d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 07:32:17.846175) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 07:32:17.846498) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 07:32:17.860126) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-04-14 07:32:17.860483) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=337fe3f4b1febe37b85fccc40000019e-1460643267.380907-168060158 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:32:18 INFO - MultiFileLogger online at 20160414 07:32:18 in /builds/slave/test 07:32:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:32:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:32:18 INFO - {'append_to_log': False, 07:32:18 INFO - 'base_work_dir': '/builds/slave/test', 07:32:18 INFO - 'blob_upload_branch': 'Firefox', 07:32:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:32:18 INFO - 'branch': 'Firefox', 07:32:18 INFO - 'buildbot_json_path': 'buildprops.json', 07:32:18 INFO - 'config_files': ('talos/linux_config.py',), 07:32:18 INFO - 'default_actions': ('clobber', 07:32:18 INFO - 'read-buildbot-config', 07:32:18 INFO - 'download-and-extract', 07:32:18 INFO - 'populate-webroot', 07:32:18 INFO - 'create-virtualenv', 07:32:18 INFO - 'install', 07:32:18 INFO - 'run-tests'), 07:32:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:32:18 INFO - 'download_minidump_stackwalk': True, 07:32:18 INFO - 'download_symbols': 'ondemand', 07:32:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:32:18 INFO - 'tooltool.py': '/tools/tooltool.py', 07:32:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:32:18 INFO - '/tools/misc-python/virtualenv.py')}, 07:32:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:32:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:32:18 INFO - 'installer_path': 'installer.exe', 07:32:18 INFO - 'log_level': 'info', 07:32:18 INFO - 'log_name': 'talos', 07:32:18 INFO - 'log_to_console': True, 07:32:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:32:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:32:18 INFO - 'opt_config_files': (), 07:32:18 INFO - 'pip_index': False, 07:32:18 INFO - 'sps_profile': False, 07:32:18 INFO - 'sps_profile_interval': 0, 07:32:18 INFO - 'suite': 'dromaeojs', 07:32:18 INFO - 'system_bits': '32', 07:32:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:32:18 INFO - 'title': 'talos-linux64-ix-060', 07:32:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:32:18 INFO - 'use_talos_json': True, 07:32:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:32:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:32:18 INFO - 'work_dir': 'build'} 07:32:18 INFO - ##### 07:32:18 INFO - ##### Running clobber step. 07:32:18 INFO - ##### 07:32:18 INFO - Running pre-action listener: _resource_record_pre_action 07:32:18 INFO - Running main action method: clobber 07:32:18 INFO - rmtree: /builds/slave/test/build 07:32:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:32:19 INFO - Running post-action listener: _resource_record_post_action 07:32:19 INFO - ##### 07:32:19 INFO - ##### Running read-buildbot-config step. 07:32:19 INFO - ##### 07:32:19 INFO - Running pre-action listener: _resource_record_pre_action 07:32:19 INFO - Running main action method: read_buildbot_config 07:32:19 INFO - Using buildbot properties: 07:32:19 INFO - { 07:32:19 INFO - "project": "", 07:32:19 INFO - "product": "firefox", 07:32:19 INFO - "script_repo_revision": "production", 07:32:19 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:32:19 INFO - "repository": "", 07:32:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 07:32:19 INFO - "buildid": "20160414043009", 07:32:19 INFO - "pgo_build": "True", 07:32:19 INFO - "basedir": "/builds/slave/test", 07:32:19 INFO - "buildnumber": 258, 07:32:19 INFO - "slavename": "talos-linux64-ix-060", 07:32:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:32:19 INFO - "platform": "ubuntu64_hw", 07:32:19 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:32:19 INFO - "branch": "mozilla-central", 07:32:19 INFO - "repo_path": "mozilla-central", 07:32:19 INFO - "revision": "91115264629dfaacf2d60d52a3eff89c18c5af0d", 07:32:19 INFO - "stage_platform": "linux64-pgo", 07:32:19 INFO - "builduid": "5932c9d202b54d4bb055a02eae7a328e", 07:32:19 INFO - "slavebuilddir": "test" 07:32:19 INFO - } 07:32:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/YQKAvJTLSIyrYGPJcHCn5g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 07:32:19 INFO - Running post-action listener: _resource_record_post_action 07:32:19 INFO - ##### 07:32:19 INFO - ##### Running download-and-extract step. 07:32:19 INFO - ##### 07:32:19 INFO - Running pre-action listener: _resource_record_pre_action 07:32:19 INFO - Running main action method: download_and_extract 07:32:19 INFO - mkdir: /builds/slave/test/build/tests 07:32: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')]} 07:32:19 INFO - https://queue.taskcluster.net/v1/task/YQKAvJTLSIyrYGPJcHCn5g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:32:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQKAvJTLSIyrYGPJcHCn5g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:32:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQKAvJTLSIyrYGPJcHCn5g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:32:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQKAvJTLSIyrYGPJcHCn5g/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 07:32:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQKAvJTLSIyrYGPJcHCn5g/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 07:32:19 INFO - Downloaded 1361 bytes. 07:32:19 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:32:19 INFO - Using the following test package requirements: 07:32:19 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:32:19 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:32:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:32:19 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:32:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:32:19 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:32:19 INFO - u'jsshell-linux-x86_64.zip'], 07:32:19 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:32:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:32:19 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:32:19 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:32:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:32:19 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:32:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:32:19 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:32:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:32:19 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:32:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:32:19 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:32: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')]} 07:32:19 INFO - https://queue.taskcluster.net/v1/task/YQKAvJTLSIyrYGPJcHCn5g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:32:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQKAvJTLSIyrYGPJcHCn5g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:32:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQKAvJTLSIyrYGPJcHCn5g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:32:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQKAvJTLSIyrYGPJcHCn5g/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 07:32:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQKAvJTLSIyrYGPJcHCn5g/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 07:32:21 INFO - Downloaded 23774359 bytes. 07:32:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:32:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:32:22 INFO - Return code: 0 07:32:22 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:32:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:32:22 INFO - https://queue.taskcluster.net/v1/task/YQKAvJTLSIyrYGPJcHCn5g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:32:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQKAvJTLSIyrYGPJcHCn5g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:32:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQKAvJTLSIyrYGPJcHCn5g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:32:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQKAvJTLSIyrYGPJcHCn5g/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 07:32:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQKAvJTLSIyrYGPJcHCn5g/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 07:32:25 INFO - Downloaded 23774359 bytes. 07:32:25 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'] 07:32:25 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 07:32:26 INFO - Return code: 0 07:32:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:32:26 INFO - https://queue.taskcluster.net/v1/task/YQKAvJTLSIyrYGPJcHCn5g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:32:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQKAvJTLSIyrYGPJcHCn5g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:32:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQKAvJTLSIyrYGPJcHCn5g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:32:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQKAvJTLSIyrYGPJcHCn5g/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 07:32:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQKAvJTLSIyrYGPJcHCn5g/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 07:32:27 INFO - Downloaded 10841076 bytes. 07:32:27 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'] 07:32:27 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 07:32:27 INFO - Return code: 0 07:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:32:27 INFO - https://queue.taskcluster.net/v1/task/YQKAvJTLSIyrYGPJcHCn5g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:32:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQKAvJTLSIyrYGPJcHCn5g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:32:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQKAvJTLSIyrYGPJcHCn5g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:32:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQKAvJTLSIyrYGPJcHCn5g/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 07:32:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQKAvJTLSIyrYGPJcHCn5g/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 07:32:29 INFO - Downloaded 58137284 bytes. 07:32:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YQKAvJTLSIyrYGPJcHCn5g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:32:29 INFO - mkdir: /builds/slave/test/properties 07:32:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:32:29 INFO - Writing to file /builds/slave/test/properties/build_url 07:32:29 INFO - Contents: 07:32:29 INFO - build_url:https://queue.taskcluster.net/v1/task/YQKAvJTLSIyrYGPJcHCn5g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:32:29 INFO - Running post-action listener: _resource_record_post_action 07:32:29 INFO - Running post-action listener: set_extra_try_arguments 07:32:29 INFO - ##### 07:32:29 INFO - ##### Running populate-webroot step. 07:32:29 INFO - ##### 07:32:29 INFO - Running pre-action listener: _resource_record_pre_action 07:32:29 INFO - Running main action method: populate_webroot 07:32:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:32:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:32:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:32:29 INFO - '--tppagecycles', 07:32:29 INFO - '7'], 07:32:29 INFO - 'tests': ['tsvgm']}}, 07:32:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:32:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:32:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:32:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:32:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:32:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:32:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:29 INFO - 'talos_options': ['--disable-e10s'], 07:32:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:32:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:32:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:29 INFO - 'talos_options': ['--disable-e10s'], 07:32:29 INFO - 'tests': ['damp', 'tps']}, 07:32:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:29 INFO - 'tests': ['damp', 'tps']}, 07:32:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:32:29 INFO - 'tests': ['dromaeo_dom']}, 07:32:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:32:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:32:29 INFO - 'tests': ['a11yr', 07:32:29 INFO - 'ts_paint', 07:32:29 INFO - 'tpaint', 07:32:29 INFO - 'sessionrestore', 07:32:29 INFO - 'sessionrestore_no_auto_restore', 07:32:29 INFO - 'tabpaint']}, 07:32:29 INFO - 'other-e10s': {'tests': ['a11yr', 07:32:29 INFO - 'ts_paint', 07:32:29 INFO - 'tpaint', 07:32:29 INFO - 'sessionrestore', 07:32:29 INFO - 'sessionrestore_no_auto_restore', 07:32:29 INFO - 'tabpaint']}, 07:32:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:32:29 INFO - 'ts_paint', 07:32:29 INFO - 'tpaint', 07:32:29 INFO - 'sessionrestore', 07:32:29 INFO - 'sessionrestore_no_auto_restore', 07:32:29 INFO - 'tabpaint']}, 07:32:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:32:29 INFO - 'ts_paint', 07:32:29 INFO - 'tpaint', 07:32:29 INFO - 'sessionrestore', 07:32:29 INFO - 'sessionrestore_no_auto_restore', 07:32:29 INFO - 'tabpaint']}, 07:32:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:32:29 INFO - 'tests': ['a11yr', 07:32:29 INFO - 'ts_paint', 07:32:29 INFO - 'tpaint', 07:32:29 INFO - 'sessionrestore', 07:32:29 INFO - 'sessionrestore_no_auto_restore', 07:32:29 INFO - 'tabpaint']}, 07:32:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:32:29 INFO - 'tests': ['a11yr', 07:32:29 INFO - 'ts_paint', 07:32:29 INFO - 'tpaint', 07:32:29 INFO - 'sessionrestore', 07:32:29 INFO - 'sessionrestore_no_auto_restore', 07:32:29 INFO - 'tabpaint']}, 07:32:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:32:29 INFO - 'tests': ['tsvgx', 07:32:29 INFO - 'tsvgr_opacity', 07:32:29 INFO - 'tart', 07:32:29 INFO - 'tscrollx', 07:32:29 INFO - 'cart']}, 07:32:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:32:29 INFO - 'tsvgr_opacity', 07:32:29 INFO - 'tart', 07:32:29 INFO - 'tscrollx', 07:32:29 INFO - 'cart']}, 07:32:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:29 INFO - 'talos_options': ['--disable-e10s'], 07:32:29 INFO - 'tests': ['tp5o']}, 07:32:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:29 INFO - 'tests': ['tp5o']}, 07:32:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:29 INFO - 'talos_options': ['--disable-e10s', 07:32:29 INFO - '--xperf_path', 07:32:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:32:29 INFO - 'tests': ['tp5n']}, 07:32:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:29 INFO - 'talos_options': ['--xperf_path', 07:32:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:32:29 INFO - 'tests': ['tp5n']}}, 07:32:29 INFO - 'talos.zip': {'path': '', 07:32:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:32:29 INFO - Running post-action listener: _resource_record_post_action 07:32:29 INFO - ##### 07:32:29 INFO - ##### Running create-virtualenv step. 07:32:29 INFO - ##### 07:32:29 INFO - Running pre-action listener: _resource_record_pre_action 07:32:29 INFO - Running main action method: create_virtualenv 07:32:29 INFO - Creating virtualenv /builds/slave/test/build/venv 07:32:29 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:32:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:32:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:32:29 INFO - Using real prefix '/usr' 07:32:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:32:30 INFO - Installing distribute.............................................................................................................................................................................................done. 07:32:32 INFO - Installing pip.................done. 07:32:32 INFO - Return code: 0 07:32:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:32:32 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')]} 07:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:32 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')]} 07:32:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:32 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 0x7efffe136f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12129a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a1810>, '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 0x12a2710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a2ba0>, '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': '337fe3f4b1febe37b85fccc40000019e-1460643267.380907-168060158', '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 07:32:32 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 07:32:32 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 07:32:32 INFO - Using env: {'DISPLAY': ':0', 07:32:32 INFO - 'HOME': '/home/cltbld', 07:32:32 INFO - 'LANG': 'en_US.UTF-8', 07:32:32 INFO - 'LANGUAGE': 'en_US:en', 07:32:32 INFO - 'LOGNAME': 'cltbld', 07:32:32 INFO - 'MAIL': '/var/mail/cltbld', 07:32:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:32 INFO - 'MOZ_NO_REMOTE': '1', 07:32:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:32:32 INFO - 'NO_EM_RESTART': '1', 07:32:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:32:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:32 INFO - 'PWD': '/builds/slave/test', 07:32:32 INFO - 'SHELL': '/bin/bash', 07:32:32 INFO - 'SHLVL': '1', 07:32:32 INFO - 'TERM': 'linux', 07:32:32 INFO - 'TMOUT': '86400', 07:32:32 INFO - 'USER': 'cltbld', 07:32:32 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1460643267.380907-168060158', 07:32:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:32 INFO - '_': '/tools/buildbot/bin/python'} 07:32:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:32 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 07:32:32 INFO - Cleaning up... 07:32:32 INFO - Return code: 0 07:32:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:32:32 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')]} 07:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:32 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')]} 07:32:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:32 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 0x7efffe136f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12129a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a1810>, '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 0x12a2710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a2ba0>, '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': '337fe3f4b1febe37b85fccc40000019e-1460643267.380907-168060158', '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 07:32:32 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 07:32:32 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 07:32:32 INFO - Using env: {'DISPLAY': ':0', 07:32:32 INFO - 'HOME': '/home/cltbld', 07:32:32 INFO - 'LANG': 'en_US.UTF-8', 07:32:32 INFO - 'LANGUAGE': 'en_US:en', 07:32:32 INFO - 'LOGNAME': 'cltbld', 07:32:32 INFO - 'MAIL': '/var/mail/cltbld', 07:32:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:32 INFO - 'MOZ_NO_REMOTE': '1', 07:32:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:32:32 INFO - 'NO_EM_RESTART': '1', 07:32:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:32:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:32 INFO - 'PWD': '/builds/slave/test', 07:32:32 INFO - 'SHELL': '/bin/bash', 07:32:32 INFO - 'SHLVL': '1', 07:32:32 INFO - 'TERM': 'linux', 07:32:32 INFO - 'TMOUT': '86400', 07:32:32 INFO - 'USER': 'cltbld', 07:32:32 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1460643267.380907-168060158', 07:32:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:32 INFO - '_': '/tools/buildbot/bin/python'} 07:32:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:32 INFO - Downloading/unpacking psutil>=0.7.1 07:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:32:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:32:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:32:34 INFO - Installing collected packages: psutil 07:32:34 INFO - Running setup.py install for psutil 07:32:34 INFO - building 'psutil._psutil_linux' extension 07:32:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:32:35 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 07:32:35 INFO - building 'psutil._psutil_posix' extension 07:32:35 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 07:32:35 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 07:32:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:32:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:32:35 INFO - Successfully installed psutil 07:32:35 INFO - Cleaning up... 07:32:35 INFO - Return code: 0 07:32:35 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:32: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')]} 07:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32: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')]} 07:32:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32: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', '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 0x7efffe136f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12129a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a1810>, '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 0x12a2710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a2ba0>, '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': '337fe3f4b1febe37b85fccc40000019e-1460643267.380907-168060158', '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 07:32: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:32: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 mozsystemmonitor==0.0.0 07:32:35 INFO - Using env: {'DISPLAY': ':0', 07:32:35 INFO - 'HOME': '/home/cltbld', 07:32:35 INFO - 'LANG': 'en_US.UTF-8', 07:32:35 INFO - 'LANGUAGE': 'en_US:en', 07:32:35 INFO - 'LOGNAME': 'cltbld', 07:32:35 INFO - 'MAIL': '/var/mail/cltbld', 07:32:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:35 INFO - 'MOZ_NO_REMOTE': '1', 07:32:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:32:35 INFO - 'NO_EM_RESTART': '1', 07:32:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:32:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:35 INFO - 'PWD': '/builds/slave/test', 07:32:35 INFO - 'SHELL': '/bin/bash', 07:32:35 INFO - 'SHLVL': '1', 07:32:35 INFO - 'TERM': 'linux', 07:32:35 INFO - 'TMOUT': '86400', 07:32:35 INFO - 'USER': 'cltbld', 07:32:35 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1460643267.380907-168060158', 07:32:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:35 INFO - '_': '/tools/buildbot/bin/python'} 07:32:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:32: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 07:32: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 07:32: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 07:32: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 07:32: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 07:32: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 07:32:37 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:32:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:32:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:32:37 INFO - Installing collected packages: mozsystemmonitor 07:32:37 INFO - Running setup.py install for mozsystemmonitor 07:32:37 INFO - Successfully installed mozsystemmonitor 07:32:37 INFO - Cleaning up... 07:32:37 INFO - Return code: 0 07:32:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:32:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:32:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:32:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:37 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 0x7efffe136f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12129a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a1810>, '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 0x12a2710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a2ba0>, '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': '337fe3f4b1febe37b85fccc40000019e-1460643267.380907-168060158', '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 07:32:37 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 07:32:37 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 07:32:37 INFO - Using env: {'DISPLAY': ':0', 07:32:37 INFO - 'HOME': '/home/cltbld', 07:32:37 INFO - 'LANG': 'en_US.UTF-8', 07:32:37 INFO - 'LANGUAGE': 'en_US:en', 07:32:37 INFO - 'LOGNAME': 'cltbld', 07:32:37 INFO - 'MAIL': '/var/mail/cltbld', 07:32:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:37 INFO - 'MOZ_NO_REMOTE': '1', 07:32:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:32:37 INFO - 'NO_EM_RESTART': '1', 07:32:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:32:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:37 INFO - 'PWD': '/builds/slave/test', 07:32:37 INFO - 'SHELL': '/bin/bash', 07:32:37 INFO - 'SHLVL': '1', 07:32:37 INFO - 'TERM': 'linux', 07:32:37 INFO - 'TMOUT': '86400', 07:32:37 INFO - 'USER': 'cltbld', 07:32:37 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1460643267.380907-168060158', 07:32:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:37 INFO - '_': '/tools/buildbot/bin/python'} 07:32:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:37 INFO - Downloading/unpacking blobuploader==1.2.4 07:32: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 07:32: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 07:32: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 07:32: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 07:32: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 07:32: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 07:32:39 INFO - Downloading blobuploader-1.2.4.tar.gz 07:32:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:32:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:32:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:32:40 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 07:32:40 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 07:32:40 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 07:32:40 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 07:32:40 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 07:32:40 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 07:32:40 INFO - Downloading docopt-0.6.1.tar.gz 07:32:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:32:40 INFO - Installing collected packages: blobuploader, requests, docopt 07:32:40 INFO - Running setup.py install for blobuploader 07:32:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:32:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:32:40 INFO - Running setup.py install for requests 07:32:40 INFO - Running setup.py install for docopt 07:32:41 INFO - Successfully installed blobuploader requests docopt 07:32:41 INFO - Cleaning up... 07:32:41 INFO - Return code: 0 07:32:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:32: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')]} 07:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32: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')]} 07:32:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:41 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 0x7efffe136f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12129a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a1810>, '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 0x12a2710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a2ba0>, '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': '337fe3f4b1febe37b85fccc40000019e-1460643267.380907-168060158', '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 07:32:41 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 07:32:41 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 07:32:41 INFO - Using env: {'DISPLAY': ':0', 07:32:41 INFO - 'HOME': '/home/cltbld', 07:32:41 INFO - 'LANG': 'en_US.UTF-8', 07:32:41 INFO - 'LANGUAGE': 'en_US:en', 07:32:41 INFO - 'LOGNAME': 'cltbld', 07:32:41 INFO - 'MAIL': '/var/mail/cltbld', 07:32:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:41 INFO - 'MOZ_NO_REMOTE': '1', 07:32:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:32:41 INFO - 'NO_EM_RESTART': '1', 07:32:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:32:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:41 INFO - 'PWD': '/builds/slave/test', 07:32:41 INFO - 'SHELL': '/bin/bash', 07:32:41 INFO - 'SHLVL': '1', 07:32:41 INFO - 'TERM': 'linux', 07:32:41 INFO - 'TMOUT': '86400', 07:32:41 INFO - 'USER': 'cltbld', 07:32:41 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1460643267.380907-168060158', 07:32:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:41 INFO - '_': '/tools/buildbot/bin/python'} 07:32:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:32:41 INFO - Running setup.py (path:/tmp/pip-8fGq16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:32:41 INFO - Running setup.py (path:/tmp/pip-NZGDU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:32:41 INFO - Running setup.py (path:/tmp/pip-5YFiSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:32:41 INFO - Running setup.py (path:/tmp/pip-PGTDQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:32:41 INFO - Running setup.py (path:/tmp/pip-5trivk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:32:41 INFO - Running setup.py (path:/tmp/pip-_4duey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:32:41 INFO - Running setup.py (path:/tmp/pip-m0b4Ya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:32:41 INFO - Running setup.py (path:/tmp/pip-qBmPHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:32:41 INFO - Running setup.py (path:/tmp/pip-sd51QF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:32:42 INFO - Running setup.py (path:/tmp/pip-1XamMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:32:42 INFO - Running setup.py (path:/tmp/pip-5MwzHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:32:42 INFO - Running setup.py (path:/tmp/pip-TiwK2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:32:42 INFO - Running setup.py (path:/tmp/pip-t8rDYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:32:42 INFO - Running setup.py (path:/tmp/pip-9ISO9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:32:42 INFO - Running setup.py (path:/tmp/pip-aFZLQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:32:42 INFO - Running setup.py (path:/tmp/pip-mDLk1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:32:42 INFO - Running setup.py (path:/tmp/pip-b07cgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:32:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:32:42 INFO - Running setup.py install for manifestparser 07:32:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:32:42 INFO - Running setup.py install for mozcrash 07:32:42 INFO - Running setup.py install for mozdebug 07:32:42 INFO - Running setup.py install for mozdevice 07:32:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:32:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:32:43 INFO - Running setup.py install for mozfile 07:32:43 INFO - Running setup.py install for mozhttpd 07:32:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:32:43 INFO - Running setup.py install for mozinfo 07:32:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:32:43 INFO - Running setup.py install for mozInstall 07:32:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:32:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:32:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:32:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:32:43 INFO - Running setup.py install for mozleak 07:32:43 INFO - Running setup.py install for mozlog 07:32:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:32:43 INFO - Running setup.py install for moznetwork 07:32:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:32:43 INFO - Running setup.py install for mozprocess 07:32:43 INFO - Running setup.py install for mozprofile 07:32:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:32:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:32:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:32:43 INFO - Running setup.py install for mozrunner 07:32:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:32:44 INFO - Running setup.py install for mozscreenshot 07:32:44 INFO - Running setup.py install for moztest 07:32:44 INFO - Running setup.py install for mozversion 07:32:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:32:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:32:44 INFO - Cleaning up... 07:32:44 INFO - Return code: 0 07:32:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:32:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:32:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:44 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 0x7efffe136f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12129a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a1810>, '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 0x12a2710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a2ba0>, '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': '337fe3f4b1febe37b85fccc40000019e-1460643267.380907-168060158', '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 07:32:44 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 07:32:44 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 07:32:44 INFO - Using env: {'DISPLAY': ':0', 07:32:44 INFO - 'HOME': '/home/cltbld', 07:32:44 INFO - 'LANG': 'en_US.UTF-8', 07:32:44 INFO - 'LANGUAGE': 'en_US:en', 07:32:44 INFO - 'LOGNAME': 'cltbld', 07:32:44 INFO - 'MAIL': '/var/mail/cltbld', 07:32:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:44 INFO - 'MOZ_NO_REMOTE': '1', 07:32:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:32:44 INFO - 'NO_EM_RESTART': '1', 07:32:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:32:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:44 INFO - 'PWD': '/builds/slave/test', 07:32:44 INFO - 'SHELL': '/bin/bash', 07:32:44 INFO - 'SHLVL': '1', 07:32:44 INFO - 'TERM': 'linux', 07:32:44 INFO - 'TMOUT': '86400', 07:32:44 INFO - 'USER': 'cltbld', 07:32:44 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1460643267.380907-168060158', 07:32:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:44 INFO - '_': '/tools/buildbot/bin/python'} 07:32:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:32:44 INFO - Running setup.py (path:/tmp/pip-JbkhSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:32:44 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)) 07:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:32:44 INFO - Running setup.py (path:/tmp/pip-WLor0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:32:44 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)) 07:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:32:44 INFO - Running setup.py (path:/tmp/pip-9wiUox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:32:44 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)) 07:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:32:44 INFO - Running setup.py (path:/tmp/pip-19Zi0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:32:44 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)) 07:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:32:44 INFO - Running setup.py (path:/tmp/pip-ilnJTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:32:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:32:44 INFO - Running setup.py (path:/tmp/pip-ffuPRu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:32:45 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)) 07:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:32:45 INFO - Running setup.py (path:/tmp/pip-NuPVVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:32:45 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)) 07:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:32:45 INFO - Running setup.py (path:/tmp/pip-l1uXyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:32:45 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)) 07:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:32:45 INFO - Running setup.py (path:/tmp/pip-dgeMUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:32:45 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)) 07:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:32:45 INFO - Running setup.py (path:/tmp/pip-NeYJ9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:32:45 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)) 07:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:32:45 INFO - Running setup.py (path:/tmp/pip-DIVfj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:32:45 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)) 07:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:32:45 INFO - Running setup.py (path:/tmp/pip-rahsUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:32:45 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)) 07:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:32:45 INFO - Running setup.py (path:/tmp/pip-xiAqi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:32:45 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)) 07:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:32:45 INFO - Running setup.py (path:/tmp/pip-UyZZbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:32:45 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)) 07:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:32:45 INFO - Running setup.py (path:/tmp/pip-WPFgcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:32:45 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)) 07:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:32:45 INFO - Running setup.py (path:/tmp/pip-IU8Oqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:32:45 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)) 07:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:32:45 INFO - Running setup.py (path:/tmp/pip-3YBG0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:32:45 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)) 07:32:45 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)) 07:32:45 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)) 07:32:45 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)) 07:32:45 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)) 07:32:45 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)) 07:32:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:32:45 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 07:32:45 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 07:32:45 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 07:32:45 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 07:32:45 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 07:32:45 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 07:32:47 INFO - Downloading blessings-1.6.tar.gz 07:32:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:32:47 INFO - Installing collected packages: blessings 07:32:47 INFO - Running setup.py install for blessings 07:32:47 INFO - Successfully installed blessings 07:32:47 INFO - Cleaning up... 07:32:47 INFO - Return code: 0 07:32:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:32:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:32:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:32:48 INFO - Reading from file tmpfile_stdout 07:32:48 INFO - Current package versions: 07:32:48 INFO - argparse == 1.2.1 07:32:48 INFO - blessings == 1.6 07:32:48 INFO - blobuploader == 1.2.4 07:32:48 INFO - docopt == 0.6.1 07:32:48 INFO - manifestparser == 1.1 07:32:48 INFO - mozInstall == 1.12 07:32:48 INFO - mozcrash == 0.17 07:32:48 INFO - mozdebug == 0.1 07:32:48 INFO - mozdevice == 0.48 07:32:48 INFO - mozfile == 1.2 07:32:48 INFO - mozhttpd == 0.7 07:32:48 INFO - mozinfo == 0.9 07:32:48 INFO - mozleak == 0.1 07:32:48 INFO - mozlog == 3.1 07:32:48 INFO - moznetwork == 0.27 07:32:48 INFO - mozprocess == 0.22 07:32:48 INFO - mozprofile == 0.28 07:32:48 INFO - mozrunner == 6.11 07:32:48 INFO - mozscreenshot == 0.1 07:32:48 INFO - mozsystemmonitor == 0.0 07:32:48 INFO - moztest == 0.7 07:32:48 INFO - mozversion == 1.4 07:32:48 INFO - psutil == 3.1.1 07:32:48 INFO - requests == 1.2.3 07:32:48 INFO - wsgiref == 0.1.2 07:32:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:32: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')]} 07:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32: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')]} 07:32:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:48 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 0x7efffe136f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12129a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a1810>, '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 0x12a2710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a2ba0>, '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': '337fe3f4b1febe37b85fccc40000019e-1460643267.380907-168060158', '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 07:32:48 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 07:32:48 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 07:32:48 INFO - Using env: {'DISPLAY': ':0', 07:32:48 INFO - 'HOME': '/home/cltbld', 07:32:48 INFO - 'LANG': 'en_US.UTF-8', 07:32:48 INFO - 'LANGUAGE': 'en_US:en', 07:32:48 INFO - 'LOGNAME': 'cltbld', 07:32:48 INFO - 'MAIL': '/var/mail/cltbld', 07:32:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:48 INFO - 'MOZ_NO_REMOTE': '1', 07:32:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:32:48 INFO - 'NO_EM_RESTART': '1', 07:32:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:32:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:48 INFO - 'PWD': '/builds/slave/test', 07:32:48 INFO - 'SHELL': '/bin/bash', 07:32:48 INFO - 'SHLVL': '1', 07:32:48 INFO - 'TERM': 'linux', 07:32:48 INFO - 'TMOUT': '86400', 07:32:48 INFO - 'USER': 'cltbld', 07:32:48 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1460643267.380907-168060158', 07:32:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:48 INFO - '_': '/tools/buildbot/bin/python'} 07:32:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:48 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)) 07:32:48 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)) 07:32:48 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)) 07:32:48 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)) 07:32:48 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)) 07:32:48 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)) 07:32:48 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)) 07:32:48 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)) 07:32:48 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)) 07:32:48 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)) 07:32:48 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)) 07:32:48 INFO - Cleaning up... 07:32:48 INFO - Return code: 0 07:32:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:32: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')]} 07:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32: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')]} 07:32:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7efffe136f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12129a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a1810>, '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 0x12a2710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a2ba0>, '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': '337fe3f4b1febe37b85fccc40000019e-1460643267.380907-168060158', '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 07:32: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', 'jsonschema'] in /builds/slave/test/build 07:32: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 jsonschema 07:32:48 INFO - Using env: {'DISPLAY': ':0', 07:32:48 INFO - 'HOME': '/home/cltbld', 07:32:48 INFO - 'LANG': 'en_US.UTF-8', 07:32:48 INFO - 'LANGUAGE': 'en_US:en', 07:32:48 INFO - 'LOGNAME': 'cltbld', 07:32:48 INFO - 'MAIL': '/var/mail/cltbld', 07:32:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:48 INFO - 'MOZ_NO_REMOTE': '1', 07:32:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:32:48 INFO - 'NO_EM_RESTART': '1', 07:32:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:32:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:48 INFO - 'PWD': '/builds/slave/test', 07:32:48 INFO - 'SHELL': '/bin/bash', 07:32:48 INFO - 'SHLVL': '1', 07:32:48 INFO - 'TERM': 'linux', 07:32:48 INFO - 'TMOUT': '86400', 07:32:48 INFO - 'USER': 'cltbld', 07:32:48 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1460643267.380907-168060158', 07:32:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:48 INFO - '_': '/tools/buildbot/bin/python'} 07:32:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:48 INFO - Downloading/unpacking jsonschema 07:32: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 07:32: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 07:32: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 07:32: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 07:32: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 07:32: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 07:32:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:32:50 INFO - Downloading/unpacking functools32 (from jsonschema) 07:32: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 07:32: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 07:32: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 07:32: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 07:32: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 07:32: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 07:32:50 INFO - Downloading functools32-3.2.3-2.tar.gz 07:32:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:32:50 INFO - warning: no files found matching '*.txt' 07:32:50 INFO - no previously-included directories found matching 'build' 07:32:50 INFO - no previously-included directories found matching 'dist' 07:32:50 INFO - no previously-included directories found matching '.git*' 07:32:50 INFO - Installing collected packages: jsonschema, functools32 07:32:50 INFO - Running setup.py install for functools32 07:32:50 INFO - warning: no files found matching '*.txt' 07:32:50 INFO - no previously-included directories found matching 'build' 07:32:50 INFO - no previously-included directories found matching 'dist' 07:32:50 INFO - no previously-included directories found matching '.git*' 07:32:50 INFO - Successfully installed jsonschema functools32 07:32:50 INFO - Cleaning up... 07:32:50 INFO - Return code: 0 07:32:50 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:32:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:32:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:32:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7efffe136f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12129a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a1810>, '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 0x12a2710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a2ba0>, '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': '337fe3f4b1febe37b85fccc40000019e-1460643267.380907-168060158', '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 07:32:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:32:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:32:50 INFO - Using env: {'DISPLAY': ':0', 07:32:50 INFO - 'HOME': '/home/cltbld', 07:32:50 INFO - 'LANG': 'en_US.UTF-8', 07:32:50 INFO - 'LANGUAGE': 'en_US:en', 07:32:50 INFO - 'LOGNAME': 'cltbld', 07:32:50 INFO - 'MAIL': '/var/mail/cltbld', 07:32:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:50 INFO - 'MOZ_NO_REMOTE': '1', 07:32:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:32:50 INFO - 'NO_EM_RESTART': '1', 07:32:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:32:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:50 INFO - 'PWD': '/builds/slave/test', 07:32:50 INFO - 'SHELL': '/bin/bash', 07:32:50 INFO - 'SHLVL': '1', 07:32:50 INFO - 'TERM': 'linux', 07:32:50 INFO - 'TMOUT': '86400', 07:32:50 INFO - 'USER': 'cltbld', 07:32:50 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1460643267.380907-168060158', 07:32:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:50 INFO - '_': '/tools/buildbot/bin/python'} 07:32:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:51 INFO - Downloading/unpacking flake8 07:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:32:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:32:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:32:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:32:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:32:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:32:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:32:53 INFO - no previously-included directories found matching 'docs/_build' 07:32:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:32:53 INFO - Running setup.py install for pep8 07:32:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:32:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:32:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:32:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:32:53 INFO - no previously-included directories found matching 'docs/_build' 07:32:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:32:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:32:53 INFO - Cleaning up... 07:32:53 INFO - Return code: 0 07:32:53 INFO - Running post-action listener: _resource_record_post_action 07:32:53 INFO - Running post-action listener: _start_resource_monitoring 07:32:53 INFO - Starting resource monitoring. 07:32:53 INFO - ##### 07:32:53 INFO - ##### Running install step. 07:32:53 INFO - ##### 07:32:53 INFO - Running pre-action listener: _resource_record_pre_action 07:32:53 INFO - Running main action method: install 07:32:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:32:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:32:54 INFO - Reading from file tmpfile_stdout 07:32:54 INFO - Detecting whether we're running mozinstall >=1.0... 07:32:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:32:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:32:54 INFO - Reading from file tmpfile_stdout 07:32:54 INFO - Output received: 07:32:54 INFO - Usage: mozinstall [options] installer 07:32:54 INFO - Options: 07:32:54 INFO - -h, --help show this help message and exit 07:32:54 INFO - -d DEST, --destination=DEST 07:32:54 INFO - Directory to install application into. [default: 07:32:54 INFO - "/builds/slave/test"] 07:32:54 INFO - --app=APP Application being installed. [default: firefox] 07:32:54 INFO - mkdir: /builds/slave/test/build/application 07:32:54 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'] 07:32:54 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 07:33:10 INFO - Reading from file tmpfile_stdout 07:33:10 INFO - Output received: 07:33:10 INFO - /builds/slave/test/build/application/firefox/firefox 07:33:10 INFO - Running post-action listener: _resource_record_post_action 07:33:10 INFO - ##### 07:33:10 INFO - ##### Running run-tests step. 07:33:10 INFO - ##### 07:33:10 INFO - Running pre-action listener: _resource_record_pre_action 07:33:10 INFO - Running main action method: run_tests 07:33:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:33:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:33:10 INFO - Python 2.7.3 07:33:10 INFO - Return code: 0 07:33:10 INFO - grabbing minidump binary from tooltool 07:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:33:10 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 0x12a1810>, '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 0x12a2710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a2ba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:33:10 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 07:33:10 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 07:33:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:33:10 INFO - Return code: 0 07:33:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:33:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:33:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:33:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:33:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:33:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:33:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:33:11 INFO - Return code: 0 07:33:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YQKAvJTLSIyrYGPJcHCn5g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 07:33:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YQKAvJTLSIyrYGPJcHCn5g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 07:33:11 INFO - Using env: {'DISPLAY': ':0', 07:33:11 INFO - 'HOME': '/home/cltbld', 07:33:11 INFO - 'LANG': 'en_US.UTF-8', 07:33:11 INFO - 'LANGUAGE': 'en_US:en', 07:33:11 INFO - 'LOGNAME': 'cltbld', 07:33:11 INFO - 'MAIL': '/var/mail/cltbld', 07:33:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:33:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:33:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:11 INFO - 'MOZ_NO_REMOTE': '1', 07:33:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:33:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:33:11 INFO - 'NO_EM_RESTART': '1', 07:33:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:33:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:11 INFO - 'PWD': '/builds/slave/test', 07:33:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:33:11 INFO - 'SHELL': '/bin/bash', 07:33:11 INFO - 'SHLVL': '1', 07:33:11 INFO - 'TERM': 'linux', 07:33:11 INFO - 'TMOUT': '86400', 07:33:11 INFO - 'USER': 'cltbld', 07:33:11 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1460643267.380907-168060158', 07:33:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:11 INFO - '_': '/tools/buildbot/bin/python'} 07:33:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YQKAvJTLSIyrYGPJcHCn5g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 07:33:12 INFO - mozversion application_buildid: 20160414043009 07:33:12 INFO - mozversion application_changeset: 91115264629dfaacf2d60d52a3eff89c18c5af0d 07:33:12 INFO - mozversion application_display_name: Nightly 07:33:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:33:12 INFO - mozversion application_name: Firefox 07:33:12 INFO - mozversion application_remotingname: firefox 07:33:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:33:12 INFO - mozversion application_vendor: Mozilla 07:33:12 INFO - mozversion application_version: 48.0a1 07:33:12 INFO - mozversion platform_buildid: 20160414043009 07:33:12 INFO - mozversion platform_changeset: 91115264629dfaacf2d60d52a3eff89c18c5af0d 07:33:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:33:12 INFO - mozversion platform_version: 48.0a1 07:33:12 INFO - using testdate: 1460644392 07:33:12 INFO - actual date: 1460644392 07:33:12 INFO - starting webserver on 'localhost:58346' 07:33:12 INFO - SUITE-START | Running 2 tests 07:33:12 INFO - TEST-START | dromaeo_css 07:33:12 INFO - operating with platform_type : linux_ 07:33:12 INFO - Initialising browser for dromaeo_css test... 07:33:12 INFO - TEST-INFO | started process 16752 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZij4D0/profile http://localhost:58346/getInfo.html) 07:33:16 INFO - PROCESS | 16752 | __metrics Screen width/height:1600/1200 07:33:16 INFO - PROCESS | 16752 | colorDepth:24 07:33:16 INFO - PROCESS | 16752 | Browser inner width/height: 1024/697 07:33:16 INFO - PROCESS | 16752 | __metrics 07:33:17 ERROR - PROCESS | 16752 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:33:17 INFO - TEST-INFO | 16752: exit 0 07:33:17 INFO - Browser initialized. 07:33:17 INFO - Running cycle 1/1 for dromaeo_css test... 07:33:17 INFO - TEST-INFO | started process 16832 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZij4D0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:33:29 INFO - PROCESS | 16832 | RSS: Main: 152985600 07:33:29 INFO - PROCESS | 16832 | 07:34:20 INFO - PROCESS | 16832 | 1460644460649 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] 07:36:27 INFO - PROCESS | 16832 | Cycle 1(1): loaded http://localhost:58346/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58346/tests/dromaeo/cssquery-ext.html) 07:36:28 INFO - PROCESS | 16832 | RSS: Main: 262193152 07:36:28 INFO - PROCESS | 16832 | 07:39:31 INFO - PROCESS | 16832 | Cycle 1(1): loaded http://localhost:58346/tests/dromaeo/cssquery-ext.html (next: http://localhost:58346/tests/dromaeo/cssquery-jquery.html) 07:39:31 INFO - PROCESS | 16832 | RSS: Main: 231075840 07:39:31 INFO - PROCESS | 16832 | 07:42:33 INFO - PROCESS | 16832 | Cycle 1(1): loaded http://localhost:58346/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58346/tests/dromaeo/cssquery-mootools.html) 07:42:34 INFO - PROCESS | 16832 | RSS: Main: 234967040 07:42:34 INFO - PROCESS | 16832 | 07:45:36 INFO - PROCESS | 16832 | Cycle 1(1): loaded http://localhost:58346/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58346/tests/dromaeo/cssquery-prototype.html) 07:45:36 INFO - PROCESS | 16832 | RSS: Main: 231182336 07:45:36 INFO - PROCESS | 16832 | 07:48:39 INFO - PROCESS | 16832 | Cycle 1(1): loaded http://localhost:58346/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58346/tests/dromaeo/cssquery-yui.html) 07:48:39 INFO - PROCESS | 16832 | RSS: Main: 220311552 07:48:39 INFO - PROCESS | 16832 | 07:51:42 INFO - PROCESS | 16832 | Cycle 1(1): loaded http://localhost:58346/tests/dromaeo/cssquery-yui.html (next: http://localhost:58346/tests/dromaeo/cssquery-dojo.html) 07:51:42 INFO - PROCESS | 16832 | RSS: Main: 260153344 07:51:42 INFO - PROCESS | 16832 | 07:51:42 INFO - PROCESS | 16832 | __start_tp_report 07:51:42 INFO - PROCESS | 16832 | _x_x_mozilla_page_load 07:51:42 INFO - PROCESS | 16832 | _x_x_mozilla_page_load_details 07:51:42 INFO - PROCESS | 16832 | |i|pagename|runs| 07:51:42 INFO - PROCESS | 16832 | |0;dojo.html;3094.334718035622;3119.82840943748;3153.2432216268103;3161.2571045804248;3186.235303527154;5145.768440420181;5240.318758561387;5246.685198888069;5292.338457692788;5295.8146464873735;5264.499872512115;5293.52358287754;5313.495217954298;5318.388385335687;5333.493318134771;4714.834980775673;4789.976050119753;4879.658423910328;4883.19427294496;4923.70457772533;4668.626509879202;4870.0122569087725;4891.217405215166;4909.189983652693;4923.359963204778;4767.976160119195;4805.255185446244;4831.106245344622;4863.610911127102;4869.220924652039;4774.427068751772;4776.546228108359;4783.378160839069;4783.856484305476;4797.928031079502;4553.339765733983;4695.976520117378;4763.54746299101;4798.0643774464;4801.855944321641;5113.539781419653;5129.871753206163;5133;5137.871553211162;5163.1480805667015;5517.668939863621;5539.307586551681;5544.667319960815;5545.223668686387;5588.972055139739;5446.564274858002;5599.720013999325;5622.353429355636;5709.857253568653;5715.914261286084;5242.344706911636;5269.789208431658;5271.71005594696;5273.973630131902;5275.472452754732;5699.971500142473;5704.429557044263;5708.143778433268;5708.885822283531;5709.172170035322;5341.946580534222;5442.510174084351;5457.208704737791;5504.559635229172;5543.861403464945;5518.061929471999;5523.061079616475;5525.060739674184;5527.474889885454;5530.087535556669;5360.142377219626;5490.423505531861;5494.340679118532;5494.835154945358;5537.750801213955;5402.972985135049;5444.8094316698725;5456.536194423518;5493.066178749622;5503.9174412383845;4252.744835309892;4268.615824575803;4275.700700950903;4279.850205242801;4314.8489802857375;3687.078230442389;3819.083419979185;3837.9232415351535;3857.035741064734;3860.2472517858746;5307.203919412119;5318.547923426475;5326.92009619856;5329.573634109262;5372.462753724596;5623.662580245198;5641.633293835887;5652.547796176296;5652.604317697722;5652.773889044474;5052.242163675478;5296.1261391870685;5305.363356397257;5360.624756267024;5368.516833484927;4808.2547205183255;4822.469528351879;4826.6621336506105;4846.903061938741;4884.511548845158;5793.073108302651;5793.594448388657;5796.739146738407;5797.217375654317;5797.681127538026;5436.782528698966;5585.832425027255;5628.099504079328;5656.915146272727;5677.8864422710485;5792.073268277056;5818.505427038749;5822.155787410717;5831.387704290988;5832.912506312324;5539.556835453234;5539.695316757456;5541.6120871540215;5545.805896793593;5548.833534993957;5494.175873618829;5499.120140777456;5544.112941929272;5596.916046259228;5607.719614019365;5359.571234301168;5368.785248590013;5371.4897084776885;5372.462753724596;5372.5701943843615;5223.973880130575;5355.30381050461;5358.571314294769;5368;5402.540784033401;5285.418603953485;5320.0955837506945;5337.466253374631;5350.143976963667;5386.973065134649;5471.8084867029465;5494.423085576117;5503.7798488060025;5515.889682206253;5519.227308176778;5138.743062846917;5347.652402593819;5373.408925018323;5394.32570928634;5400.810971616132 07:51:42 INFO - PROCESS | 16832 | |1;ext.html;590.9881802363952;619.74900165433;636.5703150373498;652.096845868472;662.7282814046242;28769;37549.62450375495;38560.614393856056;38570;38587.42118868216;41156.58843411565;41867.371989420186;41883.162336753245;41891.790541047325;41913;8488.957555212215;8604.8709269361;8693.652253909837;8694.260987816044;8699.60851761669;8549.444286121383;8662.436941598777;8668.826623467527;8679.69621063263;8851.291896648285;8829.690960816373;8901.332400069989;8907.198352148305;8907.465552066897;8912.331575131891;8693.869591956125;8739.4756314621;8768.298536117096;8778.078301778349;8817.647294108228;8446.113158118433;8503.149685031509;8503.95748021262;8533.274671652916;8535.615897284575;40549.1890162198;40913.590864091275;41167.38248926269;41208.38187427161;41290.1741965159;3389.4915762635555;3635.72732045095;3645.325614761278;3738.7943663098517;4391.934120988188;30789.692103078905;31449.37101257962;31458;31569.8421507891;31732.365352693047;4055.1078762672164;4099.221147981903;4113.588641135892;4159.896002599929;4187.72779769314;257458;259505;260205;261051;261097.69451152813;57430;57802.71098644564;57863.42136578664;58242;58359.124613130836;56653.716731416076;60846;61153;64222.46776427248;65892;15646.843531564538;15731.606709832346;15747.291371888292;15760.448384306494;15768.92115539415;12563.246205227715;12619.621411357673;12629.747405051847;12646.683832904251;12660.113792034654;17059.147042648066;19099.522511937033;19129.617407652047;19661.606767864563;19682.606347872963;6950.200726916368;7364.189939106694;7395;7416.22129676387;7444.813879652944;1044.1072882685346;1073.9140868730483;1112.571659910924;1138.7893239750506;1239.7644447554935;30081.69918300789;30387.480625968612;30443.847780760956;31587.21031974173;32174.83912580422;1095.1348434736628;1095.1676725688376;1121.8036843552509;1151.165405081326;1210.3222195570333;16785.580360491087;17196.828031719524;17250.482485525456;17325.393611223546;17379.91310043467;463967;469182;470091;471563;473158;53847;54242.18636720452;54651.72674136604;57974.7101264491;58039.709801451565;1220.6216073017215;1341.637757805387;1397.475946520055;1423.3168079321983;1443.6607397261635;28592;30007;31917.68082319147;31963;32453.675463245065;44923;45489.090218196114;45546.54453455423;45604.771976139906;45633.771831140635;277927;279266;279360;279367;279604;24825.87587062053;40320.596794031684;40539.78380648585;40841.77474675765;41399.7930010348;46062.30906536338;46229;46513.53486465092;47227.52772472369;47538;40797.38803917884;41178.1764364705;41217.793911030254;41787;42458.36312455254;40032.79983600063;40622.1875562493;40685.1862962745;41807.790961045;42094;44174;44510.332345014205;44535.55464445314;45539;45688.54311456843;32875.50686739749;35173.472397914564;35336.82331588326;36004.27991440104;36153.63846361608;28910.710892890802;29239.85380073086;29453.603952145775;29537.26156846096;29659.555106673848 07:51:42 INFO - PROCESS | 16832 | |2;jquery.html;396.1028270966262;399.8960270329714;404.4499480706237;412.2065024827207;417.26561252196126;13584;15604.84395156048;17620.383286584973;18206.99999999998;18236.45290641281;14005.719885602282;16265.918670406661;17079.40222092227;17229.7415538767;17473.825261747377;5398.406175320722;5517.806876759314;5547.1679248112705;5550.8057217997375;5573.693446860421;3935.6457918787305;4152.771597562133;4155.916881662365;5462.235287059815;5856.707164641751;6131.3868613138775;6137.048757442603;6143.508519318466;6146.200993870791;6146.907796383035;5997.940020599804;6113.052476866093;6117.969410152965;6126.23422072241;6126.969365153168;5264.578833693296;5267.078261304257;5472.616916815825;5473.151661492475;5475;12820.166689165175;13496.122752021087;21612.89193554022;21707.131714731393;21750.782492175193;2028.8884111373868;2232.1406258590396;2379.3932547200525;2548.4775620997834;2872.6696429910617;9245.815083698355;9693.418394896258;10114.747131321703;10147.89852101477;10222.795544089151;1618.951431457058;1733;1739.1652007036694;1883.8210370014826;1889.527618095476;74537.62731186363;74675.62662186654;75645;75779.62110189525;76483.23516764816;10496.842547361795;10625.415602141802;10627.89372106269;10754.623588174532;10812.810220984828;14961.177135257447;15022.474213402478;15026.474073407378;15049.699006019819;15093.169875656724;7782.766517004499;7950.24472675095;8003.439759216915;8068.515889046676;8108.716194933149;7432.3310902019075;7545.660445279976;7574.318311351894;7718.382529397635;7876.606169691607;4166.375043743463;4344.891377715582;4584.518625544337;4594.885127871763;4604.97697511517;1926.1524929031182;1927.3254360973826;1937.6899696048565;1997.7402937618308;2001.349561392524;830.5099991005216;983.2871168402851;1023.2632504596678;1026.9435181065114;1144.9313041217554;17765;17886;17895.37366192177;18098.457046288633;18581.25674973013;998.1914649134225;1022.9641962531424;1032.4734385463469;1078.703356576932;1090.7818436312768;9820.901790982141;9902.900970990198;10144.3117573843;10248.180145588334;10455.84316235257;390697;413954;423063;425867;426348;52151.73924130355;81008.18991810006;82318;82345.58827205826;84230;1002.9289517147214;1003.6085926488676;1038.631285893512;1043.410473082706;1050.0864248104199;15581.688366232385;15685.215739213221;15773.68452630918;15831;16120.516384508484;34970.82514587411;35306;36888.63111368852;37177.62822371742;37267.8136609326;49378;49683.50949471522;50676.98646027133;50975.49024509856;51309;8208.220219079178;8299.294559962229;8319.251267385964;8370.4559203654;8454.450460720034;9225.400348977295;12021.398930053638;12272.631821045383;12380.566680166152;12601.18092323996;10973.451327433757;11218.887811121784;11272.774544509228;11324.886751132382;11422.714432139262;10507.211959103252;10632.89367106319;10739.838902416626;10846.457677115955;11026.4011718302;11090.16823738239;11175.10599152082;11310.660680179608;11440.771184576095;11504.309741415542;8139.1453897339925;8203.71287004952;8257.21556452136;8409.95795021021;8431.831363372821;10522;10714.51784669676;10877.051345303531;10921.726956826144;11156.378251111144 07:51:42 INFO - PROCESS | 16832 | |3;mootools.html;1325.42344080325;1456.7523521001428;1513.2585033333662;1698.6942350376928;1853.6385404846053;8095.676172953082;8412.453190542617;8417.537035463054;8418.116097809734;8423.031351394591;8207.753767386974;8377.832443351144;8378.455400398985;8379.24586787189;8380.748577542668;1929.421173647907;2282.6461898405773;2286.3598192506124;2310.90756369745;2353.682252895854;2293.3005433342823;2311.3528212100555;2331.1025255276754;2339.63735620979;2341.6019276723;2303.5738388398117;2352.212008976986;2356.2106694257445;2358.9056437742556;2361.161787565407;1908.4274717584738;2249.8200143988443;2294.9655755163685;2297.7587353327995;2299.275728145629;2166.469215042325;2181.8036376726172;2187.6171669957694;2192.353255789546;2195.9341219763432;8110.837783244302;8233.217844304781;8276.048254450756;8292.087870334259;8304.750857474224;4945.851624451237;5014;5077.517635824591;5081.110805609041;5082.186850104003;3418.384690755663;3418.9316213675834;3459.3427248822895;3488.930221395558;3502.247016891355;1117.983230251547;1126.9380184089953;1141.3209140561353;1146.8222425524057;1150.574287513617;11870.584529541424;11893.04855611549;11898.702532436671;11906.46420911061;11911.940440297829;4365.323374876899;4468.285074388083;4544.659150563721;4621.445426548768;4651.232546629836;9984.101430871257;9990.500474976223;9996.450195239186;9999.35004224723;9999.550020249106;4474.328850672425;5203.765830537635;5207.062728708869;5208.531232189045;5211.0359583477175;4730.5032971538185;4840.322354870321;4850.248211527219;4850.854474365775;4884.877878053077;3872.5933776953016;3885.4171874218528;3967.920641587152;3972.463717398172;4032.7580345179385;1239.7582471418168;1252.0609542842867;1284.8843604075678;1288.7873500872251;1306.1183701001785;923.8913304035051;926.064674678566;940.3699521320732;972.8686627305365;997.6957028106352;5594.328680558359;5632.887342253214;5718.571107166979;5798.101294299306;5903.085021821625;377.5205489028973;385.448808204265;385.9749116307487;413.97516149031156;415.61970796721266;3753.3244016076824;3877.9806100969313;3902.70729695274;3942.1918506706056;3962.484876965976;9785;10271.435071071013;10293.74265643365;10295.124914382212;10307.330023548446;9637.71086867395;10174.694759157237;10212.795744085226;10228.693139205836;10229.59081636741;7925.405594580429;7931.762047138711;7988.360931125496;7998;8074.596270186467;5319.547838433622;5353.4646535346155;5572.4706152915405;5779.8555036124435;5892.616979896293;9509.144177024102;9553.952230238805;9575.904240957501;9620.903790962;9693.176080033276;9322.813543729224;9547.665831695856;9711.805763884542;9744.171745401436;9829.31194816356;6537.444317233088;7231;7302.890456643261;7384.778456646309;7480;8049.315808156372;8075.717349892726;8082.7171049013;8118.02583689961;8118.431709780259;7023.578585284899;7080.645967701697;7235.167955685163;7314.378277846443;7350.154732205865;6999.335063168991;7099.148102227766;7106.7157313706875;7123.358897699232;7233.9638301810255;6386.137871387304;6556.442702370352;6572.704228309642;6637.933620663925;6643.60138391698;4629.814807407666;4650.5116962719785;4678.92981605283;4694.248920172756;4741.217699079613;4730.2195137803255;4758.738269395217;4823.517648235148;4866.1727506323305;4881.658283920092 07:51:42 INFO - PROCESS | 16832 | |4;prototype.html;302.3725769029265;313.99215019624495;316.76084556160095;319.33418821756635;327.78693848998154;5535.557155427567;5553.916691249635;5583.916241256385;5606.523445507137;5623.887522249553;5531.419200983889;5531.557475401958;5544.6395984261;5547.972260138704;5554.444555544444;4091.1794251558067;4163.250614889319;4286.678499112579;4314.611684948354;4337.934930976038;4268.97865510672;4298.247806633843;4307.763073030982;4324.783760811963;4329.696921215516;4113.149082912686;4252.9362059568975;4265.976165720236;4269.573042695737;4282.571742825724;4205.915881682365;4310.568943105695;4318.784060796979;4320;4323.070539833935;3795.2409518096492;3798.6581207691443;3804.8668296609762;3808.371618682914;3818.6372294631965;5321.3348331458565;5382.78468861249;5387.515123638891;5389.51494365509;5400.108982017962;4963.255511673242;4966.304717339575;4966.776495057695;4983.377077865267;4984.601231901475;5782.3350314713925;5808.2449281593545;5812.767489300423;5845.85385365365;5850.97074514629;4053.493313335833;4186.120914607936;4186.937195942033;4187.8324867005285;4215.494140703136;6067.2719273687;6069.423404776539;6080.665563394012;6085.543584231156;6098.481629061535;4284.485861696554;4284.957150428519;4288.378185163134;4291.592298731615;4298.247806633826;4250.574942505725;4342.109867477159;4353.586409291112;4354.085642015212;4357.281048627005;4920.3111564381015;4941.505849415102;4943.752812359439;4948.356713627278;4952.653314267966;5849.268841394825;5871.500922421556;5878;5889.498177964591;5892.292924849045;1480.0971407441668;1492.7460932816268;1513.402206128573;1516.619875912914;1518.9696206076037;926.1942110364026;1009.7929924365487;1014.3305418423805;1033.1115240892825;1035.6737627647267;5550.250716153349;5550.47270509301;5552.056150454432;5558.833235002957;5585.832425027255;5938.079597662369;5948.940510594925;5961.225040744675;5966.373530779206;6014.09788531715;5471.124620060851;5611.831645050655;5649.570684605659;5659.518940889988;5667.603267771216;3158.6841315868687;3171.762117841171;3181.6818318168;3195.632502262223;3196.5136211661224;5986.3714309997695;6094.2077529920825;6112.786052488142;6150.231221097363;6275.121482992385;6177.567570270128;6177.62934223948;6183.319834818167;6186.876262474815;6197.659128747962;6114.388561143761;6233.880480636605;6279.843003924939;6281.78013769525;6290.087937249074;5923.259592550931;6038.9396106038375;6060.6666633333825;6064.151018857276;6076.90884636722;6013.939860601338;6015.939840601538;6018.548608854266;6029.668368239613;6032.276126864805;6109.663968481598;6172.22847144107;6249.937500624936;6261.749530018748;6264.686765661608;4149.066460046465;4163.916721665611;4172.457580514635;4173.245657865794;4177.770222637784;6061.787837425845;6068.241469816273;6076.179715738319;6078.756849725962;6086.573939824169;5712.65724056558;5873.148393483007;5882.676452795137;5898.94101058984;5904.173415721716;5880.294364676266;5917.940820591739;5923.141144534105;5927.140564618193;5931.673757943355;5364.14173732201;5557.499825015768;5651.660900345993;5829.09649004405;5842.269716285465;5904.380040095728;5917.289925209003;5921.644701317935;5931.182688223232;5931.703414829155;5687.943120568907;5719.914201287067;5786;5789.044807606698;5800.4489573490455 07:51:42 INFO - PROCESS | 16832 | |5;yui.html;681.9761308354208;729.2670865779892;753.8718417868962;754.8603508350952;765.7243392378739;14460.92769536152;14693.118412895234;14850.108993460373;14876;14885.330160142807;13449.932750336258;13495.932520337408;13580.864191358083;13589.728205435886;13596.456141754343;679.908212391327;800.4916877782591;831.0941074229089;834.3492076180589;835.8035861572556;828.9419740618159;833.5207255827893;834.0533494483774;835.0897521701345;836.7238811192292;709.2552819539488;878.1569693094636;886.9733907982771;888.0852721696663;888.6800751729404;861.4529773593782;882.9404714342783;885.0795173020084;885.8405487012335;886.3883920095113;644.8323435906651;646.1825790375179;646.405307117453;646.5668002438377;647.1328419917334;14375;14488.71022579553;14510.854891451056;14519.419223231058;14533.491327803582;13219.140755850838;13670.726585468235;13755.17468951856;13807.723845523033;13987.65030874226;11102.167337449724;11119;11249.887501124966;11294.717632059183;11527.942360288229;3743.9625603743884;3780.697544196485;3792.7345085844004;3871.3031654302213;3945.842166313344;53811;54122;56493;56613.32013419115;56840.147397789064;10860.294080884718;10867.510962006729;11016.228863979604;11186.832197517044;11430.714232144097;20408.591828163353;20503;20541.178352866016;20564.58870822575;20597.58804823895;8296.543690097102;8588.355873309527;8649.221570058598;8772.605232764541;8783.824323513494;4361.193179261847;4362.411074504965;4387.3857659927635;4483.932741008887;4490.57339552742;3438.862445502202;3559.056849934769;3577.3024260269517;3579.6420357964516;3580.212353282274;592.602956019468;653.953674121402;666.5467482112114;681.4752640466912;702.1854648607591;703.736098962889;723.280336065618;752.0657067933282;802.141708372048;804.2722625239943;9289.210417114486;9465.432074075577;9903.950480247697;9948.900510994798;10200.489975501196;754.5812074298707;762.5119923249125;763.94270429718;778.8481246157058;795.3676826922494;4664.65015123867;4727.220008698595;4850.175470170079;4878.512148785164;4957.90084198314;55804;62440;62505.68747156235;62603.37396626067;63312.68343658252;55215;55583;55925.72037139788;56879.715601421725;57633.13550296749;50526;51962.740186298826;52693.736531317096;53343;53741.46258537364;9523.57143928511;9532.332736708364;9617.134457898823;9717.368371055858;9723.513824308615;34285.31429371348;34470.51883255161;34593;34685.200894961454;34757;44524.55475445204;46964.53035469738;47018.29472557846;47098;47751.28373074476;12173.573924912585;12182.573609923964;12359.62921112368;12622.431990560262;12939.482420703067;14186.503472378417;14254.216018118688;14426.85573144255;15121.621959451102;15191.77212341838;13140.934295328845;13387.933060335026;13579.456821727415;13673.111247768864;14110.294485275901;13301.534446294334;13507.932460337635;13555.728885422039;14087.577372678836;14155.64610884736;13254.933725331312;13266;13654.658633534242;13777.448902043807;13803.17180969145;10773.19201059908;10895.673129806119;10957.726056848642;11015;11209.383483908463;10985.670429886797;11154.944225278821;11281.097512199169;11315.20793544444;11324.150688698546 07:51:42 INFO - PROCESS | 16832 | __end_tp_report 07:51:42 INFO - PROCESS | 16832 | __start_cc_report 07:51:42 INFO - PROCESS | 16832 | _x_x_mozilla_cycle_collect,845 07:51:42 INFO - PROCESS | 16832 | __end_cc_report 07:51:42 INFO - PROCESS | 16832 | __startTimestamp1460645502965__endTimestamp 07:51:42 INFO - PROCESS | 16832 | 07:51:42 INFO - PROCESS | 16832 | ------- Summary: start ------- 07:51:42 INFO - PROCESS | 16832 | Number of tests: 6 07:51:42 INFO - PROCESS | 16832 | 07:51:42 INFO - PROCESS | 16832 | [#0] dojo.html Cycles:165 Average:5190.05 Median:5359.57 stddev:564.17 (10.5%) stddev-sans-first:541.42 07:51:42 INFO - PROCESS | 16832 | Values: 3094.3 3119.8 3153.2 3161.3 3186.2 5145.8 5240.3 5246.7 5292.3 5295.8 5264.5 5293.5 5313.5 5318.4 5333.5 4714.8 4790.0 4879.7 4883.2 4923.7 4668.6 4870.0 4891.2 4909.2 4923.4 4768.0 4805.3 4831.1 4863.6 4869.2 4774.4 4776.5 4783.4 4783.9 4797.9 4553.3 4696.0 4763.5 4798.1 4801.9 5113.5 5129.9 5133.0 5137.9 5163.1 5517.7 5539.3 5544.7 5545.2 5589.0 5446.6 5599.7 5622.4 5709.9 5715.9 5242.3 5269.8 5271.7 5274.0 5275.5 5700.0 5704.4 5708.1 5708.9 5709.2 5341.9 5442.5 5457.2 5504.6 5543.9 5518.1 5523.1 5525.1 5527.5 5530.1 5360.1 5490.4 5494.3 5494.8 5537.8 5403.0 5444.8 5456.5 5493.1 5503.9 4252.7 4268.6 4275.7 4279.9 4314.8 3687.1 3819.1 3837.9 3857.0 3860.2 5307.2 5318.5 5326.9 5329.6 5372.5 5623.7 5641.6 5652.5 5652.6 5652.8 5052.2 5296.1 5305.4 5360.6 5368.5 4808.3 4822.5 4826.7 4846.9 4884.5 5793.1 5793.6 5796.7 5797.2 5797.7 5436.8 5585.8 5628.1 5656.9 5677.9 5792.1 5818.5 5822.2 5831.4 5832.9 5539.6 5539.7 5541.6 5545.8 5548.8 5494.2 5499.1 5544.1 5596.9 5607.7 5359.6 5368.8 5371.5 5372.5 5372.6 5224.0 5355.3 5358.6 5368.0 5402.5 5285.4 5320.1 5337.5 5350.1 5387.0 5471.8 5494.4 5503.8 5515.9 5519.2 5138.7 5347.7 5373.4 5394.3 5400.8 07:51:42 INFO - PROCESS | 16832 | 07:51:42 INFO - PROCESS | 16832 | [#1] ext.html Cycles:180 Average:51264.72 Median:4106.40 stddev:92159.00 (2244.3%) stddev-sans-first:92339.00 07:51:42 INFO - PROCESS | 16832 | Values: 591.0 619.7 636.6 652.1 662.7 28769.0 37549.6 38560.6 38570.0 38587.4 41156.6 41867.4 41883.2 41891.8 41913.0 8489.0 8604.9 8693.7 8694.3 8699.6 8549.4 8662.4 8668.8 8679.7 8851.3 8829.7 8901.3 8907.2 8907.5 8912.3 8693.9 8739.5 8768.3 8778.1 8817.6 8446.1 8503.1 8504.0 8533.3 8535.6 40549.2 40913.6 41167.4 41208.4 41290.2 3389.5 3635.7 3645.3 3738.8 4391.9 30789.7 31449.4 31458.0 31569.8 31732.4 4055.1 4099.2 4113.6 4159.9 4187.7 257458.0 259505.0 260205.0 261051.0 261097.7 57430.0 57802.7 57863.4 58242.0 58359.1 56653.7 60846.0 61153.0 64222.5 65892.0 15646.8 15731.6 15747.3 15760.4 15768.9 12563.2 12619.6 12629.7 12646.7 12660.1 17059.1 19099.5 19129.6 19661.6 19682.6 6950.2 7364.2 7395.0 7416.2 7444.8 1044.1 1073.9 1112.6 1138.8 1239.8 30081.7 30387.5 30443.8 31587.2 32174.8 1095.1 1095.2 1121.8 1151.2 1210.3 16785.6 17196.8 17250.5 17325.4 17379.9 463967.0 469182.0 470091.0 471563.0 473158.0 53847.0 54242.2 54651.7 57974.7 58039.7 1220.6 1341.6 1397.5 1423.3 1443.7 28592.0 30007.0 31917.7 31963.0 32453.7 44923.0 45489.1 45546.5 45604.8 45633.8 277927.0 279266.0 279360.0 279367.0 279604.0 24825.9 40320.6 40539.8 40841.8 41399.8 46062.3 46229.0 46513.5 47227.5 47538.0 40797.4 41178.2 41217.8 41787.0 42458.4 40032.8 40622.2 40685.2 41807.8 42094.0 44174.0 44510.3 44535.6 45539.0 45688.5 32875.5 35173.5 35336.8 36004.3 36153.6 28910.7 29239.9 29453.6 29537.3 29659.6 07:51:42 INFO - PROCESS | 16832 | 07:51:42 INFO - PROCESS | 16832 | [#2] jquery.html Cycles:180 Average:25428.64 Median:2710.57 stddev:68621.87 (2531.6%) stddev-sans-first:68788.63 07:51:42 INFO - PROCESS | 16832 | Values: 396.1 399.9 404.4 412.2 417.3 13584.0 15604.8 17620.4 18207.0 18236.5 14005.7 16265.9 17079.4 17229.7 17473.8 5398.4 5517.8 5547.2 5550.8 5573.7 3935.6 4152.8 4155.9 5462.2 5856.7 6131.4 6137.0 6143.5 6146.2 6146.9 5997.9 6113.1 6118.0 6126.2 6127.0 5264.6 5267.1 5472.6 5473.2 5475.0 12820.2 13496.1 21612.9 21707.1 21750.8 2028.9 2232.1 2379.4 2548.5 2872.7 9245.8 9693.4 10114.7 10147.9 10222.8 1619.0 1733.0 1739.2 1883.8 1889.5 74537.6 74675.6 75645.0 75779.6 76483.2 10496.8 10625.4 10627.9 10754.6 10812.8 14961.2 15022.5 15026.5 15049.7 15093.2 7782.8 7950.2 8003.4 8068.5 8108.7 7432.3 7545.7 7574.3 7718.4 7876.6 4166.4 4344.9 4584.5 4594.9 4605.0 1926.2 1927.3 1937.7 1997.7 2001.3 830.5 983.3 1023.3 1026.9 1144.9 17765.0 17886.0 17895.4 18098.5 18581.3 998.2 1023.0 1032.5 1078.7 1090.8 9820.9 9902.9 10144.3 10248.2 10455.8 390697.0 413954.0 423063.0 425867.0 426348.0 52151.7 81008.2 82318.0 82345.6 84230.0 1002.9 1003.6 1038.6 1043.4 1050.1 15581.7 15685.2 15773.7 15831.0 16120.5 34970.8 35306.0 36888.6 37177.6 37267.8 49378.0 49683.5 50677.0 50975.5 51309.0 8208.2 8299.3 8319.3 8370.5 8454.5 9225.4 12021.4 12272.6 12380.6 12601.2 10973.5 11218.9 11272.8 11324.9 11422.7 10507.2 10632.9 10739.8 10846.5 11026.4 11090.2 11175.1 11310.7 11440.8 11504.3 8139.1 8203.7 8257.2 8410.0 8431.8 10522.0 10714.5 10877.1 10921.7 11156.4 07:51:42 INFO - PROCESS | 16832 | 07:51:42 INFO - PROCESS | 16832 | [#3] mootools.html Cycles:180 Average:5518.25 Median:4858.51 stddev:3119.93 (64.2%) stddev-sans-first:3112.77 07:51:42 INFO - PROCESS | 16832 | Values: 1325.4 1456.8 1513.3 1698.7 1853.6 8095.7 8412.5 8417.5 8418.1 8423.0 8207.8 8377.8 8378.5 8379.2 8380.7 1929.4 2282.6 2286.4 2310.9 2353.7 2293.3 2311.4 2331.1 2339.6 2341.6 2303.6 2352.2 2356.2 2358.9 2361.2 1908.4 2249.8 2295.0 2297.8 2299.3 2166.5 2181.8 2187.6 2192.4 2195.9 8110.8 8233.2 8276.0 8292.1 8304.8 4945.9 5014.0 5077.5 5081.1 5082.2 3418.4 3418.9 3459.3 3488.9 3502.2 1118.0 1126.9 1141.3 1146.8 1150.6 11870.6 11893.0 11898.7 11906.5 11911.9 4365.3 4468.3 4544.7 4621.4 4651.2 9984.1 9990.5 9996.5 9999.4 9999.6 4474.3 5203.8 5207.1 5208.5 5211.0 4730.5 4840.3 4850.2 4850.9 4884.9 3872.6 3885.4 3967.9 3972.5 4032.8 1239.8 1252.1 1284.9 1288.8 1306.1 923.9 926.1 940.4 972.9 997.7 5594.3 5632.9 5718.6 5798.1 5903.1 377.5 385.4 386.0 414.0 415.6 3753.3 3878.0 3902.7 3942.2 3962.5 9785.0 10271.4 10293.7 10295.1 10307.3 9637.7 10174.7 10212.8 10228.7 10229.6 7925.4 7931.8 7988.4 7998.0 8074.6 5319.5 5353.5 5572.5 5779.9 5892.6 9509.1 9554.0 9575.9 9620.9 9693.2 9322.8 9547.7 9711.8 9744.2 9829.3 6537.4 7231.0 7302.9 7384.8 7480.0 8049.3 8075.7 8082.7 8118.0 8118.4 7023.6 7080.6 7235.2 7314.4 7350.2 6999.3 7099.1 7106.7 7123.4 7234.0 6386.1 6556.4 6572.7 6637.9 6643.6 4629.8 4650.5 4678.9 4694.2 4741.2 4730.2 4758.7 4823.5 4866.2 4881.7 07:51:42 INFO - PROCESS | 16832 | 07:51:42 INFO - PROCESS | 16832 | [#4] prototype.html Cycles:180 Average:4920.97 Median:5555.97 stddev:1462.42 (26.3%) stddev-sans-first:1424.85 07:51:42 INFO - PROCESS | 16832 | Values: 302.4 314.0 316.8 319.3 327.8 5535.6 5553.9 5583.9 5606.5 5623.9 5531.4 5531.6 5544.6 5548.0 5554.4 4091.2 4163.3 4286.7 4314.6 4337.9 4269.0 4298.2 4307.8 4324.8 4329.7 4113.1 4252.9 4266.0 4269.6 4282.6 4205.9 4310.6 4318.8 4320.0 4323.1 3795.2 3798.7 3804.9 3808.4 3818.6 5321.3 5382.8 5387.5 5389.5 5400.1 4963.3 4966.3 4966.8 4983.4 4984.6 5782.3 5808.2 5812.8 5845.9 5851.0 4053.5 4186.1 4186.9 4187.8 4215.5 6067.3 6069.4 6080.7 6085.5 6098.5 4284.5 4285.0 4288.4 4291.6 4298.2 4250.6 4342.1 4353.6 4354.1 4357.3 4920.3 4941.5 4943.8 4948.4 4952.7 5849.3 5871.5 5878.0 5889.5 5892.3 1480.1 1492.7 1513.4 1516.6 1519.0 926.2 1009.8 1014.3 1033.1 1035.7 5550.3 5550.5 5552.1 5558.8 5585.8 5938.1 5948.9 5961.2 5966.4 6014.1 5471.1 5611.8 5649.6 5659.5 5667.6 3158.7 3171.8 3181.7 3195.6 3196.5 5986.4 6094.2 6112.8 6150.2 6275.1 6177.6 6177.6 6183.3 6186.9 6197.7 6114.4 6233.9 6279.8 6281.8 6290.1 5923.3 6038.9 6060.7 6064.2 6076.9 6013.9 6015.9 6018.5 6029.7 6032.3 6109.7 6172.2 6249.9 6261.7 6264.7 4149.1 4163.9 4172.5 4173.2 4177.8 6061.8 6068.2 6076.2 6078.8 6086.6 5712.7 5873.1 5882.7 5898.9 5904.2 5880.3 5917.9 5923.1 5927.1 5931.7 5364.1 5557.5 5651.7 5829.1 5842.3 5904.4 5917.3 5921.6 5931.2 5931.7 5687.9 5719.9 5786.0 5789.0 5800.4 07:51:42 INFO - PROCESS | 16832 | 07:51:42 INFO - PROCESS | 16832 | [#5] yui.html Cycles:180 Average:15217.46 Median:4487.25 stddev:17363.38 (386.9%) stddev-sans-first:17377.78 07:51:42 INFO - PROCESS | 16832 | Values: 682.0 729.3 753.9 754.9 765.7 14460.9 14693.1 14850.1 14876.0 14885.3 13449.9 13495.9 13580.9 13589.7 13596.5 679.9 800.5 831.1 834.3 835.8 828.9 833.5 834.1 835.1 836.7 709.3 878.2 887.0 888.1 888.7 861.5 882.9 885.1 885.8 886.4 644.8 646.2 646.4 646.6 647.1 14375.0 14488.7 14510.9 14519.4 14533.5 13219.1 13670.7 13755.2 13807.7 13987.7 11102.2 11119.0 11249.9 11294.7 11527.9 3744.0 3780.7 3792.7 3871.3 3945.8 53811.0 54122.0 56493.0 56613.3 56840.1 10860.3 10867.5 11016.2 11186.8 11430.7 20408.6 20503.0 20541.2 20564.6 20597.6 8296.5 8588.4 8649.2 8772.6 8783.8 4361.2 4362.4 4387.4 4483.9 4490.6 3438.9 3559.1 3577.3 3579.6 3580.2 592.6 654.0 666.5 681.5 702.2 703.7 723.3 752.1 802.1 804.3 9289.2 9465.4 9904.0 9948.9 10200.5 754.6 762.5 763.9 778.8 795.4 4664.7 4727.2 4850.2 4878.5 4957.9 55804.0 62440.0 62505.7 62603.4 63312.7 55215.0 55583.0 55925.7 56879.7 57633.1 50526.0 51962.7 52693.7 53343.0 53741.5 9523.6 9532.3 9617.1 9717.4 9723.5 34285.3 34470.5 34593.0 34685.2 34757.0 44524.6 46964.5 47018.3 47098.0 47751.3 12173.6 12182.6 12359.6 12622.4 12939.5 14186.5 14254.2 14426.9 15121.6 15191.8 13140.9 13387.9 13579.5 13673.1 14110.3 13301.5 13507.9 13555.7 14087.6 14155.6 13254.9 13266.0 13654.7 13777.4 13803.2 10773.2 10895.7 10957.7 11015.0 11209.4 10985.7 11154.9 11281.1 11315.2 11324.2 07:51:42 INFO - PROCESS | 16832 | -------- Summary: end -------- 07:51:42 INFO - PROCESS | 16832 | 07:51:43 INFO - TEST-INFO | 16832: exit 0 07:51:43 INFO - TEST-OK | dromaeo_css | took 1111610ms 07:51:43 INFO - TEST-START | kraken 07:51:43 INFO - operating with platform_type : linux_ 07:51:43 INFO - Initialising browser for kraken test... 07:51:43 INFO - TEST-INFO | started process 17011 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd2BX8o/profile http://localhost:58346/getInfo.html) 07:51:47 INFO - PROCESS | 17011 | __metrics Screen width/height:1600/1200 07:51:47 INFO - PROCESS | 17011 | colorDepth:24 07:51:47 INFO - PROCESS | 17011 | Browser inner width/height: 1024/697 07:51:47 INFO - PROCESS | 17011 | __metrics 07:51:48 ERROR - PROCESS | 17011 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:51:49 INFO - TEST-INFO | 17011: exit 0 07:51:49 INFO - Browser initialized. 07:51:49 INFO - Running cycle 1/1 for kraken test... 07:51:49 INFO - TEST-INFO | started process 17091 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd2BX8o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:52:00 INFO - PROCESS | 17091 | RSS: Main: 153149440 07:52:00 INFO - PROCESS | 17091 | 07:52:03 INFO - PROCESS | 17091 | Cycle 1(1): loaded http://localhost:58346/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58346/tests/kraken/driver.html?testName=audio-beat-detection) 07:52:04 INFO - PROCESS | 17091 | RSS: Main: 208064512 07:52:04 INFO - PROCESS | 17091 | 07:52:06 INFO - PROCESS | 17091 | Cycle 1(1): loaded http://localhost:58346/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58346/tests/kraken/driver.html?testName=audio-dft) 07:52:07 INFO - PROCESS | 17091 | RSS: Main: 193724416 07:52:07 INFO - PROCESS | 17091 | 07:52:10 INFO - PROCESS | 17091 | Cycle 1(1): loaded http://localhost:58346/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58346/tests/kraken/driver.html?testName=audio-fft) 07:52:11 INFO - PROCESS | 17091 | RSS: Main: 263942144 07:52:11 INFO - PROCESS | 17091 | 07:52:13 INFO - PROCESS | 17091 | Cycle 1(1): loaded http://localhost:58346/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58346/tests/kraken/driver.html?testName=audio-oscillator) 07:52:13 INFO - PROCESS | 17091 | RSS: Main: 173273088 07:52:13 INFO - PROCESS | 17091 | 07:52:16 INFO - PROCESS | 17091 | Cycle 1(1): loaded http://localhost:58346/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58346/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:52:16 INFO - PROCESS | 17091 | RSS: Main: 177242112 07:52:16 INFO - PROCESS | 17091 | 07:52:19 INFO - PROCESS | 17091 | Cycle 1(1): loaded http://localhost:58346/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58346/tests/kraken/driver.html?testName=imaging-darkroom) 07:52:20 INFO - PROCESS | 17091 | RSS: Main: 213278720 07:52:20 INFO - PROCESS | 17091 | 07:52:23 INFO - PROCESS | 17091 | Cycle 1(1): loaded http://localhost:58346/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58346/tests/kraken/driver.html?testName=imaging-desaturate) 07:52:24 INFO - PROCESS | 17091 | RSS: Main: 213491712 07:52:24 INFO - PROCESS | 17091 | 07:52:26 INFO - PROCESS | 17091 | Cycle 1(1): loaded http://localhost:58346/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58346/tests/kraken/driver.html?testName=json-parse-financial) 07:52:27 INFO - PROCESS | 17091 | RSS: Main: 213102592 07:52:27 INFO - PROCESS | 17091 | 07:52:29 INFO - PROCESS | 17091 | Cycle 1(1): loaded http://localhost:58346/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58346/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:52:29 INFO - PROCESS | 17091 | RSS: Main: 203014144 07:52:29 INFO - PROCESS | 17091 | 07:52:31 INFO - PROCESS | 17091 | Cycle 1(1): loaded http://localhost:58346/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58346/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:52:32 INFO - PROCESS | 17091 | RSS: Main: 204431360 07:52:32 INFO - PROCESS | 17091 | 07:52:34 INFO - PROCESS | 17091 | Cycle 1(1): loaded http://localhost:58346/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58346/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:52:34 INFO - PROCESS | 17091 | RSS: Main: 217300992 07:52:34 INFO - PROCESS | 17091 | 07:52:37 INFO - PROCESS | 17091 | Cycle 1(1): loaded http://localhost:58346/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58346/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:52:37 INFO - PROCESS | 17091 | RSS: Main: 222117888 07:52:37 INFO - PROCESS | 17091 | 07:52:40 INFO - PROCESS | 17091 | Cycle 1(1): loaded http://localhost:58346/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58346/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:52:41 INFO - PROCESS | 17091 | RSS: Main: 218255360 07:52:41 INFO - PROCESS | 17091 | 07:52:42 INFO - PROCESS | 17091 | Cycle 1(1): loaded http://localhost:58346/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58346/tests/kraken/driver.html?testName=ai-astar) 07:52:43 INFO - PROCESS | 17091 | RSS: Main: 281751552 07:52:43 INFO - PROCESS | 17091 | 07:52:43 INFO - PROCESS | 17091 | __start_tp_report 07:52:43 INFO - PROCESS | 17091 | _x_x_mozilla_page_load 07:52:43 INFO - PROCESS | 17091 | _x_x_mozilla_page_load_details 07:52:43 INFO - PROCESS | 17091 | |i|pagename|runs| 07:52:43 INFO - PROCESS | 17091 | |0;ai-astar;110;111;106;110;112;110;100;112;110;108 07:52:43 INFO - PROCESS | 17091 | |1;audio-beat-detection;152;127;156;186;128;154;158;132;188;128 07:52:43 INFO - PROCESS | 17091 | |2;audio-dft;162;162;160;161;160;161;159;162;162;162 07:52:43 INFO - PROCESS | 17091 | |3;audio-fft;77;77;106;111;74;74;76;136;104;74 07:52:43 INFO - PROCESS | 17091 | |4;audio-oscillator;92;93;148;93;93;94;152;92;92;151 07:52:43 INFO - PROCESS | 17091 | |5;imaging-gaussian-blur;116;116;116;117;117;117;117;117;117;117 07:52:43 INFO - PROCESS | 17091 | |6;imaging-darkroom;144;145;145;146;145;146;145;145;145;145 07:52:43 INFO - PROCESS | 17091 | |7;imaging-desaturate;97;95;94;95;95;95;95;95;95;95 07:52:43 INFO - PROCESS | 17091 | |8;json-parse-financial;57;56;56;58;58;56;59;75;57;54 07:52:43 INFO - PROCESS | 17091 | |9;json-stringify-tinderbox;62;62;61;62;61;61;60;61;61;62 07:52:43 INFO - PROCESS | 17091 | |10;stanford-crypto-aes;79;80;79;79;82;81;81;81;83;82 07:52:43 INFO - PROCESS | 17091 | |11;stanford-crypto-ccm;132;130;127;128;131;124;124;124;160;128 07:52:43 INFO - PROCESS | 17091 | |12;stanford-crypto-pbkdf2;172;170;166;165;171;169;171;165;169;167 07:52:43 INFO - PROCESS | 17091 | |13;stanford-crypto-sha256-iterative;69;70;71;68;69;68;69;69;66;65 07:52:43 INFO - PROCESS | 17091 | __end_tp_report 07:52:43 INFO - PROCESS | 17091 | __start_cc_report 07:52:43 INFO - PROCESS | 17091 | _x_x_mozilla_cycle_collect,1585 07:52:43 INFO - PROCESS | 17091 | __end_cc_report 07:52:43 INFO - PROCESS | 17091 | __startTimestamp1460645563218__endTimestamp 07:52:43 INFO - PROCESS | 17091 | 07:52:43 INFO - PROCESS | 17091 | ------- Summary: start ------- 07:52:43 INFO - PROCESS | 17091 | Number of tests: 14 07:52:43 INFO - PROCESS | 17091 | 07:52:43 INFO - PROCESS | 17091 | [#0] ai-astar Cycles:10 Average:108.90 Median:110.00 stddev:3.60 (3.3%) stddev-sans-first:3.80 07:52:43 INFO - PROCESS | 17091 | Values: 110.0 111.0 106.0 110.0 112.0 110.0 100.0 112.0 110.0 108.0 07:52:43 INFO - PROCESS | 17091 | 07:52:43 INFO - PROCESS | 17091 | [#1] audio-beat-detection Cycles:10 Average:150.90 Median:155.00 stddev:22.79 (14.7%) stddev-sans-first:24.16 07:52:43 INFO - PROCESS | 17091 | Values: 152.0 127.0 156.0 186.0 128.0 154.0 158.0 132.0 188.0 128.0 07:52:43 INFO - PROCESS | 17091 | 07:52:43 INFO - PROCESS | 17091 | [#2] audio-dft Cycles:10 Average:161.10 Median:162.00 stddev:1.10 (0.7%) stddev-sans-first:1.12 07:52:43 INFO - PROCESS | 17091 | Values: 162.0 162.0 160.0 161.0 160.0 161.0 159.0 162.0 162.0 162.0 07:52:43 INFO - PROCESS | 17091 | 07:52:43 INFO - PROCESS | 17091 | [#3] audio-fft Cycles:10 Average:90.90 Median:74.00 stddev:21.87 (29.5%) stddev-sans-first:22.61 07:52:43 INFO - PROCESS | 17091 | Values: 77.0 77.0 106.0 111.0 74.0 74.0 76.0 136.0 104.0 74.0 07:52:43 INFO - PROCESS | 17091 | 07:52:43 INFO - PROCESS | 17091 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:92.50 stddev:27.86 (30.1%) stddev-sans-first:28.77 07:52:43 INFO - PROCESS | 17091 | Values: 92.0 93.0 148.0 93.0 93.0 94.0 152.0 92.0 92.0 151.0 07:52:43 INFO - PROCESS | 17091 | 07:52:43 INFO - PROCESS | 17091 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 07:52:43 INFO - PROCESS | 17091 | Values: 116.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 07:52:43 INFO - PROCESS | 17091 | 07:52:43 INFO - PROCESS | 17091 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.57 (0.4%) stddev-sans-first:0.44 07:52:43 INFO - PROCESS | 17091 | Values: 144.0 145.0 145.0 146.0 145.0 146.0 145.0 145.0 145.0 145.0 07:52:43 INFO - PROCESS | 17091 | 07:52:43 INFO - PROCESS | 17091 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.33 07:52:43 INFO - PROCESS | 17091 | Values: 97.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 07:52:43 INFO - PROCESS | 17091 | 07:52:43 INFO - PROCESS | 17091 | [#8] json-parse-financial Cycles:10 Average:58.60 Median:57.50 stddev:5.93 (10.3%) stddev-sans-first:6.26 07:52:43 INFO - PROCESS | 17091 | Values: 57.0 56.0 56.0 58.0 58.0 56.0 59.0 75.0 57.0 54.0 07:52:43 INFO - PROCESS | 17091 | 07:52:43 INFO - PROCESS | 17091 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.50 stddev:0.67 (1.1%) stddev-sans-first:0.67 07:52:43 INFO - PROCESS | 17091 | Values: 62.0 62.0 61.0 62.0 61.0 61.0 60.0 61.0 61.0 62.0 07:52:43 INFO - PROCESS | 17091 | 07:52:43 INFO - PROCESS | 17091 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:81.00 stddev:1.42 (1.8%) stddev-sans-first:1.36 07:52:43 INFO - PROCESS | 17091 | Values: 79.0 80.0 79.0 79.0 82.0 81.0 81.0 81.0 83.0 82.0 07:52:43 INFO - PROCESS | 17091 | 07:52:43 INFO - PROCESS | 17091 | [#11] stanford-crypto-ccm Cycles:10 Average:130.80 Median:129.00 stddev:10.66 (8.3%) stddev-sans-first:11.30 07:52:43 INFO - PROCESS | 17091 | Values: 132.0 130.0 127.0 128.0 131.0 124.0 124.0 124.0 160.0 128.0 07:52:43 INFO - PROCESS | 17091 | 07:52:43 INFO - PROCESS | 17091 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.50 Median:169.50 stddev:2.59 (1.5%) stddev-sans-first:2.42 07:52:43 INFO - PROCESS | 17091 | Values: 172.0 170.0 166.0 165.0 171.0 169.0 171.0 165.0 169.0 167.0 07:52:43 INFO - PROCESS | 17091 | 07:52:43 INFO - PROCESS | 17091 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:69.00 stddev:1.78 (2.6%) stddev-sans-first:1.87 07:52:43 INFO - PROCESS | 17091 | Values: 69.0 70.0 71.0 68.0 69.0 68.0 69.0 69.0 66.0 65.0 07:52:43 INFO - PROCESS | 17091 | -------- Summary: end -------- 07:52:43 INFO - PROCESS | 17091 | 07:52:44 INFO - TEST-INFO | 17091: exit 0 07:52:44 INFO - TEST-OK | kraken | took 60487ms 07:52:44 INFO - SUITE-END | took 1172s 07:52:44 INFO - Completed test suite (00:19:32) 07:52:44 INFO - javascript benchmark 07:52:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3094.334718035622, 3119.82840943748, 3153.2432216268103, 3161.2571045804248, 3186.235303527154, 5145.768440420181, 5240.318758561387, 5246.685198888069, 5292.338457692788, 5295.8146464873735, 5264.499872512115, 5293.52358287754, 5313.495217954298, 5318.388385335687, 5333.493318134771, 4714.834980775673, 4789.976050119753, 4879.658423910328, 4883.19427294496, 4923.70457772533, 4668.626509879202, 4870.0122569087725, 4891.217405215166, 4909.189983652693, 4923.359963204778, 4767.976160119195, 4805.255185446244, 4831.106245344622, 4863.610911127102, 4869.220924652039, 4774.427068751772, 4776.546228108359, 4783.378160839069, 4783.856484305476, 4797.928031079502, 4553.339765733983, 4695.976520117378, 4763.54746299101, 4798.0643774464, 4801.855944321641, 5113.539781419653, 5129.871753206163, 5133.0, 5137.871553211162, 5163.1480805667015, 5517.668939863621, 5539.307586551681, 5544.667319960815, 5545.223668686387, 5588.972055139739, 5446.564274858002, 5599.720013999325, 5622.353429355636, 5709.857253568653, 5715.914261286084, 5242.344706911636, 5269.789208431658, 5271.71005594696, 5273.973630131902, 5275.472452754732, 5699.971500142473, 5704.429557044263, 5708.143778433268, 5708.885822283531, 5709.172170035322, 5341.946580534222, 5442.510174084351, 5457.208704737791, 5504.559635229172, 5543.861403464945, 5518.061929471999, 5523.061079616475, 5525.060739674184, 5527.474889885454, 5530.087535556669, 5360.142377219626, 5490.423505531861, 5494.340679118532, 5494.835154945358, 5537.750801213955, 5402.972985135049, 5444.8094316698725, 5456.536194423518, 5493.066178749622, 5503.9174412383845, 4252.744835309892, 4268.615824575803, 4275.700700950903, 4279.850205242801, 4314.8489802857375, 3687.078230442389, 3819.083419979185, 3837.9232415351535, 3857.035741064734, 3860.2472517858746, 5307.203919412119, 5318.547923426475, 5326.92009619856, 5329.573634109262, 5372.462753724596, 5623.662580245198, 5641.633293835887, 5652.547796176296, 5652.604317697722, 5652.773889044474, 5052.242163675478, 5296.1261391870685, 5305.363356397257, 5360.624756267024, 5368.516833484927, 4808.2547205183255, 4822.469528351879, 4826.6621336506105, 4846.903061938741, 4884.511548845158, 5793.073108302651, 5793.594448388657, 5796.739146738407, 5797.217375654317, 5797.681127538026, 5436.782528698966, 5585.832425027255, 5628.099504079328, 5656.915146272727, 5677.8864422710485, 5792.073268277056, 5818.505427038749, 5822.155787410717, 5831.387704290988, 5832.912506312324, 5539.556835453234, 5539.695316757456, 5541.6120871540215, 5545.805896793593, 5548.833534993957, 5494.175873618829, 5499.120140777456, 5544.112941929272, 5596.916046259228, 5607.719614019365, 5359.571234301168, 5368.785248590013, 5371.4897084776885, 5372.462753724596, 5372.5701943843615, 5223.973880130575, 5355.30381050461, 5358.571314294769, 5368.0, 5402.540784033401, 5285.418603953485, 5320.0955837506945, 5337.466253374631, 5350.143976963667, 5386.973065134649, 5471.8084867029465, 5494.423085576117, 5503.7798488060025, 5515.889682206253, 5519.227308176778, 5138.743062846917, 5347.652402593819, 5373.408925018323, 5394.32570928634, 5400.810971616132], "value": 5154.061365589251, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.9881802363952, 619.74900165433, 636.5703150373498, 652.096845868472, 662.7282814046242, 28769.0, 37549.62450375495, 38560.614393856056, 38570.0, 38587.42118868216, 41156.58843411565, 41867.371989420186, 41883.162336753245, 41891.790541047325, 41913.0, 8488.957555212215, 8604.8709269361, 8693.652253909837, 8694.260987816044, 8699.60851761669, 8549.444286121383, 8662.436941598777, 8668.826623467527, 8679.69621063263, 8851.291896648285, 8829.690960816373, 8901.332400069989, 8907.198352148305, 8907.465552066897, 8912.331575131891, 8693.869591956125, 8739.4756314621, 8768.298536117096, 8778.078301778349, 8817.647294108228, 8446.113158118433, 8503.149685031509, 8503.95748021262, 8533.274671652916, 8535.615897284575, 40549.1890162198, 40913.590864091275, 41167.38248926269, 41208.38187427161, 41290.1741965159, 3389.4915762635555, 3635.72732045095, 3645.325614761278, 3738.7943663098517, 4391.934120988188, 30789.692103078905, 31449.37101257962, 31458.0, 31569.8421507891, 31732.365352693047, 4055.1078762672164, 4099.221147981903, 4113.588641135892, 4159.896002599929, 4187.72779769314, 257458.0, 259505.0, 260205.0, 261051.0, 261097.69451152813, 57430.0, 57802.71098644564, 57863.42136578664, 58242.0, 58359.124613130836, 56653.716731416076, 60846.0, 61153.0, 64222.46776427248, 65892.0, 15646.843531564538, 15731.606709832346, 15747.291371888292, 15760.448384306494, 15768.92115539415, 12563.246205227715, 12619.621411357673, 12629.747405051847, 12646.683832904251, 12660.113792034654, 17059.147042648066, 19099.522511937033, 19129.617407652047, 19661.606767864563, 19682.606347872963, 6950.200726916368, 7364.189939106694, 7395.0, 7416.22129676387, 7444.813879652944, 1044.1072882685346, 1073.9140868730483, 1112.571659910924, 1138.7893239750506, 1239.7644447554935, 30081.69918300789, 30387.480625968612, 30443.847780760956, 31587.21031974173, 32174.83912580422, 1095.1348434736628, 1095.1676725688376, 1121.8036843552509, 1151.165405081326, 1210.3222195570333, 16785.580360491087, 17196.828031719524, 17250.482485525456, 17325.393611223546, 17379.91310043467, 463967.0, 469182.0, 470091.0, 471563.0, 473158.0, 53847.0, 54242.18636720452, 54651.72674136604, 57974.7101264491, 58039.709801451565, 1220.6216073017215, 1341.637757805387, 1397.475946520055, 1423.3168079321983, 1443.6607397261635, 28592.0, 30007.0, 31917.68082319147, 31963.0, 32453.675463245065, 44923.0, 45489.090218196114, 45546.54453455423, 45604.771976139906, 45633.771831140635, 277927.0, 279266.0, 279360.0, 279367.0, 279604.0, 24825.87587062053, 40320.596794031684, 40539.78380648585, 40841.77474675765, 41399.7930010348, 46062.30906536338, 46229.0, 46513.53486465092, 47227.52772472369, 47538.0, 40797.38803917884, 41178.1764364705, 41217.793911030254, 41787.0, 42458.36312455254, 40032.79983600063, 40622.1875562493, 40685.1862962745, 41807.790961045, 42094.0, 44174.0, 44510.332345014205, 44535.55464445314, 45539.0, 45688.54311456843, 32875.50686739749, 35173.472397914564, 35336.82331588326, 36004.27991440104, 36153.63846361608, 28910.710892890802, 29239.85380073086, 29453.603952145775, 29537.26156846096, 29659.555106673848], "value": 19583.072698192234, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.1028270966262, 399.8960270329714, 404.4499480706237, 412.2065024827207, 417.26561252196126, 13584.0, 15604.84395156048, 17620.383286584973, 18206.99999999998, 18236.45290641281, 14005.719885602282, 16265.918670406661, 17079.40222092227, 17229.7415538767, 17473.825261747377, 5398.406175320722, 5517.806876759314, 5547.1679248112705, 5550.8057217997375, 5573.693446860421, 3935.6457918787305, 4152.771597562133, 4155.916881662365, 5462.235287059815, 5856.707164641751, 6131.3868613138775, 6137.048757442603, 6143.508519318466, 6146.200993870791, 6146.907796383035, 5997.940020599804, 6113.052476866093, 6117.969410152965, 6126.23422072241, 6126.969365153168, 5264.578833693296, 5267.078261304257, 5472.616916815825, 5473.151661492475, 5475.0, 12820.166689165175, 13496.122752021087, 21612.89193554022, 21707.131714731393, 21750.782492175193, 2028.8884111373868, 2232.1406258590396, 2379.3932547200525, 2548.4775620997834, 2872.6696429910617, 9245.815083698355, 9693.418394896258, 10114.747131321703, 10147.89852101477, 10222.795544089151, 1618.951431457058, 1733.0, 1739.1652007036694, 1883.8210370014826, 1889.527618095476, 74537.62731186363, 74675.62662186654, 75645.0, 75779.62110189525, 76483.23516764816, 10496.842547361795, 10625.415602141802, 10627.89372106269, 10754.623588174532, 10812.810220984828, 14961.177135257447, 15022.474213402478, 15026.474073407378, 15049.699006019819, 15093.169875656724, 7782.766517004499, 7950.24472675095, 8003.439759216915, 8068.515889046676, 8108.716194933149, 7432.3310902019075, 7545.660445279976, 7574.318311351894, 7718.382529397635, 7876.606169691607, 4166.375043743463, 4344.891377715582, 4584.518625544337, 4594.885127871763, 4604.97697511517, 1926.1524929031182, 1927.3254360973826, 1937.6899696048565, 1997.7402937618308, 2001.349561392524, 830.5099991005216, 983.2871168402851, 1023.2632504596678, 1026.9435181065114, 1144.9313041217554, 17765.0, 17886.0, 17895.37366192177, 18098.457046288633, 18581.25674973013, 998.1914649134225, 1022.9641962531424, 1032.4734385463469, 1078.703356576932, 1090.7818436312768, 9820.901790982141, 9902.900970990198, 10144.3117573843, 10248.180145588334, 10455.84316235257, 390697.0, 413954.0, 423063.0, 425867.0, 426348.0, 52151.73924130355, 81008.18991810006, 82318.0, 82345.58827205826, 84230.0, 1002.9289517147214, 1003.6085926488676, 1038.631285893512, 1043.410473082706, 1050.0864248104199, 15581.688366232385, 15685.215739213221, 15773.68452630918, 15831.0, 16120.516384508484, 34970.82514587411, 35306.0, 36888.63111368852, 37177.62822371742, 37267.8136609326, 49378.0, 49683.50949471522, 50676.98646027133, 50975.49024509856, 51309.0, 8208.220219079178, 8299.294559962229, 8319.251267385964, 8370.4559203654, 8454.450460720034, 9225.400348977295, 12021.398930053638, 12272.631821045383, 12380.566680166152, 12601.18092323996, 10973.451327433757, 11218.887811121784, 11272.774544509228, 11324.886751132382, 11422.714432139262, 10507.211959103252, 10632.89367106319, 10739.838902416626, 10846.457677115955, 11026.4011718302, 11090.16823738239, 11175.10599152082, 11310.660680179608, 11440.771184576095, 11504.309741415542, 8139.1453897339925, 8203.71287004952, 8257.21556452136, 8409.95795021021, 8431.831363372821, 10522.0, 10714.51784669676, 10877.051345303531, 10921.726956826144, 11156.378251111144], "value": 8686.146256212774, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1325.42344080325, 1456.7523521001428, 1513.2585033333662, 1698.6942350376928, 1853.6385404846053, 8095.676172953082, 8412.453190542617, 8417.537035463054, 8418.116097809734, 8423.031351394591, 8207.753767386974, 8377.832443351144, 8378.455400398985, 8379.24586787189, 8380.748577542668, 1929.421173647907, 2282.6461898405773, 2286.3598192506124, 2310.90756369745, 2353.682252895854, 2293.3005433342823, 2311.3528212100555, 2331.1025255276754, 2339.63735620979, 2341.6019276723, 2303.5738388398117, 2352.212008976986, 2356.2106694257445, 2358.9056437742556, 2361.161787565407, 1908.4274717584738, 2249.8200143988443, 2294.9655755163685, 2297.7587353327995, 2299.275728145629, 2166.469215042325, 2181.8036376726172, 2187.6171669957694, 2192.353255789546, 2195.9341219763432, 8110.837783244302, 8233.217844304781, 8276.048254450756, 8292.087870334259, 8304.750857474224, 4945.851624451237, 5014.0, 5077.517635824591, 5081.110805609041, 5082.186850104003, 3418.384690755663, 3418.9316213675834, 3459.3427248822895, 3488.930221395558, 3502.247016891355, 1117.983230251547, 1126.9380184089953, 1141.3209140561353, 1146.8222425524057, 1150.574287513617, 11870.584529541424, 11893.04855611549, 11898.702532436671, 11906.46420911061, 11911.940440297829, 4365.323374876899, 4468.285074388083, 4544.659150563721, 4621.445426548768, 4651.232546629836, 9984.101430871257, 9990.500474976223, 9996.450195239186, 9999.35004224723, 9999.550020249106, 4474.328850672425, 5203.765830537635, 5207.062728708869, 5208.531232189045, 5211.0359583477175, 4730.5032971538185, 4840.322354870321, 4850.248211527219, 4850.854474365775, 4884.877878053077, 3872.5933776953016, 3885.4171874218528, 3967.920641587152, 3972.463717398172, 4032.7580345179385, 1239.7582471418168, 1252.0609542842867, 1284.8843604075678, 1288.7873500872251, 1306.1183701001785, 923.8913304035051, 926.064674678566, 940.3699521320732, 972.8686627305365, 997.6957028106352, 5594.328680558359, 5632.887342253214, 5718.571107166979, 5798.101294299306, 5903.085021821625, 377.5205489028973, 385.448808204265, 385.9749116307487, 413.97516149031156, 415.61970796721266, 3753.3244016076824, 3877.9806100969313, 3902.70729695274, 3942.1918506706056, 3962.484876965976, 9785.0, 10271.435071071013, 10293.74265643365, 10295.124914382212, 10307.330023548446, 9637.71086867395, 10174.694759157237, 10212.795744085226, 10228.693139205836, 10229.59081636741, 7925.405594580429, 7931.762047138711, 7988.360931125496, 7998.0, 8074.596270186467, 5319.547838433622, 5353.4646535346155, 5572.4706152915405, 5779.8555036124435, 5892.616979896293, 9509.144177024102, 9553.952230238805, 9575.904240957501, 9620.903790962, 9693.176080033276, 9322.813543729224, 9547.665831695856, 9711.805763884542, 9744.171745401436, 9829.31194816356, 6537.444317233088, 7231.0, 7302.890456643261, 7384.778456646309, 7480.0, 8049.315808156372, 8075.717349892726, 8082.7171049013, 8118.02583689961, 8118.431709780259, 7023.578585284899, 7080.645967701697, 7235.167955685163, 7314.378277846443, 7350.154732205865, 6999.335063168991, 7099.148102227766, 7106.7157313706875, 7123.358897699232, 7233.9638301810255, 6386.137871387304, 6556.442702370352, 6572.704228309642, 6637.933620663925, 6643.60138391698, 4629.814807407666, 4650.5116962719785, 4678.92981605283, 4694.248920172756, 4741.217699079613, 4730.2195137803255, 4758.738269395217, 4823.517648235148, 4866.1727506323305, 4881.658283920092], "value": 4364.616319474183, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.3725769029265, 313.99215019624495, 316.76084556160095, 319.33418821756635, 327.78693848998154, 5535.557155427567, 5553.916691249635, 5583.916241256385, 5606.523445507137, 5623.887522249553, 5531.419200983889, 5531.557475401958, 5544.6395984261, 5547.972260138704, 5554.444555544444, 4091.1794251558067, 4163.250614889319, 4286.678499112579, 4314.611684948354, 4337.934930976038, 4268.97865510672, 4298.247806633843, 4307.763073030982, 4324.783760811963, 4329.696921215516, 4113.149082912686, 4252.9362059568975, 4265.976165720236, 4269.573042695737, 4282.571742825724, 4205.915881682365, 4310.568943105695, 4318.784060796979, 4320.0, 4323.070539833935, 3795.2409518096492, 3798.6581207691443, 3804.8668296609762, 3808.371618682914, 3818.6372294631965, 5321.3348331458565, 5382.78468861249, 5387.515123638891, 5389.51494365509, 5400.108982017962, 4963.255511673242, 4966.304717339575, 4966.776495057695, 4983.377077865267, 4984.601231901475, 5782.3350314713925, 5808.2449281593545, 5812.767489300423, 5845.85385365365, 5850.97074514629, 4053.493313335833, 4186.120914607936, 4186.937195942033, 4187.8324867005285, 4215.494140703136, 6067.2719273687, 6069.423404776539, 6080.665563394012, 6085.543584231156, 6098.481629061535, 4284.485861696554, 4284.957150428519, 4288.378185163134, 4291.592298731615, 4298.247806633826, 4250.574942505725, 4342.109867477159, 4353.586409291112, 4354.085642015212, 4357.281048627005, 4920.3111564381015, 4941.505849415102, 4943.752812359439, 4948.356713627278, 4952.653314267966, 5849.268841394825, 5871.500922421556, 5878.0, 5889.498177964591, 5892.292924849045, 1480.0971407441668, 1492.7460932816268, 1513.402206128573, 1516.619875912914, 1518.9696206076037, 926.1942110364026, 1009.7929924365487, 1014.3305418423805, 1033.1115240892825, 1035.6737627647267, 5550.250716153349, 5550.47270509301, 5552.056150454432, 5558.833235002957, 5585.832425027255, 5938.079597662369, 5948.940510594925, 5961.225040744675, 5966.373530779206, 6014.09788531715, 5471.124620060851, 5611.831645050655, 5649.570684605659, 5659.518940889988, 5667.603267771216, 3158.6841315868687, 3171.762117841171, 3181.6818318168, 3195.632502262223, 3196.5136211661224, 5986.3714309997695, 6094.2077529920825, 6112.786052488142, 6150.231221097363, 6275.121482992385, 6177.567570270128, 6177.62934223948, 6183.319834818167, 6186.876262474815, 6197.659128747962, 6114.388561143761, 6233.880480636605, 6279.843003924939, 6281.78013769525, 6290.087937249074, 5923.259592550931, 6038.9396106038375, 6060.6666633333825, 6064.151018857276, 6076.90884636722, 6013.939860601338, 6015.939840601538, 6018.548608854266, 6029.668368239613, 6032.276126864805, 6109.663968481598, 6172.22847144107, 6249.937500624936, 6261.749530018748, 6264.686765661608, 4149.066460046465, 4163.916721665611, 4172.457580514635, 4173.245657865794, 4177.770222637784, 6061.787837425845, 6068.241469816273, 6076.179715738319, 6078.756849725962, 6086.573939824169, 5712.65724056558, 5873.148393483007, 5882.676452795137, 5898.94101058984, 5904.173415721716, 5880.294364676266, 5917.940820591739, 5923.141144534105, 5927.140564618193, 5931.673757943355, 5364.14173732201, 5557.499825015768, 5651.660900345993, 5829.09649004405, 5842.269716285465, 5904.380040095728, 5917.289925209003, 5921.644701317935, 5931.182688223232, 5931.703414829155, 5687.943120568907, 5719.914201287067, 5786.0, 5789.044807606698, 5800.4489573490455], "value": 4445.922517700111, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [681.9761308354208, 729.2670865779892, 753.8718417868962, 754.8603508350952, 765.7243392378739, 14460.92769536152, 14693.118412895234, 14850.108993460373, 14876.0, 14885.330160142807, 13449.932750336258, 13495.932520337408, 13580.864191358083, 13589.728205435886, 13596.456141754343, 679.908212391327, 800.4916877782591, 831.0941074229089, 834.3492076180589, 835.8035861572556, 828.9419740618159, 833.5207255827893, 834.0533494483774, 835.0897521701345, 836.7238811192292, 709.2552819539488, 878.1569693094636, 886.9733907982771, 888.0852721696663, 888.6800751729404, 861.4529773593782, 882.9404714342783, 885.0795173020084, 885.8405487012335, 886.3883920095113, 644.8323435906651, 646.1825790375179, 646.405307117453, 646.5668002438377, 647.1328419917334, 14375.0, 14488.71022579553, 14510.854891451056, 14519.419223231058, 14533.491327803582, 13219.140755850838, 13670.726585468235, 13755.17468951856, 13807.723845523033, 13987.65030874226, 11102.167337449724, 11119.0, 11249.887501124966, 11294.717632059183, 11527.942360288229, 3743.9625603743884, 3780.697544196485, 3792.7345085844004, 3871.3031654302213, 3945.842166313344, 53811.0, 54122.0, 56493.0, 56613.32013419115, 56840.147397789064, 10860.294080884718, 10867.510962006729, 11016.228863979604, 11186.832197517044, 11430.714232144097, 20408.591828163353, 20503.0, 20541.178352866016, 20564.58870822575, 20597.58804823895, 8296.543690097102, 8588.355873309527, 8649.221570058598, 8772.605232764541, 8783.824323513494, 4361.193179261847, 4362.411074504965, 4387.3857659927635, 4483.932741008887, 4490.57339552742, 3438.862445502202, 3559.056849934769, 3577.3024260269517, 3579.6420357964516, 3580.212353282274, 592.602956019468, 653.953674121402, 666.5467482112114, 681.4752640466912, 702.1854648607591, 703.736098962889, 723.280336065618, 752.0657067933282, 802.141708372048, 804.2722625239943, 9289.210417114486, 9465.432074075577, 9903.950480247697, 9948.900510994798, 10200.489975501196, 754.5812074298707, 762.5119923249125, 763.94270429718, 778.8481246157058, 795.3676826922494, 4664.65015123867, 4727.220008698595, 4850.175470170079, 4878.512148785164, 4957.90084198314, 55804.0, 62440.0, 62505.68747156235, 62603.37396626067, 63312.68343658252, 55215.0, 55583.0, 55925.72037139788, 56879.715601421725, 57633.13550296749, 50526.0, 51962.740186298826, 52693.736531317096, 53343.0, 53741.46258537364, 9523.57143928511, 9532.332736708364, 9617.134457898823, 9717.368371055858, 9723.513824308615, 34285.31429371348, 34470.51883255161, 34593.0, 34685.200894961454, 34757.0, 44524.55475445204, 46964.53035469738, 47018.29472557846, 47098.0, 47751.28373074476, 12173.573924912585, 12182.573609923964, 12359.62921112368, 12622.431990560262, 12939.482420703067, 14186.503472378417, 14254.216018118688, 14426.85573144255, 15121.621959451102, 15191.77212341838, 13140.934295328845, 13387.933060335026, 13579.456821727415, 13673.111247768864, 14110.294485275901, 13301.534446294334, 13507.932460337635, 13555.728885422039, 14087.577372678836, 14155.64610884736, 13254.933725331312, 13266.0, 13654.658633534242, 13777.448902043807, 13803.17180969145, 10773.19201059908, 10895.673129806119, 10957.726056848642, 11015.0, 11209.383483908463, 10985.670429886797, 11154.944225278821, 11281.097512199169, 11315.20793544444, 11324.150688698546], "value": 6945.384940173516, "unit": "score"}], "name": "dromaeo_css", "value": 7005.153686878145, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 106.0, 110.0, 112.0, 110.0, 100.0, 112.0, 110.0, 108.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 127.0, 156.0, 186.0, 128.0, 154.0, 158.0, 132.0, 188.0, 128.0], "value": 150.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 160.0, 161.0, 160.0, 161.0, 159.0, 162.0, 162.0, 162.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 106.0, 111.0, 74.0, 74.0, 76.0, 136.0, 104.0, 74.0], "value": 90.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 148.0, 93.0, 93.0, 94.0, 152.0, 92.0, 92.0, 151.0], "value": 110.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0], "value": 145.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 56.0, 58.0, 58.0, 56.0, 59.0, 75.0, 57.0, 54.0], "value": 58.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 62.0, 61.0, 61.0, 60.0, 61.0, 61.0, 62.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 79.0, 79.0, 82.0, 81.0, 81.0, 81.0, 83.0, 82.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 130.0, 127.0, 128.0, 131.0, 124.0, 124.0, 124.0, 160.0, 128.0], "value": 130.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 170.0, 166.0, 165.0, 171.0, 169.0, 171.0, 165.0, 169.0, 167.0], "value": 168.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 71.0, 68.0, 69.0, 68.0, 69.0, 69.0, 66.0, 65.0], "value": 68.4, "unit": "score"}], "name": "kraken", "value": 1547.0, "alertThreshold": 2.0}]} 07:52:44 INFO - Return code: 0 07:52:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:52:44 ERROR - # TBPL SUCCESS # 07:52:44 INFO - Running post-action listener: _resource_record_post_action 07:52:44 INFO - Running post-run listener: _resource_record_post_run 07:52:45 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 550150144; Read time: 16; Write time: 618848 07:52:45 INFO - install - Wall time: 17s; CPU: 16.0%; Read bytes: 0; Write bytes: 260993024; Read time: 0; Write time: 425712 07:52:45 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288559104; Read time: 16; Write time: 193136 07:52:45 INFO - Running post-run listener: _upload_blobber_files 07:52:45 INFO - Blob upload gear active. 07:52:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:52:45 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 07:52:45 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:52:45 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:52:46 INFO - (blobuploader) - INFO - Open directory for files ... 07:52:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:52:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:52:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:52:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:52:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:52:46 INFO - (blobuploader) - INFO - Done attempting. 07:52:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:52:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:52:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:52:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:52:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:52:47 INFO - (blobuploader) - INFO - Done attempting. 07:52:47 INFO - (blobuploader) - INFO - Iteration through files over. 07:52:47 INFO - Return code: 0 07:52:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:52:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:52:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66022bdc1734dfe151ecf3b5b7e00069dfa2227c46ce94559b129b1c13ea797bd07e1cf9d903eb07c1ca0fe6cfbc7e39fed74c7f950315da86f0168d9d018174", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/09563ff9ca9a22dab5370a64481c729305b0bf679d8967b33984fa47fd3c00a37b7bde9166c8e3f4510fcd8e277c20e8a1b30bf36f7e760893aeae2cd0cfcf8e"} 07:52:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:52:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:52:47 INFO - Contents: 07:52:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66022bdc1734dfe151ecf3b5b7e00069dfa2227c46ce94559b129b1c13ea797bd07e1cf9d903eb07c1ca0fe6cfbc7e39fed74c7f950315da86f0168d9d018174", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/09563ff9ca9a22dab5370a64481c729305b0bf679d8967b33984fa47fd3c00a37b7bde9166c8e3f4510fcd8e277c20e8a1b30bf36f7e760893aeae2cd0cfcf8e"} 07:52:47 INFO - Running post-run listener: copy_logs_to_upload_dir 07:52:47 INFO - Copying logs to upload dir... 07:52:47 INFO - mkdir: /builds/slave/test/build/upload/logs 07:52:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.406708 ========= master_lag: -0.18 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-04-14 07:52:47.085911) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 07:52:47.089686) ========= 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=337fe3f4b1febe37b85fccc40000019e-1460643267.380907-168060158 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/sha512/66022bdc1734dfe151ecf3b5b7e00069dfa2227c46ce94559b129b1c13ea797bd07e1cf9d903eb07c1ca0fe6cfbc7e39fed74c7f950315da86f0168d9d018174", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/09563ff9ca9a22dab5370a64481c729305b0bf679d8967b33984fa47fd3c00a37b7bde9166c8e3f4510fcd8e277c20e8a1b30bf36f7e760893aeae2cd0cfcf8e"} build_url:https://queue.taskcluster.net/v1/task/YQKAvJTLSIyrYGPJcHCn5g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011399 build_url: 'https://queue.taskcluster.net/v1/task/YQKAvJTLSIyrYGPJcHCn5g/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/sha512/66022bdc1734dfe151ecf3b5b7e00069dfa2227c46ce94559b129b1c13ea797bd07e1cf9d903eb07c1ca0fe6cfbc7e39fed74c7f950315da86f0168d9d018174", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/09563ff9ca9a22dab5370a64481c729305b0bf679d8967b33984fa47fd3c00a37b7bde9166c8e3f4510fcd8e277c20e8a1b30bf36f7e760893aeae2cd0cfcf8e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 07:52:47.121572) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 07:52:47.122122) ========= 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=337fe3f4b1febe37b85fccc40000019e-1460643267.380907-168060158 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004443 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 07:52:47.203559) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 07:52:47.203907) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 07:52:47.204243) ========= ========= Total master_lag: -0.01 =========