builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1463676191.65 results: success (0) buildid: 20160519070342 builduid: 2981746851954708961c48de8654da04 revision: 9c96e9ec8e42fd75c62030c6840c6dc23478a07f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 09:43:11.650855) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 09:43:11.651336) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 09:43:11.651707) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 09:43:11.685500) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 09:43:11.685833) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1463676187.911723-36483592 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-19 09:43:11-- 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% 23.0M=0.001s 2016-05-19 09:43:11 (23.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123098 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 09:43:11.822289) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 09:43:11.822627) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1463676187.911723-36483592 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015954 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 09:43:11.875859) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 09:43:11.876217) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9c96e9ec8e42fd75c62030c6840c6dc23478a07f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9c96e9ec8e42fd75c62030c6840c6dc23478a07f --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1463676187.911723-36483592 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-19 09:43:12,007 truncating revision to first 12 chars 2016-05-19 09:43:12,007 Setting DEBUG logging. 2016-05-19 09:43:12,008 attempt 1/10 2016-05-19 09:43:12,008 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9c96e9ec8e42?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-19 09:43:12,266 unpacking tar archive at: mozilla-aurora-9c96e9ec8e42/testing/mozharness/ program finished with exit code 0 elapsedTime=0.534147 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 09:43:12.425988) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 09:43:12.426570) ========= script_repo_revision: 9c96e9ec8e42fd75c62030c6840c6dc23478a07f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 09:43:12.427289) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 09:43:12.427961) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 09:43:12.438815) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-19 09:43:12.439130) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1463676187.911723-36483592 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:43:12 INFO - MultiFileLogger online at 20160519 09:43:12 in /builds/slave/test 09:43:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:43:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:43:12 INFO - {'append_to_log': False, 09:43:12 INFO - 'base_work_dir': '/builds/slave/test', 09:43:12 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:43:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:43:12 INFO - 'branch': 'Mozilla-Aurora', 09:43:12 INFO - 'buildbot_json_path': 'buildprops.json', 09:43:12 INFO - 'config_files': ('talos/linux_config.py',), 09:43:12 INFO - 'default_actions': ('clobber', 09:43:12 INFO - 'read-buildbot-config', 09:43:12 INFO - 'download-and-extract', 09:43:12 INFO - 'populate-webroot', 09:43:12 INFO - 'create-virtualenv', 09:43:12 INFO - 'install', 09:43:12 INFO - 'run-tests'), 09:43:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:43:12 INFO - 'download_minidump_stackwalk': True, 09:43:12 INFO - 'download_symbols': 'ondemand', 09:43:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:43:12 INFO - 'tooltool.py': '/tools/tooltool.py', 09:43:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:43:12 INFO - '/tools/misc-python/virtualenv.py')}, 09:43:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:43:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:43:12 INFO - 'installer_path': 'installer.exe', 09:43:12 INFO - 'log_level': 'info', 09:43:12 INFO - 'log_name': 'talos', 09:43:12 INFO - 'log_to_console': True, 09:43:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:43:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:43:12 INFO - 'opt_config_files': (), 09:43:12 INFO - 'pip_index': False, 09:43:12 INFO - 'sps_profile': False, 09:43:12 INFO - 'sps_profile_interval': 0, 09:43:12 INFO - 'suite': 'dromaeojs', 09:43:12 INFO - 'system_bits': '32', 09:43:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:43:12 INFO - 'title': 'talos-linux64-ix-060', 09:43:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:43:12 INFO - 'use_talos_json': True, 09:43:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:43:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:43:12 INFO - 'work_dir': 'build'} 09:43:12 INFO - ##### 09:43:12 INFO - ##### Running clobber step. 09:43:12 INFO - ##### 09:43:12 INFO - Running pre-action listener: _resource_record_pre_action 09:43:12 INFO - Running main action method: clobber 09:43:12 INFO - rmtree: /builds/slave/test/build 09:43:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:43:13 INFO - Running post-action listener: _resource_record_post_action 09:43:13 INFO - ##### 09:43:13 INFO - ##### Running read-buildbot-config step. 09:43:13 INFO - ##### 09:43:13 INFO - Running pre-action listener: _resource_record_pre_action 09:43:13 INFO - Running main action method: read_buildbot_config 09:43:13 INFO - Using buildbot properties: 09:43:13 INFO - { 09:43:13 INFO - "project": "", 09:43:13 INFO - "product": "firefox", 09:43:13 INFO - "script_repo_revision": "production", 09:43:13 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 09:43:13 INFO - "repository": "", 09:43:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 09:43:13 INFO - "buildid": "20160519070342", 09:43:13 INFO - "pgo_build": "True", 09:43:13 INFO - "basedir": "/builds/slave/test", 09:43:13 INFO - "buildnumber": 239, 09:43:13 INFO - "slavename": "talos-linux64-ix-060", 09:43:13 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:43:13 INFO - "platform": "ubuntu64_hw", 09:43:13 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:43:13 INFO - "branch": "mozilla-aurora", 09:43:13 INFO - "repo_path": "releases/mozilla-aurora", 09:43:13 INFO - "revision": "9c96e9ec8e42fd75c62030c6840c6dc23478a07f", 09:43:13 INFO - "stage_platform": "linux64-pgo", 09:43:13 INFO - "builduid": "2981746851954708961c48de8654da04", 09:43:13 INFO - "slavebuilddir": "test" 09:43:13 INFO - } 09:43:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/U63WxBMPREyLoAJXBmjePA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 09:43:13 INFO - Running post-action listener: _resource_record_post_action 09:43:13 INFO - ##### 09:43:13 INFO - ##### Running download-and-extract step. 09:43:13 INFO - ##### 09:43:13 INFO - Running pre-action listener: _resource_record_pre_action 09:43:13 INFO - Running main action method: download_and_extract 09:43:13 INFO - mkdir: /builds/slave/test/build/tests 09:43:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:13 INFO - https://queue.taskcluster.net/v1/task/U63WxBMPREyLoAJXBmjePA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:43:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U63WxBMPREyLoAJXBmjePA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 09:43:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U63WxBMPREyLoAJXBmjePA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 09:43:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U63WxBMPREyLoAJXBmjePA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 09:43:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U63WxBMPREyLoAJXBmjePA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:43:17 INFO - Downloaded 1361 bytes. 09:43:17 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 09:43:17 INFO - Using the following test package requirements: 09:43:17 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 09:43:17 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 09:43:17 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:43:17 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 09:43:17 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:43:17 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 09:43:17 INFO - u'jsshell-linux-x86_64.zip'], 09:43:17 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 09:43:17 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:43:17 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 09:43:17 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 09:43:17 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:43:17 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 09:43:17 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:43:17 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 09:43:17 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:43:17 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 09:43:17 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:43:17 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:43:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:17 INFO - https://queue.taskcluster.net/v1/task/U63WxBMPREyLoAJXBmjePA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:43:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U63WxBMPREyLoAJXBmjePA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 09:43:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U63WxBMPREyLoAJXBmjePA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 09:43:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U63WxBMPREyLoAJXBmjePA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 09:43:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U63WxBMPREyLoAJXBmjePA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:43:20 INFO - Downloaded 23812152 bytes. 09:43:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:43:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:43:21 INFO - Return code: 0 09:43:21 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:43:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:21 INFO - https://queue.taskcluster.net/v1/task/U63WxBMPREyLoAJXBmjePA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:43:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U63WxBMPREyLoAJXBmjePA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 09:43:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U63WxBMPREyLoAJXBmjePA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 09:43:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U63WxBMPREyLoAJXBmjePA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 09:43:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U63WxBMPREyLoAJXBmjePA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:43:27 INFO - Downloaded 23812152 bytes. 09:43:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:43:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:43:28 INFO - Return code: 0 09:43:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:28 INFO - https://queue.taskcluster.net/v1/task/U63WxBMPREyLoAJXBmjePA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:43:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U63WxBMPREyLoAJXBmjePA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 09:43:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U63WxBMPREyLoAJXBmjePA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 09:43:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U63WxBMPREyLoAJXBmjePA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 09:43:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U63WxBMPREyLoAJXBmjePA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:43:29 INFO - Downloaded 10840145 bytes. 09:43:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:43:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:43:29 INFO - Return code: 0 09:43:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:29 INFO - https://queue.taskcluster.net/v1/task/U63WxBMPREyLoAJXBmjePA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:43:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U63WxBMPREyLoAJXBmjePA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 09:43:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U63WxBMPREyLoAJXBmjePA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 09:43:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U63WxBMPREyLoAJXBmjePA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 09:43:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U63WxBMPREyLoAJXBmjePA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:43:36 INFO - Downloaded 62746283 bytes. 09:43:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/U63WxBMPREyLoAJXBmjePA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 09:43:36 INFO - mkdir: /builds/slave/test/properties 09:43:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:43:36 INFO - Writing to file /builds/slave/test/properties/build_url 09:43:36 INFO - Contents: 09:43:36 INFO - build_url:https://queue.taskcluster.net/v1/task/U63WxBMPREyLoAJXBmjePA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 09:43:37 INFO - Running post-action listener: _resource_record_post_action 09:43:37 INFO - Running post-action listener: set_extra_try_arguments 09:43:37 INFO - ##### 09:43:37 INFO - ##### Running populate-webroot step. 09:43:37 INFO - ##### 09:43:37 INFO - Running pre-action listener: _resource_record_pre_action 09:43:37 INFO - Running main action method: populate_webroot 09:43:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:43:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:43:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:43:37 INFO - '--tppagecycles', 09:43:37 INFO - '7'], 09:43:37 INFO - 'tests': ['tsvgm']}}, 09:43:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:43:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:43:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:43:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:43:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:43:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:43:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:37 INFO - 'talos_options': ['--disable-e10s'], 09:43:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:43:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:43:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:37 INFO - 'talos_options': ['--disable-e10s'], 09:43:37 INFO - 'tests': ['damp', 'tps']}, 09:43:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:37 INFO - 'tests': ['damp', 'tps']}, 09:43:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:43:37 INFO - 'tests': ['dromaeo_dom']}, 09:43:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:43:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:43:37 INFO - 'tests': ['a11yr', 09:43:37 INFO - 'ts_paint', 09:43:37 INFO - 'tpaint', 09:43:37 INFO - 'sessionrestore', 09:43:37 INFO - 'sessionrestore_no_auto_restore', 09:43:37 INFO - 'tabpaint']}, 09:43:37 INFO - 'other-e10s': {'tests': ['a11yr', 09:43:37 INFO - 'ts_paint', 09:43:37 INFO - 'tpaint', 09:43:37 INFO - 'sessionrestore', 09:43:37 INFO - 'sessionrestore_no_auto_restore', 09:43:37 INFO - 'tabpaint']}, 09:43:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:43:37 INFO - 'ts_paint', 09:43:37 INFO - 'tpaint', 09:43:37 INFO - 'sessionrestore', 09:43:37 INFO - 'sessionrestore_no_auto_restore', 09:43:37 INFO - 'tabpaint']}, 09:43:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:43:37 INFO - 'ts_paint', 09:43:37 INFO - 'tpaint', 09:43:37 INFO - 'sessionrestore', 09:43:37 INFO - 'sessionrestore_no_auto_restore', 09:43:37 INFO - 'tabpaint']}, 09:43:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:43:37 INFO - 'tests': ['a11yr', 09:43:37 INFO - 'ts_paint', 09:43:37 INFO - 'tpaint', 09:43:37 INFO - 'sessionrestore', 09:43:37 INFO - 'sessionrestore_no_auto_restore', 09:43:37 INFO - 'tabpaint']}, 09:43:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:43:37 INFO - 'tests': ['a11yr', 09:43:37 INFO - 'ts_paint', 09:43:37 INFO - 'tpaint', 09:43:37 INFO - 'sessionrestore', 09:43:37 INFO - 'sessionrestore_no_auto_restore', 09:43:37 INFO - 'tabpaint']}, 09:43:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:43:37 INFO - 'tests': ['tsvgx', 09:43:37 INFO - 'tsvgr_opacity', 09:43:37 INFO - 'tart', 09:43:37 INFO - 'tscrollx', 09:43:37 INFO - 'cart']}, 09:43:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:43:37 INFO - 'tsvgr_opacity', 09:43:37 INFO - 'tart', 09:43:37 INFO - 'tscrollx', 09:43:37 INFO - 'cart']}, 09:43:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:37 INFO - 'talos_options': ['--disable-e10s'], 09:43:37 INFO - 'tests': ['tp5o']}, 09:43:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:37 INFO - 'tests': ['tp5o']}, 09:43:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:37 INFO - 'talos_options': ['--disable-e10s', 09:43:37 INFO - '--xperf_path', 09:43:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:43:37 INFO - 'tests': ['tp5n']}, 09:43:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:37 INFO - 'talos_options': ['--xperf_path', 09:43:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:43:37 INFO - 'tests': ['tp5n']}}, 09:43:37 INFO - 'talos.zip': {'path': '', 09:43:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:43:37 INFO - Running post-action listener: _resource_record_post_action 09:43:37 INFO - ##### 09:43:37 INFO - ##### Running create-virtualenv step. 09:43:37 INFO - ##### 09:43:37 INFO - Running pre-action listener: _resource_record_pre_action 09:43:37 INFO - Running main action method: create_virtualenv 09:43:37 INFO - Creating virtualenv /builds/slave/test/build/venv 09:43:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:43:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:43:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:43:37 INFO - Using real prefix '/usr' 09:43:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:43:38 INFO - Installing distribute.............................................................................................................................................................................................done. 09:43:40 INFO - Installing pip.................done. 09:43:40 INFO - Return code: 0 09:43:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:43:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:40 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 0x7f02aeed7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102a7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9640>, '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 0x10ba540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba9d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463676187.911723-36483592', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:43:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:43:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:43:40 INFO - Using env: {'DISPLAY': ':0', 09:43:40 INFO - 'HOME': '/home/cltbld', 09:43:40 INFO - 'LANG': 'en_US.UTF-8', 09:43:40 INFO - 'LANGUAGE': 'en_US:en', 09:43:40 INFO - 'LOGNAME': 'cltbld', 09:43:40 INFO - 'MAIL': '/var/mail/cltbld', 09:43:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:40 INFO - 'MOZ_NO_REMOTE': '1', 09:43:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:40 INFO - 'NO_EM_RESTART': '1', 09:43:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:40 INFO - 'PWD': '/builds/slave/test', 09:43:40 INFO - 'SHELL': '/bin/bash', 09:43:40 INFO - 'SHLVL': '1', 09:43:40 INFO - 'TERM': 'linux', 09:43:40 INFO - 'TMOUT': '86400', 09:43:40 INFO - 'USER': 'cltbld', 09:43:40 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463676187.911723-36483592', 09:43:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:40 INFO - '_': '/tools/buildbot/bin/python'} 09:43:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:43:40 INFO - Cleaning up... 09:43:40 INFO - Return code: 0 09:43:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:43:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:40 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 0x7f02aeed7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102a7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9640>, '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 0x10ba540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba9d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463676187.911723-36483592', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:43:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:43:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:43:40 INFO - Using env: {'DISPLAY': ':0', 09:43:40 INFO - 'HOME': '/home/cltbld', 09:43:40 INFO - 'LANG': 'en_US.UTF-8', 09:43:40 INFO - 'LANGUAGE': 'en_US:en', 09:43:40 INFO - 'LOGNAME': 'cltbld', 09:43:40 INFO - 'MAIL': '/var/mail/cltbld', 09:43:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:40 INFO - 'MOZ_NO_REMOTE': '1', 09:43:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:40 INFO - 'NO_EM_RESTART': '1', 09:43:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:40 INFO - 'PWD': '/builds/slave/test', 09:43:40 INFO - 'SHELL': '/bin/bash', 09:43:40 INFO - 'SHLVL': '1', 09:43:40 INFO - 'TERM': 'linux', 09:43:40 INFO - 'TMOUT': '86400', 09:43:40 INFO - 'USER': 'cltbld', 09:43:40 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463676187.911723-36483592', 09:43:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:40 INFO - '_': '/tools/buildbot/bin/python'} 09:43:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:40 INFO - Downloading/unpacking psutil>=0.7.1 09:43:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:43:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:43:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:43:42 INFO - Installing collected packages: psutil 09:43:42 INFO - Running setup.py install for psutil 09:43:42 INFO - building 'psutil._psutil_linux' extension 09:43:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:43:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:43:43 INFO - building 'psutil._psutil_posix' extension 09:43:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:43:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:43:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:43:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:43:43 INFO - Successfully installed psutil 09:43:43 INFO - Cleaning up... 09:43:43 INFO - Return code: 0 09:43:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:43:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:43 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 0x7f02aeed7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102a7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9640>, '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 0x10ba540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba9d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463676187.911723-36483592', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:43:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:43:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:43:43 INFO - Using env: {'DISPLAY': ':0', 09:43:43 INFO - 'HOME': '/home/cltbld', 09:43:43 INFO - 'LANG': 'en_US.UTF-8', 09:43:43 INFO - 'LANGUAGE': 'en_US:en', 09:43:43 INFO - 'LOGNAME': 'cltbld', 09:43:43 INFO - 'MAIL': '/var/mail/cltbld', 09:43:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:43 INFO - 'MOZ_NO_REMOTE': '1', 09:43:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:43 INFO - 'NO_EM_RESTART': '1', 09:43:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:43 INFO - 'PWD': '/builds/slave/test', 09:43:43 INFO - 'SHELL': '/bin/bash', 09:43:43 INFO - 'SHLVL': '1', 09:43:43 INFO - 'TERM': 'linux', 09:43:43 INFO - 'TMOUT': '86400', 09:43:43 INFO - 'USER': 'cltbld', 09:43:43 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463676187.911723-36483592', 09:43:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:43 INFO - '_': '/tools/buildbot/bin/python'} 09:43:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:43:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:43:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:43:45 INFO - Installing collected packages: mozsystemmonitor 09:43:45 INFO - Running setup.py install for mozsystemmonitor 09:43:45 INFO - Successfully installed mozsystemmonitor 09:43:45 INFO - Cleaning up... 09:43:45 INFO - Return code: 0 09:43:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:43:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f02aeed7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102a7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9640>, '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 0x10ba540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba9d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463676187.911723-36483592', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:43:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:43:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:43:45 INFO - Using env: {'DISPLAY': ':0', 09:43:45 INFO - 'HOME': '/home/cltbld', 09:43:45 INFO - 'LANG': 'en_US.UTF-8', 09:43:45 INFO - 'LANGUAGE': 'en_US:en', 09:43:45 INFO - 'LOGNAME': 'cltbld', 09:43:45 INFO - 'MAIL': '/var/mail/cltbld', 09:43:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:45 INFO - 'MOZ_NO_REMOTE': '1', 09:43:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:45 INFO - 'NO_EM_RESTART': '1', 09:43:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:45 INFO - 'PWD': '/builds/slave/test', 09:43:45 INFO - 'SHELL': '/bin/bash', 09:43:45 INFO - 'SHLVL': '1', 09:43:45 INFO - 'TERM': 'linux', 09:43:45 INFO - 'TMOUT': '86400', 09:43:45 INFO - 'USER': 'cltbld', 09:43:45 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463676187.911723-36483592', 09:43:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:45 INFO - '_': '/tools/buildbot/bin/python'} 09:43:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:45 INFO - Downloading/unpacking blobuploader==1.2.4 09:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:47 INFO - Downloading blobuploader-1.2.4.tar.gz 09:43:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:43:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:43:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:43:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:43:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:48 INFO - Downloading docopt-0.6.1.tar.gz 09:43:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:43:48 INFO - Installing collected packages: blobuploader, requests, docopt 09:43:48 INFO - Running setup.py install for blobuploader 09:43:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:43:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:43:48 INFO - Running setup.py install for requests 09:43:48 INFO - Running setup.py install for docopt 09:43:49 INFO - Successfully installed blobuploader requests docopt 09:43:49 INFO - Cleaning up... 09:43:49 INFO - Return code: 0 09:43:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:43:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:49 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 0x7f02aeed7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102a7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9640>, '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 0x10ba540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba9d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463676187.911723-36483592', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:43:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:43:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:43:49 INFO - Using env: {'DISPLAY': ':0', 09:43:49 INFO - 'HOME': '/home/cltbld', 09:43:49 INFO - 'LANG': 'en_US.UTF-8', 09:43:49 INFO - 'LANGUAGE': 'en_US:en', 09:43:49 INFO - 'LOGNAME': 'cltbld', 09:43:49 INFO - 'MAIL': '/var/mail/cltbld', 09:43:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:49 INFO - 'MOZ_NO_REMOTE': '1', 09:43:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:49 INFO - 'NO_EM_RESTART': '1', 09:43:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:49 INFO - 'PWD': '/builds/slave/test', 09:43:49 INFO - 'SHELL': '/bin/bash', 09:43:49 INFO - 'SHLVL': '1', 09:43:49 INFO - 'TERM': 'linux', 09:43:49 INFO - 'TMOUT': '86400', 09:43:49 INFO - 'USER': 'cltbld', 09:43:49 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463676187.911723-36483592', 09:43:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:49 INFO - '_': '/tools/buildbot/bin/python'} 09:43:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:43:49 INFO - Running setup.py (path:/tmp/pip-rx78vS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:43:49 INFO - Running setup.py (path:/tmp/pip-E1yF8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:43:49 INFO - Running setup.py (path:/tmp/pip-m4vn1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:43:49 INFO - Running setup.py (path:/tmp/pip-xxhdXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:43:49 INFO - Running setup.py (path:/tmp/pip-nQ5ReM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:43:49 INFO - Running setup.py (path:/tmp/pip-6a4EVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:43:49 INFO - Running setup.py (path:/tmp/pip-H1rJJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:43:49 INFO - Running setup.py (path:/tmp/pip-TG9Cai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:43:49 INFO - Running setup.py (path:/tmp/pip-JejlLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:43:49 INFO - Running setup.py (path:/tmp/pip-Q7wdyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:43:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:43:50 INFO - Running setup.py (path:/tmp/pip-JEK2xZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:43:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:43:50 INFO - Running setup.py (path:/tmp/pip-ouTsCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:43:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:43:50 INFO - Running setup.py (path:/tmp/pip-uVWkl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:43:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:43:50 INFO - Running setup.py (path:/tmp/pip-7PoGOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:43:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:43:50 INFO - Running setup.py (path:/tmp/pip-E7iay7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:43:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:43:50 INFO - Running setup.py (path:/tmp/pip-HUBxSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:43:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:43:50 INFO - Running setup.py (path:/tmp/pip-ec88VN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:43:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:43:50 INFO - Running setup.py install for manifestparser 09:43:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:43:50 INFO - Running setup.py install for mozcrash 09:43:50 INFO - Running setup.py install for mozdebug 09:43:50 INFO - Running setup.py install for mozdevice 09:43:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:43:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:43:50 INFO - Running setup.py install for mozfile 09:43:51 INFO - Running setup.py install for mozhttpd 09:43:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:43:51 INFO - Running setup.py install for mozinfo 09:43:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:43:51 INFO - Running setup.py install for mozInstall 09:43:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:43:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:43:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:43:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:43:51 INFO - Running setup.py install for mozleak 09:43:51 INFO - Running setup.py install for mozlog 09:43:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:43:51 INFO - Running setup.py install for moznetwork 09:43:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:43:51 INFO - Running setup.py install for mozprocess 09:43:51 INFO - Running setup.py install for mozprofile 09:43:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:43:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:43:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:43:51 INFO - Running setup.py install for mozrunner 09:43:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:43:52 INFO - Running setup.py install for mozscreenshot 09:43:52 INFO - Running setup.py install for moztest 09:43:52 INFO - Running setup.py install for mozversion 09:43:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:43:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:43:52 INFO - Cleaning up... 09:43:52 INFO - Return code: 0 09:43:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:43: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')]} 09:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43: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')]} 09:43:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:52 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 0x7f02aeed7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102a7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9640>, '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 0x10ba540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba9d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463676187.911723-36483592', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:43:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:43:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:43:52 INFO - Using env: {'DISPLAY': ':0', 09:43:52 INFO - 'HOME': '/home/cltbld', 09:43:52 INFO - 'LANG': 'en_US.UTF-8', 09:43:52 INFO - 'LANGUAGE': 'en_US:en', 09:43:52 INFO - 'LOGNAME': 'cltbld', 09:43:52 INFO - 'MAIL': '/var/mail/cltbld', 09:43:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:52 INFO - 'MOZ_NO_REMOTE': '1', 09:43:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:52 INFO - 'NO_EM_RESTART': '1', 09:43:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:52 INFO - 'PWD': '/builds/slave/test', 09:43:52 INFO - 'SHELL': '/bin/bash', 09:43:52 INFO - 'SHLVL': '1', 09:43:52 INFO - 'TERM': 'linux', 09:43:52 INFO - 'TMOUT': '86400', 09:43:52 INFO - 'USER': 'cltbld', 09:43:52 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463676187.911723-36483592', 09:43:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:52 INFO - '_': '/tools/buildbot/bin/python'} 09:43:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:43:52 INFO - Running setup.py (path:/tmp/pip-CQkf3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:43:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:43:52 INFO - Running setup.py (path:/tmp/pip-4idlqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:43:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:43:52 INFO - Running setup.py (path:/tmp/pip-WDI2Kt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:43:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:43:52 INFO - Running setup.py (path:/tmp/pip-1H1xm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:43:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:43:52 INFO - Running setup.py (path:/tmp/pip-xog2An-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:43:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:43:52 INFO - Running setup.py (path:/tmp/pip-CnL66E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:43:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:43:52 INFO - Running setup.py (path:/tmp/pip-DuMitD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:43:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:43:53 INFO - Running setup.py (path:/tmp/pip-TobaDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:43:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:43:53 INFO - Running setup.py (path:/tmp/pip-D8KW9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:43:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:43:53 INFO - Running setup.py (path:/tmp/pip-201swL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:43:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:43:53 INFO - Running setup.py (path:/tmp/pip-9IM0Bz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:43:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:43:53 INFO - Running setup.py (path:/tmp/pip-iw9cm_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:43:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:43:53 INFO - Running setup.py (path:/tmp/pip-jKImMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:43:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:43:53 INFO - Running setup.py (path:/tmp/pip-krafMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:43:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:43:53 INFO - Running setup.py (path:/tmp/pip-9X2WfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:43:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:43:53 INFO - Running setup.py (path:/tmp/pip-cAPfqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:43:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:43:53 INFO - Running setup.py (path:/tmp/pip-YEK2JL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:43:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:43:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:43:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:43:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:43:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:43:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:43:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:43:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:55 INFO - Downloading blessings-1.6.tar.gz 09:43:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:43:55 INFO - Installing collected packages: blessings 09:43:55 INFO - Running setup.py install for blessings 09:43:55 INFO - Successfully installed blessings 09:43:55 INFO - Cleaning up... 09:43:55 INFO - Return code: 0 09:43:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:43:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:43:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:43:56 INFO - Reading from file tmpfile_stdout 09:43:56 INFO - Current package versions: 09:43:56 INFO - argparse == 1.2.1 09:43:56 INFO - blessings == 1.6 09:43:56 INFO - blobuploader == 1.2.4 09:43:56 INFO - docopt == 0.6.1 09:43:56 INFO - manifestparser == 1.1 09:43:56 INFO - mozInstall == 1.12 09:43:56 INFO - mozcrash == 0.17 09:43:56 INFO - mozdebug == 0.1 09:43:56 INFO - mozdevice == 0.48 09:43:56 INFO - mozfile == 1.2 09:43:56 INFO - mozhttpd == 0.7 09:43:56 INFO - mozinfo == 0.9 09:43:56 INFO - mozleak == 0.1 09:43:56 INFO - mozlog == 3.1 09:43:56 INFO - moznetwork == 0.27 09:43:56 INFO - mozprocess == 0.22 09:43:56 INFO - mozprofile == 0.28 09:43:56 INFO - mozrunner == 6.11 09:43:56 INFO - mozscreenshot == 0.1 09:43:56 INFO - mozsystemmonitor == 0.0 09:43:56 INFO - moztest == 0.7 09:43:56 INFO - mozversion == 1.4 09:43:56 INFO - psutil == 3.1.1 09:43:56 INFO - requests == 1.2.3 09:43:56 INFO - wsgiref == 0.1.2 09:43:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:43:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:56 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 0x7f02aeed7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102a7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9640>, '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 0x10ba540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba9d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463676187.911723-36483592', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:43:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:43:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:43:56 INFO - Using env: {'DISPLAY': ':0', 09:43:56 INFO - 'HOME': '/home/cltbld', 09:43:56 INFO - 'LANG': 'en_US.UTF-8', 09:43:56 INFO - 'LANGUAGE': 'en_US:en', 09:43:56 INFO - 'LOGNAME': 'cltbld', 09:43:56 INFO - 'MAIL': '/var/mail/cltbld', 09:43:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:56 INFO - 'MOZ_NO_REMOTE': '1', 09:43:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:56 INFO - 'NO_EM_RESTART': '1', 09:43:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:56 INFO - 'PWD': '/builds/slave/test', 09:43:56 INFO - 'SHELL': '/bin/bash', 09:43:56 INFO - 'SHLVL': '1', 09:43:56 INFO - 'TERM': 'linux', 09:43:56 INFO - 'TMOUT': '86400', 09:43:56 INFO - 'USER': 'cltbld', 09:43:56 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463676187.911723-36483592', 09:43:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:56 INFO - '_': '/tools/buildbot/bin/python'} 09:43:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:43:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:43:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:43:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:43:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:43:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:43:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:43:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:43:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:43:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:43:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:43:56 INFO - Cleaning up... 09:43:56 INFO - Return code: 0 09:43:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:43:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:56 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 0x7f02aeed7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102a7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9640>, '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 0x10ba540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba9d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463676187.911723-36483592', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:43:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:43:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:43:56 INFO - Using env: {'DISPLAY': ':0', 09:43:56 INFO - 'HOME': '/home/cltbld', 09:43:56 INFO - 'LANG': 'en_US.UTF-8', 09:43:56 INFO - 'LANGUAGE': 'en_US:en', 09:43:56 INFO - 'LOGNAME': 'cltbld', 09:43:56 INFO - 'MAIL': '/var/mail/cltbld', 09:43:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:56 INFO - 'MOZ_NO_REMOTE': '1', 09:43:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:56 INFO - 'NO_EM_RESTART': '1', 09:43:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:56 INFO - 'PWD': '/builds/slave/test', 09:43:56 INFO - 'SHELL': '/bin/bash', 09:43:56 INFO - 'SHLVL': '1', 09:43:56 INFO - 'TERM': 'linux', 09:43:56 INFO - 'TMOUT': '86400', 09:43:56 INFO - 'USER': 'cltbld', 09:43:56 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463676187.911723-36483592', 09:43:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:56 INFO - '_': '/tools/buildbot/bin/python'} 09:43:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:56 INFO - Downloading/unpacking jsonschema 09:43: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 09:43: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 09:43: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 09:43: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 09:43: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 09:43: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 09:43:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:43:58 INFO - Downloading/unpacking functools32 (from jsonschema) 09:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:58 INFO - Downloading functools32-3.2.3-2.tar.gz 09:43:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:43:58 INFO - warning: no files found matching '*.txt' 09:43:58 INFO - no previously-included directories found matching 'build' 09:43:58 INFO - no previously-included directories found matching 'dist' 09:43:58 INFO - no previously-included directories found matching '.git*' 09:43:58 INFO - Installing collected packages: jsonschema, functools32 09:43:58 INFO - Running setup.py install for functools32 09:43:58 INFO - warning: no files found matching '*.txt' 09:43:58 INFO - no previously-included directories found matching 'build' 09:43:58 INFO - no previously-included directories found matching 'dist' 09:43:58 INFO - no previously-included directories found matching '.git*' 09:43:58 INFO - Successfully installed jsonschema functools32 09:43:58 INFO - Cleaning up... 09:43:59 INFO - Return code: 0 09:43:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:43:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:59 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 0x7f02aeed7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102a7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9640>, '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 0x10ba540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba9d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463676187.911723-36483592', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:43:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:43:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:43:59 INFO - Using env: {'DISPLAY': ':0', 09:43:59 INFO - 'HOME': '/home/cltbld', 09:43:59 INFO - 'LANG': 'en_US.UTF-8', 09:43:59 INFO - 'LANGUAGE': 'en_US:en', 09:43:59 INFO - 'LOGNAME': 'cltbld', 09:43:59 INFO - 'MAIL': '/var/mail/cltbld', 09:43:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:59 INFO - 'MOZ_NO_REMOTE': '1', 09:43:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:59 INFO - 'NO_EM_RESTART': '1', 09:43:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:59 INFO - 'PWD': '/builds/slave/test', 09:43:59 INFO - 'SHELL': '/bin/bash', 09:43:59 INFO - 'SHLVL': '1', 09:43:59 INFO - 'TERM': 'linux', 09:43:59 INFO - 'TMOUT': '86400', 09:43:59 INFO - 'USER': 'cltbld', 09:43:59 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463676187.911723-36483592', 09:43:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:59 INFO - '_': '/tools/buildbot/bin/python'} 09:43:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:59 INFO - Downloading/unpacking flake8 09:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:44:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:44:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:44:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:44:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:44:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:44:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:44:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:44:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:44:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:44:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:44:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:44:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:44:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:44:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:44:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:44:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:44:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:44: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 09:44: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 09:44: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 09:44: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 09:44: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 09:44: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 09:44:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:44:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:44:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:44:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:44:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:44:02 INFO - no previously-included directories found matching 'docs/_build' 09:44:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:44:02 INFO - Running setup.py install for pep8 09:44:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:44:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:44:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:44:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:44:02 INFO - no previously-included directories found matching 'docs/_build' 09:44:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:44:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:44:02 INFO - Cleaning up... 09:44:02 INFO - Return code: 0 09:44:02 INFO - Running post-action listener: _resource_record_post_action 09:44:02 INFO - Running post-action listener: _start_resource_monitoring 09:44:02 INFO - Starting resource monitoring. 09:44:02 INFO - ##### 09:44:02 INFO - ##### Running install step. 09:44:02 INFO - ##### 09:44:02 INFO - Running pre-action listener: _resource_record_pre_action 09:44:02 INFO - Running main action method: install 09:44:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:44:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:44:02 INFO - Reading from file tmpfile_stdout 09:44:02 INFO - Detecting whether we're running mozinstall >=1.0... 09:44:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:44:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:44:02 INFO - Reading from file tmpfile_stdout 09:44:02 INFO - Output received: 09:44:02 INFO - Usage: mozinstall [options] installer 09:44:02 INFO - Options: 09:44:02 INFO - -h, --help show this help message and exit 09:44:02 INFO - -d DEST, --destination=DEST 09:44:02 INFO - Directory to install application into. [default: 09:44:02 INFO - "/builds/slave/test"] 09:44:02 INFO - --app=APP Application being installed. [default: firefox] 09:44:02 INFO - mkdir: /builds/slave/test/build/application 09:44:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:44:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:44:18 INFO - Reading from file tmpfile_stdout 09:44:18 INFO - Output received: 09:44:18 INFO - /builds/slave/test/build/application/firefox/firefox 09:44:18 INFO - Running post-action listener: _resource_record_post_action 09:44:18 INFO - ##### 09:44:18 INFO - ##### Running run-tests step. 09:44:18 INFO - ##### 09:44:18 INFO - Running pre-action listener: _resource_record_pre_action 09:44:18 INFO - Running main action method: run_tests 09:44:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:44:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:44:18 INFO - Python 2.7.3 09:44:18 INFO - Return code: 0 09:44:18 INFO - grabbing minidump binary from tooltool 09:44:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:18 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 0x10b9640>, '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 0x10ba540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba9d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:44:18 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:44:18 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:44:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:44:18 INFO - Return code: 0 09:44:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:44:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:44:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:44:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:44:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:44:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:44:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:44:19 INFO - Return code: 0 09:44:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U63WxBMPREyLoAJXBmjePA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:44:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/U63WxBMPREyLoAJXBmjePA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:44:19 INFO - Using env: {'DISPLAY': ':0', 09:44:19 INFO - 'HOME': '/home/cltbld', 09:44:19 INFO - 'LANG': 'en_US.UTF-8', 09:44:19 INFO - 'LANGUAGE': 'en_US:en', 09:44:19 INFO - 'LOGNAME': 'cltbld', 09:44:19 INFO - 'MAIL': '/var/mail/cltbld', 09:44:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:44:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:44:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:19 INFO - 'MOZ_NO_REMOTE': '1', 09:44:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:44:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:44:19 INFO - 'NO_EM_RESTART': '1', 09:44:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:44:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:19 INFO - 'PWD': '/builds/slave/test', 09:44:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:44:19 INFO - 'SHELL': '/bin/bash', 09:44:19 INFO - 'SHLVL': '1', 09:44:19 INFO - 'TERM': 'linux', 09:44:19 INFO - 'TMOUT': '86400', 09:44:19 INFO - 'USER': 'cltbld', 09:44:19 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463676187.911723-36483592', 09:44:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:19 INFO - '_': '/tools/buildbot/bin/python'} 09:44:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U63WxBMPREyLoAJXBmjePA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:44:19 INFO - mozversion application_buildid: 20160519070342 09:44:19 INFO - mozversion application_changeset: 9c96e9ec8e42fd75c62030c6840c6dc23478a07f 09:44:19 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:44:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:44:19 INFO - mozversion application_name: Firefox 09:44:19 INFO - mozversion application_remotingname: firefox-dev 09:44:19 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:44:19 INFO - mozversion application_vendor: Mozilla 09:44:19 INFO - mozversion application_version: 48.0a2 09:44:19 INFO - mozversion platform_buildid: 20160519070342 09:44:19 INFO - mozversion platform_changeset: 9c96e9ec8e42fd75c62030c6840c6dc23478a07f 09:44:19 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:44:19 INFO - mozversion platform_version: 48.0a2 09:44:19 INFO - using testdate: 1463676259 09:44:19 INFO - actual date: 1463676259 09:44:19 INFO - starting webserver on 'localhost:35524' 09:44:19 INFO - SUITE-START | Running 2 tests 09:44:19 INFO - TEST-START | dromaeo_css 09:44:19 INFO - operating with platform_type : linux_ 09:44:19 INFO - Initialising browser for dromaeo_css test... 09:44:19 INFO - TEST-INFO | started process 19036 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp43Md1x/profile http://localhost:35524/getInfo.html) 09:44:23 INFO - PROCESS | 19036 | __metrics Screen width/height:1600/1200 09:44:23 INFO - PROCESS | 19036 | colorDepth:24 09:44:23 INFO - PROCESS | 19036 | Browser inner width/height: 1024/697 09:44:23 INFO - PROCESS | 19036 | __metrics 09:44:24 ERROR - PROCESS | 19036 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:44:25 INFO - TEST-INFO | 19036: exit 0 09:44:25 INFO - Browser initialized. 09:44:25 INFO - Running cycle 1/1 for dromaeo_css test... 09:44:25 INFO - TEST-INFO | started process 19125 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp43Md1x/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:44:37 INFO - PROCESS | 19125 | RSS: Main: 142151680 09:44:37 INFO - PROCESS | 19125 | 09:45:28 INFO - PROCESS | 19125 | 1463676328778 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:47:35 INFO - PROCESS | 19125 | Cycle 1(1): loaded http://localhost:35524/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35524/tests/dromaeo/cssquery-ext.html) 09:47:36 INFO - PROCESS | 19125 | RSS: Main: 256512000 09:47:36 INFO - PROCESS | 19125 | 09:50:38 INFO - PROCESS | 19125 | Cycle 1(1): loaded http://localhost:35524/tests/dromaeo/cssquery-ext.html (next: http://localhost:35524/tests/dromaeo/cssquery-jquery.html) 09:50:39 INFO - PROCESS | 19125 | RSS: Main: 224600064 09:50:39 INFO - PROCESS | 19125 | 09:53:41 INFO - PROCESS | 19125 | Cycle 1(1): loaded http://localhost:35524/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35524/tests/dromaeo/cssquery-mootools.html) 09:53:41 INFO - PROCESS | 19125 | RSS: Main: 222650368 09:53:41 INFO - PROCESS | 19125 | 09:56:43 INFO - PROCESS | 19125 | Cycle 1(1): loaded http://localhost:35524/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35524/tests/dromaeo/cssquery-prototype.html) 09:56:44 INFO - PROCESS | 19125 | RSS: Main: 219103232 09:56:44 INFO - PROCESS | 19125 | 09:59:46 INFO - PROCESS | 19125 | Cycle 1(1): loaded http://localhost:35524/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35524/tests/dromaeo/cssquery-yui.html) 09:59:47 INFO - PROCESS | 19125 | RSS: Main: 183504896 09:59:47 INFO - PROCESS | 19125 | 10:02:49 INFO - PROCESS | 19125 | Cycle 1(1): loaded http://localhost:35524/tests/dromaeo/cssquery-yui.html (next: http://localhost:35524/tests/dromaeo/cssquery-dojo.html) 10:02:49 INFO - PROCESS | 19125 | RSS: Main: 253898752 10:02:49 INFO - PROCESS | 19125 | 10:02:49 INFO - PROCESS | 19125 | __start_tp_report 10:02:49 INFO - PROCESS | 19125 | _x_x_mozilla_page_load 10:02:49 INFO - PROCESS | 19125 | _x_x_mozilla_page_load_details 10:02:49 INFO - PROCESS | 19125 | |i|pagename|runs| 10:02:49 INFO - PROCESS | 19125 | |0;dojo.html;3273.5580696605957;3347.3305338932205;3348.3972884880727;3369.8315084245783;3391.5082313064604;5465.371482279539;5475.6167068305185;5489.835304940858;5499.065158922983;5502.009638265111;5478.397376288605;5495.313085864267;5505.532029777473;5515.61390702651;5546.112621980484;4889.462159162507;5027.346444962159;5038.874028149307;5096.311997880294;5112.667676601028;4937.086638971784;4952.306677065196;4974.751262436864;5021.799128034874;5036.471170527097;5060.139776238048;5096.2865198872005;5103.132467480537;5104.923426148593;5144.3312369392115;5039.647224694273;5045.268436076748;5088.389393272831;5091.79632814687;5102.591792656579;4884.365032545782;4923.261510773377;4994.500549945013;5019.598432125457;5025.195968644999;5394.514493695547;5397.54120899724;5430;5442.619016668835;5482.506574408282;5789.8263052108505;5867.530597552228;5868.149118377812;5882.088276317178;5890.440408161261;5904.350521442638;5918.644881307092;5930.080837470199;5936.347001829795;5955.702214889281;5525.171224316345;5528.115501519737;5531.668099914018;5533.474319939599;5546.91679624806;5898.587098903035;6001.5798894077;6019.729112189874;6037.15479832815;6097.359777223416;5905.350411454737;5920.585559010828;5926.4666180044005;5926.992411290091;5927.022041363127;5974.9402505974385;6002.579819412599;6003.099535069687;6004.309504406961;6006.969965150146;5774.04728219839;5845.3277873045145;5956.970215148896;5968.552358573038;5969.164316995624;5861.677607731531;5876.471117599351;5876.706164691834;5885.411458854081;5886.558508111909;4447.577480139446;4487.5288094749585;4495.797689103998;4500.932486012713;4524.343970124313;3979.2041591681777;3994.1013272013565;4034.253663072341;4053.61490658387;4074.4499492568716;5597.076482380443;5613.382527921925;5616.550675945915;5626;5635.0702134147405;5796.42035796417;5931.347551769302;5944.494717948936;5955.7617695292565;5955.910661340084;5558.249636299129;5561.499465048084;5591.41290164535;5606.803761868315;5627.606067575231;4997.475265097112;5001.174806157016;5038.293626044655;5044.218146187347;5071.594272458195;5962.22491076166;6044.546659000504;6055;6091.390860913873;6110.419510146529;5874.118882167709;5889.352171261158;5890.705464726832;5890.793822216202;5908.084246941731;6049.727762250797;6055.182550355822;6056.121862330026;6060.878782424415;6060.939390606038;5501.4223506532835;5648.63283886546;5696.003199439999;5756.136579513107;5757.481826635623;5963.9105413417965;5967.850803729942;5973.342932277533;5979.162917191509;5980.940190598212;5789.594728368974;5803.593748437569;5825.0388685866355;5837.211976383303;5838.912416313674;5545.694986775766;5699.800506982236;5779.97110014464;5780.653160810365;5807.651540907559;5668.461496157858;5686.545076393796;5701.201831743476;5713.800016999385;5719.7426115824055;5811;5829.47534721877;5834.649921004753;5837.883242335214;5845.240118784531;5527.088030474926;5577.776888924398;5611.438856114356;5733.541316694738;5740.712964351849 10:02:49 INFO - PROCESS | 19125 | |1;ext.html;662.2979641579925;663.6217356107018;664.262668438034;672.287375382095;754.3927138653384;32601.347973040556;39193;39623.207535849266;39630.80184599077;39693.40459893104;43613.7819310903;44094.11811763763;44144.779276103574;44160;44246.557534424646;7988.9600551997155;8710.08544102868;8881.77795555113;8883.600237989305;10392;10479.371237725723;10593.735156621107;10603.893961060368;10617.256792024562;10629.574817007311;10413.739656508573;10442.634507792229;10489.213309001818;10492.737681557946;10497.527611257512;8260.793480162984;10412.375257484575;10727.946360268226;11001.834972475419;11018.11855051602;10357.689269321932;10447.84328235077;10470;10477.895221047767;10478.10936070435;39567.40648890269;40041.59958400437;40106.39840402397;40153.39769903454;40182.59817401847;3766.886993390203;3848.172642881766;3949.071968087497;4078.612531809503;4181.749095054306;33613.15967100818;34452.82773586116;35428.29143417143;36561;36760.26479470422;4125.91748165038;4339;4339.631131353807;4395.208862404766;4416.779161041967;301574;306345;306667;306851;306965;39097.6090239094;62332;63071.36928630747;63080.68459657672;63146.68426657837;37364.43953340702;37515.437268441;37522.62477375246;37538.249235015144;37583.248335033146;17124.48626541206;17310.653786924442;17336.04651744166;17342.30630774755;17343.3062677494;12286.877131228752;13458.865411345761;13726;13750.449982000608;13757.10578812394;8995.145461181308;9061.365704400629;9078.228350590274;9098.681546145985;9133.086691330815;3447;3488.424409972377;3541.6281290464644;3548.75289110461;3609.4585812127866;1078.5092782783815;1086.6468397770757;1099.7470581766079;1113.5323164271026;1297.6042307096427;33447;33591.66408335934;34064.65935340664;34244.31511369759;34311;1193.531002635257;1202.2108707797825;1214.5748987854356;1220.3166226912779;1301.7526669932683;16346.673066538602;16414.227914711893;16587.585310367096;16627.66744665124;17224.913875430793;541568;546176;546629;550027;552079;58018.419815802146;58426.41573584295;58589.41410585925;58670;58700;1383.0871624727833;1401.3553765267886;1482.7701706235334;1518.7190369781626;1601.4635097242553;29965.815263905242;31847.363052739278;31934;32356.514652280704;32813.83593082019;51190.48809511857;52147;52339.47660523498;52345.7382713084;52464.7376763129;410289;412053;412710;413217;414081;26484.735152648227;29269.121926342243;29384;30195.396092077597;30217.848910755307;42675;42782;43163.56836431596;43959;44114.55885441104;35574.466383004794;37851.810740946115;38617.2276554473;39407.40888886611;39453.40819887647;38280.234395312495;38745.2250954985;39153.608463915;39356;39577.2084558313;41043.79478102591;41121.794391027855;44883.55116448794;45866.312005319276;46063.539364605924;32858.835705821315;34314.82842585871;34875.4768678465;36192;37893.62106378901;28065.158045258675;28229.858850705616;28442.715572844834;28544.286392840346;28633.570496442153 10:02:49 INFO - PROCESS | 19125 | |2;jquery.html;418.9727667701599;422.1135615208062;427.19473791902277;433.21155496995465;438.9648828093753;14116.647083822883;18553.814461855378;19149.808501914977;19221.711674324895;19293.614127717454;15527.611809704764;17636.470905872844;18408.263669453205;18780.436586902382;19713;5552.722873739032;5748.971255143719;5751.712414379285;5776.335721392031;5777.884442311151;5660.037793575081;5738.139279108125;5745.138229265602;5745.2818397700285;5748.626339287954;4138.8137533810905;6132.63204207749;6297.08692239625;6369.554131210817;6398.552101352907;6205.689715514229;6256.624602523863;6269.059641053833;6303.810885673437;6315.463185629227;5514.80698175562;5558.082916318803;5608.859778505529;5633.63381380209;5648.096304591287;21631.78368216329;21654.35036948894;22982.66586969509;23526.882365588233;23640.054397824068;2576.0726138590094;2592.235290589281;2602.4534847682007;2641.088824355594;2716.307341627892;14033.64915877101;14580.708385832224;14639.707205855822;14812.407503699838;15100.395984160621;2058.6706127019756;2088.1751708075376;2121.16214095433;2121.543868068373;2192.3861318830754;71452.28547714508;72887.63556182185;76813;82028.58985705093;83495.16504834934;11118.388488633203;11147.721306967229;11149;11292.209545331747;11400.258983166068;15476.303566339542;15691.686166276611;15782.763258551131;15891;15941.362345506283;8599.183077607742;8611.741647750578;8649.610767515476;8738.213560779433;8864.20222180007;8114.188581141839;8246.216609422096;8256.091829898707;8264.83470330602;8497.192766687154;4411.426514553087;4602.148602508547;4888.169011268093;4896.730679812645;4925.261210818406;1929.6526625207316;2007.2773801431474;2032.1287946462014;2046.2633451957283;2053.271088763497;456.52065331401894;480.668338846195;980.612658000086;1027.8509616105773;1116.7664670658683;11810.114241431927;11883.287002779862;12044.638660840188;12101.636950891312;12108.697282568006;461.89145550795536;477.08637958309447;479.07777528257964;489.904468628614;493.0991029580914;5735.426457354231;6523.282438931714;6564.474842012628;6568.507361947873;6595.901061484082;547933;556400;563152;565827;565902;96812.51593741986;97464;99590.50204749075;99641;100386.4980675092;474.82194177183555;482.519892706752;485.54843995084207;486.5864015586723;487.0210876138986;10933.945330273298;11061.557537698724;11226.831597525881;11237.438128093727;11467.942660286979;38677.22645547017;38788.80605596954;38841.6115838838;40689.796551017054;40709.79645101756;55351.60715444448;60934.39065609464;61051.38948610457;61112.694436527534;61503;8994.640214391351;9016.774580635536;9063.41087829289;9106.27149827999;9264.768380790534;10215;13409.530666426628;13846.93076534611;13892.72214555683;13942.442302307794;11747.177697561088;11785.233959792586;11789.587364442203;11859.881401186223;11992.280463172237;11628.709282268012;12006.699832504257;12051.879481205076;12113.75772484563;12192.268463892195;11942.462589183333;11964.880351196376;12307.75384492323;12652.43064062101;12667.93666031664;8837.072107428627;8910.242629376575;9029.683961061332;9035.548222588714;9133.178013978773;11479.598214062467;12201.450934707782;12227.44976476043;12384.256944582994;12531.436085375997 10:02:49 INFO - PROCESS | 19125 | |3;mootools.html;1408.7886816977446;1554.401555401171;1554.6424322405846;1740.9825901740987;1858.2938483376315;8169.183081691828;8412.032616249126;8415.663373465062;8416;8440.366972477073;8139.877901831477;8263.380246481523;8272.75181744547;8310.085890552034;8318.958405207966;2020.3029954665617;2057.567910738747;2345.22607539512;2369.07606033647;2377.8454400464;2430.9392265193424;2434.099383228208;2437.6343548467785;2437.9390515237083;2447.21689059501;2380.0241900820665;2385.272491889973;2387.3554140382084;2435.6346548017764;2442.682451281331;2080.864743791649;2268.262814585258;2281.2471884278148;2334.684817549643;2391.712994440661;2334.2297041976108;2363.1847012780563;2364.3379853640836;2364.9881750591308;2367.7040369953756;8179.550124743197;8248.917510824875;8252.958735206346;8256.587170641444;8261.586920654003;5140.897182056338;5242.082635538765;5242.79028838846;5249.501297376782;5253.789848406059;3207.839608019613;3339.2987472630775;3340.749443791701;3357.4963755436634;3430.9313813723584;1067.4289255248405;1073.9570417183304;1091.5033659684825;1092.9672109836638;1096.7751610919743;11961.222520536137;12031.699207519794;12040;12046.096542759327;12066.155369124164;4441.378207051015;4622.607078398307;4638.930416043762;4685.367475390779;4713.81144754206;10092.04125608066;10136.594536218468;10167.186625069977;10168.796624067478;10169.54237059334;5260;5302.390225124083;5303.204519322056;5307.2569840222395;5315.787368505294;4276.273033584236;4754.952450475451;4815;4884.194107972145;4887.462379138292;3971.4042893566198;4010.7593544386846;4056.0873803394;4079.3676980068135;4083.652889504366;1351.9459221631025;1364.7270545890863;1374.17549470317;1375.6217040313993;1377.9173249605055;1012.8379459286626;1019.1133713669008;1022.0903395977585;1023.5649848814224;1053.536443964653;5866.413358664099;5899.646021238739;5903.616264942851;5948.405159484017;5979.431953964367;1001.8547310639916;1030.469308306223;1036.9792604147874;1040.3782468180143;1040.8802987656366;4125.91748165035;4178.435911152016;4186.811593478301;4195.433616461739;4204.159168166379;10442.321249118782;10554.050135487843;10660.20048496366;10828.187885908588;10856.185786065918;10544.103751181083;10545.420001899969;10557.155427565776;10557.313774604627;10562.31344962575;8031.518108913484;8134.959325203336;8142.674293028331;8224.8355032899;8240.21717936795;5743.167240749985;5784.681842498703;5828.053038366289;5846.239988801429;5998.280206375263;9371.34400591952;9416.858747118662;9577.377470464398;9684.32209745311;9716.076972687584;9456.621735130519;9698.515074246401;9720.07659272368;9775.75560610962;9904.603815847286;6719.059331693665;6930.549514281555;6934.583924964519;7664.195259497673;7698.692052317844;8061.234182752629;8144.959275203586;8248.298894594027;8294.543800091053;8299.6680132794;7340.376068034277;7401.259874012556;7493.363064139391;7599.354054905395;7640.503367281109;7335.706571737071;7363.631818409165;7415.962920185365;7506.1743208248145;7521.962390188233;6871.312868713088;6871.5189936703955;6916.100906882073;6921.7231310747;6934.133233345832;5033.194688849767;5074.746262686925;5089.211172268304;5143.459936706592;5153.175491921274;5089.414717307557;5213.061648903082;5235.083860324352;5260.237265596544;5272.841814745564 10:02:49 INFO - PROCESS | 19125 | |4;prototype.html;340.83639852870624;348.1018971054679;354.0423155364738;359.11299091244615;363.0904584017037;6328.050792381146;6328.430441260286;6330.240371155462;6338.144350512679;6350.714217860196;5975.581709280352;6084.421979911913;6224.190855188819;6269.874602507947;6301.527385446098;4788.5450882166315;4791.856244312658;4806.038792241548;4810.927836082462;4814.951850481503;4816.494268101851;4821.397325334333;4827.300041493982;4829.372181616385;4829.7826597803005;4607.608353289975;4638.489766125724;4735.218688916342;4739.763011849411;4748.738819364934;4743.810247590092;4762.380890484214;4774.785134668949;4779.545943135397;4798.928016079744;4200.7479551227025;4201;4201.369794530814;4201.516825565069;4202.411662367271;6043.8791224175275;6059.2728872535135;6062.696865156769;6070.392960703938;6072.240969878765;5572.192032155355;5574.136008918624;5575.107982722786;5575.2473416088715;5583.776648934037;6449.967750161266;6569.967150164266;6576.243731970837;6577.013447982841;6583.967080164616;4639.118567472169;4652.371929789469;4656.348111264426;4656.441227052742;4669.369635099252;6883.827904302382;6895.827604309882;6897.862042759117;6898.827529311757;6903.240643529258;4749.216379297446;4750.3824502815105;4752.453467851241;4753.904921901542;4760.214564596803;4823.734694591831;4824.565789079;4825.662203645781;4831;4832.44426890905;5419.918701219485;5517.062099443105;5531.3915469298345;5541.5289700375115;5541.806036788693;6640.435562977104;6662.067310576524;6674.365935236145;6676.766313179015;6680.699368528428;1576.8659663928695;1663.6007358233937;1675.874309426798;1699.8215187405392;1700.846923776866;1131.416017575401;1133.4276190523897;1143.17691262291;1144.8683401408778;1146.9770604587861;6429.292777794439;6432.74269029243;6440.677966101676;6442.516811239176;6450.516211284173;6792;6793.558418702769;6809.285025072296;6812.216595091628;6816.795496135124;6439.7424103035355;6440.516961227927;6447.903281450782;6451.580647257913;6457.773977910751;3663.7435379523176;3693.3351996640326;3699.445083237482;3700.7594506357;3701.6298370162767;6900.723971041202;7073.363397294268;7083.574985500886;7092.645367731593;7096;6878.793636190922;6889.311068893071;6895.138107736533;6899.310068993161;6905.205901321412;7056.92943070573;7060.5410648308725;7070.36366726997;7072.5402848814665;7072.787816365517;6792.796216113525;6794.184697836291;6795.082663840516;6806.081179040766;6810.148731408574;6551.541392102507;6690.899636505359;6701.66491675424;6711.563748356341;6712.362325579063;7045.295470452914;7054.964725176341;7055.858882822417;7063.858722825412;7069.893951590833;4794.137055330074;4794.952050479451;4796.592289655418;4798.640101992295;4804.25534042224;6671.299513551007;6790.660466976533;6798.660066996729;6803.183617965876;6810.8637827244165;6530.738770449128;6695.296993815579;6719.899201512079;6738.831529211809;6746.190457145174;6616.239132499824;6703;6707.731690732316;6707.765228216989;6707.966460167668;6574.934250657432;6581.6709164540625;6599.208095028627;6602.40578347951;6612.966935165294;6594.472442204708;6756.358145976124;6768.289329620319;6769.729210831511;6780.491463140383;6562.343765623399;6599.4390476808085;6602.240742314503;6608.471322294301;6610.735570577123 10:02:49 INFO - PROCESS | 19125 | |5;yui.html;895.8387490251752;898.9280857531396;899.6356475627373;901.9052999435061;915.8168366326736;14754.409823607057;14789.852101478982;14894.255287235635;14954.327055282525;15546;13124.409401576928;13226.470941162366;13236.205827650349;13321.866781332184;13354.799678004838;741.7033186725299;867.1761826265042;872.5986046418654;873.244643383472;891.1979218703154;886.5434301334818;887.6715615222377;889.3729920406098;889.666375109334;890.4078787606234;931.7856892914633;937.723371605378;938.6667732954805;938.9389689670184;938.9906100938972;773.6054612147817;908.554808144008;923.8521836506127;925.0703043441298;932.2076235200093;678.4741825085549;678.9592624442499;680.4930326906486;680.5236334565774;680.6936878404738;14243.857561424356;14251.928740356336;14304.213268270241;14403.639909002253;14411.351489183013;14442.49451269211;14482.34829432678;14580.854191458162;14778.48275310359;14902.552923412315;12081.758364832742;12260.325682087481;12347.62957111288;12474;12489.50041998319;3973.7417067890783;4005;4012.859549915768;4021.1756589899;4068.816903239361;55604.44395556074;55767.16349254724;55770.72114639401;55970;56113.71943140299;10787.352758834495;10965.067969222546;11920.701982450508;11980.520779168735;12117.818232726517;19672.114754836068;19870.60258794816;19962.10170542329;19978.500537486678;19982.90008549977;8236.50580965144;8258.958705206556;8966.282697384193;9019.052999435096;9087.500187489619;4927.556519913153;4978.850634480971;5104.2343648453025;5105.617078719111;5137.40919794221;3238.4008958342783;3259.5925509311337;3273.558069660613;3280.917977050593;3282.819444930504;553;605.9394060593905;669.8961660942562;672.6300534705892;672.8856094463953;700.3871612339203;768.5465575310593;770.0105364606454;791.2355447352321;823.8764185372243;9554.283428742732;9711.36876103051;9896.25778066648;10022;10458.843117353246;755.7997130760353;813.9145389734111;815.6166601697192;833.8040560468285;839.3327304792705;4441.800118994653;4541.931871021938;4552.658550608718;4565.497795242521;4643.233866412072;67881.32118678848;68529.65735171392;68531.3146868525;68646;68654;55060.44939550553;55814.04650837201;56034.15948760772;59731.10403343954;61188.38811611827;51506.48493515092;52062.739686302084;52476.73761631167;52587.47412525979;53143.46856531462;9952.452615106238;10008.39949603026;10030;10253.948730256301;10298.330608510423;39983.80008099941;40349;40425.39361909515;40575.797121014206;42211.7889410551;44071;44918;45055.32417013813;45717.314240285756;51414.74292628663;12974;13057.21656700563;13210.537631182862;13465.259410732504;13536.932315338361;13641.67806115359;14256.287185640884;14428;14662.78005829892;14980.176090315137;10982.615608453665;12544.686382840502;13487.39306731219;14266;14469.782953255499;14090;14137.575872723835;14353.497627582985;14426.783598246244;14597.708045839236;13401;13691.931540342235;13977.44090236379;14065.507707230197;14395.136291822524;10962.671119866416;11345.886541134483;11433.726053066895;11738.354390508604;11776.293422394683;10753.623623173151;11297.26567773092;11365.31808091517;11398.316101033633;11607.477663504993 10:02:49 INFO - PROCESS | 19125 | __end_tp_report 10:02:49 INFO - PROCESS | 19125 | __start_cc_report 10:02:49 INFO - PROCESS | 19125 | _x_x_mozilla_cycle_collect,916 10:02:49 INFO - PROCESS | 19125 | __end_cc_report 10:02:49 INFO - PROCESS | 19125 | __startTimestamp1463677369850__endTimestamp 10:02:49 INFO - PROCESS | 19125 | 10:02:49 INFO - PROCESS | 19125 | ------- Summary: start ------- 10:02:49 INFO - PROCESS | 19125 | Number of tests: 6 10:02:49 INFO - PROCESS | 19125 | 10:02:49 INFO - PROCESS | 19125 | [#0] dojo.html Cycles:165 Average:5484.58 Median:5686.55 stddev:606.27 (10.7%) stddev-sans-first:582.79 10:02:49 INFO - PROCESS | 19125 | Values: 3273.6 3347.3 3348.4 3369.8 3391.5 5465.4 5475.6 5489.8 5499.1 5502.0 5478.4 5495.3 5505.5 5515.6 5546.1 4889.5 5027.3 5038.9 5096.3 5112.7 4937.1 4952.3 4974.8 5021.8 5036.5 5060.1 5096.3 5103.1 5104.9 5144.3 5039.6 5045.3 5088.4 5091.8 5102.6 4884.4 4923.3 4994.5 5019.6 5025.2 5394.5 5397.5 5430.0 5442.6 5482.5 5789.8 5867.5 5868.1 5882.1 5890.4 5904.4 5918.6 5930.1 5936.3 5955.7 5525.2 5528.1 5531.7 5533.5 5546.9 5898.6 6001.6 6019.7 6037.2 6097.4 5905.4 5920.6 5926.5 5927.0 5927.0 5974.9 6002.6 6003.1 6004.3 6007.0 5774.0 5845.3 5957.0 5968.6 5969.2 5861.7 5876.5 5876.7 5885.4 5886.6 4447.6 4487.5 4495.8 4500.9 4524.3 3979.2 3994.1 4034.3 4053.6 4074.4 5597.1 5613.4 5616.6 5626.0 5635.1 5796.4 5931.3 5944.5 5955.8 5955.9 5558.2 5561.5 5591.4 5606.8 5627.6 4997.5 5001.2 5038.3 5044.2 5071.6 5962.2 6044.5 6055.0 6091.4 6110.4 5874.1 5889.4 5890.7 5890.8 5908.1 6049.7 6055.2 6056.1 6060.9 6060.9 5501.4 5648.6 5696.0 5756.1 5757.5 5963.9 5967.9 5973.3 5979.2 5980.9 5789.6 5803.6 5825.0 5837.2 5838.9 5545.7 5699.8 5780.0 5780.7 5807.7 5668.5 5686.5 5701.2 5713.8 5719.7 5811.0 5829.5 5834.6 5837.9 5845.2 5527.1 5577.8 5611.4 5733.5 5740.7 10:02:49 INFO - PROCESS | 19125 | 10:02:49 INFO - PROCESS | 19125 | [#1] ext.html Cycles:180 Average:57653.18 Median:37062.35 stddev:115064.70 (310.5%) stddev-sans-first:115307.93 10:02:49 INFO - PROCESS | 19125 | Values: 662.3 663.6 664.3 672.3 754.4 32601.3 39193.0 39623.2 39630.8 39693.4 43613.8 44094.1 44144.8 44160.0 44246.6 7989.0 8710.1 8881.8 8883.6 10392.0 10479.4 10593.7 10603.9 10617.3 10629.6 10413.7 10442.6 10489.2 10492.7 10497.5 8260.8 10412.4 10727.9 11001.8 11018.1 10357.7 10447.8 10470.0 10477.9 10478.1 39567.4 40041.6 40106.4 40153.4 40182.6 3766.9 3848.2 3949.1 4078.6 4181.7 33613.2 34452.8 35428.3 36561.0 36760.3 4125.9 4339.0 4339.6 4395.2 4416.8 301574.0 306345.0 306667.0 306851.0 306965.0 39097.6 62332.0 63071.4 63080.7 63146.7 37364.4 37515.4 37522.6 37538.2 37583.2 17124.5 17310.7 17336.0 17342.3 17343.3 12286.9 13458.9 13726.0 13750.4 13757.1 8995.1 9061.4 9078.2 9098.7 9133.1 3447.0 3488.4 3541.6 3548.8 3609.5 1078.5 1086.6 1099.7 1113.5 1297.6 33447.0 33591.7 34064.7 34244.3 34311.0 1193.5 1202.2 1214.6 1220.3 1301.8 16346.7 16414.2 16587.6 16627.7 17224.9 541568.0 546176.0 546629.0 550027.0 552079.0 58018.4 58426.4 58589.4 58670.0 58700.0 1383.1 1401.4 1482.8 1518.7 1601.5 29965.8 31847.4 31934.0 32356.5 32813.8 51190.5 52147.0 52339.5 52345.7 52464.7 410289.0 412053.0 412710.0 413217.0 414081.0 26484.7 29269.1 29384.0 30195.4 30217.8 42675.0 42782.0 43163.6 43959.0 44114.6 35574.5 37851.8 38617.2 39407.4 39453.4 38280.2 38745.2 39153.6 39356.0 39577.2 41043.8 41121.8 44883.6 45866.3 46063.5 32858.8 34314.8 34875.5 36192.0 37893.6 28065.2 28229.9 28442.7 28544.3 28633.6 10:02:49 INFO - PROCESS | 19125 | 10:02:49 INFO - PROCESS | 19125 | [#2] jquery.html Cycles:180 Average:30687.16 Median:424.65 stddev:92126.81 (21694.6%) stddev-sans-first:92357.22 10:02:49 INFO - PROCESS | 19125 | Values: 419.0 422.1 427.2 433.2 439.0 14116.6 18553.8 19149.8 19221.7 19293.6 15527.6 17636.5 18408.3 18780.4 19713.0 5552.7 5749.0 5751.7 5776.3 5777.9 5660.0 5738.1 5745.1 5745.3 5748.6 4138.8 6132.6 6297.1 6369.6 6398.6 6205.7 6256.6 6269.1 6303.8 6315.5 5514.8 5558.1 5608.9 5633.6 5648.1 21631.8 21654.4 22982.7 23526.9 23640.1 2576.1 2592.2 2602.5 2641.1 2716.3 14033.6 14580.7 14639.7 14812.4 15100.4 2058.7 2088.2 2121.2 2121.5 2192.4 71452.3 72887.6 76813.0 82028.6 83495.2 11118.4 11147.7 11149.0 11292.2 11400.3 15476.3 15691.7 15782.8 15891.0 15941.4 8599.2 8611.7 8649.6 8738.2 8864.2 8114.2 8246.2 8256.1 8264.8 8497.2 4411.4 4602.1 4888.2 4896.7 4925.3 1929.7 2007.3 2032.1 2046.3 2053.3 456.5 480.7 980.6 1027.9 1116.8 11810.1 11883.3 12044.6 12101.6 12108.7 461.9 477.1 479.1 489.9 493.1 5735.4 6523.3 6564.5 6568.5 6595.9 547933.0 556400.0 563152.0 565827.0 565902.0 96812.5 97464.0 99590.5 99641.0 100386.5 474.8 482.5 485.5 486.6 487.0 10933.9 11061.6 11226.8 11237.4 11467.9 38677.2 38788.8 38841.6 40689.8 40709.8 55351.6 60934.4 61051.4 61112.7 61503.0 8994.6 9016.8 9063.4 9106.3 9264.8 10215.0 13409.5 13846.9 13892.7 13942.4 11747.2 11785.2 11789.6 11859.9 11992.3 11628.7 12006.7 12051.9 12113.8 12192.3 11942.5 11964.9 12307.8 12652.4 12667.9 8837.1 8910.2 9029.7 9035.5 9133.2 11479.6 12201.5 12227.4 12384.3 12531.4 10:02:49 INFO - PROCESS | 19125 | 10:02:49 INFO - PROCESS | 19125 | [#3] mootools.html Cycles:180 Average:5673.57 Median:4734.38 stddev:3137.21 (66.3%) stddev-sans-first:3129.63 10:02:49 INFO - PROCESS | 19125 | Values: 1408.8 1554.4 1554.6 1741.0 1858.3 8169.2 8412.0 8415.7 8416.0 8440.4 8139.9 8263.4 8272.8 8310.1 8319.0 2020.3 2057.6 2345.2 2369.1 2377.8 2430.9 2434.1 2437.6 2437.9 2447.2 2380.0 2385.3 2387.4 2435.6 2442.7 2080.9 2268.3 2281.2 2334.7 2391.7 2334.2 2363.2 2364.3 2365.0 2367.7 8179.6 8248.9 8253.0 8256.6 8261.6 5140.9 5242.1 5242.8 5249.5 5253.8 3207.8 3339.3 3340.7 3357.5 3430.9 1067.4 1074.0 1091.5 1093.0 1096.8 11961.2 12031.7 12040.0 12046.1 12066.2 4441.4 4622.6 4638.9 4685.4 4713.8 10092.0 10136.6 10167.2 10168.8 10169.5 5260.0 5302.4 5303.2 5307.3 5315.8 4276.3 4755.0 4815.0 4884.2 4887.5 3971.4 4010.8 4056.1 4079.4 4083.7 1351.9 1364.7 1374.2 1375.6 1377.9 1012.8 1019.1 1022.1 1023.6 1053.5 5866.4 5899.6 5903.6 5948.4 5979.4 1001.9 1030.5 1037.0 1040.4 1040.9 4125.9 4178.4 4186.8 4195.4 4204.2 10442.3 10554.1 10660.2 10828.2 10856.2 10544.1 10545.4 10557.2 10557.3 10562.3 8031.5 8135.0 8142.7 8224.8 8240.2 5743.2 5784.7 5828.1 5846.2 5998.3 9371.3 9416.9 9577.4 9684.3 9716.1 9456.6 9698.5 9720.1 9775.8 9904.6 6719.1 6930.5 6934.6 7664.2 7698.7 8061.2 8145.0 8248.3 8294.5 8299.7 7340.4 7401.3 7493.4 7599.4 7640.5 7335.7 7363.6 7416.0 7506.2 7522.0 6871.3 6871.5 6916.1 6921.7 6934.1 5033.2 5074.7 5089.2 5143.5 5153.2 5089.4 5213.1 5235.1 5260.2 5272.8 10:02:49 INFO - PROCESS | 19125 | 10:02:49 INFO - PROCESS | 19125 | [#4] prototype.html Cycles:180 Average:5562.53 Median:6431.02 stddev:1666.74 (25.9%) stddev-sans-first:1624.68 10:02:49 INFO - PROCESS | 19125 | Values: 340.8 348.1 354.0 359.1 363.1 6328.1 6328.4 6330.2 6338.1 6350.7 5975.6 6084.4 6224.2 6269.9 6301.5 4788.5 4791.9 4806.0 4810.9 4815.0 4816.5 4821.4 4827.3 4829.4 4829.8 4607.6 4638.5 4735.2 4739.8 4748.7 4743.8 4762.4 4774.8 4779.5 4798.9 4200.7 4201.0 4201.4 4201.5 4202.4 6043.9 6059.3 6062.7 6070.4 6072.2 5572.2 5574.1 5575.1 5575.2 5583.8 6450.0 6570.0 6576.2 6577.0 6584.0 4639.1 4652.4 4656.3 4656.4 4669.4 6883.8 6895.8 6897.9 6898.8 6903.2 4749.2 4750.4 4752.5 4753.9 4760.2 4823.7 4824.6 4825.7 4831.0 4832.4 5419.9 5517.1 5531.4 5541.5 5541.8 6640.4 6662.1 6674.4 6676.8 6680.7 1576.9 1663.6 1675.9 1699.8 1700.8 1131.4 1133.4 1143.2 1144.9 1147.0 6429.3 6432.7 6440.7 6442.5 6450.5 6792.0 6793.6 6809.3 6812.2 6816.8 6439.7 6440.5 6447.9 6451.6 6457.8 3663.7 3693.3 3699.4 3700.8 3701.6 6900.7 7073.4 7083.6 7092.6 7096.0 6878.8 6889.3 6895.1 6899.3 6905.2 7056.9 7060.5 7070.4 7072.5 7072.8 6792.8 6794.2 6795.1 6806.1 6810.1 6551.5 6690.9 6701.7 6711.6 6712.4 7045.3 7055.0 7055.9 7063.9 7069.9 4794.1 4795.0 4796.6 4798.6 4804.3 6671.3 6790.7 6798.7 6803.2 6810.9 6530.7 6695.3 6719.9 6738.8 6746.2 6616.2 6703.0 6707.7 6707.8 6708.0 6574.9 6581.7 6599.2 6602.4 6613.0 6594.5 6756.4 6768.3 6769.7 6780.5 6562.3 6599.4 6602.2 6608.5 6610.7 10:02:49 INFO - PROCESS | 19125 | 10:02:49 INFO - PROCESS | 19125 | [#5] yui.html Cycles:180 Average:15747.09 Median:43141.39 stddev:18165.11 (42.1%) stddev-sans-first:18181.83 10:02:49 INFO - PROCESS | 19125 | Values: 895.8 898.9 899.6 901.9 915.8 14754.4 14789.9 14894.3 14954.3 15546.0 13124.4 13226.5 13236.2 13321.9 13354.8 741.7 867.2 872.6 873.2 891.2 886.5 887.7 889.4 889.7 890.4 931.8 937.7 938.7 938.9 939.0 773.6 908.6 923.9 925.1 932.2 678.5 679.0 680.5 680.5 680.7 14243.9 14251.9 14304.2 14403.6 14411.4 14442.5 14482.3 14580.9 14778.5 14902.6 12081.8 12260.3 12347.6 12474.0 12489.5 3973.7 4005.0 4012.9 4021.2 4068.8 55604.4 55767.2 55770.7 55970.0 56113.7 10787.4 10965.1 11920.7 11980.5 12117.8 19672.1 19870.6 19962.1 19978.5 19982.9 8236.5 8259.0 8966.3 9019.1 9087.5 4927.6 4978.9 5104.2 5105.6 5137.4 3238.4 3259.6 3273.6 3280.9 3282.8 553.0 605.9 669.9 672.6 672.9 700.4 768.5 770.0 791.2 823.9 9554.3 9711.4 9896.3 10022.0 10458.8 755.8 813.9 815.6 833.8 839.3 4441.8 4541.9 4552.7 4565.5 4643.2 67881.3 68529.7 68531.3 68646.0 68654.0 55060.4 55814.0 56034.2 59731.1 61188.4 51506.5 52062.7 52476.7 52587.5 53143.5 9952.5 10008.4 10030.0 10253.9 10298.3 39983.8 40349.0 40425.4 40575.8 42211.8 44071.0 44918.0 45055.3 45717.3 51414.7 12974.0 13057.2 13210.5 13465.3 13536.9 13641.7 14256.3 14428.0 14662.8 14980.2 10982.6 12544.7 13487.4 14266.0 14469.8 14090.0 14137.6 14353.5 14426.8 14597.7 13401.0 13691.9 13977.4 14065.5 14395.1 10962.7 11345.9 11433.7 11738.4 11776.3 10753.6 11297.3 11365.3 11398.3 11607.5 10:02:49 INFO - PROCESS | 19125 | -------- Summary: end -------- 10:02:49 INFO - PROCESS | 19125 | 10:02:50 INFO - TEST-INFO | 19125: exit 0 10:02:50 INFO - TEST-OK | dromaeo_css | took 1110808ms 10:02:50 INFO - TEST-START | kraken 10:02:50 INFO - operating with platform_type : linux_ 10:02:50 INFO - Initialising browser for kraken test... 10:02:50 INFO - TEST-INFO | started process 19314 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYnnK5B/profile http://localhost:35524/getInfo.html) 10:02:54 INFO - PROCESS | 19314 | __metrics Screen width/height:1600/1200 10:02:54 INFO - PROCESS | 19314 | colorDepth:24 10:02:54 INFO - PROCESS | 19314 | Browser inner width/height: 1024/697 10:02:54 INFO - PROCESS | 19314 | __metrics 10:02:55 ERROR - PROCESS | 19314 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:02:56 INFO - TEST-INFO | 19314: exit 0 10:02:56 INFO - Browser initialized. 10:02:56 INFO - Running cycle 1/1 for kraken test... 10:02:56 INFO - TEST-INFO | started process 19406 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYnnK5B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:03:07 INFO - PROCESS | 19406 | RSS: Main: 141762560 10:03:07 INFO - PROCESS | 19406 | 10:03:10 INFO - PROCESS | 19406 | Cycle 1(1): loaded http://localhost:35524/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35524/tests/kraken/driver.html?testName=audio-beat-detection) 10:03:11 INFO - PROCESS | 19406 | RSS: Main: 196263936 10:03:11 INFO - PROCESS | 19406 | 10:03:13 INFO - PROCESS | 19406 | Cycle 1(1): loaded http://localhost:35524/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35524/tests/kraken/driver.html?testName=audio-dft) 10:03:14 INFO - PROCESS | 19406 | RSS: Main: 182530048 10:03:14 INFO - PROCESS | 19406 | 10:03:17 INFO - PROCESS | 19406 | Cycle 1(1): loaded http://localhost:35524/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35524/tests/kraken/driver.html?testName=audio-fft) 10:03:17 INFO - PROCESS | 19406 | RSS: Main: 272433152 10:03:17 INFO - PROCESS | 19406 | 10:03:20 INFO - PROCESS | 19406 | Cycle 1(1): loaded http://localhost:35524/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35524/tests/kraken/driver.html?testName=audio-oscillator) 10:03:20 INFO - PROCESS | 19406 | RSS: Main: 179527680 10:03:20 INFO - PROCESS | 19406 | 10:03:22 INFO - PROCESS | 19406 | Cycle 1(1): loaded http://localhost:35524/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35524/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:03:23 INFO - PROCESS | 19406 | RSS: Main: 177180672 10:03:23 INFO - PROCESS | 19406 | 10:03:26 INFO - PROCESS | 19406 | Cycle 1(1): loaded http://localhost:35524/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35524/tests/kraken/driver.html?testName=imaging-darkroom) 10:03:26 INFO - PROCESS | 19406 | RSS: Main: 212434944 10:03:26 INFO - PROCESS | 19406 | 10:03:30 INFO - PROCESS | 19406 | Cycle 1(1): loaded http://localhost:35524/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35524/tests/kraken/driver.html?testName=imaging-desaturate) 10:03:30 INFO - PROCESS | 19406 | RSS: Main: 212996096 10:03:30 INFO - PROCESS | 19406 | 10:03:33 INFO - PROCESS | 19406 | Cycle 1(1): loaded http://localhost:35524/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35524/tests/kraken/driver.html?testName=json-parse-financial) 10:03:34 INFO - PROCESS | 19406 | RSS: Main: 213319680 10:03:34 INFO - PROCESS | 19406 | 10:03:35 INFO - PROCESS | 19406 | Cycle 1(1): loaded http://localhost:35524/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35524/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:03:36 INFO - PROCESS | 19406 | RSS: Main: 193105920 10:03:36 INFO - PROCESS | 19406 | 10:03:37 INFO - PROCESS | 19406 | Cycle 1(1): loaded http://localhost:35524/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35524/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:03:38 INFO - PROCESS | 19406 | RSS: Main: 195248128 10:03:38 INFO - PROCESS | 19406 | 10:03:40 INFO - PROCESS | 19406 | Cycle 1(1): loaded http://localhost:35524/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35524/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:03:41 INFO - PROCESS | 19406 | RSS: Main: 212033536 10:03:41 INFO - PROCESS | 19406 | 10:03:43 INFO - PROCESS | 19406 | Cycle 1(1): loaded http://localhost:35524/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35524/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:03:44 INFO - PROCESS | 19406 | RSS: Main: 213540864 10:03:44 INFO - PROCESS | 19406 | 10:03:46 INFO - PROCESS | 19406 | Cycle 1(1): loaded http://localhost:35524/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35524/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:03:47 INFO - PROCESS | 19406 | RSS: Main: 209940480 10:03:47 INFO - PROCESS | 19406 | 10:03:49 INFO - PROCESS | 19406 | Cycle 1(1): loaded http://localhost:35524/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35524/tests/kraken/driver.html?testName=ai-astar) 10:03:49 INFO - PROCESS | 19406 | RSS: Main: 272912384 10:03:49 INFO - PROCESS | 19406 | 10:03:49 INFO - PROCESS | 19406 | __start_tp_report 10:03:49 INFO - PROCESS | 19406 | _x_x_mozilla_page_load 10:03:49 INFO - PROCESS | 19406 | _x_x_mozilla_page_load_details 10:03:49 INFO - PROCESS | 19406 | |i|pagename|runs| 10:03:49 INFO - PROCESS | 19406 | |0;ai-astar;113;112;111;111;112;113;106;110;111;110 10:03:49 INFO - PROCESS | 19406 | |1;audio-beat-detection;150;126;150;194;127;156;154;127;174;126 10:03:49 INFO - PROCESS | 19406 | |2;audio-dft;161;162;161;161;159;161;161;159;162;160 10:03:49 INFO - PROCESS | 19406 | |3;audio-fft;81;74;75;173;74;77;75;76;160;76 10:03:49 INFO - PROCESS | 19406 | |4;audio-oscillator;92;97;164;92;93;92;152;92;93;142 10:03:49 INFO - PROCESS | 19406 | |5;imaging-gaussian-blur;116;118;117;117;118;117;117;117;117;116 10:03:49 INFO - PROCESS | 19406 | |6;imaging-darkroom;145;145;145;145;146;146;145;145;146;145 10:03:49 INFO - PROCESS | 19406 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;94;94 10:03:49 INFO - PROCESS | 19406 | |8;json-parse-financial;53;53;54;54;54;54;56;79;52;53 10:03:49 INFO - PROCESS | 19406 | |9;json-stringify-tinderbox;59;58;57;58;58;60;58;58;59;57 10:03:49 INFO - PROCESS | 19406 | |10;stanford-crypto-aes;72;72;71;72;75;75;82;73;80;73 10:03:49 INFO - PROCESS | 19406 | |11;stanford-crypto-ccm;125;111;114;130;113;113;112;112;134;126 10:03:49 INFO - PROCESS | 19406 | |12;stanford-crypto-pbkdf2;168;159;165;164;163;161;158;158;162;162 10:03:49 INFO - PROCESS | 19406 | |13;stanford-crypto-sha256-iterative;66;66;65;68;65;66;65;66;67;65 10:03:49 INFO - PROCESS | 19406 | __end_tp_report 10:03:49 INFO - PROCESS | 19406 | __start_cc_report 10:03:49 INFO - PROCESS | 19406 | _x_x_mozilla_cycle_collect,1621 10:03:49 INFO - PROCESS | 19406 | __end_cc_report 10:03:49 INFO - PROCESS | 19406 | __startTimestamp1463677429445__endTimestamp 10:03:49 INFO - PROCESS | 19406 | 10:03:49 INFO - PROCESS | 19406 | ------- Summary: start ------- 10:03:49 INFO - PROCESS | 19406 | Number of tests: 14 10:03:49 INFO - PROCESS | 19406 | 10:03:49 INFO - PROCESS | 19406 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.50 stddev:2.02 (1.8%) stddev-sans-first:2.00 10:03:49 INFO - PROCESS | 19406 | Values: 113.0 112.0 111.0 111.0 112.0 113.0 106.0 110.0 111.0 110.0 10:03:49 INFO - PROCESS | 19406 | 10:03:49 INFO - PROCESS | 19406 | [#1] audio-beat-detection Cycles:10 Average:148.40 Median:152.00 stddev:22.97 (15.1%) stddev-sans-first:24.36 10:03:49 INFO - PROCESS | 19406 | Values: 150.0 126.0 150.0 194.0 127.0 156.0 154.0 127.0 174.0 126.0 10:03:49 INFO - PROCESS | 19406 | 10:03:49 INFO - PROCESS | 19406 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.06 (0.7%) stddev-sans-first:1.12 10:03:49 INFO - PROCESS | 19406 | Values: 161.0 162.0 161.0 161.0 159.0 161.0 161.0 159.0 162.0 160.0 10:03:49 INFO - PROCESS | 19406 | 10:03:49 INFO - PROCESS | 19406 | [#3] audio-fft Cycles:10 Average:94.10 Median:75.50 stddev:38.33 (50.8%) stddev-sans-first:40.36 10:03:49 INFO - PROCESS | 19406 | Values: 81.0 74.0 75.0 173.0 74.0 77.0 75.0 76.0 160.0 76.0 10:03:49 INFO - PROCESS | 19406 | 10:03:49 INFO - PROCESS | 19406 | [#4] audio-oscillator Cycles:10 Average:110.90 Median:92.00 stddev:29.32 (31.9%) stddev-sans-first:30.29 10:03:49 INFO - PROCESS | 19406 | Values: 92.0 97.0 164.0 92.0 93.0 92.0 152.0 92.0 93.0 142.0 10:03:49 INFO - PROCESS | 19406 | 10:03:49 INFO - PROCESS | 19406 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 10:03:49 INFO - PROCESS | 19406 | Values: 116.0 118.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 116.0 10:03:49 INFO - PROCESS | 19406 | 10:03:49 INFO - PROCESS | 19406 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 10:03:49 INFO - PROCESS | 19406 | Values: 145.0 145.0 145.0 145.0 146.0 146.0 145.0 145.0 146.0 145.0 10:03:49 INFO - PROCESS | 19406 | 10:03:49 INFO - PROCESS | 19406 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:03:49 INFO - PROCESS | 19406 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 94.0 10:03:49 INFO - PROCESS | 19406 | 10:03:49 INFO - PROCESS | 19406 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:54.00 stddev:8.08 (15.0%) stddev-sans-first:8.49 10:03:49 INFO - PROCESS | 19406 | Values: 53.0 53.0 54.0 54.0 54.0 54.0 56.0 79.0 52.0 53.0 10:03:49 INFO - PROCESS | 19406 | 10:03:49 INFO - PROCESS | 19406 | [#9] json-stringify-tinderbox Cycles:10 Average:58.20 Median:58.00 stddev:0.92 (1.6%) stddev-sans-first:0.93 10:03:49 INFO - PROCESS | 19406 | Values: 59.0 58.0 57.0 58.0 58.0 60.0 58.0 58.0 59.0 57.0 10:03:49 INFO - PROCESS | 19406 | 10:03:49 INFO - PROCESS | 19406 | [#10] stanford-crypto-aes Cycles:10 Average:74.50 Median:74.00 stddev:3.69 (5.0%) stddev-sans-first:3.80 10:03:49 INFO - PROCESS | 19406 | Values: 72.0 72.0 71.0 72.0 75.0 75.0 82.0 73.0 80.0 73.0 10:03:49 INFO - PROCESS | 19406 | 10:03:49 INFO - PROCESS | 19406 | [#11] stanford-crypto-ccm Cycles:10 Average:119.00 Median:119.50 stddev:8.76 (7.3%) stddev-sans-first:9.01 10:03:49 INFO - PROCESS | 19406 | Values: 125.0 111.0 114.0 130.0 113.0 113.0 112.0 112.0 134.0 126.0 10:03:49 INFO - PROCESS | 19406 | 10:03:49 INFO - PROCESS | 19406 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.00 Median:162.50 stddev:3.20 (2.0%) stddev-sans-first:2.55 10:03:49 INFO - PROCESS | 19406 | Values: 168.0 159.0 165.0 164.0 163.0 161.0 158.0 158.0 162.0 162.0 10:03:49 INFO - PROCESS | 19406 | 10:03:49 INFO - PROCESS | 19406 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:0.99 (1.5%) stddev-sans-first:1.05 10:03:49 INFO - PROCESS | 19406 | Values: 66.0 66.0 65.0 68.0 65.0 66.0 65.0 66.0 67.0 65.0 10:03:49 INFO - PROCESS | 19406 | -------- Summary: end -------- 10:03:49 INFO - PROCESS | 19406 | 10:03:50 INFO - TEST-INFO | 19406: exit 0 10:03:50 INFO - TEST-OK | kraken | took 59878ms 10:03:50 INFO - SUITE-END | took 1170s 10:03:50 INFO - Completed test suite (00:19:30) 10:03:50 INFO - javascript benchmark 10:03:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3273.5580696605957, 3347.3305338932205, 3348.3972884880727, 3369.8315084245783, 3391.5082313064604, 5465.371482279539, 5475.6167068305185, 5489.835304940858, 5499.065158922983, 5502.009638265111, 5478.397376288605, 5495.313085864267, 5505.532029777473, 5515.61390702651, 5546.112621980484, 4889.462159162507, 5027.346444962159, 5038.874028149307, 5096.311997880294, 5112.667676601028, 4937.086638971784, 4952.306677065196, 4974.751262436864, 5021.799128034874, 5036.471170527097, 5060.139776238048, 5096.2865198872005, 5103.132467480537, 5104.923426148593, 5144.3312369392115, 5039.647224694273, 5045.268436076748, 5088.389393272831, 5091.79632814687, 5102.591792656579, 4884.365032545782, 4923.261510773377, 4994.500549945013, 5019.598432125457, 5025.195968644999, 5394.514493695547, 5397.54120899724, 5430.0, 5442.619016668835, 5482.506574408282, 5789.8263052108505, 5867.530597552228, 5868.149118377812, 5882.088276317178, 5890.440408161261, 5904.350521442638, 5918.644881307092, 5930.080837470199, 5936.347001829795, 5955.702214889281, 5525.171224316345, 5528.115501519737, 5531.668099914018, 5533.474319939599, 5546.91679624806, 5898.587098903035, 6001.5798894077, 6019.729112189874, 6037.15479832815, 6097.359777223416, 5905.350411454737, 5920.585559010828, 5926.4666180044005, 5926.992411290091, 5927.022041363127, 5974.9402505974385, 6002.579819412599, 6003.099535069687, 6004.309504406961, 6006.969965150146, 5774.04728219839, 5845.3277873045145, 5956.970215148896, 5968.552358573038, 5969.164316995624, 5861.677607731531, 5876.471117599351, 5876.706164691834, 5885.411458854081, 5886.558508111909, 4447.577480139446, 4487.5288094749585, 4495.797689103998, 4500.932486012713, 4524.343970124313, 3979.2041591681777, 3994.1013272013565, 4034.253663072341, 4053.61490658387, 4074.4499492568716, 5597.076482380443, 5613.382527921925, 5616.550675945915, 5626.0, 5635.0702134147405, 5796.42035796417, 5931.347551769302, 5944.494717948936, 5955.7617695292565, 5955.910661340084, 5558.249636299129, 5561.499465048084, 5591.41290164535, 5606.803761868315, 5627.606067575231, 4997.475265097112, 5001.174806157016, 5038.293626044655, 5044.218146187347, 5071.594272458195, 5962.22491076166, 6044.546659000504, 6055.0, 6091.390860913873, 6110.419510146529, 5874.118882167709, 5889.352171261158, 5890.705464726832, 5890.793822216202, 5908.084246941731, 6049.727762250797, 6055.182550355822, 6056.121862330026, 6060.878782424415, 6060.939390606038, 5501.4223506532835, 5648.63283886546, 5696.003199439999, 5756.136579513107, 5757.481826635623, 5963.9105413417965, 5967.850803729942, 5973.342932277533, 5979.162917191509, 5980.940190598212, 5789.594728368974, 5803.593748437569, 5825.0388685866355, 5837.211976383303, 5838.912416313674, 5545.694986775766, 5699.800506982236, 5779.97110014464, 5780.653160810365, 5807.651540907559, 5668.461496157858, 5686.545076393796, 5701.201831743476, 5713.800016999385, 5719.7426115824055, 5811.0, 5829.47534721877, 5834.649921004753, 5837.883242335214, 5845.240118784531, 5527.088030474926, 5577.776888924398, 5611.438856114356, 5733.541316694738, 5740.712964351849], "value": 5445.462164630754, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [662.2979641579925, 663.6217356107018, 664.262668438034, 672.287375382095, 754.3927138653384, 32601.347973040556, 39193.0, 39623.207535849266, 39630.80184599077, 39693.40459893104, 43613.7819310903, 44094.11811763763, 44144.779276103574, 44160.0, 44246.557534424646, 7988.9600551997155, 8710.08544102868, 8881.77795555113, 8883.600237989305, 10392.0, 10479.371237725723, 10593.735156621107, 10603.893961060368, 10617.256792024562, 10629.574817007311, 10413.739656508573, 10442.634507792229, 10489.213309001818, 10492.737681557946, 10497.527611257512, 8260.793480162984, 10412.375257484575, 10727.946360268226, 11001.834972475419, 11018.11855051602, 10357.689269321932, 10447.84328235077, 10470.0, 10477.895221047767, 10478.10936070435, 39567.40648890269, 40041.59958400437, 40106.39840402397, 40153.39769903454, 40182.59817401847, 3766.886993390203, 3848.172642881766, 3949.071968087497, 4078.612531809503, 4181.749095054306, 33613.15967100818, 34452.82773586116, 35428.29143417143, 36561.0, 36760.26479470422, 4125.91748165038, 4339.0, 4339.631131353807, 4395.208862404766, 4416.779161041967, 301574.0, 306345.0, 306667.0, 306851.0, 306965.0, 39097.6090239094, 62332.0, 63071.36928630747, 63080.68459657672, 63146.68426657837, 37364.43953340702, 37515.437268441, 37522.62477375246, 37538.249235015144, 37583.248335033146, 17124.48626541206, 17310.653786924442, 17336.04651744166, 17342.30630774755, 17343.3062677494, 12286.877131228752, 13458.865411345761, 13726.0, 13750.449982000608, 13757.10578812394, 8995.145461181308, 9061.365704400629, 9078.228350590274, 9098.681546145985, 9133.086691330815, 3447.0, 3488.424409972377, 3541.6281290464644, 3548.75289110461, 3609.4585812127866, 1078.5092782783815, 1086.6468397770757, 1099.7470581766079, 1113.5323164271026, 1297.6042307096427, 33447.0, 33591.66408335934, 34064.65935340664, 34244.31511369759, 34311.0, 1193.531002635257, 1202.2108707797825, 1214.5748987854356, 1220.3166226912779, 1301.7526669932683, 16346.673066538602, 16414.227914711893, 16587.585310367096, 16627.66744665124, 17224.913875430793, 541568.0, 546176.0, 546629.0, 550027.0, 552079.0, 58018.419815802146, 58426.41573584295, 58589.41410585925, 58670.0, 58700.0, 1383.0871624727833, 1401.3553765267886, 1482.7701706235334, 1518.7190369781626, 1601.4635097242553, 29965.815263905242, 31847.363052739278, 31934.0, 32356.514652280704, 32813.83593082019, 51190.48809511857, 52147.0, 52339.47660523498, 52345.7382713084, 52464.7376763129, 410289.0, 412053.0, 412710.0, 413217.0, 414081.0, 26484.735152648227, 29269.121926342243, 29384.0, 30195.396092077597, 30217.848910755307, 42675.0, 42782.0, 43163.56836431596, 43959.0, 44114.55885441104, 35574.466383004794, 37851.810740946115, 38617.2276554473, 39407.40888886611, 39453.40819887647, 38280.234395312495, 38745.2250954985, 39153.608463915, 39356.0, 39577.2084558313, 41043.79478102591, 41121.794391027855, 44883.55116448794, 45866.312005319276, 46063.539364605924, 32858.835705821315, 34314.82842585871, 34875.4768678465, 36192.0, 37893.62106378901, 28065.158045258675, 28229.858850705616, 28442.715572844834, 28544.286392840346, 28633.570496442153], "value": 19559.743017966823, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.9727667701599, 422.1135615208062, 427.19473791902277, 433.21155496995465, 438.9648828093753, 14116.647083822883, 18553.814461855378, 19149.808501914977, 19221.711674324895, 19293.614127717454, 15527.611809704764, 17636.470905872844, 18408.263669453205, 18780.436586902382, 19713.0, 5552.722873739032, 5748.971255143719, 5751.712414379285, 5776.335721392031, 5777.884442311151, 5660.037793575081, 5738.139279108125, 5745.138229265602, 5745.2818397700285, 5748.626339287954, 4138.8137533810905, 6132.63204207749, 6297.08692239625, 6369.554131210817, 6398.552101352907, 6205.689715514229, 6256.624602523863, 6269.059641053833, 6303.810885673437, 6315.463185629227, 5514.80698175562, 5558.082916318803, 5608.859778505529, 5633.63381380209, 5648.096304591287, 21631.78368216329, 21654.35036948894, 22982.66586969509, 23526.882365588233, 23640.054397824068, 2576.0726138590094, 2592.235290589281, 2602.4534847682007, 2641.088824355594, 2716.307341627892, 14033.64915877101, 14580.708385832224, 14639.707205855822, 14812.407503699838, 15100.395984160621, 2058.6706127019756, 2088.1751708075376, 2121.16214095433, 2121.543868068373, 2192.3861318830754, 71452.28547714508, 72887.63556182185, 76813.0, 82028.58985705093, 83495.16504834934, 11118.388488633203, 11147.721306967229, 11149.0, 11292.209545331747, 11400.258983166068, 15476.303566339542, 15691.686166276611, 15782.763258551131, 15891.0, 15941.362345506283, 8599.183077607742, 8611.741647750578, 8649.610767515476, 8738.213560779433, 8864.20222180007, 8114.188581141839, 8246.216609422096, 8256.091829898707, 8264.83470330602, 8497.192766687154, 4411.426514553087, 4602.148602508547, 4888.169011268093, 4896.730679812645, 4925.261210818406, 1929.6526625207316, 2007.2773801431474, 2032.1287946462014, 2046.2633451957283, 2053.271088763497, 456.52065331401894, 480.668338846195, 980.612658000086, 1027.8509616105773, 1116.7664670658683, 11810.114241431927, 11883.287002779862, 12044.638660840188, 12101.636950891312, 12108.697282568006, 461.89145550795536, 477.08637958309447, 479.07777528257964, 489.904468628614, 493.0991029580914, 5735.426457354231, 6523.282438931714, 6564.474842012628, 6568.507361947873, 6595.901061484082, 547933.0, 556400.0, 563152.0, 565827.0, 565902.0, 96812.51593741986, 97464.0, 99590.50204749075, 99641.0, 100386.4980675092, 474.82194177183555, 482.519892706752, 485.54843995084207, 486.5864015586723, 487.0210876138986, 10933.945330273298, 11061.557537698724, 11226.831597525881, 11237.438128093727, 11467.942660286979, 38677.22645547017, 38788.80605596954, 38841.6115838838, 40689.796551017054, 40709.79645101756, 55351.60715444448, 60934.39065609464, 61051.38948610457, 61112.694436527534, 61503.0, 8994.640214391351, 9016.774580635536, 9063.41087829289, 9106.27149827999, 9264.768380790534, 10215.0, 13409.530666426628, 13846.93076534611, 13892.72214555683, 13942.442302307794, 11747.177697561088, 11785.233959792586, 11789.587364442203, 11859.881401186223, 11992.280463172237, 11628.709282268012, 12006.699832504257, 12051.879481205076, 12113.75772484563, 12192.268463892195, 11942.462589183333, 11964.880351196376, 12307.75384492323, 12652.43064062101, 12667.93666031664, 8837.072107428627, 8910.242629376575, 9029.683961061332, 9035.548222588714, 9133.178013978773, 11479.598214062467, 12201.450934707782, 12227.44976476043, 12384.256944582994, 12531.436085375997], "value": 8741.867844206534, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1408.7886816977446, 1554.401555401171, 1554.6424322405846, 1740.9825901740987, 1858.2938483376315, 8169.183081691828, 8412.032616249126, 8415.663373465062, 8416.0, 8440.366972477073, 8139.877901831477, 8263.380246481523, 8272.75181744547, 8310.085890552034, 8318.958405207966, 2020.3029954665617, 2057.567910738747, 2345.22607539512, 2369.07606033647, 2377.8454400464, 2430.9392265193424, 2434.099383228208, 2437.6343548467785, 2437.9390515237083, 2447.21689059501, 2380.0241900820665, 2385.272491889973, 2387.3554140382084, 2435.6346548017764, 2442.682451281331, 2080.864743791649, 2268.262814585258, 2281.2471884278148, 2334.684817549643, 2391.712994440661, 2334.2297041976108, 2363.1847012780563, 2364.3379853640836, 2364.9881750591308, 2367.7040369953756, 8179.550124743197, 8248.917510824875, 8252.958735206346, 8256.587170641444, 8261.586920654003, 5140.897182056338, 5242.082635538765, 5242.79028838846, 5249.501297376782, 5253.789848406059, 3207.839608019613, 3339.2987472630775, 3340.749443791701, 3357.4963755436634, 3430.9313813723584, 1067.4289255248405, 1073.9570417183304, 1091.5033659684825, 1092.9672109836638, 1096.7751610919743, 11961.222520536137, 12031.699207519794, 12040.0, 12046.096542759327, 12066.155369124164, 4441.378207051015, 4622.607078398307, 4638.930416043762, 4685.367475390779, 4713.81144754206, 10092.04125608066, 10136.594536218468, 10167.186625069977, 10168.796624067478, 10169.54237059334, 5260.0, 5302.390225124083, 5303.204519322056, 5307.2569840222395, 5315.787368505294, 4276.273033584236, 4754.952450475451, 4815.0, 4884.194107972145, 4887.462379138292, 3971.4042893566198, 4010.7593544386846, 4056.0873803394, 4079.3676980068135, 4083.652889504366, 1351.9459221631025, 1364.7270545890863, 1374.17549470317, 1375.6217040313993, 1377.9173249605055, 1012.8379459286626, 1019.1133713669008, 1022.0903395977585, 1023.5649848814224, 1053.536443964653, 5866.413358664099, 5899.646021238739, 5903.616264942851, 5948.405159484017, 5979.431953964367, 1001.8547310639916, 1030.469308306223, 1036.9792604147874, 1040.3782468180143, 1040.8802987656366, 4125.91748165035, 4178.435911152016, 4186.811593478301, 4195.433616461739, 4204.159168166379, 10442.321249118782, 10554.050135487843, 10660.20048496366, 10828.187885908588, 10856.185786065918, 10544.103751181083, 10545.420001899969, 10557.155427565776, 10557.313774604627, 10562.31344962575, 8031.518108913484, 8134.959325203336, 8142.674293028331, 8224.8355032899, 8240.21717936795, 5743.167240749985, 5784.681842498703, 5828.053038366289, 5846.239988801429, 5998.280206375263, 9371.34400591952, 9416.858747118662, 9577.377470464398, 9684.32209745311, 9716.076972687584, 9456.621735130519, 9698.515074246401, 9720.07659272368, 9775.75560610962, 9904.603815847286, 6719.059331693665, 6930.549514281555, 6934.583924964519, 7664.195259497673, 7698.692052317844, 8061.234182752629, 8144.959275203586, 8248.298894594027, 8294.543800091053, 8299.6680132794, 7340.376068034277, 7401.259874012556, 7493.363064139391, 7599.354054905395, 7640.503367281109, 7335.706571737071, 7363.631818409165, 7415.962920185365, 7506.1743208248145, 7521.962390188233, 6871.312868713088, 6871.5189936703955, 6916.100906882073, 6921.7231310747, 6934.133233345832, 5033.194688849767, 5074.746262686925, 5089.211172268304, 5143.459936706592, 5153.175491921274, 5089.414717307557, 5213.061648903082, 5235.083860324352, 5260.237265596544, 5272.841814745564], "value": 4605.230754688197, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.83639852870624, 348.1018971054679, 354.0423155364738, 359.11299091244615, 363.0904584017037, 6328.050792381146, 6328.430441260286, 6330.240371155462, 6338.144350512679, 6350.714217860196, 5975.581709280352, 6084.421979911913, 6224.190855188819, 6269.874602507947, 6301.527385446098, 4788.5450882166315, 4791.856244312658, 4806.038792241548, 4810.927836082462, 4814.951850481503, 4816.494268101851, 4821.397325334333, 4827.300041493982, 4829.372181616385, 4829.7826597803005, 4607.608353289975, 4638.489766125724, 4735.218688916342, 4739.763011849411, 4748.738819364934, 4743.810247590092, 4762.380890484214, 4774.785134668949, 4779.545943135397, 4798.928016079744, 4200.7479551227025, 4201.0, 4201.369794530814, 4201.516825565069, 4202.411662367271, 6043.8791224175275, 6059.2728872535135, 6062.696865156769, 6070.392960703938, 6072.240969878765, 5572.192032155355, 5574.136008918624, 5575.107982722786, 5575.2473416088715, 5583.776648934037, 6449.967750161266, 6569.967150164266, 6576.243731970837, 6577.013447982841, 6583.967080164616, 4639.118567472169, 4652.371929789469, 4656.348111264426, 4656.441227052742, 4669.369635099252, 6883.827904302382, 6895.827604309882, 6897.862042759117, 6898.827529311757, 6903.240643529258, 4749.216379297446, 4750.3824502815105, 4752.453467851241, 4753.904921901542, 4760.214564596803, 4823.734694591831, 4824.565789079, 4825.662203645781, 4831.0, 4832.44426890905, 5419.918701219485, 5517.062099443105, 5531.3915469298345, 5541.5289700375115, 5541.806036788693, 6640.435562977104, 6662.067310576524, 6674.365935236145, 6676.766313179015, 6680.699368528428, 1576.8659663928695, 1663.6007358233937, 1675.874309426798, 1699.8215187405392, 1700.846923776866, 1131.416017575401, 1133.4276190523897, 1143.17691262291, 1144.8683401408778, 1146.9770604587861, 6429.292777794439, 6432.74269029243, 6440.677966101676, 6442.516811239176, 6450.516211284173, 6792.0, 6793.558418702769, 6809.285025072296, 6812.216595091628, 6816.795496135124, 6439.7424103035355, 6440.516961227927, 6447.903281450782, 6451.580647257913, 6457.773977910751, 3663.7435379523176, 3693.3351996640326, 3699.445083237482, 3700.7594506357, 3701.6298370162767, 6900.723971041202, 7073.363397294268, 7083.574985500886, 7092.645367731593, 7096.0, 6878.793636190922, 6889.311068893071, 6895.138107736533, 6899.310068993161, 6905.205901321412, 7056.92943070573, 7060.5410648308725, 7070.36366726997, 7072.5402848814665, 7072.787816365517, 6792.796216113525, 6794.184697836291, 6795.082663840516, 6806.081179040766, 6810.148731408574, 6551.541392102507, 6690.899636505359, 6701.66491675424, 6711.563748356341, 6712.362325579063, 7045.295470452914, 7054.964725176341, 7055.858882822417, 7063.858722825412, 7069.893951590833, 4794.137055330074, 4794.952050479451, 4796.592289655418, 4798.640101992295, 4804.25534042224, 6671.299513551007, 6790.660466976533, 6798.660066996729, 6803.183617965876, 6810.8637827244165, 6530.738770449128, 6695.296993815579, 6719.899201512079, 6738.831529211809, 6746.190457145174, 6616.239132499824, 6703.0, 6707.731690732316, 6707.765228216989, 6707.966460167668, 6574.934250657432, 6581.6709164540625, 6599.208095028627, 6602.40578347951, 6612.966935165294, 6594.472442204708, 6756.358145976124, 6768.289329620319, 6769.729210831511, 6780.491463140383, 6562.343765623399, 6599.4390476808085, 6602.240742314503, 6608.471322294301, 6610.735570577123], "value": 5019.569706443861, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [895.8387490251752, 898.9280857531396, 899.6356475627373, 901.9052999435061, 915.8168366326736, 14754.409823607057, 14789.852101478982, 14894.255287235635, 14954.327055282525, 15546.0, 13124.409401576928, 13226.470941162366, 13236.205827650349, 13321.866781332184, 13354.799678004838, 741.7033186725299, 867.1761826265042, 872.5986046418654, 873.244643383472, 891.1979218703154, 886.5434301334818, 887.6715615222377, 889.3729920406098, 889.666375109334, 890.4078787606234, 931.7856892914633, 937.723371605378, 938.6667732954805, 938.9389689670184, 938.9906100938972, 773.6054612147817, 908.554808144008, 923.8521836506127, 925.0703043441298, 932.2076235200093, 678.4741825085549, 678.9592624442499, 680.4930326906486, 680.5236334565774, 680.6936878404738, 14243.857561424356, 14251.928740356336, 14304.213268270241, 14403.639909002253, 14411.351489183013, 14442.49451269211, 14482.34829432678, 14580.854191458162, 14778.48275310359, 14902.552923412315, 12081.758364832742, 12260.325682087481, 12347.62957111288, 12474.0, 12489.50041998319, 3973.7417067890783, 4005.0, 4012.859549915768, 4021.1756589899, 4068.816903239361, 55604.44395556074, 55767.16349254724, 55770.72114639401, 55970.0, 56113.71943140299, 10787.352758834495, 10965.067969222546, 11920.701982450508, 11980.520779168735, 12117.818232726517, 19672.114754836068, 19870.60258794816, 19962.10170542329, 19978.500537486678, 19982.90008549977, 8236.50580965144, 8258.958705206556, 8966.282697384193, 9019.052999435096, 9087.500187489619, 4927.556519913153, 4978.850634480971, 5104.2343648453025, 5105.617078719111, 5137.40919794221, 3238.4008958342783, 3259.5925509311337, 3273.558069660613, 3280.917977050593, 3282.819444930504, 553.0, 605.9394060593905, 669.8961660942562, 672.6300534705892, 672.8856094463953, 700.3871612339203, 768.5465575310593, 770.0105364606454, 791.2355447352321, 823.8764185372243, 9554.283428742732, 9711.36876103051, 9896.25778066648, 10022.0, 10458.843117353246, 755.7997130760353, 813.9145389734111, 815.6166601697192, 833.8040560468285, 839.3327304792705, 4441.800118994653, 4541.931871021938, 4552.658550608718, 4565.497795242521, 4643.233866412072, 67881.32118678848, 68529.65735171392, 68531.3146868525, 68646.0, 68654.0, 55060.44939550553, 55814.04650837201, 56034.15948760772, 59731.10403343954, 61188.38811611827, 51506.48493515092, 52062.739686302084, 52476.73761631167, 52587.47412525979, 53143.46856531462, 9952.452615106238, 10008.39949603026, 10030.0, 10253.948730256301, 10298.330608510423, 39983.80008099941, 40349.0, 40425.39361909515, 40575.797121014206, 42211.7889410551, 44071.0, 44918.0, 45055.32417013813, 45717.314240285756, 51414.74292628663, 12974.0, 13057.21656700563, 13210.537631182862, 13465.259410732504, 13536.932315338361, 13641.67806115359, 14256.287185640884, 14428.0, 14662.78005829892, 14980.176090315137, 10982.615608453665, 12544.686382840502, 13487.39306731219, 14266.0, 14469.782953255499, 14090.0, 14137.575872723835, 14353.497627582985, 14426.783598246244, 14597.708045839236, 13401.0, 13691.931540342235, 13977.44090236379, 14065.507707230197, 14395.136291822524, 10962.671119866416, 11345.886541134483, 11433.726053066895, 11738.354390508604, 11776.293422394683, 10753.623623173151, 11297.26567773092, 11365.31808091517, 11398.316101033633, 11607.477663504993], "value": 7184.290869765653, "unit": "score"}], "name": "dromaeo_css", "value": 7326.3926800508425, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 111.0, 111.0, 112.0, 113.0, 106.0, 110.0, 111.0, 110.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 126.0, 150.0, 194.0, 127.0, 156.0, 154.0, 127.0, 174.0, 126.0], "value": 148.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 161.0, 159.0, 161.0, 161.0, 159.0, 162.0, 160.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 74.0, 75.0, 173.0, 74.0, 77.0, 75.0, 76.0, 160.0, 76.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 97.0, 164.0, 92.0, 93.0, 92.0, 152.0, 92.0, 93.0, 142.0], "value": 110.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 54.0, 54.0, 54.0, 54.0, 56.0, 79.0, 52.0, 53.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 57.0, 58.0, 58.0, 60.0, 58.0, 58.0, 59.0, 57.0], "value": 58.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 71.0, 72.0, 75.0, 75.0, 82.0, 73.0, 80.0, 73.0], "value": 74.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 111.0, 114.0, 130.0, 113.0, 113.0, 112.0, 112.0, 134.0, 126.0], "value": 119.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 159.0, 165.0, 164.0, 163.0, 161.0, 158.0, 158.0, 162.0, 162.0], "value": 162.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 68.0, 65.0, 66.0, 65.0, 66.0, 67.0, 65.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1517.9, "alertThreshold": 2.0}]} 10:03:50 INFO - Return code: 0 10:03:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:03:50 ERROR - # TBPL SUCCESS # 10:03:50 INFO - Running post-action listener: _resource_record_post_action 10:03:50 INFO - Running post-run listener: _resource_record_post_run 10:03:51 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 266240; Write bytes: 332619776; Read time: 32; Write time: 191996 10:03:51 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 81694720; Read time: 0; Write time: 37532 10:03:51 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 266240; Write bytes: 250925056; Read time: 32; Write time: 154464 10:03:51 INFO - Running post-run listener: _upload_blobber_files 10:03:51 INFO - Blob upload gear active. 10:03:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:03:51 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:03:51 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:03:51 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:03:52 INFO - (blobuploader) - INFO - Open directory for files ... 10:03:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:03:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:03:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:03:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:03:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:03:52 INFO - (blobuploader) - INFO - Done attempting. 10:03:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:03:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:03:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:03:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:03:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:03:53 INFO - (blobuploader) - INFO - Done attempting. 10:03:53 INFO - (blobuploader) - INFO - Iteration through files over. 10:03:53 INFO - Return code: 0 10:03:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:03:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:03:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8507f1a98ebaa575065cfe790215bb91015eefde63439ddc64da4da0164e3d02e1d3c6042fe745d7c358681e7830cbfd4457b1e6b8d793235abebad0fb596909", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0a66462eb29e5b73b4ca14c042db1ea0513c7e867d0d91964f1012568c0cc91d514a2572a0a5f890779790bb3b74335ba8ceff9b0d63d23afe7f8a43a4611c8b"} 10:03:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:03:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:03:53 INFO - Contents: 10:03:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8507f1a98ebaa575065cfe790215bb91015eefde63439ddc64da4da0164e3d02e1d3c6042fe745d7c358681e7830cbfd4457b1e6b8d793235abebad0fb596909", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0a66462eb29e5b73b4ca14c042db1ea0513c7e867d0d91964f1012568c0cc91d514a2572a0a5f890779790bb3b74335ba8ceff9b0d63d23afe7f8a43a4611c8b"} 10:03:53 INFO - Running post-run listener: copy_logs_to_upload_dir 10:03:53 INFO - Copying logs to upload dir... 10:03:53 INFO - mkdir: /builds/slave/test/build/upload/logs 10:03:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.407354 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-19 10:03:53.861762) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 10:03:53.864969) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1463676187.911723-36483592 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8507f1a98ebaa575065cfe790215bb91015eefde63439ddc64da4da0164e3d02e1d3c6042fe745d7c358681e7830cbfd4457b1e6b8d793235abebad0fb596909", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0a66462eb29e5b73b4ca14c042db1ea0513c7e867d0d91964f1012568c0cc91d514a2572a0a5f890779790bb3b74335ba8ceff9b0d63d23afe7f8a43a4611c8b"} build_url:https://queue.taskcluster.net/v1/task/U63WxBMPREyLoAJXBmjePA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011299 build_url: 'https://queue.taskcluster.net/v1/task/U63WxBMPREyLoAJXBmjePA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8507f1a98ebaa575065cfe790215bb91015eefde63439ddc64da4da0164e3d02e1d3c6042fe745d7c358681e7830cbfd4457b1e6b8d793235abebad0fb596909", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0a66462eb29e5b73b4ca14c042db1ea0513c7e867d0d91964f1012568c0cc91d514a2572a0a5f890779790bb3b74335ba8ceff9b0d63d23afe7f8a43a4611c8b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 10:03:53.889808) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 10:03:53.890132) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1463676187.911723-36483592 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004525 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 10:03:53.975378) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 10:03:53.975706) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 10:03:53.976002) ========= ========= Total master_lag: 0.18 =========