builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-004 starttime: 1461691232.8 results: success (0) buildid: 20160426073449 builduid: c4f94dca916d423c9c8118a11b697ea5 revision: 9ce31e9f90cb0e534611b0f617c5bbc232ffe748 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 10:20:32.800339) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 10:20:32.800797) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 10:20:32.801103) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 10:20:32.829024) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 10:20:32.829341) ========= 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=c6927cf182745ad25b1d38b9000001fe-1461691034.209767-404806119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-26 10:20:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-04-26 10:20:33 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.141499 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 10:20:32.983930) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 10:20:32.987313) ========= 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=c6927cf182745ad25b1d38b9000001fe-1461691034.209767-404806119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017467 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 10:20:33.036704) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 10:20:33.037075) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9ce31e9f90cb0e534611b0f617c5bbc232ffe748 --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 9ce31e9f90cb0e534611b0f617c5bbc232ffe748 --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=c6927cf182745ad25b1d38b9000001fe-1461691034.209767-404806119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-26 10:20:33,146 truncating revision to first 12 chars 2016-04-26 10:20:33,146 Setting DEBUG logging. 2016-04-26 10:20:33,146 attempt 1/10 2016-04-26 10:20:33,146 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9ce31e9f90cb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-26 10:20:33,518 unpacking tar archive at: mozilla-central-9ce31e9f90cb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.699671 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 10:20:33.749594) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 10:20:33.749911) ========= script_repo_revision: 9ce31e9f90cb0e534611b0f617c5bbc232ffe748 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 10:20:33.750345) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 10:20:33.750619) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 10:20:33.759721) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-04-26 10:20:33.760077) ========= /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=c6927cf182745ad25b1d38b9000001fe-1461691034.209767-404806119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:20:33 INFO - MultiFileLogger online at 20160426 10:20:33 in /builds/slave/test 10:20:33 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 10:20:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:20:33 INFO - {'append_to_log': False, 10:20:33 INFO - 'base_work_dir': '/builds/slave/test', 10:20:33 INFO - 'blob_upload_branch': 'Firefox', 10:20:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:20:33 INFO - 'branch': 'Firefox', 10:20:33 INFO - 'buildbot_json_path': 'buildprops.json', 10:20:33 INFO - 'config_files': ('talos/linux_config.py',), 10:20:33 INFO - 'default_actions': ('clobber', 10:20:33 INFO - 'read-buildbot-config', 10:20:33 INFO - 'download-and-extract', 10:20:33 INFO - 'populate-webroot', 10:20:33 INFO - 'create-virtualenv', 10:20:33 INFO - 'install', 10:20:33 INFO - 'run-tests'), 10:20:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:20:33 INFO - 'download_minidump_stackwalk': True, 10:20:33 INFO - 'download_symbols': 'ondemand', 10:20:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:20:33 INFO - 'tooltool.py': '/tools/tooltool.py', 10:20:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:20:33 INFO - '/tools/misc-python/virtualenv.py')}, 10:20:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:20:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:20:33 INFO - 'installer_path': 'installer.exe', 10:20:33 INFO - 'log_level': 'info', 10:20:33 INFO - 'log_name': 'talos', 10:20:33 INFO - 'log_to_console': True, 10:20:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:20:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:20:33 INFO - 'opt_config_files': (), 10:20:33 INFO - 'pip_index': False, 10:20:33 INFO - 'sps_profile': False, 10:20:33 INFO - 'sps_profile_interval': 0, 10:20:33 INFO - 'suite': 'dromaeojs', 10:20:33 INFO - 'system_bits': '32', 10:20:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:20:33 INFO - 'title': 'talos-linux64-ix-004', 10:20:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:20:33 INFO - 'use_talos_json': True, 10:20:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:20:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:20:33 INFO - 'work_dir': 'build'} 10:20:33 INFO - ##### 10:20:33 INFO - ##### Running clobber step. 10:20:33 INFO - ##### 10:20:33 INFO - Running pre-action listener: _resource_record_pre_action 10:20:33 INFO - Running main action method: clobber 10:20:33 INFO - rmtree: /builds/slave/test/build 10:20:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:20:34 INFO - Running post-action listener: _resource_record_post_action 10:20:34 INFO - ##### 10:20:34 INFO - ##### Running read-buildbot-config step. 10:20:34 INFO - ##### 10:20:34 INFO - Running pre-action listener: _resource_record_pre_action 10:20:34 INFO - Running main action method: read_buildbot_config 10:20:34 INFO - Using buildbot properties: 10:20:34 INFO - { 10:20:34 INFO - "project": "", 10:20:34 INFO - "product": "firefox", 10:20:34 INFO - "script_repo_revision": "production", 10:20:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 10:20:34 INFO - "repository": "", 10:20:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 10:20:34 INFO - "buildid": "20160426073449", 10:20:34 INFO - "pgo_build": "True", 10:20:34 INFO - "basedir": "/builds/slave/test", 10:20:34 INFO - "buildnumber": 422, 10:20:34 INFO - "slavename": "talos-linux64-ix-004", 10:20:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:20:34 INFO - "platform": "ubuntu64_hw", 10:20:34 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:20:34 INFO - "branch": "mozilla-central", 10:20:34 INFO - "repo_path": "mozilla-central", 10:20:34 INFO - "revision": "9ce31e9f90cb0e534611b0f617c5bbc232ffe748", 10:20:34 INFO - "stage_platform": "linux64-pgo", 10:20:34 INFO - "builduid": "c4f94dca916d423c9c8118a11b697ea5", 10:20:34 INFO - "slavebuilddir": "test" 10:20:34 INFO - } 10:20:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/dxTfsYfVS4CN2hz5BmtcvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 10:20:34 INFO - Running post-action listener: _resource_record_post_action 10:20:34 INFO - ##### 10:20:34 INFO - ##### Running download-and-extract step. 10:20:34 INFO - ##### 10:20:34 INFO - Running pre-action listener: _resource_record_pre_action 10:20:34 INFO - Running main action method: download_and_extract 10:20:34 INFO - mkdir: /builds/slave/test/build/tests 10:20:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:20:34 INFO - https://queue.taskcluster.net/v1/task/dxTfsYfVS4CN2hz5BmtcvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:20:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxTfsYfVS4CN2hz5BmtcvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:20:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxTfsYfVS4CN2hz5BmtcvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:20:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxTfsYfVS4CN2hz5BmtcvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:20:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxTfsYfVS4CN2hz5BmtcvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:20:36 INFO - Downloaded 1361 bytes. 10:20:36 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:20:36 INFO - Using the following test package requirements: 10:20:36 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:20:36 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:20:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:20:36 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:20:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:20:36 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:20:36 INFO - u'jsshell-linux-x86_64.zip'], 10:20:36 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:20:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:20:36 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:20:36 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:20:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:20:36 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:20:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:20:36 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:20:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:20:36 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:20:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:20:36 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:20:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:20:36 INFO - https://queue.taskcluster.net/v1/task/dxTfsYfVS4CN2hz5BmtcvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:20:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxTfsYfVS4CN2hz5BmtcvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:20:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxTfsYfVS4CN2hz5BmtcvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:20:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxTfsYfVS4CN2hz5BmtcvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:20:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxTfsYfVS4CN2hz5BmtcvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:20:37 INFO - Downloaded 23863599 bytes. 10:20:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:20:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:20:39 INFO - Return code: 0 10:20:39 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:20:39 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')]} 10:20:39 INFO - https://queue.taskcluster.net/v1/task/dxTfsYfVS4CN2hz5BmtcvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:20:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxTfsYfVS4CN2hz5BmtcvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:20:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxTfsYfVS4CN2hz5BmtcvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:20:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxTfsYfVS4CN2hz5BmtcvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:20:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxTfsYfVS4CN2hz5BmtcvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:20:40 INFO - Downloaded 23863599 bytes. 10:20:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:20:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:20:41 INFO - Return code: 0 10:20: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')]} 10:20:41 INFO - https://queue.taskcluster.net/v1/task/dxTfsYfVS4CN2hz5BmtcvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:20:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxTfsYfVS4CN2hz5BmtcvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:20:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxTfsYfVS4CN2hz5BmtcvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:20:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxTfsYfVS4CN2hz5BmtcvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:20:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxTfsYfVS4CN2hz5BmtcvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:20:43 INFO - Downloaded 10840145 bytes. 10:20:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:20:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:20:43 INFO - Return code: 0 10:20:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:20:43 INFO - https://queue.taskcluster.net/v1/task/dxTfsYfVS4CN2hz5BmtcvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:20:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxTfsYfVS4CN2hz5BmtcvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:20:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxTfsYfVS4CN2hz5BmtcvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:20:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxTfsYfVS4CN2hz5BmtcvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:20:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dxTfsYfVS4CN2hz5BmtcvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:20:46 INFO - Downloaded 58368076 bytes. 10:20:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dxTfsYfVS4CN2hz5BmtcvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:20:46 INFO - mkdir: /builds/slave/test/properties 10:20:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:20:46 INFO - Writing to file /builds/slave/test/properties/build_url 10:20:46 INFO - Contents: 10:20:46 INFO - build_url:https://queue.taskcluster.net/v1/task/dxTfsYfVS4CN2hz5BmtcvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:20:46 INFO - Running post-action listener: _resource_record_post_action 10:20:46 INFO - Running post-action listener: set_extra_try_arguments 10:20:46 INFO - ##### 10:20:46 INFO - ##### Running populate-webroot step. 10:20:46 INFO - ##### 10:20:46 INFO - Running pre-action listener: _resource_record_pre_action 10:20:46 INFO - Running main action method: populate_webroot 10:20:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:20:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:20:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:20:46 INFO - '--tppagecycles', 10:20:46 INFO - '7'], 10:20:46 INFO - 'tests': ['tsvgm']}}, 10:20:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:20:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:20:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:20:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:20:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:20:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:20:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:20:46 INFO - 'talos_options': ['--disable-e10s'], 10:20:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:20:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:20:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:20:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:20:46 INFO - 'talos_options': ['--disable-e10s'], 10:20:46 INFO - 'tests': ['damp', 'tps']}, 10:20:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:20:46 INFO - 'tests': ['damp', 'tps']}, 10:20:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:20:46 INFO - 'tests': ['dromaeo_dom']}, 10:20:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:20:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:20:46 INFO - 'tests': ['a11yr', 10:20:46 INFO - 'ts_paint', 10:20:46 INFO - 'tpaint', 10:20:46 INFO - 'sessionrestore', 10:20:46 INFO - 'sessionrestore_no_auto_restore', 10:20:46 INFO - 'tabpaint']}, 10:20:46 INFO - 'other-e10s': {'tests': ['a11yr', 10:20:46 INFO - 'ts_paint', 10:20:46 INFO - 'tpaint', 10:20:46 INFO - 'sessionrestore', 10:20:46 INFO - 'sessionrestore_no_auto_restore', 10:20:46 INFO - 'tabpaint']}, 10:20:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:20:46 INFO - 'ts_paint', 10:20:46 INFO - 'tpaint', 10:20:46 INFO - 'sessionrestore', 10:20:46 INFO - 'sessionrestore_no_auto_restore', 10:20:46 INFO - 'tabpaint']}, 10:20:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:20:46 INFO - 'ts_paint', 10:20:46 INFO - 'tpaint', 10:20:46 INFO - 'sessionrestore', 10:20:46 INFO - 'sessionrestore_no_auto_restore', 10:20:46 INFO - 'tabpaint']}, 10:20:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:20:46 INFO - 'tests': ['a11yr', 10:20:46 INFO - 'ts_paint', 10:20:46 INFO - 'tpaint', 10:20:46 INFO - 'sessionrestore', 10:20:46 INFO - 'sessionrestore_no_auto_restore', 10:20:46 INFO - 'tabpaint']}, 10:20:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:20:46 INFO - 'tests': ['a11yr', 10:20:46 INFO - 'ts_paint', 10:20:46 INFO - 'tpaint', 10:20:46 INFO - 'sessionrestore', 10:20:46 INFO - 'sessionrestore_no_auto_restore', 10:20:46 INFO - 'tabpaint']}, 10:20:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:20:46 INFO - 'tests': ['tsvgx', 10:20:46 INFO - 'tsvgr_opacity', 10:20:46 INFO - 'tart', 10:20:46 INFO - 'tscrollx', 10:20:46 INFO - 'cart']}, 10:20:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:20:46 INFO - 'tsvgr_opacity', 10:20:46 INFO - 'tart', 10:20:46 INFO - 'tscrollx', 10:20:46 INFO - 'cart']}, 10:20:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:20:46 INFO - 'talos_options': ['--disable-e10s'], 10:20:46 INFO - 'tests': ['tp5o']}, 10:20:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:20:46 INFO - 'tests': ['tp5o']}, 10:20:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:20:46 INFO - 'talos_options': ['--disable-e10s', 10:20:46 INFO - '--xperf_path', 10:20:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:20:46 INFO - 'tests': ['tp5n']}, 10:20:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:20:46 INFO - 'talos_options': ['--xperf_path', 10:20:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:20:46 INFO - 'tests': ['tp5n']}}, 10:20:46 INFO - 'talos.zip': {'path': '', 10:20:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:20:46 INFO - Running post-action listener: _resource_record_post_action 10:20:46 INFO - ##### 10:20:46 INFO - ##### Running create-virtualenv step. 10:20:46 INFO - ##### 10:20:46 INFO - Running pre-action listener: _resource_record_pre_action 10:20:46 INFO - Running main action method: create_virtualenv 10:20:46 INFO - Creating virtualenv /builds/slave/test/build/venv 10:20:46 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:20:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:20:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:20:46 INFO - Using real prefix '/usr' 10:20:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:20:47 INFO - Installing distribute.............................................................................................................................................................................................done. 10:20:49 INFO - Installing pip.................done. 10:20:49 INFO - Return code: 0 10:20:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:20:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:20:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:20:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0f9498af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1baf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d09810>, '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 0x1d0a710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0aba0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1461691034.209767-404806119', '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 10:20:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:20:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:20:49 INFO - Using env: {'DISPLAY': ':0', 10:20:49 INFO - 'HOME': '/home/cltbld', 10:20:49 INFO - 'LANG': 'en_US.UTF-8', 10:20:49 INFO - 'LANGUAGE': 'en_US:en', 10:20:49 INFO - 'LOGNAME': 'cltbld', 10:20:49 INFO - 'MAIL': '/var/mail/cltbld', 10:20:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:49 INFO - 'MOZ_NO_REMOTE': '1', 10:20:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:49 INFO - 'NO_EM_RESTART': '1', 10:20:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:49 INFO - 'PWD': '/builds/slave/test', 10:20:49 INFO - 'SHELL': '/bin/bash', 10:20:49 INFO - 'SHLVL': '1', 10:20:49 INFO - 'TERM': 'linux', 10:20:49 INFO - 'TMOUT': '86400', 10:20:49 INFO - 'USER': 'cltbld', 10:20:49 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461691034.209767-404806119', 10:20:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:49 INFO - '_': '/tools/buildbot/bin/python'} 10:20:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:49 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:20:49 INFO - Cleaning up... 10:20:49 INFO - Return code: 0 10:20:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:20:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:20:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:20:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0f9498af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1baf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d09810>, '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 0x1d0a710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0aba0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1461691034.209767-404806119', '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 10:20:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 10:20:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:20:49 INFO - Using env: {'DISPLAY': ':0', 10:20:49 INFO - 'HOME': '/home/cltbld', 10:20:49 INFO - 'LANG': 'en_US.UTF-8', 10:20:49 INFO - 'LANGUAGE': 'en_US:en', 10:20:49 INFO - 'LOGNAME': 'cltbld', 10:20:49 INFO - 'MAIL': '/var/mail/cltbld', 10:20:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:49 INFO - 'MOZ_NO_REMOTE': '1', 10:20:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:49 INFO - 'NO_EM_RESTART': '1', 10:20:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:49 INFO - 'PWD': '/builds/slave/test', 10:20:49 INFO - 'SHELL': '/bin/bash', 10:20:49 INFO - 'SHLVL': '1', 10:20:49 INFO - 'TERM': 'linux', 10:20:49 INFO - 'TMOUT': '86400', 10:20:49 INFO - 'USER': 'cltbld', 10:20:49 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461691034.209767-404806119', 10:20:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:49 INFO - '_': '/tools/buildbot/bin/python'} 10:20:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:49 INFO - Downloading/unpacking psutil>=0.7.1 10:20:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:20:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:20:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:20:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:20:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:20:51 INFO - Installing collected packages: psutil 10:20:51 INFO - Running setup.py install for psutil 10:20:51 INFO - building 'psutil._psutil_linux' extension 10:20:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:20:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:20:52 INFO - building 'psutil._psutil_posix' extension 10:20:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:20:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:20:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:20:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:20:52 INFO - Successfully installed psutil 10:20:52 INFO - Cleaning up... 10:20:52 INFO - Return code: 0 10:20:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:20:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:20:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0f9498af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1baf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d09810>, '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 0x1d0a710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0aba0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1461691034.209767-404806119', '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 10:20:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:20:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:20:52 INFO - Using env: {'DISPLAY': ':0', 10:20:52 INFO - 'HOME': '/home/cltbld', 10:20:52 INFO - 'LANG': 'en_US.UTF-8', 10:20:52 INFO - 'LANGUAGE': 'en_US:en', 10:20:52 INFO - 'LOGNAME': 'cltbld', 10:20:52 INFO - 'MAIL': '/var/mail/cltbld', 10:20:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:52 INFO - 'MOZ_NO_REMOTE': '1', 10:20:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:52 INFO - 'NO_EM_RESTART': '1', 10:20:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:52 INFO - 'PWD': '/builds/slave/test', 10:20:52 INFO - 'SHELL': '/bin/bash', 10:20:52 INFO - 'SHLVL': '1', 10:20:52 INFO - 'TERM': 'linux', 10:20:52 INFO - 'TMOUT': '86400', 10:20:52 INFO - 'USER': 'cltbld', 10:20:52 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461691034.209767-404806119', 10:20:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:52 INFO - '_': '/tools/buildbot/bin/python'} 10:20:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:20:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:20:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:20:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:20:54 INFO - Installing collected packages: mozsystemmonitor 10:20:54 INFO - Running setup.py install for mozsystemmonitor 10:20:54 INFO - Successfully installed mozsystemmonitor 10:20:54 INFO - Cleaning up... 10:20:54 INFO - Return code: 0 10:20:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:20:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:20:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0f9498af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1baf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d09810>, '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 0x1d0a710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0aba0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1461691034.209767-404806119', '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 10:20:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:20:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:20:54 INFO - Using env: {'DISPLAY': ':0', 10:20:54 INFO - 'HOME': '/home/cltbld', 10:20:54 INFO - 'LANG': 'en_US.UTF-8', 10:20:54 INFO - 'LANGUAGE': 'en_US:en', 10:20:54 INFO - 'LOGNAME': 'cltbld', 10:20:54 INFO - 'MAIL': '/var/mail/cltbld', 10:20:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:54 INFO - 'MOZ_NO_REMOTE': '1', 10:20:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:54 INFO - 'NO_EM_RESTART': '1', 10:20:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:54 INFO - 'PWD': '/builds/slave/test', 10:20:54 INFO - 'SHELL': '/bin/bash', 10:20:54 INFO - 'SHLVL': '1', 10:20:54 INFO - 'TERM': 'linux', 10:20:54 INFO - 'TMOUT': '86400', 10:20:54 INFO - 'USER': 'cltbld', 10:20:54 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461691034.209767-404806119', 10:20:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:54 INFO - '_': '/tools/buildbot/bin/python'} 10:20:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:54 INFO - Downloading/unpacking blobuploader==1.2.4 10:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:20:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:56 INFO - Downloading blobuploader-1.2.4.tar.gz 10:20:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:20:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:20:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:20:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:20:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:57 INFO - Downloading docopt-0.6.1.tar.gz 10:20:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:20:57 INFO - Installing collected packages: blobuploader, requests, docopt 10:20:57 INFO - Running setup.py install for blobuploader 10:20:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:20:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:20:57 INFO - Running setup.py install for requests 10:20:57 INFO - Running setup.py install for docopt 10:20:58 INFO - Successfully installed blobuploader requests docopt 10:20:58 INFO - Cleaning up... 10:20:58 INFO - Return code: 0 10:20:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:20:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0f9498af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1baf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d09810>, '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 0x1d0a710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0aba0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1461691034.209767-404806119', '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 10:20:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:20:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:20:58 INFO - Using env: {'DISPLAY': ':0', 10:20:58 INFO - 'HOME': '/home/cltbld', 10:20:58 INFO - 'LANG': 'en_US.UTF-8', 10:20:58 INFO - 'LANGUAGE': 'en_US:en', 10:20:58 INFO - 'LOGNAME': 'cltbld', 10:20:58 INFO - 'MAIL': '/var/mail/cltbld', 10:20:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:58 INFO - 'MOZ_NO_REMOTE': '1', 10:20:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:58 INFO - 'NO_EM_RESTART': '1', 10:20:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:58 INFO - 'PWD': '/builds/slave/test', 10:20:58 INFO - 'SHELL': '/bin/bash', 10:20:58 INFO - 'SHLVL': '1', 10:20:58 INFO - 'TERM': 'linux', 10:20:58 INFO - 'TMOUT': '86400', 10:20:58 INFO - 'USER': 'cltbld', 10:20:58 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461691034.209767-404806119', 10:20:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:58 INFO - '_': '/tools/buildbot/bin/python'} 10:20:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:20:58 INFO - Running setup.py (path:/tmp/pip-lwpt1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:20:58 INFO - Running setup.py (path:/tmp/pip-B0dJZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:20:58 INFO - Running setup.py (path:/tmp/pip-TVEZ99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:20:58 INFO - Running setup.py (path:/tmp/pip-uARaA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:20:58 INFO - Running setup.py (path:/tmp/pip-zEn9a5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:20:58 INFO - Running setup.py (path:/tmp/pip-m06KV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:20:58 INFO - Running setup.py (path:/tmp/pip-5Ylmp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:20:58 INFO - Running setup.py (path:/tmp/pip-UCthDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:20:58 INFO - Running setup.py (path:/tmp/pip-pK2sRq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:20:58 INFO - Running setup.py (path:/tmp/pip-HbzVu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:20:59 INFO - Running setup.py (path:/tmp/pip-gs87Gr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:20:59 INFO - Running setup.py (path:/tmp/pip-lDK1Li-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:20:59 INFO - Running setup.py (path:/tmp/pip-EIwqUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:20:59 INFO - Running setup.py (path:/tmp/pip-aESILB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:20:59 INFO - Running setup.py (path:/tmp/pip-YwPPm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:20:59 INFO - Running setup.py (path:/tmp/pip-UhnPLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:20:59 INFO - Running setup.py (path:/tmp/pip-c4M13B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:20:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:20:59 INFO - Running setup.py install for manifestparser 10:20:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:20:59 INFO - Running setup.py install for mozcrash 10:20:59 INFO - Running setup.py install for mozdebug 10:20:59 INFO - Running setup.py install for mozdevice 10:20:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:20:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:20:59 INFO - Running setup.py install for mozfile 10:21:00 INFO - Running setup.py install for mozhttpd 10:21:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:21:00 INFO - Running setup.py install for mozinfo 10:21:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:21:00 INFO - Running setup.py install for mozInstall 10:21:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:21:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:21:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:21:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:21:00 INFO - Running setup.py install for mozleak 10:21:00 INFO - Running setup.py install for mozlog 10:21:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:21:00 INFO - Running setup.py install for moznetwork 10:21:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:21:00 INFO - Running setup.py install for mozprocess 10:21:00 INFO - Running setup.py install for mozprofile 10:21:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:21:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:21:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:21:00 INFO - Running setup.py install for mozrunner 10:21:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:21:01 INFO - Running setup.py install for mozscreenshot 10:21:01 INFO - Running setup.py install for moztest 10:21:01 INFO - Running setup.py install for mozversion 10:21:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:21:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:21:01 INFO - Cleaning up... 10:21:01 INFO - Return code: 0 10:21:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0f9498af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1baf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d09810>, '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 0x1d0a710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0aba0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1461691034.209767-404806119', '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 10:21:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:21:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:21:01 INFO - Using env: {'DISPLAY': ':0', 10:21:01 INFO - 'HOME': '/home/cltbld', 10:21:01 INFO - 'LANG': 'en_US.UTF-8', 10:21:01 INFO - 'LANGUAGE': 'en_US:en', 10:21:01 INFO - 'LOGNAME': 'cltbld', 10:21:01 INFO - 'MAIL': '/var/mail/cltbld', 10:21:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:01 INFO - 'MOZ_NO_REMOTE': '1', 10:21:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:01 INFO - 'NO_EM_RESTART': '1', 10:21:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:01 INFO - 'PWD': '/builds/slave/test', 10:21:01 INFO - 'SHELL': '/bin/bash', 10:21:01 INFO - 'SHLVL': '1', 10:21:01 INFO - 'TERM': 'linux', 10:21:01 INFO - 'TMOUT': '86400', 10:21:01 INFO - 'USER': 'cltbld', 10:21:01 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461691034.209767-404806119', 10:21:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:01 INFO - '_': '/tools/buildbot/bin/python'} 10:21:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:21:01 INFO - Running setup.py (path:/tmp/pip-u7oLxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:21:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:21:01 INFO - Running setup.py (path:/tmp/pip-Zw9RN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:21:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:21:01 INFO - Running setup.py (path:/tmp/pip-AX3P7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:21:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:21:01 INFO - Running setup.py (path:/tmp/pip-5XxFhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:21:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:21:01 INFO - Running setup.py (path:/tmp/pip-txDVY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:21:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:21:01 INFO - Running setup.py (path:/tmp/pip-XBuRnj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:21:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:21:01 INFO - Running setup.py (path:/tmp/pip-p5czTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:21:02 INFO - Running setup.py (path:/tmp/pip-A8bgP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:21:02 INFO - Running setup.py (path:/tmp/pip-Ijslix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:21:02 INFO - Running setup.py (path:/tmp/pip-AQDaGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:21:02 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)) 10:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:21:02 INFO - Running setup.py (path:/tmp/pip-VBql01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:21:02 INFO - Running setup.py (path:/tmp/pip-Yz9hXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:21:02 INFO - Running setup.py (path:/tmp/pip-IhIynV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:21:02 INFO - Running setup.py (path:/tmp/pip-BZolN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:21:02 INFO - Running setup.py (path:/tmp/pip-WGPiMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:21:02 INFO - Running setup.py (path:/tmp/pip-Ei7wCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:21:02 INFO - Running setup.py (path:/tmp/pip-biQfl0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:21:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:21:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:04 INFO - Downloading blessings-1.6.tar.gz 10:21:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:21:04 INFO - Installing collected packages: blessings 10:21:04 INFO - Running setup.py install for blessings 10:21:04 INFO - Successfully installed blessings 10:21:04 INFO - Cleaning up... 10:21:04 INFO - Return code: 0 10:21:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:21:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:21:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:21:05 INFO - Reading from file tmpfile_stdout 10:21:05 INFO - Current package versions: 10:21:05 INFO - argparse == 1.2.1 10:21:05 INFO - blessings == 1.6 10:21:05 INFO - blobuploader == 1.2.4 10:21:05 INFO - docopt == 0.6.1 10:21:05 INFO - manifestparser == 1.1 10:21:05 INFO - mozInstall == 1.12 10:21:05 INFO - mozcrash == 0.17 10:21:05 INFO - mozdebug == 0.1 10:21:05 INFO - mozdevice == 0.48 10:21:05 INFO - mozfile == 1.2 10:21:05 INFO - mozhttpd == 0.7 10:21:05 INFO - mozinfo == 0.9 10:21:05 INFO - mozleak == 0.1 10:21:05 INFO - mozlog == 3.1 10:21:05 INFO - moznetwork == 0.27 10:21:05 INFO - mozprocess == 0.22 10:21:05 INFO - mozprofile == 0.28 10:21:05 INFO - mozrunner == 6.11 10:21:05 INFO - mozscreenshot == 0.1 10:21:05 INFO - mozsystemmonitor == 0.0 10:21:05 INFO - moztest == 0.7 10:21:05 INFO - mozversion == 1.4 10:21:05 INFO - psutil == 3.1.1 10:21:05 INFO - requests == 1.2.3 10:21:05 INFO - wsgiref == 0.1.2 10:21:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:21:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0f9498af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1baf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d09810>, '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 0x1d0a710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0aba0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1461691034.209767-404806119', '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 10:21:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:21:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:21:05 INFO - Using env: {'DISPLAY': ':0', 10:21:05 INFO - 'HOME': '/home/cltbld', 10:21:05 INFO - 'LANG': 'en_US.UTF-8', 10:21:05 INFO - 'LANGUAGE': 'en_US:en', 10:21:05 INFO - 'LOGNAME': 'cltbld', 10:21:05 INFO - 'MAIL': '/var/mail/cltbld', 10:21:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:05 INFO - 'MOZ_NO_REMOTE': '1', 10:21:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:05 INFO - 'NO_EM_RESTART': '1', 10:21:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:05 INFO - 'PWD': '/builds/slave/test', 10:21:05 INFO - 'SHELL': '/bin/bash', 10:21:05 INFO - 'SHLVL': '1', 10:21:05 INFO - 'TERM': 'linux', 10:21:05 INFO - 'TMOUT': '86400', 10:21:05 INFO - 'USER': 'cltbld', 10:21:05 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461691034.209767-404806119', 10:21:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:05 INFO - '_': '/tools/buildbot/bin/python'} 10:21:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:21:05 INFO - Cleaning up... 10:21:05 INFO - Return code: 0 10:21:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:21:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0f9498af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1baf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d09810>, '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 0x1d0a710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0aba0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1461691034.209767-404806119', '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 10:21:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:21:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:21:05 INFO - Using env: {'DISPLAY': ':0', 10:21:05 INFO - 'HOME': '/home/cltbld', 10:21:05 INFO - 'LANG': 'en_US.UTF-8', 10:21:05 INFO - 'LANGUAGE': 'en_US:en', 10:21:05 INFO - 'LOGNAME': 'cltbld', 10:21:05 INFO - 'MAIL': '/var/mail/cltbld', 10:21:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:05 INFO - 'MOZ_NO_REMOTE': '1', 10:21:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:05 INFO - 'NO_EM_RESTART': '1', 10:21:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:05 INFO - 'PWD': '/builds/slave/test', 10:21:05 INFO - 'SHELL': '/bin/bash', 10:21:05 INFO - 'SHLVL': '1', 10:21:05 INFO - 'TERM': 'linux', 10:21:05 INFO - 'TMOUT': '86400', 10:21:05 INFO - 'USER': 'cltbld', 10:21:05 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461691034.209767-404806119', 10:21:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:05 INFO - '_': '/tools/buildbot/bin/python'} 10:21:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:05 INFO - Downloading/unpacking jsonschema 10:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:21:07 INFO - Downloading/unpacking functools32 (from jsonschema) 10:21:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:07 INFO - Downloading functools32-3.2.3-2.tar.gz 10:21:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:21:07 INFO - warning: no files found matching '*.txt' 10:21:07 INFO - no previously-included directories found matching 'build' 10:21:07 INFO - no previously-included directories found matching 'dist' 10:21:07 INFO - no previously-included directories found matching '.git*' 10:21:07 INFO - Installing collected packages: jsonschema, functools32 10:21:07 INFO - Running setup.py install for functools32 10:21:07 INFO - warning: no files found matching '*.txt' 10:21:07 INFO - no previously-included directories found matching 'build' 10:21:07 INFO - no previously-included directories found matching 'dist' 10:21:07 INFO - no previously-included directories found matching '.git*' 10:21:07 INFO - Successfully installed jsonschema functools32 10:21:07 INFO - Cleaning up... 10:21:07 INFO - Return code: 0 10:21:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:21:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0f9498af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1baf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d09810>, '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 0x1d0a710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0aba0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1461691034.209767-404806119', '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 10:21:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:21:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:21:07 INFO - Using env: {'DISPLAY': ':0', 10:21:07 INFO - 'HOME': '/home/cltbld', 10:21:07 INFO - 'LANG': 'en_US.UTF-8', 10:21:07 INFO - 'LANGUAGE': 'en_US:en', 10:21:07 INFO - 'LOGNAME': 'cltbld', 10:21:07 INFO - 'MAIL': '/var/mail/cltbld', 10:21:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:07 INFO - 'MOZ_NO_REMOTE': '1', 10:21:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:07 INFO - 'NO_EM_RESTART': '1', 10:21:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:07 INFO - 'PWD': '/builds/slave/test', 10:21:07 INFO - 'SHELL': '/bin/bash', 10:21:07 INFO - 'SHLVL': '1', 10:21:07 INFO - 'TERM': 'linux', 10:21:07 INFO - 'TMOUT': '86400', 10:21:07 INFO - 'USER': 'cltbld', 10:21:07 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461691034.209767-404806119', 10:21:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:07 INFO - '_': '/tools/buildbot/bin/python'} 10:21:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:08 INFO - Downloading/unpacking flake8 10:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:21:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:21:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:21:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:21:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:21:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:21:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:21:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:21:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:21:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:21:10 INFO - no previously-included directories found matching 'docs/_build' 10:21:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:21:10 INFO - Running setup.py install for pep8 10:21:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:21:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:21:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:21:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:21:10 INFO - no previously-included directories found matching 'docs/_build' 10:21:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:21:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:21:10 INFO - Cleaning up... 10:21:11 INFO - Return code: 0 10:21:11 INFO - Running post-action listener: _resource_record_post_action 10:21:11 INFO - Running post-action listener: _start_resource_monitoring 10:21:11 INFO - Starting resource monitoring. 10:21:11 INFO - ##### 10:21:11 INFO - ##### Running install step. 10:21:11 INFO - ##### 10:21:11 INFO - Running pre-action listener: _resource_record_pre_action 10:21:11 INFO - Running main action method: install 10:21:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:21:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:21:11 INFO - Reading from file tmpfile_stdout 10:21:11 INFO - Detecting whether we're running mozinstall >=1.0... 10:21:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:21:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:21:11 INFO - Reading from file tmpfile_stdout 10:21:11 INFO - Output received: 10:21:11 INFO - Usage: mozinstall [options] installer 10:21:11 INFO - Options: 10:21:11 INFO - -h, --help show this help message and exit 10:21:11 INFO - -d DEST, --destination=DEST 10:21:11 INFO - Directory to install application into. [default: 10:21:11 INFO - "/builds/slave/test"] 10:21:11 INFO - --app=APP Application being installed. [default: firefox] 10:21:11 INFO - mkdir: /builds/slave/test/build/application 10:21:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:21:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:21:27 INFO - Reading from file tmpfile_stdout 10:21:27 INFO - Output received: 10:21:27 INFO - /builds/slave/test/build/application/firefox/firefox 10:21:27 INFO - Running post-action listener: _resource_record_post_action 10:21:27 INFO - ##### 10:21:27 INFO - ##### Running run-tests step. 10:21:27 INFO - ##### 10:21:27 INFO - Running pre-action listener: _resource_record_pre_action 10:21:27 INFO - Running main action method: run_tests 10:21:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:21:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:21:27 INFO - Python 2.7.3 10:21:27 INFO - Return code: 0 10:21:27 INFO - grabbing minidump binary from tooltool 10:21: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')]} 10:21:27 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d09810>, '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 0x1d0a710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0aba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:21:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:21:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:21:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:21:27 INFO - Return code: 0 10:21:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:21:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:21:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:21:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:21:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:21:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:21:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:21:28 INFO - Return code: 0 10:21:28 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/dxTfsYfVS4CN2hz5BmtcvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 10:21:28 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/dxTfsYfVS4CN2hz5BmtcvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --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 10:21:28 INFO - Using env: {'DISPLAY': ':0', 10:21:28 INFO - 'HOME': '/home/cltbld', 10:21:28 INFO - 'LANG': 'en_US.UTF-8', 10:21:28 INFO - 'LANGUAGE': 'en_US:en', 10:21:28 INFO - 'LOGNAME': 'cltbld', 10:21:28 INFO - 'MAIL': '/var/mail/cltbld', 10:21:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:21:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:28 INFO - 'MOZ_NO_REMOTE': '1', 10:21:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:21:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:28 INFO - 'NO_EM_RESTART': '1', 10:21:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:28 INFO - 'PWD': '/builds/slave/test', 10:21:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:21:28 INFO - 'SHELL': '/bin/bash', 10:21:28 INFO - 'SHLVL': '1', 10:21:28 INFO - 'TERM': 'linux', 10:21:28 INFO - 'TMOUT': '86400', 10:21:28 INFO - 'USER': 'cltbld', 10:21:28 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461691034.209767-404806119', 10:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:28 INFO - '_': '/tools/buildbot/bin/python'} 10:21:28 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/dxTfsYfVS4CN2hz5BmtcvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 10:21:29 INFO - mozversion application_buildid: 20160426073449 10:21:29 INFO - mozversion application_changeset: 9ce31e9f90cb0e534611b0f617c5bbc232ffe748 10:21:29 INFO - mozversion application_display_name: Nightly 10:21:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:21:29 INFO - mozversion application_name: Firefox 10:21:29 INFO - mozversion application_remotingname: firefox 10:21:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:21:29 INFO - mozversion application_vendor: Mozilla 10:21:29 INFO - mozversion application_version: 49.0a1 10:21:29 INFO - mozversion platform_buildid: 20160426073449 10:21:29 INFO - mozversion platform_changeset: 9ce31e9f90cb0e534611b0f617c5bbc232ffe748 10:21:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:21:29 INFO - mozversion platform_version: 49.0a1 10:21:29 INFO - using testdate: 1461691289 10:21:29 INFO - actual date: 1461691289 10:21:29 INFO - starting webserver on 'localhost:53561' 10:21:29 INFO - SUITE-START | Running 2 tests 10:21:29 INFO - TEST-START | dromaeo_css 10:21:29 INFO - operating with platform_type : linux_ 10:21:29 INFO - Initialising browser for dromaeo_css test... 10:21:29 INFO - TEST-INFO | started process 12105 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjVkPQX/profile http://localhost:53561/getInfo.html) 10:21:33 INFO - PROCESS | 12105 | __metrics Screen width/height:1600/1200 10:21:33 INFO - PROCESS | 12105 | colorDepth:24 10:21:33 INFO - PROCESS | 12105 | Browser inner width/height: 1024/697 10:21:33 INFO - PROCESS | 12105 | __metrics 10:21:34 ERROR - PROCESS | 12105 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:21:34 INFO - TEST-INFO | 12105: exit 0 10:21:34 INFO - Browser initialized. 10:21:34 INFO - Running cycle 1/1 for dromaeo_css test... 10:21:34 INFO - TEST-INFO | started process 12187 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjVkPQX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:21:46 INFO - PROCESS | 12187 | RSS: Main: 154337280 10:21:46 INFO - PROCESS | 12187 | 10:22:37 INFO - PROCESS | 12187 | 1461691357885 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] 10:24:45 INFO - PROCESS | 12187 | Cycle 1(1): loaded http://localhost:53561/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53561/tests/dromaeo/cssquery-ext.html) 10:24:46 INFO - PROCESS | 12187 | RSS: Main: 253255680 10:24:46 INFO - PROCESS | 12187 | 10:27:48 INFO - PROCESS | 12187 | Cycle 1(1): loaded http://localhost:53561/tests/dromaeo/cssquery-ext.html (next: http://localhost:53561/tests/dromaeo/cssquery-jquery.html) 10:27:49 INFO - PROCESS | 12187 | RSS: Main: 237387776 10:27:49 INFO - PROCESS | 12187 | 10:30:50 INFO - PROCESS | 12187 | Cycle 1(1): loaded http://localhost:53561/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53561/tests/dromaeo/cssquery-mootools.html) 10:30:51 INFO - PROCESS | 12187 | RSS: Main: 233402368 10:30:51 INFO - PROCESS | 12187 | 10:33:53 INFO - PROCESS | 12187 | Cycle 1(1): loaded http://localhost:53561/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53561/tests/dromaeo/cssquery-prototype.html) 10:33:53 INFO - PROCESS | 12187 | RSS: Main: 228474880 10:33:53 INFO - PROCESS | 12187 | 10:36:56 INFO - PROCESS | 12187 | Cycle 1(1): loaded http://localhost:53561/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53561/tests/dromaeo/cssquery-yui.html) 10:36:57 INFO - PROCESS | 12187 | RSS: Main: 216842240 10:36:57 INFO - PROCESS | 12187 | 10:39:59 INFO - PROCESS | 12187 | Cycle 1(1): loaded http://localhost:53561/tests/dromaeo/cssquery-yui.html (next: http://localhost:53561/tests/dromaeo/cssquery-dojo.html) 10:39:59 INFO - PROCESS | 12187 | RSS: Main: 262004736 10:39:59 INFO - PROCESS | 12187 | 10:39:59 INFO - PROCESS | 12187 | __start_tp_report 10:39:59 INFO - PROCESS | 12187 | _x_x_mozilla_page_load 10:39:59 INFO - PROCESS | 12187 | _x_x_mozilla_page_load_details 10:39:59 INFO - PROCESS | 12187 | |i|pagename|runs| 10:39:59 INFO - PROCESS | 12187 | |0;dojo.html;3069.248034231613;3162.2884850908563;3203.439398105331;3203.631582368027;3233.5634689316935;5291.523762861341;5367.060764366235;5378.757955891984;5396.271503347057;5465.2895123633925;5338.572914166867;5352.170413585891;5372.140457526796;5436.510714035736;5477.589180811445;4806.9519304806945;4836.733979631119;4847.903041939177;4848.7090774553635;4977;4882.902341953159;4910.558049775519;4946.40643122824;4955.405351357842;4955.677880937727;4744.217204161309;4748.0978614063215;4812.614990800745;4842.297866809328;4859.41686997559;4833.734144622044;4845.6123510119105;4858.80564777412;4868.853934381974;4887.853364399074;4750.382450281476;4824.517548245182;4850.151223535902;4864.1974074277705;4884.316195732565;5217.426083130853;5225.581953443715;5263.763130659129;5311.229871668586;5321.733913304358;5652.09566469367;5672.34768001681;5687.317521897398;5689.089745640719;5696.3733989261145;5652.604317697763;5718.199452076713;5718.399568045378;5721.370649228582;5724.685142317171;5285.2600635911;5286.339207599089;5290.047791397508;5303.60222983274;5304.522592966651;5760.74076666551;5767.019606666793;5767.452092051249;5769.221155144086;5774.595778295563;5496.725163741797;5537.390887002426;5544;5605.607607467519;5683.204351390726;5722;5723.055695810144;5726.284214473191;5730.226419433323;5760.36635970043;5684.971575142098;5700.173474846124;5710.600257981901;5711.914321285184;5721.713914304268;5611.691356975405;5710.314762228559;5713.257276554022;5785.4214578541805;5816.41835816415;4267.445232119867;4271.380649805761;4279.144171165779;4301.118270754488;4303.376010478526;3843.942340864889;3856.1323702166787;3868.0909986153233;3890.902727431837;3892.3772196449;5204.167333226741;5284.286621306074;5314.388845282765;5370.570354371641;5409.6213265071065;5711.228984087178;5743.339515955635;5758.424157584208;5770.13447982806;5770.653760774367;5286.81496147633;5380.757865896044;5385.7307134643115;5386.8383948481605;5422.349318081777;4636.559526844944;4689.343491911135;4708.176069187878;4740.407449068866;4750;5771.480566749013;5812.099124635688;5823.5341172706085;5831.620944638585;5857.26784151981;5676.318841739017;5698.059820129715;5726.685032323262;5729.828105156852;5733.243533138733;5862.648241105548;5872.383399743137;5875.794347197828;5906.911396328973;5923.585349025527;5649.915251271152;5650.434956504317;5653.265075540154;5657.858553536194;5662.575306852085;5607.411221821813;5638.915416268677;5738;5743.167240750151;5744.425557444222;5523.061079616556;5542.473465020817;5548.750306236148;5549.112142057252;5596.524295434933;5511.917321240265;5540.418256083053;5544.251526043932;5545.417731138173;5546.556275498031;5387.5689944803535;5415.079436495884;5415.5396791271605;5471.097268950738;5519.3652729936575;5532.253145825423;5557.388687244319;5557.777688892399;5565.916511252415;5576.693281869536;5428.891422171613;5448.918266226089;5453.318335208099;5453.345598528043;5459.344878614592 10:39:59 INFO - PROCESS | 12187 | |1;ext.html;585.519873703563;647.391452035087;660.5640277416906;668.3650531994606;672.4485921544333;31410;36037.459438108446;36768.264634707324;36853;36855.631443685554;38353.808230958806;39115;39186.21627567447;39205.60794392062;39259.21481570367;7632.732854350099;7807.843843123134;8220.958895205516;8403.033651130107;8422.452540584842;9664.903350966471;9910.058544438267;9947.701568952943;9953;9956.452395118265;9736.464494452803;9912.752181195456;9913.306068575203;9921.255905807056;9927.205823534136;7562.092548894113;9716.951415242878;9808.607655693799;9965.601375944954;10013;9705.223582113415;9823.656172034016;9826.1156495915;9846.852297215548;9849.507524623812;36997.44503832418;37454.81272593647;37512.62487375146;37553.43669844954;37558;3416.4704470807064;3495.5805303363504;3502.842372093262;3636.30910127075;4004.1190937993597;29006.564901526493;29073.85463072692;29282.267943301376;29298.707012930023;29765.70234297651;4146.875593732193;4193.32906734924;4219.493660760729;4224.85213017546;4368.322909948963;248928;251845;254183.99999999814;254809;255550;55535.444645553835;55601.721991390594;55894.441055589734;55997.72001139968;55998.880022399324;54722;55561.444385555624;55909.72045139748;55934.160987585215;58255.70872145612;15444.382224711111;15672.216389180723;15680.843191567938;15700.214989250491;15700.371985120695;12666.620001399973;12687.873121268669;12707.809382859265;12715.364231788373;12737.872621273855;17785.19966601506;17909.37317193918;17935.192916318796;18017.18922648484;18019.369322073926;6914.896276555855;7024.733498923026;7025.332593403618;7138.964305178441;7257.092863392076;887.4364778365784;904.9638164301838;994.8408254679362;1019.4647809899714;1023.0945613132283;27660.170194894185;28041;28686.856565717455;28723;29310.853445732635;1063.1388575253914;1093.2565855218368;1107.7562936154034;1124.100719424457;1225.5097960815567;15914.76127858083;16243.756343654855;16344.294487110961;16416.917915410348;16803.579910502092;346529;350171;350294;351286;351620;53621.73189134029;53964.73017634965;54294.7285263579;54390.18414723782;54448.45551544434;1213.854337479508;1281.7116148866617;1384.5292600515872;1411.400154934149;1515.6428510848302;26783.330416739736;28729;28730.280075057868;30798;30897.227569310948;44690.3296450547;44734;45108.32337514874;45213.54786452094;45218.77390613157;238210;238502;238786;239628;240998;22367.888160559745;25087.87456062708;25364.365890852878;25556.872215639545;26389.868050659625;43266.13467730691;43347;44067.77966110149;44284.33573496465;44352.7782361099;33156.50265245975;33966.66033339635;34382.65617343794;37496.437553436175;37651.81174094112;34144.317113658086;34212.14469638279;34407.827960860035;34468.65531344755;35181.82409087938;35738.64261357353;36104.63895361013;36107;36478.993655348146;38528.42207366948;35841.28317433689;36301;36349;36857.447138293486;37189;29140.56289155622;29781.5532767013;29831.254218644706;30258.54612180863;30434 10:39:59 INFO - PROCESS | 12187 | |2;jquery.html;395.22535829773625;397.41183049087357;399.894028082558;410.17350039670066;414.9768933320757;16749;17241.396551120713;17337.56656083597;17352.913235433803;18208.81791182088;16866.83133168668;17007.31970721173;17040;17091.40180093697;17625.11874406281;5517.724113794315;5605.887882242353;5651.1523271509395;5659.801906933259;5696.145578163288;5457.290552228204;5618.269624948751;5651;5652.717364131798;5654.915176272339;5458.863528411782;5543.805966791163;5612.15817627355;5614.157876318564;5616.887662246752;5589.413111623282;5607.915881261784;5620.606557540974;5639.577031722617;5645.040343141676;4986.4514903360605;5038.949610503884;5039.294498770175;5195.792168313263;5488.807891723811;13342.666433339244;13480.730385392237;13613.727725445435;13704.45182192711;13706.93146534261;2129.33990462957;2201.3395981205736;2225.1655629139073;2274.647429648407;2561.9615705764427;9831.26265530081;9857.507124643811;9935.950320248425;10047.196224302039;10178.592856285739;1865.6268746250669;1921.5484361175113;1948.8928108954;1973.6940774180025;1987.3739771971927;72654.27345726528;73122.63438682826;73828.6308568459;74246.62876685582;75764;10344.5344959477;10362.222833287533;10414.271001030007;10517.843037265895;10742.838857417146;14818.925905370405;14885.255737213096;14919.925400373146;14962.102273863604;15000.774988375184;7561.886571701429;7726.806829829186;7896.644650990719;7926.801829954297;7947.5231486111015;7380.409567234608;7528.661210245552;7578;7599.202083781123;7607.505512141693;4625.699329543636;4706.247000479975;4747.572718455355;4766.83731399771;4781.091592597395;1892.4890279624424;1951.5316324082403;1955.599102184049;1963.9312624058375;1981.28673677476;883.8983516895511;948.4262021476907;966.8888077871135;986.8075725233654;1010.525053224983;17348.739768903477;17686.91156544209;17933.820661793477;17967.191476383596;18421.355252566365;945.5083356654501;1023.9948800255951;1031.3966329697062;1035.5961175141701;1054.778496515725;9605.423674579548;10041.397516149054;10303.227257955534;10315.690529284133;10351.63769268072;507965;512773;514726;516036;521254;55016.72491637596;70671;72189.6390518044;81921.59039204885;84442.57778711067;1036.5905467340508;1047.3715770537617;1069.7593041565742;1106.198006445337;1107.85044019058;15181.6204594886;15555.377784888931;16304.266308015931;16534.66930661356;16792.66414671724;36297.45553816748;36614.63385366112;37165.25669486541;38015.80992095022;38242.2351552973;49717.50282497273;50886;52766;53272.20091698705;53452.73273633607;8276.420650554644;8493.089054962584;8544.700935467228;8556.529390883561;8748.518831464331;8879.822403552022;11496.94251528737;11713.297202167898;12122.575709850113;12335.629931102081;10554.788904222027;10683.89316106829;10884.183686223723;11009.504572294105;11027.558897644005;10359.792804144026;10436.425996570262;10542.420166890895;10592.629257975934;10856.022957933825;10942.890571094187;11288.153388496059;11358.204925655455;11530.192886497865;12112.818307725214;8225.136360682041;8436.198561136682;8457.746267611981;8571.785705357415;8657;9799.314048016855;10650.786984260427;10664.84002739944;10726.624568140078;10974.670759877217 10:39:59 INFO - PROCESS | 12187 | |3;mootools.html;1319.663485811118;1476.8670819626232;1506.3447400380835;1630.4456484795166;1753.6229710612224;7853.253940875622;8150.347972162228;8155.42911996159;8179.836403271931;8204.794880128;7945.364370850332;8152;8156.592170391486;8160.91839081609;8172.91827081729;2277.1119263487253;2318.0611852199886;2321.106374045996;2321.6401457773986;2323.186884590388;2277.2826559633745;2306.042992158261;2321;2326.7673232676766;2329.37106981115;2304.9193278235266;2331.160782118436;2332.6734257204007;2336.9883150584224;2339;2236.1279101150562;2260.1298500077587;2291.1522736587485;2297.517521320516;2298.0118549023914;2255.4248666589915;2266.9546609067893;2270.035235025108;2270.0579259607407;2271.5911135995516;7975.720849770289;8235.794105147359;8240.8351832963;8289.792755181108;8292.709755158541;4986.675866068694;5045.823396181153;5060.822871199491;5117;5118.411382690963;3241.5299781531544;3252.512123181518;3284.359549887773;3456.1186897341017;3459.757816952814;1123.1632433836762;1140.5836869542557;1142.103448792702;1142.714321419645;1207.7041124924363;10742.516586753614;11078.390688512129;11146.164037697125;11166.274192177563;11184.552617895193;4338.848140315074;4343;4441.133978874089;4454.621357184611;4554.908901821945;8907.465552066767;8963.372563920462;8981.730548083568;9006.369554131148;9007.819843603222;5042.546170844642;5078.669886457368;5103.795848166106;5124;5126.564242039394;4233.618974292267;4370.104128653618;4403.713758605681;4629.560191781776;4810;3623.7282203834816;3642.3261696585687;3706.054955986206;3726.795026273581;3744.3260213161893;1122.6968718445974;1155.5782139519015;1156.4853640130061;1164.5283660117666;1169.181572898974;890.2210565754964;920.3143657974852;923.5843870258276;950.8193443245899;953.4327075390271;5578.0517312057045;5696.3449203341315;5754.769809207669;5756.740946657411;6106.175666285084;902.6254104546671;967.8644989701447;1004.5885530829197;1006.8288390973552;1036.9377837329785;3796.4495148203355;3850.441685955521;3852.2680690668685;3861.2663593917064;3936.389859571771;9684.225261979025;10091.545880435398;10156.746081347877;10198.031187037219;10212.540435680412;9838.114569688762;10112.241581881388;10185.796284074277;10325.48372581368;10419.166466682647;7677.654505547152;7716.4212684048925;7789.844203116019;7839.490433121829;7938;5427.864303392446;5580.246666700106;5583.637063590853;5609.27079479665;5690.430956904276;9593.904060959301;9603.087706667855;9657.806843862943;9761.902380976384;9784.364016338915;8989.05614910425;9195.816083678155;9201.447913125234;9330.066993300616;9752.414855108716;7168.820779480555;7477.887831682638;7479.326860582573;7491.587962661888;7493.288137626917;7803.570803605856;7923.128455869965;7974.362051036019;7978.162292959156;7978.720744773905;7012.368886800213;7191.640417979184;7197.604131772803;7340.522866013692;7480.92519074824;7215.927840721525;7244.855102898018;7265.854682906418;7326.890096648448;7372;6449.645269510034;6484.897567413645;6500.804975850732;6514.185726784152;6521.771737989147;4767.61859051282;4940.629452790983;4941.901161976669;4956.008798240294;4986.15235409974;4973.005398920158;5062.620303477328;5114.46298138705;5149.845504634867;5155.561777248826 10:39:59 INFO - PROCESS | 12187 | |4;prototype.html;308.2478751845495;311.2545453638536;311.41298652040894;323.55188064530626;324.8619336781868;5227.581793456524;5326.60302863711;5368.248445217668;5393.298871146755;5403.378611459683;5299.258103865462;5303.65526240794;5303.7082960437165;5307.2569840222395;5317.415084340729;3977.8011099445057;4042.3532234842432;4121.072758629314;4171.916561668765;4228.238916994939;4184.581541845821;4211.157768446323;4215.156968606276;4217.514985776629;4248.98024474127;4163.958360416403;4172.728772629769;4183.155454291081;4199.916001679964;4201.684873634475;3988.1824226033596;4000.339943909266;4148.651688201317;4184.832606695729;4191.8532851350055;3732.1416074302792;3735.1409175889426;3753.9436908446396;3754.924901501982;3766.4162054881263;5137.897242055175;5138.203578445347;5141.511556402136;5143.485651434827;5150.145947458912;4401.933970990438;4689.718616882998;4694.037722266927;4699.483056863743;4782.593479554242;5524.922640085185;5525.033119204163;5535.169724541351;5544.91682624761;5549.19536667185;3870.3807390817333;3902.0635047588657;3917.9804100979313;3926.9018274543364;3953.3081710700512;5558.610897237195;5651.2370829937845;5771.797987070432;5776.306843178803;5798.362180160179;4002.659773919191;4035.6367926886132;4038.5557588665224;4048.4534587830267;4060.1879624074713;4093.263212621697;4108.096218831853;4112.527059388209;4132.132252227066;4140.468026830092;4575.17646823575;4654.25531914892;4665.836695715634;4678.613906907502;4683.92269777953;5577.888442231133;5593.804216852391;5598.916016259759;5605;5623.775048998076;1451.6008097772985;1458.2781523145898;1463.2683658170915;1475.7786332050064;1477.4459577658379;922.2115091596588;930.292977337215;966.0822218892081;967.3180407812475;971.7910649210454;5647.689377084218;5676.650776042073;5681.517071048925;5702.885942281131;5717.971410142923;6034.2155519782145;6035.215421995113;6070.575059745775;6073.089036644538;6076.301225359052;5465.890682186334;5594.356648985337;5653.378128405954;5680.147977803363;5687.203791469197;3206.2625596112557;3219.4205043092;3220.935581288408;3226.661200573953;3247.821369824635;5957.4042595740075;6194.721237544321;6195;6198.411150940653;6240;6109.877802443926;6126.100908718312;6136.9079463808075;6160.10678451622;6215.96892015537;6135.263768347827;6232.18981532407;6235.750569977241;6247.219097612799;6252.06186082316;5836.678982655994;6046;6064.211652485149;6067.817965461043;6077.453029227391;5971.313298970674;5987.401259873977;5988.850278743066;5990.820275391745;6032.155498230163;6046.395360463918;6215.564910456405;6258.155149054819;6260.780872669435;6273.843153921189;4171.124063946605;4193.601607847249;4195.9370609440275;4224.788760562021;4228.365745138254;6021.638701677914;6092.147099405998;6095.359987201457;6101.359357267423;6108.450239478469;5431.511163995259;5612.635178713371;5637.915431268616;5668.744906479136;5910.290765108042;5608.635438696471;5614.63504872182;5621.747021383966;5655.547556195576;5657.179708942263;5132.563732082665;5336.332958380202;5563.499285064364;5577.406505974741;5604.635698679573;5608.85977850557;5614.6631202128;5628.718564071862;5637.154426836008;5644;5508.925759476863;5515.779368825202;5564.165375193753;5591.888162236651;5601.24383208278 10:39:59 INFO - PROCESS | 12187 | |5;yui.html;815.8980127484068;827.577935253021;830.9833803323934;840.9159084091596;861.2722249699002;13957.09278896871;14570.344334504945;14617.415303387852;14669.633259168526;14909.850901490996;12678.049146314017;12724.618261452171;12737.490500379998;12766.42551085201;12778.488860445572;672.6838385958604;691.778630838132;693.3724978894109;694.798508432554;782.2216894190288;802.7631848604676;807.4791759315239;807.9838403231931;811.2131232704268;812.9837403251961;840.6301227459898;844.1094645149365;847.3052097280232;848.0671261612239;849.0829903704016;842.5071333270014;844.6748002019267;844.957752112395;845.2308399356556;845.3997661660198;529.1797713543991;603.5805115444767;620.3579295429209;620.6741460733106;621.4748537485817;13375.866241337559;13381.598552043455;13382.464701411931;13393;13402.195868247936;12907.354632268349;13501.59495215145;13618.659533511642;13661.316934153352;13718.45126194951;11306.321620702702;11519.48162332697;11519.539218431253;11535.307881527135;11723.824142637868;3679.411294192916;3765.2093060457337;3769.736118471708;3780.7920564368947;3860.36304009838;55167.72416137894;55175.724121379135;55175.724121379535;56142.438575614535;56235.71882140604;10357.84463233037;10533.999270069331;10906.5092070857;10935.234533582732;11182.496787644575;18438.631227375645;18661.066946652612;18672.066396680384;18723.25106995705;18778.342758003404;8040.798980025429;8135.918640813635;8140.308073813674;8433.367497437717;8442.57787110642;4642.4911903631455;4643.141018911512;4661.650376221797;4751.097291514601;4793.257045158006;3123.8125712457327;3187.0438868339406;3190.9042728718177;3192.8243946582697;3199.1842080269384;586.191056342245;591.4174538079988;596.2040675697991;601.8615718384796;603.9818805435845;700.3206889317354;774.8217909880759;775.8478659191097;793.218679600593;820.5609998650693;9270.90729092714;9423.293253006052;9522.85715714265;9615.51922403877;9642.228621710246;721.3858568571391;728.1262485018;743.5612988336907;762.954222746637;766.4749646492171;4284.828606855691;4290.2706539888295;4380.3210502372185;4474.105178964221;4507.616852567503;65142.348576514574;66562;67671.3232867665;67738.3226167732;67855.32144678589;55258.44741552533;56172.71913640487;56288;56495;59258.40741592615;52970.73514632402;53213.7339313301;53504.19743703848;53787.462125379025;54330.91338173214;8551.12311036556;8652.437591556529;8685.826283474169;8718.869216961624;8733.257673097603;31394;32937.67062329442;35088.82455587706;35357.646423535436;36252;47281.29078063901;47386.52613473821;47752.7612361936;47868.28197577109;49086;11523.308601483937;11692.123090768056;12575.87424125747;12621;12634.115611907078;12820.23078615286;13824.308784560531;13873.861261387257;14099.365528551445;14582.4896128635;8749.956250218707;12660;13051.543195988095;13442.798358024442;13722.931385343009;11784.58753943608;12677;12739.872601273868;12842.807357889826;13027.218366898016;12638.936805315914;13095.214287142802;13162.736745264849;13167.275799830719;13402.731945360843;10286.485675716334;10526.31578947366;10765.246432749946;10825.67522974312;10881.78236435251;10840.891591083988;10998.670039898816;11117.388543630179;11150.498227579941;11167.106631469625 10:39:59 INFO - PROCESS | 12187 | __end_tp_report 10:39:59 INFO - PROCESS | 12187 | __start_cc_report 10:39:59 INFO - PROCESS | 12187 | _x_x_mozilla_cycle_collect,852 10:39:59 INFO - PROCESS | 12187 | __end_cc_report 10:39:59 INFO - PROCESS | 12187 | __startTimestamp1461692399895__endTimestamp 10:39:59 INFO - PROCESS | 12187 | 10:39:59 INFO - PROCESS | 12187 | ------- Summary: start ------- 10:39:59 INFO - PROCESS | 12187 | Number of tests: 6 10:39:59 INFO - PROCESS | 12187 | 10:39:59 INFO - PROCESS | 12187 | [#0] dojo.html Cycles:165 Average:5281.84 Median:5471.10 stddev:595.51 (10.9%) stddev-sans-first:571.48 10:39:59 INFO - PROCESS | 12187 | Values: 3069.2 3162.3 3203.4 3203.6 3233.6 5291.5 5367.1 5378.8 5396.3 5465.3 5338.6 5352.2 5372.1 5436.5 5477.6 4807.0 4836.7 4847.9 4848.7 4977.0 4882.9 4910.6 4946.4 4955.4 4955.7 4744.2 4748.1 4812.6 4842.3 4859.4 4833.7 4845.6 4858.8 4868.9 4887.9 4750.4 4824.5 4850.2 4864.2 4884.3 5217.4 5225.6 5263.8 5311.2 5321.7 5652.1 5672.3 5687.3 5689.1 5696.4 5652.6 5718.2 5718.4 5721.4 5724.7 5285.3 5286.3 5290.0 5303.6 5304.5 5760.7 5767.0 5767.5 5769.2 5774.6 5496.7 5537.4 5544.0 5605.6 5683.2 5722.0 5723.1 5726.3 5730.2 5760.4 5685.0 5700.2 5710.6 5711.9 5721.7 5611.7 5710.3 5713.3 5785.4 5816.4 4267.4 4271.4 4279.1 4301.1 4303.4 3843.9 3856.1 3868.1 3890.9 3892.4 5204.2 5284.3 5314.4 5370.6 5409.6 5711.2 5743.3 5758.4 5770.1 5770.7 5286.8 5380.8 5385.7 5386.8 5422.3 4636.6 4689.3 4708.2 4740.4 4750.0 5771.5 5812.1 5823.5 5831.6 5857.3 5676.3 5698.1 5726.7 5729.8 5733.2 5862.6 5872.4 5875.8 5906.9 5923.6 5649.9 5650.4 5653.3 5657.9 5662.6 5607.4 5638.9 5738.0 5743.2 5744.4 5523.1 5542.5 5548.8 5549.1 5596.5 5511.9 5540.4 5544.3 5545.4 5546.6 5387.6 5415.1 5415.5 5471.1 5519.4 5532.3 5557.4 5557.8 5565.9 5576.7 5428.9 5448.9 5453.3 5453.3 5459.3 10:39:59 INFO - PROCESS | 12187 | 10:39:59 INFO - PROCESS | 12187 | [#1] ext.html Cycles:180 Average:45072.46 Median:36325.00 stddev:74490.39 (205.1%) stddev-sans-first:74624.47 10:39:59 INFO - PROCESS | 12187 | Values: 585.5 647.4 660.6 668.4 672.4 31410.0 36037.5 36768.3 36853.0 36855.6 38353.8 39115.0 39186.2 39205.6 39259.2 7632.7 7807.8 8221.0 8403.0 8422.5 9664.9 9910.1 9947.7 9953.0 9956.5 9736.5 9912.8 9913.3 9921.3 9927.2 7562.1 9717.0 9808.6 9965.6 10013.0 9705.2 9823.7 9826.1 9846.9 9849.5 36997.4 37454.8 37512.6 37553.4 37558.0 3416.5 3495.6 3502.8 3636.3 4004.1 29006.6 29073.9 29282.3 29298.7 29765.7 4146.9 4193.3 4219.5 4224.9 4368.3 248928.0 251845.0 254184.0 254809.0 255550.0 55535.4 55601.7 55894.4 55997.7 55998.9 54722.0 55561.4 55909.7 55934.2 58255.7 15444.4 15672.2 15680.8 15700.2 15700.4 12666.6 12687.9 12707.8 12715.4 12737.9 17785.2 17909.4 17935.2 18017.2 18019.4 6914.9 7024.7 7025.3 7139.0 7257.1 887.4 905.0 994.8 1019.5 1023.1 27660.2 28041.0 28686.9 28723.0 29310.9 1063.1 1093.3 1107.8 1124.1 1225.5 15914.8 16243.8 16344.3 16416.9 16803.6 346529.0 350171.0 350294.0 351286.0 351620.0 53621.7 53964.7 54294.7 54390.2 54448.5 1213.9 1281.7 1384.5 1411.4 1515.6 26783.3 28729.0 28730.3 30798.0 30897.2 44690.3 44734.0 45108.3 45213.5 45218.8 238210.0 238502.0 238786.0 239628.0 240998.0 22367.9 25087.9 25364.4 25556.9 26389.9 43266.1 43347.0 44067.8 44284.3 44352.8 33156.5 33966.7 34382.7 37496.4 37651.8 34144.3 34212.1 34407.8 34468.7 35181.8 35738.6 36104.6 36107.0 36479.0 38528.4 35841.3 36301.0 36349.0 36857.4 37189.0 29140.6 29781.6 29831.3 30258.5 30434.0 10:39:59 INFO - PROCESS | 12187 | 10:39:59 INFO - PROCESS | 12187 | [#2] jquery.html Cycles:180 Average:27974.64 Median:36889.95 stddev:84319.99 (228.6%) stddev-sans-first:84531.10 10:39:59 INFO - PROCESS | 12187 | Values: 395.2 397.4 399.9 410.2 415.0 16749.0 17241.4 17337.6 17352.9 18208.8 16866.8 17007.3 17040.0 17091.4 17625.1 5517.7 5605.9 5651.2 5659.8 5696.1 5457.3 5618.3 5651.0 5652.7 5654.9 5458.9 5543.8 5612.2 5614.2 5616.9 5589.4 5607.9 5620.6 5639.6 5645.0 4986.5 5038.9 5039.3 5195.8 5488.8 13342.7 13480.7 13613.7 13704.5 13706.9 2129.3 2201.3 2225.2 2274.6 2562.0 9831.3 9857.5 9936.0 10047.2 10178.6 1865.6 1921.5 1948.9 1973.7 1987.4 72654.3 73122.6 73828.6 74246.6 75764.0 10344.5 10362.2 10414.3 10517.8 10742.8 14818.9 14885.3 14919.9 14962.1 15000.8 7561.9 7726.8 7896.6 7926.8 7947.5 7380.4 7528.7 7578.0 7599.2 7607.5 4625.7 4706.2 4747.6 4766.8 4781.1 1892.5 1951.5 1955.6 1963.9 1981.3 883.9 948.4 966.9 986.8 1010.5 17348.7 17686.9 17933.8 17967.2 18421.4 945.5 1024.0 1031.4 1035.6 1054.8 9605.4 10041.4 10303.2 10315.7 10351.6 507965.0 512773.0 514726.0 516036.0 521254.0 55016.7 70671.0 72189.6 81921.6 84442.6 1036.6 1047.4 1069.8 1106.2 1107.9 15181.6 15555.4 16304.3 16534.7 16792.7 36297.5 36614.6 37165.3 38015.8 38242.2 49717.5 50886.0 52766.0 53272.2 53452.7 8276.4 8493.1 8544.7 8556.5 8748.5 8879.8 11496.9 11713.3 12122.6 12335.6 10554.8 10683.9 10884.2 11009.5 11027.6 10359.8 10436.4 10542.4 10592.6 10856.0 10942.9 11288.2 11358.2 11530.2 12112.8 8225.1 8436.2 8457.7 8571.8 8657.0 9799.3 10650.8 10664.8 10726.6 10974.7 10:39:59 INFO - PROCESS | 12187 | 10:39:59 INFO - PROCESS | 12187 | [#3] mootools.html Cycles:180 Average:5456.65 Median:5061.72 stddev:2993.59 (59.1%) stddev-sans-first:2985.84 10:39:59 INFO - PROCESS | 12187 | Values: 1319.7 1476.9 1506.3 1630.4 1753.6 7853.3 8150.3 8155.4 8179.8 8204.8 7945.4 8152.0 8156.6 8160.9 8172.9 2277.1 2318.1 2321.1 2321.6 2323.2 2277.3 2306.0 2321.0 2326.8 2329.4 2304.9 2331.2 2332.7 2337.0 2339.0 2236.1 2260.1 2291.2 2297.5 2298.0 2255.4 2267.0 2270.0 2270.1 2271.6 7975.7 8235.8 8240.8 8289.8 8292.7 4986.7 5045.8 5060.8 5117.0 5118.4 3241.5 3252.5 3284.4 3456.1 3459.8 1123.2 1140.6 1142.1 1142.7 1207.7 10742.5 11078.4 11146.2 11166.3 11184.6 4338.8 4343.0 4441.1 4454.6 4554.9 8907.5 8963.4 8981.7 9006.4 9007.8 5042.5 5078.7 5103.8 5124.0 5126.6 4233.6 4370.1 4403.7 4629.6 4810.0 3623.7 3642.3 3706.1 3726.8 3744.3 1122.7 1155.6 1156.5 1164.5 1169.2 890.2 920.3 923.6 950.8 953.4 5578.1 5696.3 5754.8 5756.7 6106.2 902.6 967.9 1004.6 1006.8 1036.9 3796.4 3850.4 3852.3 3861.3 3936.4 9684.2 10091.5 10156.7 10198.0 10212.5 9838.1 10112.2 10185.8 10325.5 10419.2 7677.7 7716.4 7789.8 7839.5 7938.0 5427.9 5580.2 5583.6 5609.3 5690.4 9593.9 9603.1 9657.8 9761.9 9784.4 8989.1 9195.8 9201.4 9330.1 9752.4 7168.8 7477.9 7479.3 7491.6 7493.3 7803.6 7923.1 7974.4 7978.2 7978.7 7012.4 7191.6 7197.6 7340.5 7480.9 7215.9 7244.9 7265.9 7326.9 7372.0 6449.6 6484.9 6500.8 6514.2 6521.8 4767.6 4940.6 4941.9 4956.0 4986.2 4973.0 5062.6 5114.5 5149.8 5155.6 10:39:59 INFO - PROCESS | 12187 | 10:39:59 INFO - PROCESS | 12187 | [#4] prototype.html Cycles:180 Average:4795.44 Median:5520.35 stddev:1444.73 (26.2%) stddev-sans-first:1408.98 10:39:59 INFO - PROCESS | 12187 | Values: 308.2 311.3 311.4 323.6 324.9 5227.6 5326.6 5368.2 5393.3 5403.4 5299.3 5303.7 5303.7 5307.3 5317.4 3977.8 4042.4 4121.1 4171.9 4228.2 4184.6 4211.2 4215.2 4217.5 4249.0 4164.0 4172.7 4183.2 4199.9 4201.7 3988.2 4000.3 4148.7 4184.8 4191.9 3732.1 3735.1 3753.9 3754.9 3766.4 5137.9 5138.2 5141.5 5143.5 5150.1 4401.9 4689.7 4694.0 4699.5 4782.6 5524.9 5525.0 5535.2 5544.9 5549.2 3870.4 3902.1 3918.0 3926.9 3953.3 5558.6 5651.2 5771.8 5776.3 5798.4 4002.7 4035.6 4038.6 4048.5 4060.2 4093.3 4108.1 4112.5 4132.1 4140.5 4575.2 4654.3 4665.8 4678.6 4683.9 5577.9 5593.8 5598.9 5605.0 5623.8 1451.6 1458.3 1463.3 1475.8 1477.4 922.2 930.3 966.1 967.3 971.8 5647.7 5676.7 5681.5 5702.9 5718.0 6034.2 6035.2 6070.6 6073.1 6076.3 5465.9 5594.4 5653.4 5680.1 5687.2 3206.3 3219.4 3220.9 3226.7 3247.8 5957.4 6194.7 6195.0 6198.4 6240.0 6109.9 6126.1 6136.9 6160.1 6216.0 6135.3 6232.2 6235.8 6247.2 6252.1 5836.7 6046.0 6064.2 6067.8 6077.5 5971.3 5987.4 5988.9 5990.8 6032.2 6046.4 6215.6 6258.2 6260.8 6273.8 4171.1 4193.6 4195.9 4224.8 4228.4 6021.6 6092.1 6095.4 6101.4 6108.5 5431.5 5612.6 5637.9 5668.7 5910.3 5608.6 5614.6 5621.7 5655.5 5657.2 5132.6 5336.3 5563.5 5577.4 5604.6 5608.9 5614.7 5628.7 5637.2 5644.0 5508.9 5515.8 5564.2 5591.9 5601.2 10:39:59 INFO - PROCESS | 12187 | 10:39:59 INFO - PROCESS | 12187 | [#5] yui.html Cycles:180 Average:15139.03 Median:4652.40 stddev:17983.31 (386.5%) stddev-sans-first:18001.59 10:39:59 INFO - PROCESS | 12187 | Values: 815.9 827.6 831.0 840.9 861.3 13957.1 14570.3 14617.4 14669.6 14909.9 12678.0 12724.6 12737.5 12766.4 12778.5 672.7 691.8 693.4 694.8 782.2 802.8 807.5 808.0 811.2 813.0 840.6 844.1 847.3 848.1 849.1 842.5 844.7 845.0 845.2 845.4 529.2 603.6 620.4 620.7 621.5 13375.9 13381.6 13382.5 13393.0 13402.2 12907.4 13501.6 13618.7 13661.3 13718.5 11306.3 11519.5 11519.5 11535.3 11723.8 3679.4 3765.2 3769.7 3780.8 3860.4 55167.7 55175.7 55175.7 56142.4 56235.7 10357.8 10534.0 10906.5 10935.2 11182.5 18438.6 18661.1 18672.1 18723.3 18778.3 8040.8 8135.9 8140.3 8433.4 8442.6 4642.5 4643.1 4661.7 4751.1 4793.3 3123.8 3187.0 3190.9 3192.8 3199.2 586.2 591.4 596.2 601.9 604.0 700.3 774.8 775.8 793.2 820.6 9270.9 9423.3 9522.9 9615.5 9642.2 721.4 728.1 743.6 763.0 766.5 4284.8 4290.3 4380.3 4474.1 4507.6 65142.3 66562.0 67671.3 67738.3 67855.3 55258.4 56172.7 56288.0 56495.0 59258.4 52970.7 53213.7 53504.2 53787.5 54330.9 8551.1 8652.4 8685.8 8718.9 8733.3 31394.0 32937.7 35088.8 35357.6 36252.0 47281.3 47386.5 47752.8 47868.3 49086.0 11523.3 11692.1 12575.9 12621.0 12634.1 12820.2 13824.3 13873.9 14099.4 14582.5 8750.0 12660.0 13051.5 13442.8 13722.9 11784.6 12677.0 12739.9 12842.8 13027.2 12638.9 13095.2 13162.7 13167.3 13402.7 10286.5 10526.3 10765.2 10825.7 10881.8 10840.9 10998.7 11117.4 11150.5 11167.1 10:39:59 INFO - PROCESS | 12187 | -------- Summary: end -------- 10:39:59 INFO - PROCESS | 12187 | 10:40:00 INFO - TEST-INFO | 12187: exit 0 10:40:00 INFO - TEST-OK | dromaeo_css | took 1111484ms 10:40:00 INFO - TEST-START | kraken 10:40:00 INFO - operating with platform_type : linux_ 10:40:00 INFO - Initialising browser for kraken test... 10:40:00 INFO - TEST-INFO | started process 12364 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoCt5eY/profile http://localhost:53561/getInfo.html) 10:40:04 INFO - PROCESS | 12364 | __metrics Screen width/height:1600/1200 10:40:04 INFO - PROCESS | 12364 | colorDepth:24 10:40:04 INFO - PROCESS | 12364 | Browser inner width/height: 1024/697 10:40:04 INFO - PROCESS | 12364 | __metrics 10:40:05 ERROR - PROCESS | 12364 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:40:06 INFO - TEST-INFO | 12364: exit 0 10:40:06 INFO - Browser initialized. 10:40:06 INFO - Running cycle 1/1 for kraken test... 10:40:06 INFO - TEST-INFO | started process 12444 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoCt5eY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:40:18 INFO - PROCESS | 12444 | RSS: Main: 154009600 10:40:18 INFO - PROCESS | 12444 | 10:40:20 INFO - PROCESS | 12444 | Cycle 1(1): loaded http://localhost:53561/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53561/tests/kraken/driver.html?testName=audio-beat-detection) 10:40:21 INFO - PROCESS | 12444 | RSS: Main: 209408000 10:40:21 INFO - PROCESS | 12444 | 10:40:24 INFO - PROCESS | 12444 | Cycle 1(1): loaded http://localhost:53561/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53561/tests/kraken/driver.html?testName=audio-dft) 10:40:25 INFO - PROCESS | 12444 | RSS: Main: 194994176 10:40:25 INFO - PROCESS | 12444 | 10:40:28 INFO - PROCESS | 12444 | Cycle 1(1): loaded http://localhost:53561/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53561/tests/kraken/driver.html?testName=audio-fft) 10:40:28 INFO - PROCESS | 12444 | RSS: Main: 266186752 10:40:28 INFO - PROCESS | 12444 | 10:40:30 INFO - PROCESS | 12444 | Cycle 1(1): loaded http://localhost:53561/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53561/tests/kraken/driver.html?testName=audio-oscillator) 10:40:31 INFO - PROCESS | 12444 | RSS: Main: 173924352 10:40:31 INFO - PROCESS | 12444 | 10:40:33 INFO - PROCESS | 12444 | Cycle 1(1): loaded http://localhost:53561/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53561/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:40:34 INFO - PROCESS | 12444 | RSS: Main: 178769920 10:40:34 INFO - PROCESS | 12444 | 10:40:37 INFO - PROCESS | 12444 | Cycle 1(1): loaded http://localhost:53561/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53561/tests/kraken/driver.html?testName=imaging-darkroom) 10:40:37 INFO - PROCESS | 12444 | RSS: Main: 214659072 10:40:37 INFO - PROCESS | 12444 | 10:40:41 INFO - PROCESS | 12444 | Cycle 1(1): loaded http://localhost:53561/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53561/tests/kraken/driver.html?testName=imaging-desaturate) 10:40:41 INFO - PROCESS | 12444 | RSS: Main: 215617536 10:40:41 INFO - PROCESS | 12444 | 10:40:44 INFO - PROCESS | 12444 | Cycle 1(1): loaded http://localhost:53561/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53561/tests/kraken/driver.html?testName=json-parse-financial) 10:40:45 INFO - PROCESS | 12444 | RSS: Main: 215486464 10:40:45 INFO - PROCESS | 12444 | 10:40:46 INFO - PROCESS | 12444 | Cycle 1(1): loaded http://localhost:53561/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53561/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:40:47 INFO - PROCESS | 12444 | RSS: Main: 200343552 10:40:47 INFO - PROCESS | 12444 | 10:40:49 INFO - PROCESS | 12444 | Cycle 1(1): loaded http://localhost:53561/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53561/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:40:49 INFO - PROCESS | 12444 | RSS: Main: 202989568 10:40:49 INFO - PROCESS | 12444 | 10:40:51 INFO - PROCESS | 12444 | Cycle 1(1): loaded http://localhost:53561/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53561/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:40:52 INFO - PROCESS | 12444 | RSS: Main: 215805952 10:40:52 INFO - PROCESS | 12444 | 10:40:54 INFO - PROCESS | 12444 | Cycle 1(1): loaded http://localhost:53561/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53561/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:40:55 INFO - PROCESS | 12444 | RSS: Main: 224886784 10:40:55 INFO - PROCESS | 12444 | 10:40:58 INFO - PROCESS | 12444 | Cycle 1(1): loaded http://localhost:53561/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53561/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:40:59 INFO - PROCESS | 12444 | RSS: Main: 220844032 10:40:59 INFO - PROCESS | 12444 | 10:41:01 INFO - PROCESS | 12444 | Cycle 1(1): loaded http://localhost:53561/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53561/tests/kraken/driver.html?testName=ai-astar) 10:41:01 INFO - PROCESS | 12444 | RSS: Main: 284532736 10:41:01 INFO - PROCESS | 12444 | 10:41:01 INFO - PROCESS | 12444 | __start_tp_report 10:41:01 INFO - PROCESS | 12444 | _x_x_mozilla_page_load 10:41:01 INFO - PROCESS | 12444 | _x_x_mozilla_page_load_details 10:41:01 INFO - PROCESS | 12444 | |i|pagename|runs| 10:41:01 INFO - PROCESS | 12444 | |0;ai-astar;111;111;106;110;110;112;101;111;110;112 10:41:01 INFO - PROCESS | 12444 | |1;audio-beat-detection;151;127;152;199;127;161;174;131;188;132 10:41:01 INFO - PROCESS | 12444 | |2;audio-dft;161;172;161;160;160;160;161;161;161;160 10:41:01 INFO - PROCESS | 12444 | |3;audio-fft;76;77;110;123;73;79;85;117;100;72 10:41:01 INFO - PROCESS | 12444 | |4;audio-oscillator;94;93;157;94;93;95;155;92;92;147 10:41:01 INFO - PROCESS | 12444 | |5;imaging-gaussian-blur;116;116;117;117;118;117;117;117;117;117 10:41:01 INFO - PROCESS | 12444 | |6;imaging-darkroom;146;145;145;145;145;145;145;145;145;147 10:41:01 INFO - PROCESS | 12444 | |7;imaging-desaturate;95;95;96;95;95;95;95;95;95;95 10:41:01 INFO - PROCESS | 12444 | |8;json-parse-financial;55;57;58;56;57;58;57;73;54;53 10:41:01 INFO - PROCESS | 12444 | |9;json-stringify-tinderbox;60;62;61;61;61;60;61;60;61;61 10:41:01 INFO - PROCESS | 12444 | |10;stanford-crypto-aes;77;78;76;77;78;77;84;77;78;77 10:41:01 INFO - PROCESS | 12444 | |11;stanford-crypto-ccm;128;134;134;127;124;127;139;127;160;129 10:41:01 INFO - PROCESS | 12444 | |12;stanford-crypto-pbkdf2;203;201;198;199;203;203;199;210;197;201 10:41:01 INFO - PROCESS | 12444 | |13;stanford-crypto-sha256-iterative;73;72;74;72;71;69;71;71;71;70 10:41:01 INFO - PROCESS | 12444 | __end_tp_report 10:41:01 INFO - PROCESS | 12444 | __start_cc_report 10:41:01 INFO - PROCESS | 12444 | _x_x_mozilla_cycle_collect,1631 10:41:01 INFO - PROCESS | 12444 | __end_cc_report 10:41:01 INFO - PROCESS | 12444 | __startTimestamp1461692461319__endTimestamp 10:41:01 INFO - PROCESS | 12444 | 10:41:01 INFO - PROCESS | 12444 | ------- Summary: start ------- 10:41:01 INFO - PROCESS | 12444 | Number of tests: 14 10:41:01 INFO - PROCESS | 12444 | 10:41:01 INFO - PROCESS | 12444 | [#0] ai-astar Cycles:10 Average:109.40 Median:111.00 stddev:3.41 (3.1%) stddev-sans-first:3.56 10:41:01 INFO - PROCESS | 12444 | Values: 111.0 111.0 106.0 110.0 110.0 112.0 101.0 111.0 110.0 112.0 10:41:01 INFO - PROCESS | 12444 | 10:41:01 INFO - PROCESS | 12444 | [#1] audio-beat-detection Cycles:10 Average:154.20 Median:156.50 stddev:26.06 (16.7%) stddev-sans-first:27.62 10:41:01 INFO - PROCESS | 12444 | Values: 151.0 127.0 152.0 199.0 127.0 161.0 174.0 131.0 188.0 132.0 10:41:01 INFO - PROCESS | 12444 | 10:41:01 INFO - PROCESS | 12444 | [#2] audio-dft Cycles:10 Average:161.70 Median:161.00 stddev:3.65 (2.3%) stddev-sans-first:3.87 10:41:01 INFO - PROCESS | 12444 | Values: 161.0 172.0 161.0 160.0 160.0 160.0 161.0 161.0 161.0 160.0 10:41:01 INFO - PROCESS | 12444 | 10:41:01 INFO - PROCESS | 12444 | [#3] audio-fft Cycles:10 Average:91.20 Median:74.50 stddev:19.52 (26.2%) stddev-sans-first:19.91 10:41:01 INFO - PROCESS | 12444 | Values: 76.0 77.0 110.0 123.0 73.0 79.0 85.0 117.0 100.0 72.0 10:41:01 INFO - PROCESS | 12444 | 10:41:01 INFO - PROCESS | 12444 | [#4] audio-oscillator Cycles:10 Average:111.20 Median:93.00 stddev:28.97 (31.1%) stddev-sans-first:30.05 10:41:01 INFO - PROCESS | 12444 | Values: 94.0 93.0 157.0 94.0 93.0 95.0 155.0 92.0 92.0 147.0 10:41:01 INFO - PROCESS | 12444 | 10:41:01 INFO - PROCESS | 12444 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 10:41:01 INFO - PROCESS | 12444 | Values: 116.0 116.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 10:41:01 INFO - PROCESS | 12444 | 10:41:01 INFO - PROCESS | 12444 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 10:41:01 INFO - PROCESS | 12444 | Values: 146.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 147.0 10:41:01 INFO - PROCESS | 12444 | 10:41:01 INFO - PROCESS | 12444 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:41:01 INFO - PROCESS | 12444 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 10:41:01 INFO - PROCESS | 12444 | 10:41:01 INFO - PROCESS | 12444 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:57.00 stddev:5.59 (9.8%) stddev-sans-first:5.84 10:41:01 INFO - PROCESS | 12444 | Values: 55.0 57.0 58.0 56.0 57.0 58.0 57.0 73.0 54.0 53.0 10:41:01 INFO - PROCESS | 12444 | 10:41:01 INFO - PROCESS | 12444 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 10:41:01 INFO - PROCESS | 12444 | Values: 60.0 62.0 61.0 61.0 61.0 60.0 61.0 60.0 61.0 61.0 10:41:01 INFO - PROCESS | 12444 | 10:41:01 INFO - PROCESS | 12444 | [#10] stanford-crypto-aes Cycles:10 Average:77.90 Median:77.50 stddev:2.23 (2.9%) stddev-sans-first:2.35 10:41:01 INFO - PROCESS | 12444 | Values: 77.0 78.0 76.0 77.0 78.0 77.0 84.0 77.0 78.0 77.0 10:41:01 INFO - PROCESS | 12444 | 10:41:01 INFO - PROCESS | 12444 | [#11] stanford-crypto-ccm Cycles:10 Average:132.90 Median:131.50 stddev:10.52 (8.0%) stddev-sans-first:11.01 10:41:01 INFO - PROCESS | 12444 | Values: 128.0 134.0 134.0 127.0 124.0 127.0 139.0 127.0 160.0 129.0 10:41:01 INFO - PROCESS | 12444 | 10:41:01 INFO - PROCESS | 12444 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:201.40 Median:202.00 stddev:3.72 (1.8%) stddev-sans-first:3.90 10:41:01 INFO - PROCESS | 12444 | Values: 203.0 201.0 198.0 199.0 203.0 203.0 199.0 210.0 197.0 201.0 10:41:01 INFO - PROCESS | 12444 | 10:41:01 INFO - PROCESS | 12444 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:71.50 stddev:1.43 (2.0%) stddev-sans-first:1.39 10:41:01 INFO - PROCESS | 12444 | Values: 73.0 72.0 74.0 72.0 71.0 69.0 71.0 71.0 71.0 70.0 10:41:01 INFO - PROCESS | 12444 | -------- Summary: end -------- 10:41:01 INFO - PROCESS | 12444 | 10:41:02 INFO - TEST-INFO | 12444: exit 0 10:41:02 INFO - TEST-OK | kraken | took 61676ms 10:41:02 INFO - SUITE-END | took 1173s 10:41:02 INFO - Completed test suite (00:19:33) 10:41:02 INFO - javascript benchmark 10:41:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3069.248034231613, 3162.2884850908563, 3203.439398105331, 3203.631582368027, 3233.5634689316935, 5291.523762861341, 5367.060764366235, 5378.757955891984, 5396.271503347057, 5465.2895123633925, 5338.572914166867, 5352.170413585891, 5372.140457526796, 5436.510714035736, 5477.589180811445, 4806.9519304806945, 4836.733979631119, 4847.903041939177, 4848.7090774553635, 4977.0, 4882.902341953159, 4910.558049775519, 4946.40643122824, 4955.405351357842, 4955.677880937727, 4744.217204161309, 4748.0978614063215, 4812.614990800745, 4842.297866809328, 4859.41686997559, 4833.734144622044, 4845.6123510119105, 4858.80564777412, 4868.853934381974, 4887.853364399074, 4750.382450281476, 4824.517548245182, 4850.151223535902, 4864.1974074277705, 4884.316195732565, 5217.426083130853, 5225.581953443715, 5263.763130659129, 5311.229871668586, 5321.733913304358, 5652.09566469367, 5672.34768001681, 5687.317521897398, 5689.089745640719, 5696.3733989261145, 5652.604317697763, 5718.199452076713, 5718.399568045378, 5721.370649228582, 5724.685142317171, 5285.2600635911, 5286.339207599089, 5290.047791397508, 5303.60222983274, 5304.522592966651, 5760.74076666551, 5767.019606666793, 5767.452092051249, 5769.221155144086, 5774.595778295563, 5496.725163741797, 5537.390887002426, 5544.0, 5605.607607467519, 5683.204351390726, 5722.0, 5723.055695810144, 5726.284214473191, 5730.226419433323, 5760.36635970043, 5684.971575142098, 5700.173474846124, 5710.600257981901, 5711.914321285184, 5721.713914304268, 5611.691356975405, 5710.314762228559, 5713.257276554022, 5785.4214578541805, 5816.41835816415, 4267.445232119867, 4271.380649805761, 4279.144171165779, 4301.118270754488, 4303.376010478526, 3843.942340864889, 3856.1323702166787, 3868.0909986153233, 3890.902727431837, 3892.3772196449, 5204.167333226741, 5284.286621306074, 5314.388845282765, 5370.570354371641, 5409.6213265071065, 5711.228984087178, 5743.339515955635, 5758.424157584208, 5770.13447982806, 5770.653760774367, 5286.81496147633, 5380.757865896044, 5385.7307134643115, 5386.8383948481605, 5422.349318081777, 4636.559526844944, 4689.343491911135, 4708.176069187878, 4740.407449068866, 4750.0, 5771.480566749013, 5812.099124635688, 5823.5341172706085, 5831.620944638585, 5857.26784151981, 5676.318841739017, 5698.059820129715, 5726.685032323262, 5729.828105156852, 5733.243533138733, 5862.648241105548, 5872.383399743137, 5875.794347197828, 5906.911396328973, 5923.585349025527, 5649.915251271152, 5650.434956504317, 5653.265075540154, 5657.858553536194, 5662.575306852085, 5607.411221821813, 5638.915416268677, 5738.0, 5743.167240750151, 5744.425557444222, 5523.061079616556, 5542.473465020817, 5548.750306236148, 5549.112142057252, 5596.524295434933, 5511.917321240265, 5540.418256083053, 5544.251526043932, 5545.417731138173, 5546.556275498031, 5387.5689944803535, 5415.079436495884, 5415.5396791271605, 5471.097268950738, 5519.3652729936575, 5532.253145825423, 5557.388687244319, 5557.777688892399, 5565.916511252415, 5576.693281869536, 5428.891422171613, 5448.918266226089, 5453.318335208099, 5453.345598528043, 5459.344878614592], "value": 5242.39386189695, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.519873703563, 647.391452035087, 660.5640277416906, 668.3650531994606, 672.4485921544333, 31410.0, 36037.459438108446, 36768.264634707324, 36853.0, 36855.631443685554, 38353.808230958806, 39115.0, 39186.21627567447, 39205.60794392062, 39259.21481570367, 7632.732854350099, 7807.843843123134, 8220.958895205516, 8403.033651130107, 8422.452540584842, 9664.903350966471, 9910.058544438267, 9947.701568952943, 9953.0, 9956.452395118265, 9736.464494452803, 9912.752181195456, 9913.306068575203, 9921.255905807056, 9927.205823534136, 7562.092548894113, 9716.951415242878, 9808.607655693799, 9965.601375944954, 10013.0, 9705.223582113415, 9823.656172034016, 9826.1156495915, 9846.852297215548, 9849.507524623812, 36997.44503832418, 37454.81272593647, 37512.62487375146, 37553.43669844954, 37558.0, 3416.4704470807064, 3495.5805303363504, 3502.842372093262, 3636.30910127075, 4004.1190937993597, 29006.564901526493, 29073.85463072692, 29282.267943301376, 29298.707012930023, 29765.70234297651, 4146.875593732193, 4193.32906734924, 4219.493660760729, 4224.85213017546, 4368.322909948963, 248928.0, 251845.0, 254183.99999999814, 254809.0, 255550.0, 55535.444645553835, 55601.721991390594, 55894.441055589734, 55997.72001139968, 55998.880022399324, 54722.0, 55561.444385555624, 55909.72045139748, 55934.160987585215, 58255.70872145612, 15444.382224711111, 15672.216389180723, 15680.843191567938, 15700.214989250491, 15700.371985120695, 12666.620001399973, 12687.873121268669, 12707.809382859265, 12715.364231788373, 12737.872621273855, 17785.19966601506, 17909.37317193918, 17935.192916318796, 18017.18922648484, 18019.369322073926, 6914.896276555855, 7024.733498923026, 7025.332593403618, 7138.964305178441, 7257.092863392076, 887.4364778365784, 904.9638164301838, 994.8408254679362, 1019.4647809899714, 1023.0945613132283, 27660.170194894185, 28041.0, 28686.856565717455, 28723.0, 29310.853445732635, 1063.1388575253914, 1093.2565855218368, 1107.7562936154034, 1124.100719424457, 1225.5097960815567, 15914.76127858083, 16243.756343654855, 16344.294487110961, 16416.917915410348, 16803.579910502092, 346529.0, 350171.0, 350294.0, 351286.0, 351620.0, 53621.73189134029, 53964.73017634965, 54294.7285263579, 54390.18414723782, 54448.45551544434, 1213.854337479508, 1281.7116148866617, 1384.5292600515872, 1411.400154934149, 1515.6428510848302, 26783.330416739736, 28729.0, 28730.280075057868, 30798.0, 30897.227569310948, 44690.3296450547, 44734.0, 45108.32337514874, 45213.54786452094, 45218.77390613157, 238210.0, 238502.0, 238786.0, 239628.0, 240998.0, 22367.888160559745, 25087.87456062708, 25364.365890852878, 25556.872215639545, 26389.868050659625, 43266.13467730691, 43347.0, 44067.77966110149, 44284.33573496465, 44352.7782361099, 33156.50265245975, 33966.66033339635, 34382.65617343794, 37496.437553436175, 37651.81174094112, 34144.317113658086, 34212.14469638279, 34407.827960860035, 34468.65531344755, 35181.82409087938, 35738.64261357353, 36104.63895361013, 36107.0, 36478.993655348146, 38528.42207366948, 35841.28317433689, 36301.0, 36349.0, 36857.447138293486, 37189.0, 29140.56289155622, 29781.5532767013, 29831.254218644706, 30258.54612180863, 30434.0], "value": 18574.351253706234, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.22535829773625, 397.41183049087357, 399.894028082558, 410.17350039670066, 414.9768933320757, 16749.0, 17241.396551120713, 17337.56656083597, 17352.913235433803, 18208.81791182088, 16866.83133168668, 17007.31970721173, 17040.0, 17091.40180093697, 17625.11874406281, 5517.724113794315, 5605.887882242353, 5651.1523271509395, 5659.801906933259, 5696.145578163288, 5457.290552228204, 5618.269624948751, 5651.0, 5652.717364131798, 5654.915176272339, 5458.863528411782, 5543.805966791163, 5612.15817627355, 5614.157876318564, 5616.887662246752, 5589.413111623282, 5607.915881261784, 5620.606557540974, 5639.577031722617, 5645.040343141676, 4986.4514903360605, 5038.949610503884, 5039.294498770175, 5195.792168313263, 5488.807891723811, 13342.666433339244, 13480.730385392237, 13613.727725445435, 13704.45182192711, 13706.93146534261, 2129.33990462957, 2201.3395981205736, 2225.1655629139073, 2274.647429648407, 2561.9615705764427, 9831.26265530081, 9857.507124643811, 9935.950320248425, 10047.196224302039, 10178.592856285739, 1865.6268746250669, 1921.5484361175113, 1948.8928108954, 1973.6940774180025, 1987.3739771971927, 72654.27345726528, 73122.63438682826, 73828.6308568459, 74246.62876685582, 75764.0, 10344.5344959477, 10362.222833287533, 10414.271001030007, 10517.843037265895, 10742.838857417146, 14818.925905370405, 14885.255737213096, 14919.925400373146, 14962.102273863604, 15000.774988375184, 7561.886571701429, 7726.806829829186, 7896.644650990719, 7926.801829954297, 7947.5231486111015, 7380.409567234608, 7528.661210245552, 7578.0, 7599.202083781123, 7607.505512141693, 4625.699329543636, 4706.247000479975, 4747.572718455355, 4766.83731399771, 4781.091592597395, 1892.4890279624424, 1951.5316324082403, 1955.599102184049, 1963.9312624058375, 1981.28673677476, 883.8983516895511, 948.4262021476907, 966.8888077871135, 986.8075725233654, 1010.525053224983, 17348.739768903477, 17686.91156544209, 17933.820661793477, 17967.191476383596, 18421.355252566365, 945.5083356654501, 1023.9948800255951, 1031.3966329697062, 1035.5961175141701, 1054.778496515725, 9605.423674579548, 10041.397516149054, 10303.227257955534, 10315.690529284133, 10351.63769268072, 507965.0, 512773.0, 514726.0, 516036.0, 521254.0, 55016.72491637596, 70671.0, 72189.6390518044, 81921.59039204885, 84442.57778711067, 1036.5905467340508, 1047.3715770537617, 1069.7593041565742, 1106.198006445337, 1107.85044019058, 15181.6204594886, 15555.377784888931, 16304.266308015931, 16534.66930661356, 16792.66414671724, 36297.45553816748, 36614.63385366112, 37165.25669486541, 38015.80992095022, 38242.2351552973, 49717.50282497273, 50886.0, 52766.0, 53272.20091698705, 53452.73273633607, 8276.420650554644, 8493.089054962584, 8544.700935467228, 8556.529390883561, 8748.518831464331, 8879.822403552022, 11496.94251528737, 11713.297202167898, 12122.575709850113, 12335.629931102081, 10554.788904222027, 10683.89316106829, 10884.183686223723, 11009.504572294105, 11027.558897644005, 10359.792804144026, 10436.425996570262, 10542.420166890895, 10592.629257975934, 10856.022957933825, 10942.890571094187, 11288.153388496059, 11358.204925655455, 11530.192886497865, 12112.818307725214, 8225.136360682041, 8436.198561136682, 8457.746267611981, 8571.785705357415, 8657.0, 9799.314048016855, 10650.786984260427, 10664.84002739944, 10726.624568140078, 10974.670759877217], "value": 8665.236236460372, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1319.663485811118, 1476.8670819626232, 1506.3447400380835, 1630.4456484795166, 1753.6229710612224, 7853.253940875622, 8150.347972162228, 8155.42911996159, 8179.836403271931, 8204.794880128, 7945.364370850332, 8152.0, 8156.592170391486, 8160.91839081609, 8172.91827081729, 2277.1119263487253, 2318.0611852199886, 2321.106374045996, 2321.6401457773986, 2323.186884590388, 2277.2826559633745, 2306.042992158261, 2321.0, 2326.7673232676766, 2329.37106981115, 2304.9193278235266, 2331.160782118436, 2332.6734257204007, 2336.9883150584224, 2339.0, 2236.1279101150562, 2260.1298500077587, 2291.1522736587485, 2297.517521320516, 2298.0118549023914, 2255.4248666589915, 2266.9546609067893, 2270.035235025108, 2270.0579259607407, 2271.5911135995516, 7975.720849770289, 8235.794105147359, 8240.8351832963, 8289.792755181108, 8292.709755158541, 4986.675866068694, 5045.823396181153, 5060.822871199491, 5117.0, 5118.411382690963, 3241.5299781531544, 3252.512123181518, 3284.359549887773, 3456.1186897341017, 3459.757816952814, 1123.1632433836762, 1140.5836869542557, 1142.103448792702, 1142.714321419645, 1207.7041124924363, 10742.516586753614, 11078.390688512129, 11146.164037697125, 11166.274192177563, 11184.552617895193, 4338.848140315074, 4343.0, 4441.133978874089, 4454.621357184611, 4554.908901821945, 8907.465552066767, 8963.372563920462, 8981.730548083568, 9006.369554131148, 9007.819843603222, 5042.546170844642, 5078.669886457368, 5103.795848166106, 5124.0, 5126.564242039394, 4233.618974292267, 4370.104128653618, 4403.713758605681, 4629.560191781776, 4810.0, 3623.7282203834816, 3642.3261696585687, 3706.054955986206, 3726.795026273581, 3744.3260213161893, 1122.6968718445974, 1155.5782139519015, 1156.4853640130061, 1164.5283660117666, 1169.181572898974, 890.2210565754964, 920.3143657974852, 923.5843870258276, 950.8193443245899, 953.4327075390271, 5578.0517312057045, 5696.3449203341315, 5754.769809207669, 5756.740946657411, 6106.175666285084, 902.6254104546671, 967.8644989701447, 1004.5885530829197, 1006.8288390973552, 1036.9377837329785, 3796.4495148203355, 3850.441685955521, 3852.2680690668685, 3861.2663593917064, 3936.389859571771, 9684.225261979025, 10091.545880435398, 10156.746081347877, 10198.031187037219, 10212.540435680412, 9838.114569688762, 10112.241581881388, 10185.796284074277, 10325.48372581368, 10419.166466682647, 7677.654505547152, 7716.4212684048925, 7789.844203116019, 7839.490433121829, 7938.0, 5427.864303392446, 5580.246666700106, 5583.637063590853, 5609.27079479665, 5690.430956904276, 9593.904060959301, 9603.087706667855, 9657.806843862943, 9761.902380976384, 9784.364016338915, 8989.05614910425, 9195.816083678155, 9201.447913125234, 9330.066993300616, 9752.414855108716, 7168.820779480555, 7477.887831682638, 7479.326860582573, 7491.587962661888, 7493.288137626917, 7803.570803605856, 7923.128455869965, 7974.362051036019, 7978.162292959156, 7978.720744773905, 7012.368886800213, 7191.640417979184, 7197.604131772803, 7340.522866013692, 7480.92519074824, 7215.927840721525, 7244.855102898018, 7265.854682906418, 7326.890096648448, 7372.0, 6449.645269510034, 6484.897567413645, 6500.804975850732, 6514.185726784152, 6521.771737989147, 4767.61859051282, 4940.629452790983, 4941.901161976669, 4956.008798240294, 4986.15235409974, 4973.005398920158, 5062.620303477328, 5114.46298138705, 5149.845504634867, 5155.561777248826], "value": 4428.142506672072, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.2478751845495, 311.2545453638536, 311.41298652040894, 323.55188064530626, 324.8619336781868, 5227.581793456524, 5326.60302863711, 5368.248445217668, 5393.298871146755, 5403.378611459683, 5299.258103865462, 5303.65526240794, 5303.7082960437165, 5307.2569840222395, 5317.415084340729, 3977.8011099445057, 4042.3532234842432, 4121.072758629314, 4171.916561668765, 4228.238916994939, 4184.581541845821, 4211.157768446323, 4215.156968606276, 4217.514985776629, 4248.98024474127, 4163.958360416403, 4172.728772629769, 4183.155454291081, 4199.916001679964, 4201.684873634475, 3988.1824226033596, 4000.339943909266, 4148.651688201317, 4184.832606695729, 4191.8532851350055, 3732.1416074302792, 3735.1409175889426, 3753.9436908446396, 3754.924901501982, 3766.4162054881263, 5137.897242055175, 5138.203578445347, 5141.511556402136, 5143.485651434827, 5150.145947458912, 4401.933970990438, 4689.718616882998, 4694.037722266927, 4699.483056863743, 4782.593479554242, 5524.922640085185, 5525.033119204163, 5535.169724541351, 5544.91682624761, 5549.19536667185, 3870.3807390817333, 3902.0635047588657, 3917.9804100979313, 3926.9018274543364, 3953.3081710700512, 5558.610897237195, 5651.2370829937845, 5771.797987070432, 5776.306843178803, 5798.362180160179, 4002.659773919191, 4035.6367926886132, 4038.5557588665224, 4048.4534587830267, 4060.1879624074713, 4093.263212621697, 4108.096218831853, 4112.527059388209, 4132.132252227066, 4140.468026830092, 4575.17646823575, 4654.25531914892, 4665.836695715634, 4678.613906907502, 4683.92269777953, 5577.888442231133, 5593.804216852391, 5598.916016259759, 5605.0, 5623.775048998076, 1451.6008097772985, 1458.2781523145898, 1463.2683658170915, 1475.7786332050064, 1477.4459577658379, 922.2115091596588, 930.292977337215, 966.0822218892081, 967.3180407812475, 971.7910649210454, 5647.689377084218, 5676.650776042073, 5681.517071048925, 5702.885942281131, 5717.971410142923, 6034.2155519782145, 6035.215421995113, 6070.575059745775, 6073.089036644538, 6076.301225359052, 5465.890682186334, 5594.356648985337, 5653.378128405954, 5680.147977803363, 5687.203791469197, 3206.2625596112557, 3219.4205043092, 3220.935581288408, 3226.661200573953, 3247.821369824635, 5957.4042595740075, 6194.721237544321, 6195.0, 6198.411150940653, 6240.0, 6109.877802443926, 6126.100908718312, 6136.9079463808075, 6160.10678451622, 6215.96892015537, 6135.263768347827, 6232.18981532407, 6235.750569977241, 6247.219097612799, 6252.06186082316, 5836.678982655994, 6046.0, 6064.211652485149, 6067.817965461043, 6077.453029227391, 5971.313298970674, 5987.401259873977, 5988.850278743066, 5990.820275391745, 6032.155498230163, 6046.395360463918, 6215.564910456405, 6258.155149054819, 6260.780872669435, 6273.843153921189, 4171.124063946605, 4193.601607847249, 4195.9370609440275, 4224.788760562021, 4228.365745138254, 6021.638701677914, 6092.147099405998, 6095.359987201457, 6101.359357267423, 6108.450239478469, 5431.511163995259, 5612.635178713371, 5637.915431268616, 5668.744906479136, 5910.290765108042, 5608.635438696471, 5614.63504872182, 5621.747021383966, 5655.547556195576, 5657.179708942263, 5132.563732082665, 5336.332958380202, 5563.499285064364, 5577.406505974741, 5604.635698679573, 5608.85977850557, 5614.6631202128, 5628.718564071862, 5637.154426836008, 5644.0, 5508.925759476863, 5515.779368825202, 5564.165375193753, 5591.888162236651, 5601.24383208278], "value": 4329.481706482939, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [815.8980127484068, 827.577935253021, 830.9833803323934, 840.9159084091596, 861.2722249699002, 13957.09278896871, 14570.344334504945, 14617.415303387852, 14669.633259168526, 14909.850901490996, 12678.049146314017, 12724.618261452171, 12737.490500379998, 12766.42551085201, 12778.488860445572, 672.6838385958604, 691.778630838132, 693.3724978894109, 694.798508432554, 782.2216894190288, 802.7631848604676, 807.4791759315239, 807.9838403231931, 811.2131232704268, 812.9837403251961, 840.6301227459898, 844.1094645149365, 847.3052097280232, 848.0671261612239, 849.0829903704016, 842.5071333270014, 844.6748002019267, 844.957752112395, 845.2308399356556, 845.3997661660198, 529.1797713543991, 603.5805115444767, 620.3579295429209, 620.6741460733106, 621.4748537485817, 13375.866241337559, 13381.598552043455, 13382.464701411931, 13393.0, 13402.195868247936, 12907.354632268349, 13501.59495215145, 13618.659533511642, 13661.316934153352, 13718.45126194951, 11306.321620702702, 11519.48162332697, 11519.539218431253, 11535.307881527135, 11723.824142637868, 3679.411294192916, 3765.2093060457337, 3769.736118471708, 3780.7920564368947, 3860.36304009838, 55167.72416137894, 55175.724121379135, 55175.724121379535, 56142.438575614535, 56235.71882140604, 10357.84463233037, 10533.999270069331, 10906.5092070857, 10935.234533582732, 11182.496787644575, 18438.631227375645, 18661.066946652612, 18672.066396680384, 18723.25106995705, 18778.342758003404, 8040.798980025429, 8135.918640813635, 8140.308073813674, 8433.367497437717, 8442.57787110642, 4642.4911903631455, 4643.141018911512, 4661.650376221797, 4751.097291514601, 4793.257045158006, 3123.8125712457327, 3187.0438868339406, 3190.9042728718177, 3192.8243946582697, 3199.1842080269384, 586.191056342245, 591.4174538079988, 596.2040675697991, 601.8615718384796, 603.9818805435845, 700.3206889317354, 774.8217909880759, 775.8478659191097, 793.218679600593, 820.5609998650693, 9270.90729092714, 9423.293253006052, 9522.85715714265, 9615.51922403877, 9642.228621710246, 721.3858568571391, 728.1262485018, 743.5612988336907, 762.954222746637, 766.4749646492171, 4284.828606855691, 4290.2706539888295, 4380.3210502372185, 4474.105178964221, 4507.616852567503, 65142.348576514574, 66562.0, 67671.3232867665, 67738.3226167732, 67855.32144678589, 55258.44741552533, 56172.71913640487, 56288.0, 56495.0, 59258.40741592615, 52970.73514632402, 53213.7339313301, 53504.19743703848, 53787.462125379025, 54330.91338173214, 8551.12311036556, 8652.437591556529, 8685.826283474169, 8718.869216961624, 8733.257673097603, 31394.0, 32937.67062329442, 35088.82455587706, 35357.646423535436, 36252.0, 47281.29078063901, 47386.52613473821, 47752.7612361936, 47868.28197577109, 49086.0, 11523.308601483937, 11692.123090768056, 12575.87424125747, 12621.0, 12634.115611907078, 12820.23078615286, 13824.308784560531, 13873.861261387257, 14099.365528551445, 14582.4896128635, 8749.956250218707, 12660.0, 13051.543195988095, 13442.798358024442, 13722.931385343009, 11784.58753943608, 12677.0, 12739.872601273868, 12842.807357889826, 13027.218366898016, 12638.936805315914, 13095.214287142802, 13162.736745264849, 13167.275799830719, 13402.731945360843, 10286.485675716334, 10526.31578947366, 10765.246432749946, 10825.67522974312, 10881.78236435251, 10840.891591083988, 10998.670039898816, 11117.388543630179, 11150.498227579941, 11167.106631469625], "value": 6742.82111871765, "unit": "score"}], "name": "dromaeo_css", "value": 6912.378329489557, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 106.0, 110.0, 110.0, 112.0, 101.0, 111.0, 110.0, 112.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 127.0, 152.0, 199.0, 127.0, 161.0, 174.0, 131.0, 188.0, 132.0], "value": 154.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 172.0, 161.0, 160.0, 160.0, 160.0, 161.0, 161.0, 161.0, 160.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 110.0, 123.0, 73.0, 79.0, 85.0, 117.0, 100.0, 72.0], "value": 91.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 157.0, 94.0, 93.0, 95.0, 155.0, 92.0, 92.0, 147.0], "value": 111.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 147.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.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": [55.0, 57.0, 58.0, 56.0, 57.0, 58.0, 57.0, 73.0, 54.0, 53.0], "value": 57.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 61.0, 61.0, 61.0, 60.0, 61.0, 60.0, 61.0, 61.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 76.0, 77.0, 78.0, 77.0, 84.0, 77.0, 78.0, 77.0], "value": 77.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 134.0, 134.0, 127.0, 124.0, 127.0, 139.0, 127.0, 160.0, 129.0], "value": 132.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [203.0, 201.0, 198.0, 199.0, 203.0, 203.0, 199.0, 210.0, 197.0, 201.0], "value": 201.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 74.0, 72.0, 71.0, 69.0, 71.0, 71.0, 71.0, 70.0], "value": 71.4, "unit": "score"}], "name": "kraken", "value": 1587.2000000000005, "alertThreshold": 2.0}]} 10:41:02 INFO - Return code: 0 10:41:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:41:02 ERROR - # TBPL SUCCESS # 10:41:02 INFO - Running post-action listener: _resource_record_post_action 10:41:02 INFO - Running post-run listener: _resource_record_post_run 10:41:03 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 542507008; Read time: 0; Write time: 838296 10:41:03 INFO - install - Wall time: 17s; CPU: 16.0%; Read bytes: 0; Write bytes: 257630208; Read time: 0; Write time: 586516 10:41:03 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 284876800; Read time: 0; Write time: 251780 10:41:03 INFO - Running post-run listener: _upload_blobber_files 10:41:03 INFO - Blob upload gear active. 10:41:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:41:03 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:41:03 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'] 10:41:03 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 10:41:04 INFO - (blobuploader) - INFO - Open directory for files ... 10:41:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:41:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:41:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:41:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:41:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:41:04 INFO - (blobuploader) - INFO - Done attempting. 10:41:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:41:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:41:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:41:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:41:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:41:05 INFO - (blobuploader) - INFO - Done attempting. 10:41:05 INFO - (blobuploader) - INFO - Iteration through files over. 10:41:05 INFO - Return code: 0 10:41:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:41:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:41:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e961fd66b0bb50e28b8e35cb13ded3e8c2475c0766f9f279bd8d93b22f30f8a269fef9efe2c44b0b606daafa0c18d3292263fc26970992440df417afb6d60ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4426534fed1ae4e48f3b299f1e65e3bc9517f27241238efb12a222bb6676c9ce2f4c2df805fcf1dc37c9b79e5dae59dcc7e733132dae10bdbcef3708253e67ce"} 10:41:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:41:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:41:05 INFO - Contents: 10:41:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e961fd66b0bb50e28b8e35cb13ded3e8c2475c0766f9f279bd8d93b22f30f8a269fef9efe2c44b0b606daafa0c18d3292263fc26970992440df417afb6d60ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4426534fed1ae4e48f3b299f1e65e3bc9517f27241238efb12a222bb6676c9ce2f4c2df805fcf1dc37c9b79e5dae59dcc7e733132dae10bdbcef3708253e67ce"} 10:41:05 INFO - Running post-run listener: copy_logs_to_upload_dir 10:41:05 INFO - Copying logs to upload dir... 10:41:05 INFO - mkdir: /builds/slave/test/build/upload/logs 10:41:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.832371 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-04-26 10:41:05.606775) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 10:41:05.610413) ========= 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=c6927cf182745ad25b1d38b9000001fe-1461691034.209767-404806119 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/4e961fd66b0bb50e28b8e35cb13ded3e8c2475c0766f9f279bd8d93b22f30f8a269fef9efe2c44b0b606daafa0c18d3292263fc26970992440df417afb6d60ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4426534fed1ae4e48f3b299f1e65e3bc9517f27241238efb12a222bb6676c9ce2f4c2df805fcf1dc37c9b79e5dae59dcc7e733132dae10bdbcef3708253e67ce"} build_url:https://queue.taskcluster.net/v1/task/dxTfsYfVS4CN2hz5BmtcvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011278 build_url: 'https://queue.taskcluster.net/v1/task/dxTfsYfVS4CN2hz5BmtcvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e961fd66b0bb50e28b8e35cb13ded3e8c2475c0766f9f279bd8d93b22f30f8a269fef9efe2c44b0b606daafa0c18d3292263fc26970992440df417afb6d60ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4426534fed1ae4e48f3b299f1e65e3bc9517f27241238efb12a222bb6676c9ce2f4c2df805fcf1dc37c9b79e5dae59dcc7e733132dae10bdbcef3708253e67ce"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 10:41:05.634797) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 10:41:05.635125) ========= 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=c6927cf182745ad25b1d38b9000001fe-1461691034.209767-404806119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004429 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 10:41:05.717846) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 10:41:05.718184) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 10:41:05.718476) ========= ========= Total master_lag: 0.16 =========