builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-018 starttime: 1463036187.09 results: success (0) buildid: 20160511211918 builduid: b5b007d81d4a4000989fa67bcd6e7e31 revision: 2fb177e17d81e069a02797c6234e8ed085cbc55c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 23:56:27.095211) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 23:56:27.095586) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 23:56:27.095851) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 23:56:27.129925) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 23:56:27.130193) ========= 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=62c568580acbfdaac3eec7be000001dc-1463034321.241424-1720971420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-11 23:56:27-- 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% 223M=0s 2016-05-11 23:56:27 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103723 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 23:56:27.249343) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 23:56:27.249855) ========= 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=62c568580acbfdaac3eec7be000001dc-1463034321.241424-1720971420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017241 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 23:56:27.300187) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-11 23:56:27.300529) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2fb177e17d81e069a02797c6234e8ed085cbc55c --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 2fb177e17d81e069a02797c6234e8ed085cbc55c --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=62c568580acbfdaac3eec7be000001dc-1463034321.241424-1720971420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-11 23:56:27,470 truncating revision to first 12 chars 2016-05-11 23:56:27,470 Setting DEBUG logging. 2016-05-11 23:56:27,470 attempt 1/10 2016-05-11 23:56:27,470 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2fb177e17d81?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-11 23:56:28,293 unpacking tar archive at: mozilla-aurora-2fb177e17d81/testing/mozharness/ program finished with exit code 0 elapsedTime=1.093918 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-11 23:56:28.407170) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 23:56:28.407509) ========= script_repo_revision: 2fb177e17d81e069a02797c6234e8ed085cbc55c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 23:56:28.407898) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 23:56:28.408156) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 23:56:28.418372) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-11 23:56:28.418644) ========= /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=62c568580acbfdaac3eec7be000001dc-1463034321.241424-1720971420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:56:28 INFO - MultiFileLogger online at 20160511 23:56:28 in /builds/slave/test 23:56:28 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 23:56:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:56:28 INFO - {'append_to_log': False, 23:56:28 INFO - 'base_work_dir': '/builds/slave/test', 23:56:28 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 23:56:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:56:28 INFO - 'branch': 'Mozilla-Aurora', 23:56:28 INFO - 'buildbot_json_path': 'buildprops.json', 23:56:28 INFO - 'config_files': ('talos/linux_config.py',), 23:56:28 INFO - 'default_actions': ('clobber', 23:56:28 INFO - 'read-buildbot-config', 23:56:28 INFO - 'download-and-extract', 23:56:28 INFO - 'populate-webroot', 23:56:28 INFO - 'create-virtualenv', 23:56:28 INFO - 'install', 23:56:28 INFO - 'run-tests'), 23:56:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:56:28 INFO - 'download_minidump_stackwalk': True, 23:56:28 INFO - 'download_symbols': 'ondemand', 23:56:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:56:28 INFO - 'tooltool.py': '/tools/tooltool.py', 23:56:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:56:28 INFO - '/tools/misc-python/virtualenv.py')}, 23:56:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:56:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:56:28 INFO - 'installer_path': 'installer.exe', 23:56:28 INFO - 'log_level': 'info', 23:56:28 INFO - 'log_name': 'talos', 23:56:28 INFO - 'log_to_console': True, 23:56:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:56:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:56:28 INFO - 'opt_config_files': (), 23:56:28 INFO - 'pip_index': False, 23:56:28 INFO - 'sps_profile': False, 23:56:28 INFO - 'sps_profile_interval': 0, 23:56:28 INFO - 'suite': 'dromaeojs', 23:56:28 INFO - 'system_bits': '32', 23:56:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:56:28 INFO - 'title': 'talos-linux64-ix-018', 23:56:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:56:28 INFO - 'use_talos_json': True, 23:56:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:56:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:56:28 INFO - 'work_dir': 'build'} 23:56:28 INFO - ##### 23:56:28 INFO - ##### Running clobber step. 23:56:28 INFO - ##### 23:56:28 INFO - Running pre-action listener: _resource_record_pre_action 23:56:28 INFO - Running main action method: clobber 23:56:28 INFO - rmtree: /builds/slave/test/build 23:56:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:56:29 INFO - Running post-action listener: _resource_record_post_action 23:56:29 INFO - ##### 23:56:29 INFO - ##### Running read-buildbot-config step. 23:56:29 INFO - ##### 23:56:29 INFO - Running pre-action listener: _resource_record_pre_action 23:56:29 INFO - Running main action method: read_buildbot_config 23:56:29 INFO - Using buildbot properties: 23:56:29 INFO - { 23:56:29 INFO - "project": "", 23:56:29 INFO - "product": "firefox", 23:56:29 INFO - "script_repo_revision": "production", 23:56:29 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 23:56:29 INFO - "repository": "", 23:56:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 23:56:29 INFO - "buildid": "20160511211918", 23:56:29 INFO - "pgo_build": "True", 23:56:29 INFO - "basedir": "/builds/slave/test", 23:56:29 INFO - "buildnumber": 326, 23:56:29 INFO - "slavename": "talos-linux64-ix-018", 23:56:29 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:56:29 INFO - "platform": "ubuntu64_hw", 23:56:29 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 23:56:29 INFO - "branch": "mozilla-aurora", 23:56:29 INFO - "repo_path": "releases/mozilla-aurora", 23:56:29 INFO - "revision": "2fb177e17d81e069a02797c6234e8ed085cbc55c", 23:56:29 INFO - "stage_platform": "linux64-pgo", 23:56:29 INFO - "builduid": "b5b007d81d4a4000989fa67bcd6e7e31", 23:56:29 INFO - "slavebuilddir": "test" 23:56:29 INFO - } 23:56:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 23:56:29 INFO - Running post-action listener: _resource_record_post_action 23:56:29 INFO - ##### 23:56:29 INFO - ##### Running download-and-extract step. 23:56:29 INFO - ##### 23:56:29 INFO - Running pre-action listener: _resource_record_pre_action 23:56:29 INFO - Running main action method: download_and_extract 23:56:29 INFO - mkdir: /builds/slave/test/build/tests 23:56: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')]} 23:56:29 INFO - https://queue.taskcluster.net/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:56:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 23:56:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 23:56:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/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 23:56:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/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 23:56:31 INFO - Downloaded 1361 bytes. 23:56:31 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 23:56:31 INFO - Using the following test package requirements: 23:56:31 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 23:56:31 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 23:56:31 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 23:56:31 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 23:56:31 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 23:56:31 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 23:56:31 INFO - u'jsshell-linux-x86_64.zip'], 23:56:31 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 23:56:31 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 23:56:31 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 23:56:31 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 23:56:31 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 23:56:31 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 23:56:31 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 23:56:31 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 23:56:31 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 23:56:31 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 23:56:31 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 23:56:31 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:56:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:56:31 INFO - https://queue.taskcluster.net/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:56:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 23:56:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 23:56:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/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 23:56:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/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 23:56:36 INFO - Downloaded 23800103 bytes. 23:56:36 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'] 23:56:36 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 23:56:37 INFO - Return code: 0 23:56:37 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 23:56:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:56:37 INFO - https://queue.taskcluster.net/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:56:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 23:56:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 23:56:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/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 23:56:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/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 23:56:39 INFO - Downloaded 23800103 bytes. 23:56:39 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'] 23:56:39 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 23:56:40 INFO - Return code: 0 23:56: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')]} 23:56:40 INFO - https://queue.taskcluster.net/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:56:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 23:56:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 23:56:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/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 23:56:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/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 23:56:41 INFO - Downloaded 10840145 bytes. 23:56:41 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'] 23:56:41 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 23:56:42 INFO - Return code: 0 23:56:42 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')]} 23:56:42 INFO - https://queue.taskcluster.net/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:56:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 23:56:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 23:56:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/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 23:56:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/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 23:56:47 INFO - Downloaded 62692424 bytes. 23:56:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 23:56:47 INFO - mkdir: /builds/slave/test/properties 23:56:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:56:47 INFO - Writing to file /builds/slave/test/properties/build_url 23:56:47 INFO - Contents: 23:56:47 INFO - build_url:https://queue.taskcluster.net/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 23:56:47 INFO - Running post-action listener: _resource_record_post_action 23:56:47 INFO - Running post-action listener: set_extra_try_arguments 23:56:47 INFO - ##### 23:56:47 INFO - ##### Running populate-webroot step. 23:56:47 INFO - ##### 23:56:47 INFO - Running pre-action listener: _resource_record_pre_action 23:56:47 INFO - Running main action method: populate_webroot 23:56:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:56:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:56:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:56:47 INFO - '--tppagecycles', 23:56:47 INFO - '7'], 23:56:47 INFO - 'tests': ['tsvgm']}}, 23:56:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:56:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:56:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:56:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:56:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:56:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:56:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:56:47 INFO - 'talos_options': ['--disable-e10s'], 23:56:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:56:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:56:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:56:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:56:47 INFO - 'talos_options': ['--disable-e10s'], 23:56:47 INFO - 'tests': ['damp', 'tps']}, 23:56:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:56:47 INFO - 'tests': ['damp', 'tps']}, 23:56:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:56:47 INFO - 'tests': ['dromaeo_dom']}, 23:56:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:56:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:56:47 INFO - 'tests': ['a11yr', 23:56:47 INFO - 'ts_paint', 23:56:47 INFO - 'tpaint', 23:56:47 INFO - 'sessionrestore', 23:56:47 INFO - 'sessionrestore_no_auto_restore', 23:56:47 INFO - 'tabpaint']}, 23:56:47 INFO - 'other-e10s': {'tests': ['a11yr', 23:56:47 INFO - 'ts_paint', 23:56:47 INFO - 'tpaint', 23:56:47 INFO - 'sessionrestore', 23:56:47 INFO - 'sessionrestore_no_auto_restore', 23:56:47 INFO - 'tabpaint']}, 23:56:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:56:47 INFO - 'ts_paint', 23:56:47 INFO - 'tpaint', 23:56:47 INFO - 'sessionrestore', 23:56:47 INFO - 'sessionrestore_no_auto_restore', 23:56:47 INFO - 'tabpaint']}, 23:56:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:56:47 INFO - 'ts_paint', 23:56:47 INFO - 'tpaint', 23:56:47 INFO - 'sessionrestore', 23:56:47 INFO - 'sessionrestore_no_auto_restore', 23:56:47 INFO - 'tabpaint']}, 23:56:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:56:47 INFO - 'tests': ['a11yr', 23:56:47 INFO - 'ts_paint', 23:56:47 INFO - 'tpaint', 23:56:47 INFO - 'sessionrestore', 23:56:47 INFO - 'sessionrestore_no_auto_restore', 23:56:47 INFO - 'tabpaint']}, 23:56:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:56:47 INFO - 'tests': ['a11yr', 23:56:47 INFO - 'ts_paint', 23:56:47 INFO - 'tpaint', 23:56:47 INFO - 'sessionrestore', 23:56:47 INFO - 'sessionrestore_no_auto_restore', 23:56:47 INFO - 'tabpaint']}, 23:56:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:56:47 INFO - 'tests': ['tsvgx', 23:56:47 INFO - 'tsvgr_opacity', 23:56:47 INFO - 'tart', 23:56:47 INFO - 'tscrollx', 23:56:47 INFO - 'cart']}, 23:56:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:56:47 INFO - 'tsvgr_opacity', 23:56:47 INFO - 'tart', 23:56:47 INFO - 'tscrollx', 23:56:47 INFO - 'cart']}, 23:56:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:56:47 INFO - 'talos_options': ['--disable-e10s'], 23:56:47 INFO - 'tests': ['tp5o']}, 23:56:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:56:47 INFO - 'tests': ['tp5o']}, 23:56:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:56:47 INFO - 'talos_options': ['--disable-e10s', 23:56:47 INFO - '--xperf_path', 23:56:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:56:47 INFO - 'tests': ['tp5n']}, 23:56:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:56:47 INFO - 'talos_options': ['--xperf_path', 23:56:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:56:47 INFO - 'tests': ['tp5n']}}, 23:56:47 INFO - 'talos.zip': {'path': '', 23:56:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:56:47 INFO - Running post-action listener: _resource_record_post_action 23:56:47 INFO - ##### 23:56:47 INFO - ##### Running create-virtualenv step. 23:56:47 INFO - ##### 23:56:47 INFO - Running pre-action listener: _resource_record_pre_action 23:56:47 INFO - Running main action method: create_virtualenv 23:56:47 INFO - Creating virtualenv /builds/slave/test/build/venv 23:56:47 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 23:56:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:56:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:56:47 INFO - Using real prefix '/usr' 23:56:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:56:48 INFO - Installing distribute.............................................................................................................................................................................................done. 23:56:50 INFO - Installing pip.................done. 23:56:50 INFO - Return code: 0 23:56:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:56:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:56:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:56:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:56:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:56:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:56:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f072ca0cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x257a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2609410>, '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 0x260a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260a7a0>, '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': '62c568580acbfdaac3eec7be000001dc-1463034321.241424-1720971420', '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 23:56:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:56:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:56:50 INFO - Using env: {'DISPLAY': ':0', 23:56:50 INFO - 'HOME': '/home/cltbld', 23:56:50 INFO - 'LANG': 'en_US.UTF-8', 23:56:50 INFO - 'LANGUAGE': 'en_US:en', 23:56:50 INFO - 'LOGNAME': 'cltbld', 23:56:50 INFO - 'MAIL': '/var/mail/cltbld', 23:56:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:56:50 INFO - 'MOZ_NO_REMOTE': '1', 23:56:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:56:50 INFO - 'NO_EM_RESTART': '1', 23:56:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:56:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:56:50 INFO - 'PWD': '/builds/slave/test', 23:56:50 INFO - 'SHELL': '/bin/bash', 23:56:50 INFO - 'SHLVL': '1', 23:56:50 INFO - 'TERM': 'linux', 23:56:50 INFO - 'TMOUT': '86400', 23:56:50 INFO - 'USER': 'cltbld', 23:56:50 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463034321.241424-1720971420', 23:56:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:56:50 INFO - '_': '/tools/buildbot/bin/python'} 23:56:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:56:50 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 23:56:50 INFO - Cleaning up... 23:56:50 INFO - Return code: 0 23:56:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 23:56:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:56:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:56:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:56:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:56:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:56:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f072ca0cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x257a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2609410>, '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 0x260a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260a7a0>, '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': '62c568580acbfdaac3eec7be000001dc-1463034321.241424-1720971420', '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 23:56:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 23:56:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 23:56:50 INFO - Using env: {'DISPLAY': ':0', 23:56:50 INFO - 'HOME': '/home/cltbld', 23:56:50 INFO - 'LANG': 'en_US.UTF-8', 23:56:50 INFO - 'LANGUAGE': 'en_US:en', 23:56:50 INFO - 'LOGNAME': 'cltbld', 23:56:50 INFO - 'MAIL': '/var/mail/cltbld', 23:56:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:56:50 INFO - 'MOZ_NO_REMOTE': '1', 23:56:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:56:50 INFO - 'NO_EM_RESTART': '1', 23:56:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:56:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:56:50 INFO - 'PWD': '/builds/slave/test', 23:56:50 INFO - 'SHELL': '/bin/bash', 23:56:50 INFO - 'SHLVL': '1', 23:56:50 INFO - 'TERM': 'linux', 23:56:50 INFO - 'TMOUT': '86400', 23:56:50 INFO - 'USER': 'cltbld', 23:56:50 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463034321.241424-1720971420', 23:56:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:56:50 INFO - '_': '/tools/buildbot/bin/python'} 23:56:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:56:50 INFO - Downloading/unpacking psutil>=0.7.1 23:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:56:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:56:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:56:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:56:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:56:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:56:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:56:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:56:52 INFO - Installing collected packages: psutil 23:56:52 INFO - Running setup.py install for psutil 23:56:52 INFO - building 'psutil._psutil_linux' extension 23:56:52 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 23:56:53 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 23:56:53 INFO - building 'psutil._psutil_posix' extension 23:56:53 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 23:56:53 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 23:56:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:56:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:56:53 INFO - Successfully installed psutil 23:56:53 INFO - Cleaning up... 23:56:54 INFO - Return code: 0 23:56:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 23:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:56:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:56:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:56:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:56:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f072ca0cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x257a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2609410>, '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 0x260a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260a7a0>, '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': '62c568580acbfdaac3eec7be000001dc-1463034321.241424-1720971420', '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 23:56:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 23:56:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 23:56:54 INFO - Using env: {'DISPLAY': ':0', 23:56:54 INFO - 'HOME': '/home/cltbld', 23:56:54 INFO - 'LANG': 'en_US.UTF-8', 23:56:54 INFO - 'LANGUAGE': 'en_US:en', 23:56:54 INFO - 'LOGNAME': 'cltbld', 23:56:54 INFO - 'MAIL': '/var/mail/cltbld', 23:56:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:56:54 INFO - 'MOZ_NO_REMOTE': '1', 23:56:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:56:54 INFO - 'NO_EM_RESTART': '1', 23:56:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:56:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:56:54 INFO - 'PWD': '/builds/slave/test', 23:56:54 INFO - 'SHELL': '/bin/bash', 23:56:54 INFO - 'SHLVL': '1', 23:56:54 INFO - 'TERM': 'linux', 23:56:54 INFO - 'TMOUT': '86400', 23:56:54 INFO - 'USER': 'cltbld', 23:56:54 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463034321.241424-1720971420', 23:56:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:56:54 INFO - '_': '/tools/buildbot/bin/python'} 23:56:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:56:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:56:55 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 23:56:55 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 23:56:55 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 23:56:55 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 23:56:55 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 23:56:55 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 23:56:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:56:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:56:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:56:56 INFO - Installing collected packages: mozsystemmonitor 23:56:56 INFO - Running setup.py install for mozsystemmonitor 23:56:57 INFO - Successfully installed mozsystemmonitor 23:56:57 INFO - Cleaning up... 23:56:57 INFO - Return code: 0 23:56:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:56:57 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')]} 23:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:56:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:56:57 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')]} 23:56:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:56:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:56:57 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 0x7f072ca0cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x257a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2609410>, '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 0x260a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260a7a0>, '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': '62c568580acbfdaac3eec7be000001dc-1463034321.241424-1720971420', '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 23:56:57 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 23:56:57 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 23:56:57 INFO - Using env: {'DISPLAY': ':0', 23:56:57 INFO - 'HOME': '/home/cltbld', 23:56:57 INFO - 'LANG': 'en_US.UTF-8', 23:56:57 INFO - 'LANGUAGE': 'en_US:en', 23:56:57 INFO - 'LOGNAME': 'cltbld', 23:56:57 INFO - 'MAIL': '/var/mail/cltbld', 23:56:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:56:57 INFO - 'MOZ_NO_REMOTE': '1', 23:56:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:56:57 INFO - 'NO_EM_RESTART': '1', 23:56:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:56:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:56:57 INFO - 'PWD': '/builds/slave/test', 23:56:57 INFO - 'SHELL': '/bin/bash', 23:56:57 INFO - 'SHLVL': '1', 23:56:57 INFO - 'TERM': 'linux', 23:56:57 INFO - 'TMOUT': '86400', 23:56:57 INFO - 'USER': 'cltbld', 23:56:57 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463034321.241424-1720971420', 23:56:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:56:57 INFO - '_': '/tools/buildbot/bin/python'} 23:56:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:56:57 INFO - Downloading/unpacking blobuploader==1.2.4 23:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:56:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:56:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:56:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:56:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:56:59 INFO - Downloading blobuploader-1.2.4.tar.gz 23:56:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:56:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:56: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 23:56: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 23:56: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 23:56: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 23:56: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 23:56: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 23:56:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:56:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:56: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 23:56: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 23:56: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 23:56: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 23:56: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 23:56: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 23:56:59 INFO - Downloading docopt-0.6.1.tar.gz 23:56:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:56:59 INFO - Installing collected packages: blobuploader, requests, docopt 23:56:59 INFO - Running setup.py install for blobuploader 23:56:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:56:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:56:59 INFO - Running setup.py install for requests 23:57:00 INFO - Running setup.py install for docopt 23:57:00 INFO - Successfully installed blobuploader requests docopt 23:57:00 INFO - Cleaning up... 23:57:00 INFO - Return code: 0 23:57:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:57:00 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')]} 23:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:57:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:57:00 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')]} 23:57:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:57:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:57:00 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 0x7f072ca0cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x257a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2609410>, '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 0x260a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260a7a0>, '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': '62c568580acbfdaac3eec7be000001dc-1463034321.241424-1720971420', '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 23:57:00 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 23:57:00 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 23:57:00 INFO - Using env: {'DISPLAY': ':0', 23:57:00 INFO - 'HOME': '/home/cltbld', 23:57:00 INFO - 'LANG': 'en_US.UTF-8', 23:57:00 INFO - 'LANGUAGE': 'en_US:en', 23:57:00 INFO - 'LOGNAME': 'cltbld', 23:57:00 INFO - 'MAIL': '/var/mail/cltbld', 23:57:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:57:00 INFO - 'MOZ_NO_REMOTE': '1', 23:57:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:57:00 INFO - 'NO_EM_RESTART': '1', 23:57:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:57:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:57:00 INFO - 'PWD': '/builds/slave/test', 23:57:00 INFO - 'SHELL': '/bin/bash', 23:57:00 INFO - 'SHLVL': '1', 23:57:00 INFO - 'TERM': 'linux', 23:57:00 INFO - 'TMOUT': '86400', 23:57:00 INFO - 'USER': 'cltbld', 23:57:00 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463034321.241424-1720971420', 23:57:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:57:00 INFO - '_': '/tools/buildbot/bin/python'} 23:57:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:57:00 INFO - Running setup.py (path:/tmp/pip-9taveF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:57:00 INFO - Running setup.py (path:/tmp/pip-BSycfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:57:00 INFO - Running setup.py (path:/tmp/pip-164yWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:57:00 INFO - Running setup.py (path:/tmp/pip-W2gkwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:57:01 INFO - Running setup.py (path:/tmp/pip-0HKNAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:57:01 INFO - Running setup.py (path:/tmp/pip-bO_C3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:57:01 INFO - Running setup.py (path:/tmp/pip-NOaTS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:57:01 INFO - Running setup.py (path:/tmp/pip-RzLAbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:57:01 INFO - Running setup.py (path:/tmp/pip-puSTFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:57:01 INFO - Running setup.py (path:/tmp/pip-ekqyRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:57:01 INFO - Running setup.py (path:/tmp/pip-QiEjb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:57:01 INFO - Running setup.py (path:/tmp/pip-bJGxqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:57:01 INFO - Running setup.py (path:/tmp/pip-LqIpcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:57:01 INFO - Running setup.py (path:/tmp/pip-p77y4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:57:01 INFO - Running setup.py (path:/tmp/pip-zmGNzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:57:01 INFO - Running setup.py (path:/tmp/pip-nkSEGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:57:01 INFO - Running setup.py (path:/tmp/pip-DESkF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:57:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:57:01 INFO - Running setup.py install for manifestparser 23:57:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:57:02 INFO - Running setup.py install for mozcrash 23:57:02 INFO - Running setup.py install for mozdebug 23:57:02 INFO - Running setup.py install for mozdevice 23:57:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:57:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:57:02 INFO - Running setup.py install for mozfile 23:57:02 INFO - Running setup.py install for mozhttpd 23:57:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:57:02 INFO - Running setup.py install for mozinfo 23:57:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:57:02 INFO - Running setup.py install for mozInstall 23:57:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:57:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:57:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:57:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:57:02 INFO - Running setup.py install for mozleak 23:57:02 INFO - Running setup.py install for mozlog 23:57:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:57:02 INFO - Running setup.py install for moznetwork 23:57:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:57:03 INFO - Running setup.py install for mozprocess 23:57:03 INFO - Running setup.py install for mozprofile 23:57:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:57:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:57:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:57:03 INFO - Running setup.py install for mozrunner 23:57:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:57:03 INFO - Running setup.py install for mozscreenshot 23:57:03 INFO - Running setup.py install for moztest 23:57:03 INFO - Running setup.py install for mozversion 23:57:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:57:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:57:03 INFO - Cleaning up... 23:57:03 INFO - Return code: 0 23:57:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:57:03 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')]} 23:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:57:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:57:03 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')]} 23:57:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:57:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:57:03 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 0x7f072ca0cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x257a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2609410>, '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 0x260a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260a7a0>, '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': '62c568580acbfdaac3eec7be000001dc-1463034321.241424-1720971420', '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 23:57:03 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 23:57:03 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 23:57:03 INFO - Using env: {'DISPLAY': ':0', 23:57:03 INFO - 'HOME': '/home/cltbld', 23:57:03 INFO - 'LANG': 'en_US.UTF-8', 23:57:03 INFO - 'LANGUAGE': 'en_US:en', 23:57:03 INFO - 'LOGNAME': 'cltbld', 23:57:03 INFO - 'MAIL': '/var/mail/cltbld', 23:57:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:57:03 INFO - 'MOZ_NO_REMOTE': '1', 23:57:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:57:03 INFO - 'NO_EM_RESTART': '1', 23:57:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:57:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:57:03 INFO - 'PWD': '/builds/slave/test', 23:57:03 INFO - 'SHELL': '/bin/bash', 23:57:03 INFO - 'SHLVL': '1', 23:57:03 INFO - 'TERM': 'linux', 23:57:03 INFO - 'TMOUT': '86400', 23:57:03 INFO - 'USER': 'cltbld', 23:57:03 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463034321.241424-1720971420', 23:57:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:57:03 INFO - '_': '/tools/buildbot/bin/python'} 23:57:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:57:03 INFO - Running setup.py (path:/tmp/pip-Dv5qWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:57:03 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)) 23:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:57:03 INFO - Running setup.py (path:/tmp/pip-ZL04Az-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:57:04 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)) 23:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:57:04 INFO - Running setup.py (path:/tmp/pip-OWs53p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:57:04 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)) 23:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:57:04 INFO - Running setup.py (path:/tmp/pip-IYCbzy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:57:04 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)) 23:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:57:04 INFO - Running setup.py (path:/tmp/pip-0lfkm_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:57:04 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)) 23:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:57:04 INFO - Running setup.py (path:/tmp/pip-SYXSxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:57:04 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)) 23:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:57:04 INFO - Running setup.py (path:/tmp/pip-g2B4eF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:57:04 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)) 23:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:57:04 INFO - Running setup.py (path:/tmp/pip-5b6RlR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:57:04 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)) 23:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:57:04 INFO - Running setup.py (path:/tmp/pip-5gubk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:57:04 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)) 23:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:57:04 INFO - Running setup.py (path:/tmp/pip-xrgmyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:57:04 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)) 23:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:57:04 INFO - Running setup.py (path:/tmp/pip-3ZavJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:57:04 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)) 23:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:57:04 INFO - Running setup.py (path:/tmp/pip-tSuD1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:57:04 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)) 23:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:57:04 INFO - Running setup.py (path:/tmp/pip-b4LySs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:57:04 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)) 23:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:57:04 INFO - Running setup.py (path:/tmp/pip-igvlDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:57:04 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)) 23:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:57:04 INFO - Running setup.py (path:/tmp/pip-i7h4kB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:57:05 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)) 23:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:57:05 INFO - Running setup.py (path:/tmp/pip-P4bhFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:57:05 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)) 23:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:57:05 INFO - Running setup.py (path:/tmp/pip-6a_QBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:57:05 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)) 23:57:05 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)) 23:57:05 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)) 23:57:05 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)) 23:57:05 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)) 23:57:05 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)) 23:57:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:57:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:57:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:57:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:57:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:57:07 INFO - Downloading blessings-1.6.tar.gz 23:57:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:57:07 INFO - Installing collected packages: blessings 23:57:07 INFO - Running setup.py install for blessings 23:57:07 INFO - Successfully installed blessings 23:57:07 INFO - Cleaning up... 23:57:07 INFO - Return code: 0 23:57:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:57:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:57:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:57:07 INFO - Reading from file tmpfile_stdout 23:57:07 INFO - Current package versions: 23:57:07 INFO - argparse == 1.2.1 23:57:07 INFO - blessings == 1.6 23:57:07 INFO - blobuploader == 1.2.4 23:57:07 INFO - docopt == 0.6.1 23:57:07 INFO - manifestparser == 1.1 23:57:07 INFO - mozInstall == 1.12 23:57:07 INFO - mozcrash == 0.17 23:57:07 INFO - mozdebug == 0.1 23:57:07 INFO - mozdevice == 0.48 23:57:07 INFO - mozfile == 1.2 23:57:07 INFO - mozhttpd == 0.7 23:57:07 INFO - mozinfo == 0.9 23:57:07 INFO - mozleak == 0.1 23:57:07 INFO - mozlog == 3.1 23:57:07 INFO - moznetwork == 0.27 23:57:07 INFO - mozprocess == 0.22 23:57:07 INFO - mozprofile == 0.28 23:57:07 INFO - mozrunner == 6.11 23:57:07 INFO - mozscreenshot == 0.1 23:57:07 INFO - mozsystemmonitor == 0.0 23:57:07 INFO - moztest == 0.7 23:57:07 INFO - mozversion == 1.4 23:57:07 INFO - psutil == 3.1.1 23:57:07 INFO - requests == 1.2.3 23:57:07 INFO - wsgiref == 0.1.2 23:57:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:57:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:57:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:57:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:57:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:57:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:57:07 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 0x7f072ca0cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x257a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2609410>, '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 0x260a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260a7a0>, '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': '62c568580acbfdaac3eec7be000001dc-1463034321.241424-1720971420', '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 23:57:07 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 23:57:07 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 23:57:07 INFO - Using env: {'DISPLAY': ':0', 23:57:07 INFO - 'HOME': '/home/cltbld', 23:57:07 INFO - 'LANG': 'en_US.UTF-8', 23:57:07 INFO - 'LANGUAGE': 'en_US:en', 23:57:07 INFO - 'LOGNAME': 'cltbld', 23:57:07 INFO - 'MAIL': '/var/mail/cltbld', 23:57:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:57:07 INFO - 'MOZ_NO_REMOTE': '1', 23:57:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:57:07 INFO - 'NO_EM_RESTART': '1', 23:57:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:57:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:57:07 INFO - 'PWD': '/builds/slave/test', 23:57:07 INFO - 'SHELL': '/bin/bash', 23:57:07 INFO - 'SHLVL': '1', 23:57:07 INFO - 'TERM': 'linux', 23:57:07 INFO - 'TMOUT': '86400', 23:57:07 INFO - 'USER': 'cltbld', 23:57:07 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463034321.241424-1720971420', 23:57:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:57:07 INFO - '_': '/tools/buildbot/bin/python'} 23:57:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:57:07 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)) 23:57:07 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)) 23:57:07 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)) 23:57:07 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)) 23:57:07 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)) 23:57:07 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)) 23:57:07 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)) 23:57:07 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)) 23:57:07 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)) 23:57:07 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)) 23:57:07 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)) 23:57:07 INFO - Cleaning up... 23:57:07 INFO - Return code: 0 23:57:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:57:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:57:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:57:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:57:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:57:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:57:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f072ca0cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x257a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2609410>, '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 0x260a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260a7a0>, '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': '62c568580acbfdaac3eec7be000001dc-1463034321.241424-1720971420', '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 23:57:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:57:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:57:07 INFO - Using env: {'DISPLAY': ':0', 23:57:07 INFO - 'HOME': '/home/cltbld', 23:57:07 INFO - 'LANG': 'en_US.UTF-8', 23:57:07 INFO - 'LANGUAGE': 'en_US:en', 23:57:07 INFO - 'LOGNAME': 'cltbld', 23:57:07 INFO - 'MAIL': '/var/mail/cltbld', 23:57:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:57:07 INFO - 'MOZ_NO_REMOTE': '1', 23:57:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:57:07 INFO - 'NO_EM_RESTART': '1', 23:57:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:57:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:57:07 INFO - 'PWD': '/builds/slave/test', 23:57:07 INFO - 'SHELL': '/bin/bash', 23:57:07 INFO - 'SHLVL': '1', 23:57:07 INFO - 'TERM': 'linux', 23:57:07 INFO - 'TMOUT': '86400', 23:57:07 INFO - 'USER': 'cltbld', 23:57:07 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463034321.241424-1720971420', 23:57:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:57:07 INFO - '_': '/tools/buildbot/bin/python'} 23:57:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:57:07 INFO - Downloading/unpacking jsonschema 23:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:57:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:57:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:57:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:57:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:57:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:57:09 INFO - Downloading/unpacking functools32 (from jsonschema) 23:57:09 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 23:57:09 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 23:57:09 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 23:57:09 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 23:57:09 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 23:57:09 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 23:57:09 INFO - Downloading functools32-3.2.3-2.tar.gz 23:57:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:57:10 INFO - warning: no files found matching '*.txt' 23:57:10 INFO - no previously-included directories found matching 'build' 23:57:10 INFO - no previously-included directories found matching 'dist' 23:57:10 INFO - no previously-included directories found matching '.git*' 23:57:10 INFO - Installing collected packages: jsonschema, functools32 23:57:10 INFO - Running setup.py install for functools32 23:57:10 INFO - warning: no files found matching '*.txt' 23:57:10 INFO - no previously-included directories found matching 'build' 23:57:10 INFO - no previously-included directories found matching 'dist' 23:57:10 INFO - no previously-included directories found matching '.git*' 23:57:10 INFO - Successfully installed jsonschema functools32 23:57:10 INFO - Cleaning up... 23:57:10 INFO - Return code: 0 23:57:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:57:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:57:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:57:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:57:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:57:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:57:10 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 0x7f072ca0cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x257a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2609410>, '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 0x260a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260a7a0>, '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': '62c568580acbfdaac3eec7be000001dc-1463034321.241424-1720971420', '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 23:57:10 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 23:57:10 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 23:57:10 INFO - Using env: {'DISPLAY': ':0', 23:57:10 INFO - 'HOME': '/home/cltbld', 23:57:10 INFO - 'LANG': 'en_US.UTF-8', 23:57:10 INFO - 'LANGUAGE': 'en_US:en', 23:57:10 INFO - 'LOGNAME': 'cltbld', 23:57:10 INFO - 'MAIL': '/var/mail/cltbld', 23:57:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:57:10 INFO - 'MOZ_NO_REMOTE': '1', 23:57:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:57:10 INFO - 'NO_EM_RESTART': '1', 23:57:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:57:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:57:10 INFO - 'PWD': '/builds/slave/test', 23:57:10 INFO - 'SHELL': '/bin/bash', 23:57:10 INFO - 'SHLVL': '1', 23:57:10 INFO - 'TERM': 'linux', 23:57:10 INFO - 'TMOUT': '86400', 23:57:10 INFO - 'USER': 'cltbld', 23:57:10 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463034321.241424-1720971420', 23:57:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:57:10 INFO - '_': '/tools/buildbot/bin/python'} 23:57:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:57:10 INFO - Downloading/unpacking flake8 23:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:57:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:57:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:57:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:57:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:57:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:57:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:57:12 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 23:57:12 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 23:57:12 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 23:57:12 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 23:57:12 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 23:57:12 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 23:57:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:57:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:57:12 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 23:57:12 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 23:57:12 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 23:57:12 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 23:57:12 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 23:57:12 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 23:57:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:57:12 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 23:57:12 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 23:57:12 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 23:57:12 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 23:57:12 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 23:57:12 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 23:57:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:57:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:57:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:57:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:57:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:57:13 INFO - no previously-included directories found matching 'docs/_build' 23:57:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:57:13 INFO - Running setup.py install for pep8 23:57:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:57:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:57:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:57:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:57:13 INFO - no previously-included directories found matching 'docs/_build' 23:57:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:57:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:57:13 INFO - Cleaning up... 23:57:13 INFO - Return code: 0 23:57:13 INFO - Running post-action listener: _resource_record_post_action 23:57:13 INFO - Running post-action listener: _start_resource_monitoring 23:57:13 INFO - Starting resource monitoring. 23:57:13 INFO - ##### 23:57:13 INFO - ##### Running install step. 23:57:13 INFO - ##### 23:57:13 INFO - Running pre-action listener: _resource_record_pre_action 23:57:13 INFO - Running main action method: install 23:57:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:57:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:57:13 INFO - Reading from file tmpfile_stdout 23:57:13 INFO - Detecting whether we're running mozinstall >=1.0... 23:57:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:57:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:57:13 INFO - Reading from file tmpfile_stdout 23:57:13 INFO - Output received: 23:57:13 INFO - Usage: mozinstall [options] installer 23:57:13 INFO - Options: 23:57:13 INFO - -h, --help show this help message and exit 23:57:13 INFO - -d DEST, --destination=DEST 23:57:13 INFO - Directory to install application into. [default: 23:57:13 INFO - "/builds/slave/test"] 23:57:13 INFO - --app=APP Application being installed. [default: firefox] 23:57:13 INFO - mkdir: /builds/slave/test/build/application 23:57:13 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'] 23:57:13 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 23:57:29 INFO - Reading from file tmpfile_stdout 23:57:29 INFO - Output received: 23:57:29 INFO - /builds/slave/test/build/application/firefox/firefox 23:57:29 INFO - Running post-action listener: _resource_record_post_action 23:57:29 INFO - ##### 23:57:29 INFO - ##### Running run-tests step. 23:57:29 INFO - ##### 23:57:29 INFO - Running pre-action listener: _resource_record_pre_action 23:57:29 INFO - Running main action method: run_tests 23:57:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:57:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:57:29 INFO - Python 2.7.3 23:57:29 INFO - Return code: 0 23:57:29 INFO - grabbing minidump binary from tooltool 23:57: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')]} 23:57:29 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 0x2609410>, '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 0x260a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260a7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:57:29 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 23:57:29 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 23:57:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:57:29 INFO - Return code: 0 23:57:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:57:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:57:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:57:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:57:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:57:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:57:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:57:30 INFO - Return code: 0 23:57:30 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/eXRlJ-CJRjKDz5MY3Ywoqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 23:57:30 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/eXRlJ-CJRjKDz5MY3Ywoqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 23:57:30 INFO - Using env: {'DISPLAY': ':0', 23:57:30 INFO - 'HOME': '/home/cltbld', 23:57:30 INFO - 'LANG': 'en_US.UTF-8', 23:57:30 INFO - 'LANGUAGE': 'en_US:en', 23:57:30 INFO - 'LOGNAME': 'cltbld', 23:57:30 INFO - 'MAIL': '/var/mail/cltbld', 23:57:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:57:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:57:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:57:30 INFO - 'MOZ_NO_REMOTE': '1', 23:57:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:57:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:57:30 INFO - 'NO_EM_RESTART': '1', 23:57:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:57:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:57:30 INFO - 'PWD': '/builds/slave/test', 23:57:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:57:30 INFO - 'SHELL': '/bin/bash', 23:57:30 INFO - 'SHLVL': '1', 23:57:30 INFO - 'TERM': 'linux', 23:57:30 INFO - 'TMOUT': '86400', 23:57:30 INFO - 'USER': 'cltbld', 23:57:30 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463034321.241424-1720971420', 23:57:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:57:30 INFO - '_': '/tools/buildbot/bin/python'} 23:57:30 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/eXRlJ-CJRjKDz5MY3Ywoqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 23:57:30 INFO - mozversion application_buildid: 20160511211918 23:57:30 INFO - mozversion application_changeset: 2fb177e17d81e069a02797c6234e8ed085cbc55c 23:57:30 INFO - mozversion application_display_name: FirefoxDeveloperEdition 23:57:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:57:30 INFO - mozversion application_name: Firefox 23:57:30 INFO - mozversion application_remotingname: firefox-dev 23:57:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 23:57:30 INFO - mozversion application_vendor: Mozilla 23:57:30 INFO - mozversion application_version: 48.0a2 23:57:30 INFO - mozversion platform_buildid: 20160511211918 23:57:30 INFO - mozversion platform_changeset: 2fb177e17d81e069a02797c6234e8ed085cbc55c 23:57:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 23:57:30 INFO - mozversion platform_version: 48.0a2 23:57:30 INFO - using testdate: 1463036250 23:57:30 INFO - actual date: 1463036250 23:57:30 INFO - starting webserver on 'localhost:52483' 23:57:30 INFO - SUITE-START | Running 2 tests 23:57:30 INFO - TEST-START | dromaeo_css 23:57:30 INFO - operating with platform_type : linux_ 23:57:30 INFO - Initialising browser for dromaeo_css test... 23:57:30 INFO - TEST-INFO | started process 6491 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpotw5nu/profile http://localhost:52483/getInfo.html) 23:57:34 INFO - PROCESS | 6491 | __metrics Screen width/height:1600/1200 23:57:34 INFO - PROCESS | 6491 | colorDepth:24 23:57:34 INFO - PROCESS | 6491 | Browser inner width/height: 1024/697 23:57:34 INFO - PROCESS | 6491 | __metrics 23:57:35 ERROR - PROCESS | 6491 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:57:36 INFO - TEST-INFO | 6491: exit 0 23:57:36 INFO - Browser initialized. 23:57:36 INFO - Running cycle 1/1 for dromaeo_css test... 23:57:36 INFO - TEST-INFO | started process 6579 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpotw5nu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:57:48 INFO - PROCESS | 6579 | RSS: Main: 141881344 23:57:48 INFO - PROCESS | 6579 | 23:58:39 INFO - PROCESS | 6579 | 1463036319893 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] 00:00:46 INFO - PROCESS | 6579 | Cycle 1(1): loaded http://localhost:52483/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52483/tests/dromaeo/cssquery-ext.html) 00:00:47 INFO - PROCESS | 6579 | RSS: Main: 253947904 00:00:47 INFO - PROCESS | 6579 | 00:03:50 INFO - PROCESS | 6579 | Cycle 1(1): loaded http://localhost:52483/tests/dromaeo/cssquery-ext.html (next: http://localhost:52483/tests/dromaeo/cssquery-jquery.html) 00:03:50 INFO - PROCESS | 6579 | RSS: Main: 220307456 00:03:50 INFO - PROCESS | 6579 | 00:06:52 INFO - PROCESS | 6579 | Cycle 1(1): loaded http://localhost:52483/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52483/tests/dromaeo/cssquery-mootools.html) 00:06:53 INFO - PROCESS | 6579 | RSS: Main: 222756864 00:06:53 INFO - PROCESS | 6579 | 00:09:55 INFO - PROCESS | 6579 | Cycle 1(1): loaded http://localhost:52483/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52483/tests/dromaeo/cssquery-prototype.html) 00:09:55 INFO - PROCESS | 6579 | RSS: Main: 212971520 00:09:55 INFO - PROCESS | 6579 | 00:12:58 INFO - PROCESS | 6579 | Cycle 1(1): loaded http://localhost:52483/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52483/tests/dromaeo/cssquery-yui.html) 00:12:58 INFO - PROCESS | 6579 | RSS: Main: 186695680 00:12:58 INFO - PROCESS | 6579 | 00:16:01 INFO - PROCESS | 6579 | Cycle 1(1): loaded http://localhost:52483/tests/dromaeo/cssquery-yui.html (next: http://localhost:52483/tests/dromaeo/cssquery-dojo.html) 00:16:01 INFO - PROCESS | 6579 | RSS: Main: 256299008 00:16:01 INFO - PROCESS | 6579 | 00:16:01 INFO - PROCESS | 6579 | __start_tp_report 00:16:01 INFO - PROCESS | 6579 | _x_x_mozilla_page_load 00:16:01 INFO - PROCESS | 6579 | _x_x_mozilla_page_load_details 00:16:01 INFO - PROCESS | 6579 | |i|pagename|runs| 00:16:01 INFO - PROCESS | 6579 | |0;dojo.html;3321.883734069307;3416.0264324667473;3417.8461969211385;3435.4846772984065;3465.0297916583368;5555.50000499955;5569.10894256919;5589.664620122785;5610.635308704942;5615.045442274808;5571.470710282527;5606.411326810688;5620.831375058745;5624.71876406179;5630.352509461413;4998.975005124969;5000.449950505442;5051.292819005333;5143.382794064699;5176.430592634807;4987.875303117433;5048.318477005612;5050.873728156789;5055.671381360218;5107.974460127694;5133.563647090002;5173.120569503175;5174.172132458807;5174.818881339153;5182.585393168538;5102.923456148161;5120.539151476348;5175.482451754832;5179.896402071938;5193.558547523465;4918.901621967577;5046.142155833517;5082.6188035897085;5099.311592934943;5126.5642420394315;5493.533049690781;5498.917516237259;5505.697186654733;5514.448555144493;5525.309336332958;5799.913001304942;5998.28020637522;6000.549958753068;6002.189704389939;6004.309504407005;5962.433568810956;6018.428249316308;6026.939730602681;6062.454379105901;6065.363136870609;5653.547716182696;5653.689047102366;5677.858053548694;5687.402822703598;5710.971445142789;5979.491743201789;6016.488598469092;6105.725242364104;6175.382461753788;6190.566660333733;5907.438793314628;5912.024515954905;5920.200772895604;5923.378045305181;5924.377940316291;5961.4038596140035;5985.072313791369;5986.491148252448;5988.101784732238;5988.580799344004;5798.594098413155;5909.763609455574;5954.642721436728;5974.4324289192455;5979.850503737442;5908.084246941731;5953.523718102628;5963.135345374896;5971.104334349795;5972.163897054415;4519.638428925678;4538.410006699108;4538.614217791524;4561.954380456153;4585.79363928624;4000.7999600019884;4054.2296963576828;4062.1266427718183;4103.4460347853255;4150.107726838744;5696.23100881384;5714.914276285859;5715.771369145271;5717.199592057115;5724.484796368347;5988.251468566429;6027.9095813562835;6031.698415079229;6032.547558933097;6034.969825150846;5543.223948647193;5587.720613969285;5629.7185140742795;5666.263385759825;5682.943170568324;5145.4597267287145;5146.279520867081;5149.613778966517;5167.896642067138;5170.560502357342;5983.401659834069;6141.416565426277;6196.380361963767;6206.348333425016;6208.596441231396;5968.671723055187;6048.637081775108;6061.969690151521;6068.666223357758;6075.878482430415;6134.018557030854;6141.508679305734;6160.10678451631;6164.506839452743;6179.073139029181;5722.599418040863;5857.1799948008165;5913.704314784158;5913.852153696192;5917.082852157922;5994.160817485643;6010.218671572842;6015.338312785678;6031.60794548353;6057.727402266997;5807.477327040587;5848.239728835224;5850.64896106235;5859.648421094748;5867.823965281048;5743.167240750151;5755.65466072037;5791.044477661308;5795;5851.21008663842;5753.884922301614;5756.3380211276235;5764.13537969308;5769.221155144001;5769.913451298318;5820.796272130455;5862.912056319244;5865.120231965239;5867.237259156283;5878.2358293421585;5666.46168613981;5758.280214973129;5804.477597016289;5877.764889404547;5893.616914900518 00:16:01 INFO - PROCESS | 6579 | |1;ext.html;648.0635481728904;654.7315600603754;664.9128674617003;676.2324761395815;740.9147947985981;40525.39211911824;41494.17011659765;41552.96117597058;41602;41603.37594936079;42981.35527967083;44087.33868991968;44094;44227.3365899511;44279.55720442795;8198.098209197013;8985;9168.358214924958;10557.577696892115;10751.731206719816;10642.78714425711;10796;10799.622013229538;10806.72983175423;10811.135109191286;10860.239783215178;10917.781644367107;10920.726981825439;10925.07136893365;10926.180536459757;8418.621162047692;10888.020078192962;11153.275037122561;11157.609483668033;11160.274582152135;10464.52909619069;10545.050945414949;10579;10579.100776434012;10585.73535661607;39213.41179882304;39714;39752.60247397518;39757.20485590272;39766.20467590661;3841.5006049213425;3870.2646497165447;4045.0898547826796;4127.252837548179;4558.088382323515;34234.82882585596;34315.48526772101;34544.13639659004;35470.467942980875;35776.28447431037;4077.97961010196;4107.876763697064;4122.525909520384;4145.689073319513;4288.206681763852;334084;334465;335447;335716.6428335734;336301;38036.619633803304;38571.80714096411;38728.419073713914;62546.68726656338;63372.366276336645;39190.608093918694;39976.200475990896;40095.39856902149;40112.79943600322;40188;14734.778978315333;17396.39112631052;17545.824541754675;17564.736528952075;17583.648327033643;12992.350382481027;14702.485413010494;14947.850521494864;14964.551063468114;15052.247387630574;9077.137671921157;9085.727428177166;9151;9180.31147663928;9347.813043739086;3472.392331342005;3494.7029502492064;3533.2050288685355;3535.575730912307;3549.8757543485854;1074.1782536359692;1087.7443800706828;1171.7363593191465;1199.3044034460167;1269.8095285707218;34049.82975085109;34221.31557368889;34539.30921381609;34606.82696586501;35253.64746352555;1047.1936608811172;1063.7766069125416;1125.1561329003248;1139.2480962564832;1169.6958790714305;17553;18109.818901811075;18746.437606871816;19119.42641720723;19226.903865480584;464474;468454;469924;471890;474671;64454;64461.35538644647;64996.67501662461;65175.67412162909;65328.67335663291;1504.9623759405883;1526.4205438247293;1536.976945345843;1561.7032763774846;1609.9114548699933;30363.24402085924;32850.50724239091;33516.832415837765;33855.49216761701;35010.29979400347;52410.213846791565;52478.737606311726;53046.46953530415;53138.20292695535;53144.734276328374;348625;350928;351051;351389;352553;28081.297967550974;28197.859010704815;47972.520274798204;48819;49451.25823112728;45797.54202457933;47660.523394767;48810.75594622146;50227.24659130189;51546.484535154166;39781.80109099552;40159;40730.592694073865;40792.796036020816;41409.79295103505;41619.37570936499;42522.5747742531;42978.35532467078;43314;43789.34315985326;42753;43034.56965430431;43369;44227.557724423634;44448.77775611101;37020.81489592643;37688.43467347937;38197.427038595;38537.80731096327;38589.80705096569;28977.56533652039;29456.917581243488;29543.409131817672;29623;29729.554056689598 00:16:01 INFO - PROCESS | 6579 | |2;jquery.html;410.6981368694009;414.8817586987709;420.30020016672245;427.790382712471;435.1970614216769;14381.424743010268;18912.716309255356;19480;19498.512537186576;20078.397648070546;16124.193790310466;18017.279308827663;19744.506387340287;19796.802031979674;20424.489387765312;5657.745401456934;5792.855178620526;5841.7955371562;5864.912026319587;5868.295804503444;5760.107183386582;5832.358440571534;5833.3874943130995;5833.445822646863;5838.386969368197;4289.356596510533;5802.47777700009;6235.625862448245;6527.314631963647;6551.639659818708;6330.87338253237;6334.873302533946;6346.333634968308;6372.299047104838;6383.616982981012;5603.551715862721;5864.06175011996;5866.120081987693;5866.266716660418;5868.354481007086;12887.484500619965;12892.677683057906;12969;13109.934450327783;13178.86821131786;2423.297243799296;2454.9386265343333;2509.372656835791;3020.7281344678863;3186.713195812365;9720.465374404404;10261.589536418534;10515.789684206273;10606.166608365369;10926.125909927267;1969.8227159555709;2004.7494063242095;2144.3888491779767;2160.8163306119;2262.230841513877;76089.23910760877;83842;83938;84568.57715711443;87336.56331718364;10878.72803179911;11039.337639741641;11178.944105279421;11412.372319522507;11433.485493152662;15505.302261398265;15626.609334766721;15678.451254206277;15704;15720.135392553519;8624.482531048157;8682.565871706516;8684.56577171139;8693.869591956125;8740.475571465733;8643.654253829776;8660.30717542595;8670.349723770742;8672.479651220947;8726.389152759246;4433.600975912119;4820.831270905572;4842.15262329091;4877.609791216694;4986.925196122061;1826.2938726948403;1899.6200759848086;1955.706644003411;1958.9608207835763;1964.2339487599847;988.5057471264367;1065.4459680965854;1124.16249893828;1143.0798207443088;1175.641429364052;19329.903350483157;19888.70166947497;19901.201123438885;20185.596288074157;20223.4944126398;1054.2394201683207;1058.4919238765435;1111.777644471109;1125.2348403085816;1129.5877004893318;10915.672529824118;10968.451577421098;11197.104231661448;11206.887931120747;11278.210525263317;400618;404220;406067;612743;632499;84824.57587712022;92282.53858730664;92699.5365023184;92807.53596232111;107088;1165.935873526964;1168.8422063021553;1186.2052424875353;1210.7457433938796;1220.2312543097792;17821.643567128325;18101;18128;18170.72743908869;18522.444326670222;39834.60165398309;40424.39363409492;41241.58758412377;41649.79175104226;42404;54672.72663636656;56546.717266413405;56824.431755681915;57010;62048.68975655093;8677.392582519164;8734.606942687467;8814.250788683034;9122.087791220825;9197.08029197075;11988.520459181535;13248.735025299247;13474.393652285475;13485.730285394433;13659.931700341434;11979.520819167135;12085.75828483443;12151.696207594881;12287.815682764944;12303.75392492163;11656.417179140839;12235.388230588613;12470.501179953064;12510.437030333474;12821.102522823687;10927.52103462899;12240.326782027074;12848.421821018264;12934.482620695444;13328.600141995756;9006.63973441055;9148;9219.677311294072;9321.394109382869;9378.765530861783;10700.953137410828;12855.485780568673;12924.224546527239;12929.935350323189;13144.80282795778 00:16:01 INFO - PROCESS | 6579 | |3;mootools.html;1418.6453386653336;1513.3568233500762;1517.9544613661587;1730.774999250098;1924.2687778644122;7837.294643482085;7977.321927636151;7998.960005199966;8001.63992620332;8032.9196708032905;7982.560959147245;8155.551444670556;8163.061247956487;8166.224208700179;8169.550674712888;2116.8094871461567;2152.203684636687;2380.6071998120287;2388.7491813359607;2415.927522174338;2412.300432874464;2429.0890915906534;2429.1983645397063;2429.6598476213344;2430.3195105370523;2315.8263130265213;2334.8015418689433;2390.2351247600773;2390.40239940015;2391.258709799959;2108.5255817441107;2343.6718859359703;2391.1630929174826;2392.928212153638;2394.3774618599114;2343.3907184132077;2350.048230466664;2371.6561098640773;2371.905123795046;2376.358383236534;8158.347332213409;8220.876686849702;8243.793905152419;8246.876296855551;8251.793705157359;5227.398849132361;5321;5321.042212401766;5336.092864213054;5336.279602253685;3520.8591656333715;3527.1182204448887;3596.226811235571;3600.567931848169;3633.0372451300427;1106.4910141334994;1138.3340745663797;1139.5384869128015;1175.670812172593;1208.7219939413983;10891.945540272249;10984.450777461096;10986.670399888017;11005;11034.834477482844;4598.839040633628;4636.629069674418;4646.558576935186;4687.179743544866;4688.976555117202;9835.75410614726;9840.065193806577;9840.60637574489;9851.359661621971;9885.456299903575;5324.307839980777;5382.327209098863;5402.51377376038;5404.405515393303;5410.1343784994215;4183.267928112568;4757.191277482836;4802.759862006886;4841.661083724176;4864.537868902448;3947.111899822517;3986.920261594752;4024.4768180136393;4039.7374170678813;4081.0817566047403;1300.2523548959387;1310.462710288777;1311.8360204974379;1317.538861398522;1326.4760419634383;1055.577768892449;1055.8574592430077;1057.1331508163387;1062.8618279623754;1072.4208927179236;5865.706714664249;5940.821775346746;5970.582059255898;5973.1936188614845;6067.513459202523;475.86675730795434;483.24131114151146;486.20020066989605;487.43214155508434;487.6927535652516;4128.2156390285745;4163.417121602978;4174.874753757332;4189.099343641071;4255.127698821734;9746.805063898682;10148.441835698959;10212.183025358103;10293.330933489298;10316.17470602365;10056.094951454405;10080.747981300527;10110.595576176871;10121.1903047756;10213.182945364502;7204.207537170907;7617.809554761065;7620.97116889224;7647.235276472419;7733.8453230935065;5778.364379918122;5859.882802344015;5863.912041319469;5989.40105989415;6036.547258955508;8963.731088067369;9030.638774449211;9082.59128339213;9096.681616143404;9139.497327647043;9146.817063658556;9463.716088517356;9486.715398538056;9613.471259080537;9669.468179250209;6386.840328991812;7090.858182836418;7093.680784364613;7201;7293.562386256842;7568.091828980338;7610.961945190239;7616.7334143304715;7634.427417943787;7661.540307581563;6847;7013.123359580052;7102.5028248022145;7113.644317784194;7155.534890232118;6790.388865002174;6872.518923675295;7008.544444611084;7008.719651213894;7101.964490177723;6567.310432404529;6571.34286571339;6572.112764776694;6582.901256481061;6603.438707709706;5190.97404512975;5255.684658920477;5263.421023687315;5278.419373868948;5282.445343238905;5219.451957544403;5284.286621306074;5290.312259406252;5309.991101690666;5380.73096345189 00:16:01 INFO - PROCESS | 6579 | |4;prototype.html;354.85805677728905;358.0993800591512;360.0817914318488;366.68648305698645;367.20866532622193;6100.420460056288;6240.7503699852;6275.592086514384;6310;6330.905036424458;6340.968295158529;6358.554901156921;6365.713542890569;6379.617222966625;6380.585261957981;4805.591524720403;4807.471178170407;4808.567228949394;4811.206150985084;4815.66290359675;4555.794989225493;4645.094206629708;4779.545943135397;4811.855644330676;4814.398200224972;4735.242361222206;4737.786799594027;4741.976290118545;4746.288056791474;4751.643626727992;4736.3369128322065;4752.667313288071;4752.809887604491;4754.14425403429;4761.571458568746;4181.142865712522;4188.099558594917;4191.497020357577;4197.895052623709;4202.747835129871;6032.879342413171;6038.547108966845;6038.758449662052;6043.788467403664;6060.848478788022;5356.035913535562;5581.413951535112;5587.329520457572;5601.719914004324;5606.859828504279;6584.572002819801;6602.60384376939;6627;6633.701483433257;6647.900281495781;4592.33411155384;4597.080583883203;4600.953990460086;4601.102784956935;4609.861704148881;6940.09778728762;7007.439404847651;7015.263397343257;7024.367806897352;7027.89458158128;4705.576498115186;4708.670393072521;4709.599684026827;4709.85870423881;4710.36410084641;4623.052274283764;4766.523347665275;4769.59458446029;4773.689710168828;4774.856754297377;5501.917471237854;5537.889242215214;5538.363088244903;5538.47384498472;5541.418151094077;6743.98840173968;6746.156730408699;6747.089142965735;6749.797506074826;6765.966170169216;1599.448190374319;1643.3837311008372;1676.9916150419415;1677.270387381493;1681.041806170471;1078.8327809189589;1098.8791232964368;1100.2298391126244;1101.8181999970075;1103.939283339424;6332.176817013851;6374.617522948545;6388.584741991755;6389.520785941073;6392.936070639327;6794.45644348451;6801.2178599461695;6811.25076241613;6814.62519561419;6815.114035175396;6368.29948705642;6370.267419246846;6377.298497165308;6378.330275321117;6384.297727249998;3692.7415080944074;3720.5721342046013;3722.683571896365;3723.7765734056043;3733.1227161617;6960.869715000049;7028.543144695578;7104.964475177591;7106.395956343666;7111.146662400545;6931.37617614407;6944.618046007518;6968.65156742171;6973.12835895513;6974.372306492339;7016.912378581328;7020.719171233196;7031.613261270577;7079.82300442493;7091.290870912868;6862.3137686230975;6864.759733409307;6865.244823069358;6870.828229294308;6881;6681.465482761465;6771.052052712723;6906.136732908387;6922.58464492132;6923.757668481579;7123.893141602776;7206.495545311778;7219.6029218391395;7222.711091556279;7233.927660723536;4696.882577935579;4727.692699974491;4727.905441891212;4738.147133516;4742.359781429601;6649.202095748541;6782.728690852311;6883.449324053963;6962.268961758942;6990.685419156252;6700;6749.0888730020815;6759.155105611799;6775.356341147583;6799.184097908283;6734.797956061326;6743.258241593323;6752.122224110834;6759.763408280884;6772.356626120511;6661.600303981777;6663.966680166568;6664.766733164316;6672.566283191577;6678.933210667831;6616.603003819786;6822.761203357859;6823.1812182538415;6832.555883867532;6833.829154270984;6574.8356291093105;6616.040674102132;6649.035889795856;6657.833554161185;6677.3656502632175 00:16:01 INFO - PROCESS | 6579 | |5;yui.html;777.4402430250218;798.329403301227;802.3380710913494;848.8684253940639;889.484099222451;14475.203863787487;14702.264886755673;14877.107373557594;16541.66916661669;16799.748003779954;15409.383624655;15554.300056497457;15572.922135389308;15600.375984960616;15605.063696178237;725.8221735674741;859.6260626627405;861.7027125641675;870.3602851903846;871.3377832847018;876.9605367758467;883.2271762208068;883.6067949762358;886.4858382138376;886.9556522173898;931.8089791592741;935.0042205051599;935.5275585829181;936.3679516326487;936.8547875079373;756.5158298688843;910.1399177777004;923.1829830599901;927.7680579855037;935.3125452792192;676.5331920974512;677.6510097299895;677.8508728079814;680.4794332335767;683.8290427393151;13869.167849929037;13892.097013694078;13900.721985560232;13944.442222311096;13951.162930224218;12466.875331246752;12942.805857912139;13366.933165334209;13540.917767806292;13802.447902083904;11518.193726439153;11733.647990560297;11783.764324713458;11829.467673954692;11939.820902686466;3935.626115519021;3952.664023557972;4029.6373326400767;4086.5709100544314;4091.631753142202;57129;57774.133387999216;58033.70983145057;58135.41864581342;58244.708776455846;10372.11836993849;10404.895951040544;10454.581816727397;10618.946905265579;10791.02880740737;19667.311644092675;19681.606367872562;19689.21243150258;19694.01529923498;19707.605847882962;7905.209479052164;7994.5203287802915;8015.198480152055;8233.876491852627;8255.958720206481;4935.087008903292;4991.625628077909;5000.249962505581;5030.798768049237;5133.717645529457;3463.0130412832223;3536.3457760314423;3550.6449355064806;3552.769070010441;3565.0730809989072;596.3916804859019;612.1552257884091;617.7961272780062;628.5254632752243;649.0718272869841;721.2571051816637;811.1726039439857;817.5094943034132;831.193742070191;831.8835363049178;9034.2320902724;9302.813943721088;9391;9664.516774161404;9874.555644995993;789.4158322841056;790.4506368074249;810.5663470043617;818.2676504528414;829.9709510167115;4433.689641725113;4457.420535330386;4510.2783554631105;4515.209838278288;4541.659375546781;66435;66879.66560167167;67273.66363168153;67597.32402676009;68304.65847670729;57651.711741441024;58488;58828.41171588229;59265.407345926855;59992.400075999554;53703;53925.73037134789;54486.727566361915;54855.451445485036;55919.44080559224;8749.956250218707;8858.557072146496;8989.955050224708;9052.411593246417;9117.5441227937;38350;38455.80772096122;38568;38985.220295594496;39993.40009899912;47158;51865.22202167046;52148.739256303474;52423.73788131035;52552.47447525629;11454;11527.596534121265;11528.308301501602;11610.245334053598;11636.36000020007;13090.14914030585;13142.60572182836;13572;13711.520096796565;13943;10173.338732982333;11360.375179365214;12080.39598020113;12206.877931220573;12907.965055512917;12051.638450846489;12073.456694448596;12279.754404911673;12385.814212786636;12838.871611284141;12978.935105324414;13034.283114428797;13113.213207207598;13310.134841235289;13562.38969246406;11266.887331126583;11302.378369189773;11474.541018359172;11675.708107297385;11727.413629318671;10955.56177752881;11098;11349.205555611028;11486.540538378371;11576.710582235175 00:16:01 INFO - PROCESS | 6579 | __end_tp_report 00:16:01 INFO - PROCESS | 6579 | __start_cc_report 00:16:01 INFO - PROCESS | 6579 | _x_x_mozilla_cycle_collect,895 00:16:01 INFO - PROCESS | 6579 | __end_cc_report 00:16:01 INFO - PROCESS | 6579 | __startTimestamp1463037361358__endTimestamp 00:16:01 INFO - PROCESS | 6579 | 00:16:01 INFO - PROCESS | 6579 | ------- Summary: start ------- 00:16:01 INFO - PROCESS | 6579 | Number of tests: 6 00:16:01 INFO - PROCESS | 6579 | 00:16:01 INFO - PROCESS | 6579 | [#0] dojo.html Cycles:165 Average:5563.08 Median:5764.14 stddev:610.61 (10.6%) stddev-sans-first:586.63 00:16:01 INFO - PROCESS | 6579 | Values: 3321.9 3416.0 3417.8 3435.5 3465.0 5555.5 5569.1 5589.7 5610.6 5615.0 5571.5 5606.4 5620.8 5624.7 5630.4 4999.0 5000.4 5051.3 5143.4 5176.4 4987.9 5048.3 5050.9 5055.7 5108.0 5133.6 5173.1 5174.2 5174.8 5182.6 5102.9 5120.5 5175.5 5179.9 5193.6 4918.9 5046.1 5082.6 5099.3 5126.6 5493.5 5498.9 5505.7 5514.4 5525.3 5799.9 5998.3 6000.5 6002.2 6004.3 5962.4 6018.4 6026.9 6062.5 6065.4 5653.5 5653.7 5677.9 5687.4 5711.0 5979.5 6016.5 6105.7 6175.4 6190.6 5907.4 5912.0 5920.2 5923.4 5924.4 5961.4 5985.1 5986.5 5988.1 5988.6 5798.6 5909.8 5954.6 5974.4 5979.9 5908.1 5953.5 5963.1 5971.1 5972.2 4519.6 4538.4 4538.6 4562.0 4585.8 4000.8 4054.2 4062.1 4103.4 4150.1 5696.2 5714.9 5715.8 5717.2 5724.5 5988.3 6027.9 6031.7 6032.5 6035.0 5543.2 5587.7 5629.7 5666.3 5682.9 5145.5 5146.3 5149.6 5167.9 5170.6 5983.4 6141.4 6196.4 6206.3 6208.6 5968.7 6048.6 6062.0 6068.7 6075.9 6134.0 6141.5 6160.1 6164.5 6179.1 5722.6 5857.2 5913.7 5913.9 5917.1 5994.2 6010.2 6015.3 6031.6 6057.7 5807.5 5848.2 5850.6 5859.6 5867.8 5743.2 5755.7 5791.0 5795.0 5851.2 5753.9 5756.3 5764.1 5769.2 5769.9 5820.8 5862.9 5865.1 5867.2 5878.2 5666.5 5758.3 5804.5 5877.8 5893.6 00:16:01 INFO - PROCESS | 6579 | 00:16:01 INFO - PROCESS | 6579 | [#1] ext.html Cycles:180 Average:55580.38 Median:38117.02 stddev:102787.36 (269.7%) stddev-sans-first:102992.95 00:16:01 INFO - PROCESS | 6579 | Values: 648.1 654.7 664.9 676.2 740.9 40525.4 41494.2 41553.0 41602.0 41603.4 42981.4 44087.3 44094.0 44227.3 44279.6 8198.1 8985.0 9168.4 10557.6 10751.7 10642.8 10796.0 10799.6 10806.7 10811.1 10860.2 10917.8 10920.7 10925.1 10926.2 8418.6 10888.0 11153.3 11157.6 11160.3 10464.5 10545.1 10579.0 10579.1 10585.7 39213.4 39714.0 39752.6 39757.2 39766.2 3841.5 3870.3 4045.1 4127.3 4558.1 34234.8 34315.5 34544.1 35470.5 35776.3 4078.0 4107.9 4122.5 4145.7 4288.2 334084.0 334465.0 335447.0 335716.6 336301.0 38036.6 38571.8 38728.4 62546.7 63372.4 39190.6 39976.2 40095.4 40112.8 40188.0 14734.8 17396.4 17545.8 17564.7 17583.6 12992.4 14702.5 14947.9 14964.6 15052.2 9077.1 9085.7 9151.0 9180.3 9347.8 3472.4 3494.7 3533.2 3535.6 3549.9 1074.2 1087.7 1171.7 1199.3 1269.8 34049.8 34221.3 34539.3 34606.8 35253.6 1047.2 1063.8 1125.2 1139.2 1169.7 17553.0 18109.8 18746.4 19119.4 19226.9 464474.0 468454.0 469924.0 471890.0 474671.0 64454.0 64461.4 64996.7 65175.7 65328.7 1505.0 1526.4 1537.0 1561.7 1609.9 30363.2 32850.5 33516.8 33855.5 35010.3 52410.2 52478.7 53046.5 53138.2 53144.7 348625.0 350928.0 351051.0 351389.0 352553.0 28081.3 28197.9 47972.5 48819.0 49451.3 45797.5 47660.5 48810.8 50227.2 51546.5 39781.8 40159.0 40730.6 40792.8 41409.8 41619.4 42522.6 42978.4 43314.0 43789.3 42753.0 43034.6 43369.0 44227.6 44448.8 37020.8 37688.4 38197.4 38537.8 38589.8 28977.6 29456.9 29543.4 29623.0 29729.6 00:16:01 INFO - PROCESS | 6579 | 00:16:01 INFO - PROCESS | 6579 | [#2] jquery.html Cycles:180 Average:29075.24 Median:11284.44 stddev:83020.09 (735.7%) stddev-sans-first:83225.09 00:16:01 INFO - PROCESS | 6579 | Values: 410.7 414.9 420.3 427.8 435.2 14381.4 18912.7 19480.0 19498.5 20078.4 16124.2 18017.3 19744.5 19796.8 20424.5 5657.7 5792.9 5841.8 5864.9 5868.3 5760.1 5832.4 5833.4 5833.4 5838.4 4289.4 5802.5 6235.6 6527.3 6551.6 6330.9 6334.9 6346.3 6372.3 6383.6 5603.6 5864.1 5866.1 5866.3 5868.4 12887.5 12892.7 12969.0 13109.9 13178.9 2423.3 2454.9 2509.4 3020.7 3186.7 9720.5 10261.6 10515.8 10606.2 10926.1 1969.8 2004.7 2144.4 2160.8 2262.2 76089.2 83842.0 83938.0 84568.6 87336.6 10878.7 11039.3 11178.9 11412.4 11433.5 15505.3 15626.6 15678.5 15704.0 15720.1 8624.5 8682.6 8684.6 8693.9 8740.5 8643.7 8660.3 8670.3 8672.5 8726.4 4433.6 4820.8 4842.2 4877.6 4986.9 1826.3 1899.6 1955.7 1959.0 1964.2 988.5 1065.4 1124.2 1143.1 1175.6 19329.9 19888.7 19901.2 20185.6 20223.5 1054.2 1058.5 1111.8 1125.2 1129.6 10915.7 10968.5 11197.1 11206.9 11278.2 400618.0 404220.0 406067.0 612743.0 632499.0 84824.6 92282.5 92699.5 92807.5 107088.0 1165.9 1168.8 1186.2 1210.7 1220.2 17821.6 18101.0 18128.0 18170.7 18522.4 39834.6 40424.4 41241.6 41649.8 42404.0 54672.7 56546.7 56824.4 57010.0 62048.7 8677.4 8734.6 8814.3 9122.1 9197.1 11988.5 13248.7 13474.4 13485.7 13659.9 11979.5 12085.8 12151.7 12287.8 12303.8 11656.4 12235.4 12470.5 12510.4 12821.1 10927.5 12240.3 12848.4 12934.5 13328.6 9006.6 9148.0 9219.7 9321.4 9378.8 10701.0 12855.5 12924.2 12929.9 13144.8 00:16:01 INFO - PROCESS | 6579 | 00:16:01 INFO - PROCESS | 6579 | [#3] mootools.html Cycles:180 Average:5510.04 Median:5223.43 stddev:2958.13 (56.6%) stddev-sans-first:2950.44 00:16:01 INFO - PROCESS | 6579 | Values: 1418.6 1513.4 1518.0 1730.8 1924.3 7837.3 7977.3 7999.0 8001.6 8032.9 7982.6 8155.6 8163.1 8166.2 8169.6 2116.8 2152.2 2380.6 2388.7 2415.9 2412.3 2429.1 2429.2 2429.7 2430.3 2315.8 2334.8 2390.2 2390.4 2391.3 2108.5 2343.7 2391.2 2392.9 2394.4 2343.4 2350.0 2371.7 2371.9 2376.4 8158.3 8220.9 8243.8 8246.9 8251.8 5227.4 5321.0 5321.0 5336.1 5336.3 3520.9 3527.1 3596.2 3600.6 3633.0 1106.5 1138.3 1139.5 1175.7 1208.7 10891.9 10984.5 10986.7 11005.0 11034.8 4598.8 4636.6 4646.6 4687.2 4689.0 9835.8 9840.1 9840.6 9851.4 9885.5 5324.3 5382.3 5402.5 5404.4 5410.1 4183.3 4757.2 4802.8 4841.7 4864.5 3947.1 3986.9 4024.5 4039.7 4081.1 1300.3 1310.5 1311.8 1317.5 1326.5 1055.6 1055.9 1057.1 1062.9 1072.4 5865.7 5940.8 5970.6 5973.2 6067.5 475.9 483.2 486.2 487.4 487.7 4128.2 4163.4 4174.9 4189.1 4255.1 9746.8 10148.4 10212.2 10293.3 10316.2 10056.1 10080.7 10110.6 10121.2 10213.2 7204.2 7617.8 7621.0 7647.2 7733.8 5778.4 5859.9 5863.9 5989.4 6036.5 8963.7 9030.6 9082.6 9096.7 9139.5 9146.8 9463.7 9486.7 9613.5 9669.5 6386.8 7090.9 7093.7 7201.0 7293.6 7568.1 7611.0 7616.7 7634.4 7661.5 6847.0 7013.1 7102.5 7113.6 7155.5 6790.4 6872.5 7008.5 7008.7 7102.0 6567.3 6571.3 6572.1 6582.9 6603.4 5191.0 5255.7 5263.4 5278.4 5282.4 5219.5 5284.3 5290.3 5310.0 5380.7 00:16:01 INFO - PROCESS | 6579 | 00:16:01 INFO - PROCESS | 6579 | [#4] prototype.html Cycles:180 Average:5581.34 Median:6372.44 stddev:1695.11 (26.6%) stddev-sans-first:1653.85 00:16:01 INFO - PROCESS | 6579 | Values: 354.9 358.1 360.1 366.7 367.2 6100.4 6240.8 6275.6 6310.0 6330.9 6341.0 6358.6 6365.7 6379.6 6380.6 4805.6 4807.5 4808.6 4811.2 4815.7 4555.8 4645.1 4779.5 4811.9 4814.4 4735.2 4737.8 4742.0 4746.3 4751.6 4736.3 4752.7 4752.8 4754.1 4761.6 4181.1 4188.1 4191.5 4197.9 4202.7 6032.9 6038.5 6038.8 6043.8 6060.8 5356.0 5581.4 5587.3 5601.7 5606.9 6584.6 6602.6 6627.0 6633.7 6647.9 4592.3 4597.1 4601.0 4601.1 4609.9 6940.1 7007.4 7015.3 7024.4 7027.9 4705.6 4708.7 4709.6 4709.9 4710.4 4623.1 4766.5 4769.6 4773.7 4774.9 5501.9 5537.9 5538.4 5538.5 5541.4 6744.0 6746.2 6747.1 6749.8 6766.0 1599.4 1643.4 1677.0 1677.3 1681.0 1078.8 1098.9 1100.2 1101.8 1103.9 6332.2 6374.6 6388.6 6389.5 6392.9 6794.5 6801.2 6811.3 6814.6 6815.1 6368.3 6370.3 6377.3 6378.3 6384.3 3692.7 3720.6 3722.7 3723.8 3733.1 6960.9 7028.5 7105.0 7106.4 7111.1 6931.4 6944.6 6968.7 6973.1 6974.4 7016.9 7020.7 7031.6 7079.8 7091.3 6862.3 6864.8 6865.2 6870.8 6881.0 6681.5 6771.1 6906.1 6922.6 6923.8 7123.9 7206.5 7219.6 7222.7 7233.9 4696.9 4727.7 4727.9 4738.1 4742.4 6649.2 6782.7 6883.4 6962.3 6990.7 6700.0 6749.1 6759.2 6775.4 6799.2 6734.8 6743.3 6752.1 6759.8 6772.4 6661.6 6664.0 6664.8 6672.6 6678.9 6616.6 6822.8 6823.2 6832.6 6833.8 6574.8 6616.0 6649.0 6657.8 6677.4 00:16:01 INFO - PROCESS | 6579 | 00:16:01 INFO - PROCESS | 6579 | [#5] yui.html Cycles:180 Average:15687.61 Median:26046.54 stddev:18643.89 (71.6%) stddev-sans-first:18662.57 00:16:01 INFO - PROCESS | 6579 | Values: 777.4 798.3 802.3 848.9 889.5 14475.2 14702.3 14877.1 16541.7 16799.7 15409.4 15554.3 15572.9 15600.4 15605.1 725.8 859.6 861.7 870.4 871.3 877.0 883.2 883.6 886.5 887.0 931.8 935.0 935.5 936.4 936.9 756.5 910.1 923.2 927.8 935.3 676.5 677.7 677.9 680.5 683.8 13869.2 13892.1 13900.7 13944.4 13951.2 12466.9 12942.8 13366.9 13540.9 13802.4 11518.2 11733.6 11783.8 11829.5 11939.8 3935.6 3952.7 4029.6 4086.6 4091.6 57129.0 57774.1 58033.7 58135.4 58244.7 10372.1 10404.9 10454.6 10618.9 10791.0 19667.3 19681.6 19689.2 19694.0 19707.6 7905.2 7994.5 8015.2 8233.9 8256.0 4935.1 4991.6 5000.2 5030.8 5133.7 3463.0 3536.3 3550.6 3552.8 3565.1 596.4 612.2 617.8 628.5 649.1 721.3 811.2 817.5 831.2 831.9 9034.2 9302.8 9391.0 9664.5 9874.6 789.4 790.5 810.6 818.3 830.0 4433.7 4457.4 4510.3 4515.2 4541.7 66435.0 66879.7 67273.7 67597.3 68304.7 57651.7 58488.0 58828.4 59265.4 59992.4 53703.0 53925.7 54486.7 54855.5 55919.4 8750.0 8858.6 8990.0 9052.4 9117.5 38350.0 38455.8 38568.0 38985.2 39993.4 47158.0 51865.2 52148.7 52423.7 52552.5 11454.0 11527.6 11528.3 11610.2 11636.4 13090.1 13142.6 13572.0 13711.5 13943.0 10173.3 11360.4 12080.4 12206.9 12908.0 12051.6 12073.5 12279.8 12385.8 12838.9 12978.9 13034.3 13113.2 13310.1 13562.4 11266.9 11302.4 11474.5 11675.7 11727.4 10955.6 11098.0 11349.2 11486.5 11576.7 00:16:01 INFO - PROCESS | 6579 | -------- Summary: end -------- 00:16:01 INFO - PROCESS | 6579 | 00:16:02 INFO - TEST-INFO | 6579: exit 0 00:16:02 INFO - TEST-OK | dromaeo_css | took 1111661ms 00:16:02 INFO - TEST-START | kraken 00:16:02 INFO - operating with platform_type : linux_ 00:16:02 INFO - Initialising browser for kraken test... 00:16:02 INFO - TEST-INFO | started process 6764 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT2nkqe/profile http://localhost:52483/getInfo.html) 00:16:05 INFO - PROCESS | 6764 | __metrics Screen width/height:1600/1200 00:16:05 INFO - PROCESS | 6764 | colorDepth:24 00:16:05 INFO - PROCESS | 6764 | Browser inner width/height: 1024/697 00:16:05 INFO - PROCESS | 6764 | __metrics 00:16:06 ERROR - PROCESS | 6764 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 00:16:07 INFO - TEST-INFO | 6764: exit 0 00:16:07 INFO - Browser initialized. 00:16:07 INFO - Running cycle 1/1 for kraken test... 00:16:07 INFO - TEST-INFO | started process 6855 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT2nkqe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:16:19 INFO - PROCESS | 6855 | RSS: Main: 142147584 00:16:19 INFO - PROCESS | 6855 | 00:16:22 INFO - PROCESS | 6855 | Cycle 1(1): loaded http://localhost:52483/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52483/tests/kraken/driver.html?testName=audio-beat-detection) 00:16:22 INFO - PROCESS | 6855 | RSS: Main: 196317184 00:16:22 INFO - PROCESS | 6855 | 00:16:25 INFO - PROCESS | 6855 | Cycle 1(1): loaded http://localhost:52483/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52483/tests/kraken/driver.html?testName=audio-dft) 00:16:26 INFO - PROCESS | 6855 | RSS: Main: 181501952 00:16:26 INFO - PROCESS | 6855 | 00:16:28 INFO - PROCESS | 6855 | Cycle 1(1): loaded http://localhost:52483/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52483/tests/kraken/driver.html?testName=audio-fft) 00:16:29 INFO - PROCESS | 6855 | RSS: Main: 273297408 00:16:29 INFO - PROCESS | 6855 | 00:16:31 INFO - PROCESS | 6855 | Cycle 1(1): loaded http://localhost:52483/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52483/tests/kraken/driver.html?testName=audio-oscillator) 00:16:32 INFO - PROCESS | 6855 | RSS: Main: 179228672 00:16:32 INFO - PROCESS | 6855 | 00:16:34 INFO - PROCESS | 6855 | Cycle 1(1): loaded http://localhost:52483/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52483/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:16:34 INFO - PROCESS | 6855 | RSS: Main: 177102848 00:16:34 INFO - PROCESS | 6855 | 00:16:37 INFO - PROCESS | 6855 | Cycle 1(1): loaded http://localhost:52483/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52483/tests/kraken/driver.html?testName=imaging-darkroom) 00:16:38 INFO - PROCESS | 6855 | RSS: Main: 211763200 00:16:38 INFO - PROCESS | 6855 | 00:16:41 INFO - PROCESS | 6855 | Cycle 1(1): loaded http://localhost:52483/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52483/tests/kraken/driver.html?testName=imaging-desaturate) 00:16:42 INFO - PROCESS | 6855 | RSS: Main: 211685376 00:16:42 INFO - PROCESS | 6855 | 00:16:45 INFO - PROCESS | 6855 | Cycle 1(1): loaded http://localhost:52483/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52483/tests/kraken/driver.html?testName=json-parse-financial) 00:16:45 INFO - PROCESS | 6855 | RSS: Main: 212316160 00:16:45 INFO - PROCESS | 6855 | 00:16:47 INFO - PROCESS | 6855 | Cycle 1(1): loaded http://localhost:52483/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52483/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:16:47 INFO - PROCESS | 6855 | RSS: Main: 191934464 00:16:47 INFO - PROCESS | 6855 | 00:16:49 INFO - PROCESS | 6855 | Cycle 1(1): loaded http://localhost:52483/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52483/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:16:50 INFO - PROCESS | 6855 | RSS: Main: 196599808 00:16:50 INFO - PROCESS | 6855 | 00:16:52 INFO - PROCESS | 6855 | Cycle 1(1): loaded http://localhost:52483/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52483/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:16:52 INFO - PROCESS | 6855 | RSS: Main: 211083264 00:16:52 INFO - PROCESS | 6855 | 00:16:55 INFO - PROCESS | 6855 | Cycle 1(1): loaded http://localhost:52483/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52483/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:16:55 INFO - PROCESS | 6855 | RSS: Main: 214986752 00:16:55 INFO - PROCESS | 6855 | 00:16:58 INFO - PROCESS | 6855 | Cycle 1(1): loaded http://localhost:52483/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52483/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:16:59 INFO - PROCESS | 6855 | RSS: Main: 210665472 00:16:59 INFO - PROCESS | 6855 | 00:17:00 INFO - PROCESS | 6855 | Cycle 1(1): loaded http://localhost:52483/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52483/tests/kraken/driver.html?testName=ai-astar) 00:17:00 INFO - PROCESS | 6855 | RSS: Main: 274468864 00:17:00 INFO - PROCESS | 6855 | 00:17:00 INFO - PROCESS | 6855 | __start_tp_report 00:17:00 INFO - PROCESS | 6855 | _x_x_mozilla_page_load 00:17:00 INFO - PROCESS | 6855 | _x_x_mozilla_page_load_details 00:17:00 INFO - PROCESS | 6855 | |i|pagename|runs| 00:17:00 INFO - PROCESS | 6855 | |0;ai-astar;110;109;108;110;110;110;104;108;108;109 00:17:00 INFO - PROCESS | 6855 | |1;audio-beat-detection;158;127;152;179;127;148;148;127;184;133 00:17:00 INFO - PROCESS | 6855 | |2;audio-dft;159;160;163;161;169;161;160;162;159;162 00:17:00 INFO - PROCESS | 6855 | |3;audio-fft;73;76;76;161;76;76;75;77;182;75 00:17:00 INFO - PROCESS | 6855 | |4;audio-oscillator;92;91;150;92;92;91;152;91;91;145 00:17:00 INFO - PROCESS | 6855 | |5;imaging-gaussian-blur;116;117;116;116;116;116;117;117;117;116 00:17:00 INFO - PROCESS | 6855 | |6;imaging-darkroom;145;145;145;145;145;145;146;145;145;145 00:17:00 INFO - PROCESS | 6855 | |7;imaging-desaturate;94;95;94;94;94;94;94;94;95;95 00:17:00 INFO - PROCESS | 6855 | |8;json-parse-financial;55;55;56;56;54;55;56;79;57;56 00:17:00 INFO - PROCESS | 6855 | |9;json-stringify-tinderbox;57;60;58;59;58;57;59;58;58;58 00:17:00 INFO - PROCESS | 6855 | |10;stanford-crypto-aes;71;72;79;73;74;72;80;72;73;74 00:17:00 INFO - PROCESS | 6855 | |11;stanford-crypto-ccm;112;121;118;114;115;112;126;109;126;110 00:17:00 INFO - PROCESS | 6855 | |12;stanford-crypto-pbkdf2;157;154;158;158;160;159;157;160;158;157 00:17:00 INFO - PROCESS | 6855 | |13;stanford-crypto-sha256-iterative;67;67;65;65;65;64;69;66;65;66 00:17:00 INFO - PROCESS | 6855 | __end_tp_report 00:17:00 INFO - PROCESS | 6855 | __start_cc_report 00:17:00 INFO - PROCESS | 6855 | _x_x_mozilla_cycle_collect,1564 00:17:00 INFO - PROCESS | 6855 | __end_cc_report 00:17:00 INFO - PROCESS | 6855 | __startTimestamp1463037420968__endTimestamp 00:17:00 INFO - PROCESS | 6855 | 00:17:00 INFO - PROCESS | 6855 | ------- Summary: start ------- 00:17:00 INFO - PROCESS | 6855 | Number of tests: 14 00:17:00 INFO - PROCESS | 6855 | 00:17:00 INFO - PROCESS | 6855 | [#0] ai-astar Cycles:10 Average:108.60 Median:109.50 stddev:1.84 (1.7%) stddev-sans-first:1.88 00:17:00 INFO - PROCESS | 6855 | Values: 110.0 109.0 108.0 110.0 110.0 110.0 104.0 108.0 108.0 109.0 00:17:00 INFO - PROCESS | 6855 | 00:17:00 INFO - PROCESS | 6855 | [#1] audio-beat-detection Cycles:10 Average:148.30 Median:150.00 stddev:20.87 (13.9%) stddev-sans-first:21.84 00:17:00 INFO - PROCESS | 6855 | Values: 158.0 127.0 152.0 179.0 127.0 148.0 148.0 127.0 184.0 133.0 00:17:00 INFO - PROCESS | 6855 | 00:17:00 INFO - PROCESS | 6855 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:2.91 (1.8%) stddev-sans-first:2.93 00:17:00 INFO - PROCESS | 6855 | Values: 159.0 160.0 163.0 161.0 169.0 161.0 160.0 162.0 159.0 162.0 00:17:00 INFO - PROCESS | 6855 | 00:17:00 INFO - PROCESS | 6855 | [#3] audio-fft Cycles:10 Average:94.70 Median:76.00 stddev:40.79 (53.7%) stddev-sans-first:42.50 00:17:00 INFO - PROCESS | 6855 | Values: 73.0 76.0 76.0 161.0 76.0 76.0 75.0 77.0 182.0 75.0 00:17:00 INFO - PROCESS | 6855 | 00:17:00 INFO - PROCESS | 6855 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:91.00 stddev:27.86 (30.6%) stddev-sans-first:28.89 00:17:00 INFO - PROCESS | 6855 | Values: 92.0 91.0 150.0 92.0 92.0 91.0 152.0 91.0 91.0 145.0 00:17:00 INFO - PROCESS | 6855 | 00:17:00 INFO - PROCESS | 6855 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 00:17:00 INFO - PROCESS | 6855 | Values: 116.0 117.0 116.0 116.0 116.0 116.0 117.0 117.0 117.0 116.0 00:17:00 INFO - PROCESS | 6855 | 00:17:00 INFO - PROCESS | 6855 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 00:17:00 INFO - PROCESS | 6855 | Values: 145.0 145.0 145.0 145.0 145.0 145.0 146.0 145.0 145.0 145.0 00:17:00 INFO - PROCESS | 6855 | 00:17:00 INFO - PROCESS | 6855 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 00:17:00 INFO - PROCESS | 6855 | Values: 94.0 95.0 94.0 94.0 94.0 94.0 94.0 94.0 95.0 95.0 00:17:00 INFO - PROCESS | 6855 | 00:17:00 INFO - PROCESS | 6855 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:56.00 stddev:7.46 (13.3%) stddev-sans-first:7.84 00:17:00 INFO - PROCESS | 6855 | Values: 55.0 55.0 56.0 56.0 54.0 55.0 56.0 79.0 57.0 56.0 00:17:00 INFO - PROCESS | 6855 | 00:17:00 INFO - PROCESS | 6855 | [#9] json-stringify-tinderbox Cycles:10 Average:58.20 Median:58.00 stddev:0.92 (1.6%) stddev-sans-first:0.87 00:17:00 INFO - PROCESS | 6855 | Values: 57.0 60.0 58.0 59.0 58.0 57.0 59.0 58.0 58.0 58.0 00:17:00 INFO - PROCESS | 6855 | 00:17:00 INFO - PROCESS | 6855 | [#10] stanford-crypto-aes Cycles:10 Average:74.00 Median:73.50 stddev:3.06 (4.2%) stddev-sans-first:3.04 00:17:00 INFO - PROCESS | 6855 | Values: 71.0 72.0 79.0 73.0 74.0 72.0 80.0 72.0 73.0 74.0 00:17:00 INFO - PROCESS | 6855 | 00:17:00 INFO - PROCESS | 6855 | [#11] stanford-crypto-ccm Cycles:10 Average:116.30 Median:116.50 stddev:6.24 (5.4%) stddev-sans-first:6.42 00:17:00 INFO - PROCESS | 6855 | Values: 112.0 121.0 118.0 114.0 115.0 112.0 126.0 109.0 126.0 110.0 00:17:00 INFO - PROCESS | 6855 | 00:17:00 INFO - PROCESS | 6855 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.80 Median:158.00 stddev:1.75 (1.1%) stddev-sans-first:1.83 00:17:00 INFO - PROCESS | 6855 | Values: 157.0 154.0 158.0 158.0 160.0 159.0 157.0 160.0 158.0 157.0 00:17:00 INFO - PROCESS | 6855 | 00:17:00 INFO - PROCESS | 6855 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:1.45 (2.2%) stddev-sans-first:1.48 00:17:00 INFO - PROCESS | 6855 | Values: 67.0 67.0 65.0 65.0 65.0 64.0 69.0 66.0 65.0 66.0 00:17:00 INFO - PROCESS | 6855 | -------- Summary: end -------- 00:17:00 INFO - PROCESS | 6855 | 00:17:02 INFO - TEST-INFO | 6855: exit 0 00:17:02 INFO - TEST-OK | kraken | took 60000ms 00:17:02 INFO - SUITE-END | took 1171s 00:17:02 INFO - Completed test suite (00:19:31) 00:17:02 INFO - javascript benchmark 00:17:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3321.883734069307, 3416.0264324667473, 3417.8461969211385, 3435.4846772984065, 3465.0297916583368, 5555.50000499955, 5569.10894256919, 5589.664620122785, 5610.635308704942, 5615.045442274808, 5571.470710282527, 5606.411326810688, 5620.831375058745, 5624.71876406179, 5630.352509461413, 4998.975005124969, 5000.449950505442, 5051.292819005333, 5143.382794064699, 5176.430592634807, 4987.875303117433, 5048.318477005612, 5050.873728156789, 5055.671381360218, 5107.974460127694, 5133.563647090002, 5173.120569503175, 5174.172132458807, 5174.818881339153, 5182.585393168538, 5102.923456148161, 5120.539151476348, 5175.482451754832, 5179.896402071938, 5193.558547523465, 4918.901621967577, 5046.142155833517, 5082.6188035897085, 5099.311592934943, 5126.5642420394315, 5493.533049690781, 5498.917516237259, 5505.697186654733, 5514.448555144493, 5525.309336332958, 5799.913001304942, 5998.28020637522, 6000.549958753068, 6002.189704389939, 6004.309504407005, 5962.433568810956, 6018.428249316308, 6026.939730602681, 6062.454379105901, 6065.363136870609, 5653.547716182696, 5653.689047102366, 5677.858053548694, 5687.402822703598, 5710.971445142789, 5979.491743201789, 6016.488598469092, 6105.725242364104, 6175.382461753788, 6190.566660333733, 5907.438793314628, 5912.024515954905, 5920.200772895604, 5923.378045305181, 5924.377940316291, 5961.4038596140035, 5985.072313791369, 5986.491148252448, 5988.101784732238, 5988.580799344004, 5798.594098413155, 5909.763609455574, 5954.642721436728, 5974.4324289192455, 5979.850503737442, 5908.084246941731, 5953.523718102628, 5963.135345374896, 5971.104334349795, 5972.163897054415, 4519.638428925678, 4538.410006699108, 4538.614217791524, 4561.954380456153, 4585.79363928624, 4000.7999600019884, 4054.2296963576828, 4062.1266427718183, 4103.4460347853255, 4150.107726838744, 5696.23100881384, 5714.914276285859, 5715.771369145271, 5717.199592057115, 5724.484796368347, 5988.251468566429, 6027.9095813562835, 6031.698415079229, 6032.547558933097, 6034.969825150846, 5543.223948647193, 5587.720613969285, 5629.7185140742795, 5666.263385759825, 5682.943170568324, 5145.4597267287145, 5146.279520867081, 5149.613778966517, 5167.896642067138, 5170.560502357342, 5983.401659834069, 6141.416565426277, 6196.380361963767, 6206.348333425016, 6208.596441231396, 5968.671723055187, 6048.637081775108, 6061.969690151521, 6068.666223357758, 6075.878482430415, 6134.018557030854, 6141.508679305734, 6160.10678451631, 6164.506839452743, 6179.073139029181, 5722.599418040863, 5857.1799948008165, 5913.704314784158, 5913.852153696192, 5917.082852157922, 5994.160817485643, 6010.218671572842, 6015.338312785678, 6031.60794548353, 6057.727402266997, 5807.477327040587, 5848.239728835224, 5850.64896106235, 5859.648421094748, 5867.823965281048, 5743.167240750151, 5755.65466072037, 5791.044477661308, 5795.0, 5851.21008663842, 5753.884922301614, 5756.3380211276235, 5764.13537969308, 5769.221155144001, 5769.913451298318, 5820.796272130455, 5862.912056319244, 5865.120231965239, 5867.237259156283, 5878.2358293421585, 5666.46168613981, 5758.280214973129, 5804.477597016289, 5877.764889404547, 5893.616914900518], "value": 5523.939177100357, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [648.0635481728904, 654.7315600603754, 664.9128674617003, 676.2324761395815, 740.9147947985981, 40525.39211911824, 41494.17011659765, 41552.96117597058, 41602.0, 41603.37594936079, 42981.35527967083, 44087.33868991968, 44094.0, 44227.3365899511, 44279.55720442795, 8198.098209197013, 8985.0, 9168.358214924958, 10557.577696892115, 10751.731206719816, 10642.78714425711, 10796.0, 10799.622013229538, 10806.72983175423, 10811.135109191286, 10860.239783215178, 10917.781644367107, 10920.726981825439, 10925.07136893365, 10926.180536459757, 8418.621162047692, 10888.020078192962, 11153.275037122561, 11157.609483668033, 11160.274582152135, 10464.52909619069, 10545.050945414949, 10579.0, 10579.100776434012, 10585.73535661607, 39213.41179882304, 39714.0, 39752.60247397518, 39757.20485590272, 39766.20467590661, 3841.5006049213425, 3870.2646497165447, 4045.0898547826796, 4127.252837548179, 4558.088382323515, 34234.82882585596, 34315.48526772101, 34544.13639659004, 35470.467942980875, 35776.28447431037, 4077.97961010196, 4107.876763697064, 4122.525909520384, 4145.689073319513, 4288.206681763852, 334084.0, 334465.0, 335447.0, 335716.6428335734, 336301.0, 38036.619633803304, 38571.80714096411, 38728.419073713914, 62546.68726656338, 63372.366276336645, 39190.608093918694, 39976.200475990896, 40095.39856902149, 40112.79943600322, 40188.0, 14734.778978315333, 17396.39112631052, 17545.824541754675, 17564.736528952075, 17583.648327033643, 12992.350382481027, 14702.485413010494, 14947.850521494864, 14964.551063468114, 15052.247387630574, 9077.137671921157, 9085.727428177166, 9151.0, 9180.31147663928, 9347.813043739086, 3472.392331342005, 3494.7029502492064, 3533.2050288685355, 3535.575730912307, 3549.8757543485854, 1074.1782536359692, 1087.7443800706828, 1171.7363593191465, 1199.3044034460167, 1269.8095285707218, 34049.82975085109, 34221.31557368889, 34539.30921381609, 34606.82696586501, 35253.64746352555, 1047.1936608811172, 1063.7766069125416, 1125.1561329003248, 1139.2480962564832, 1169.6958790714305, 17553.0, 18109.818901811075, 18746.437606871816, 19119.42641720723, 19226.903865480584, 464474.0, 468454.0, 469924.0, 471890.0, 474671.0, 64454.0, 64461.35538644647, 64996.67501662461, 65175.67412162909, 65328.67335663291, 1504.9623759405883, 1526.4205438247293, 1536.976945345843, 1561.7032763774846, 1609.9114548699933, 30363.24402085924, 32850.50724239091, 33516.832415837765, 33855.49216761701, 35010.29979400347, 52410.213846791565, 52478.737606311726, 53046.46953530415, 53138.20292695535, 53144.734276328374, 348625.0, 350928.0, 351051.0, 351389.0, 352553.0, 28081.297967550974, 28197.859010704815, 47972.520274798204, 48819.0, 49451.25823112728, 45797.54202457933, 47660.523394767, 48810.75594622146, 50227.24659130189, 51546.484535154166, 39781.80109099552, 40159.0, 40730.592694073865, 40792.796036020816, 41409.79295103505, 41619.37570936499, 42522.5747742531, 42978.35532467078, 43314.0, 43789.34315985326, 42753.0, 43034.56965430431, 43369.0, 44227.557724423634, 44448.77775611101, 37020.81489592643, 37688.43467347937, 38197.427038595, 38537.80731096327, 38589.80705096569, 28977.56533652039, 29456.917581243488, 29543.409131817672, 29623.0, 29729.554056689598], "value": 20043.287786209345, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.6981368694009, 414.8817586987709, 420.30020016672245, 427.790382712471, 435.1970614216769, 14381.424743010268, 18912.716309255356, 19480.0, 19498.512537186576, 20078.397648070546, 16124.193790310466, 18017.279308827663, 19744.506387340287, 19796.802031979674, 20424.489387765312, 5657.745401456934, 5792.855178620526, 5841.7955371562, 5864.912026319587, 5868.295804503444, 5760.107183386582, 5832.358440571534, 5833.3874943130995, 5833.445822646863, 5838.386969368197, 4289.356596510533, 5802.47777700009, 6235.625862448245, 6527.314631963647, 6551.639659818708, 6330.87338253237, 6334.873302533946, 6346.333634968308, 6372.299047104838, 6383.616982981012, 5603.551715862721, 5864.06175011996, 5866.120081987693, 5866.266716660418, 5868.354481007086, 12887.484500619965, 12892.677683057906, 12969.0, 13109.934450327783, 13178.86821131786, 2423.297243799296, 2454.9386265343333, 2509.372656835791, 3020.7281344678863, 3186.713195812365, 9720.465374404404, 10261.589536418534, 10515.789684206273, 10606.166608365369, 10926.125909927267, 1969.8227159555709, 2004.7494063242095, 2144.3888491779767, 2160.8163306119, 2262.230841513877, 76089.23910760877, 83842.0, 83938.0, 84568.57715711443, 87336.56331718364, 10878.72803179911, 11039.337639741641, 11178.944105279421, 11412.372319522507, 11433.485493152662, 15505.302261398265, 15626.609334766721, 15678.451254206277, 15704.0, 15720.135392553519, 8624.482531048157, 8682.565871706516, 8684.56577171139, 8693.869591956125, 8740.475571465733, 8643.654253829776, 8660.30717542595, 8670.349723770742, 8672.479651220947, 8726.389152759246, 4433.600975912119, 4820.831270905572, 4842.15262329091, 4877.609791216694, 4986.925196122061, 1826.2938726948403, 1899.6200759848086, 1955.706644003411, 1958.9608207835763, 1964.2339487599847, 988.5057471264367, 1065.4459680965854, 1124.16249893828, 1143.0798207443088, 1175.641429364052, 19329.903350483157, 19888.70166947497, 19901.201123438885, 20185.596288074157, 20223.4944126398, 1054.2394201683207, 1058.4919238765435, 1111.777644471109, 1125.2348403085816, 1129.5877004893318, 10915.672529824118, 10968.451577421098, 11197.104231661448, 11206.887931120747, 11278.210525263317, 400618.0, 404220.0, 406067.0, 612743.0, 632499.0, 84824.57587712022, 92282.53858730664, 92699.5365023184, 92807.53596232111, 107088.0, 1165.935873526964, 1168.8422063021553, 1186.2052424875353, 1210.7457433938796, 1220.2312543097792, 17821.643567128325, 18101.0, 18128.0, 18170.72743908869, 18522.444326670222, 39834.60165398309, 40424.39363409492, 41241.58758412377, 41649.79175104226, 42404.0, 54672.72663636656, 56546.717266413405, 56824.431755681915, 57010.0, 62048.68975655093, 8677.392582519164, 8734.606942687467, 8814.250788683034, 9122.087791220825, 9197.08029197075, 11988.520459181535, 13248.735025299247, 13474.393652285475, 13485.730285394433, 13659.931700341434, 11979.520819167135, 12085.75828483443, 12151.696207594881, 12287.815682764944, 12303.75392492163, 11656.417179140839, 12235.388230588613, 12470.501179953064, 12510.437030333474, 12821.102522823687, 10927.52103462899, 12240.326782027074, 12848.421821018264, 12934.482620695444, 13328.600141995756, 9006.63973441055, 9148.0, 9219.677311294072, 9321.394109382869, 9378.765530861783, 10700.953137410828, 12855.485780568673, 12924.224546527239, 12929.935350323189, 13144.80282795778], "value": 9457.792851742008, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1418.6453386653336, 1513.3568233500762, 1517.9544613661587, 1730.774999250098, 1924.2687778644122, 7837.294643482085, 7977.321927636151, 7998.960005199966, 8001.63992620332, 8032.9196708032905, 7982.560959147245, 8155.551444670556, 8163.061247956487, 8166.224208700179, 8169.550674712888, 2116.8094871461567, 2152.203684636687, 2380.6071998120287, 2388.7491813359607, 2415.927522174338, 2412.300432874464, 2429.0890915906534, 2429.1983645397063, 2429.6598476213344, 2430.3195105370523, 2315.8263130265213, 2334.8015418689433, 2390.2351247600773, 2390.40239940015, 2391.258709799959, 2108.5255817441107, 2343.6718859359703, 2391.1630929174826, 2392.928212153638, 2394.3774618599114, 2343.3907184132077, 2350.048230466664, 2371.6561098640773, 2371.905123795046, 2376.358383236534, 8158.347332213409, 8220.876686849702, 8243.793905152419, 8246.876296855551, 8251.793705157359, 5227.398849132361, 5321.0, 5321.042212401766, 5336.092864213054, 5336.279602253685, 3520.8591656333715, 3527.1182204448887, 3596.226811235571, 3600.567931848169, 3633.0372451300427, 1106.4910141334994, 1138.3340745663797, 1139.5384869128015, 1175.670812172593, 1208.7219939413983, 10891.945540272249, 10984.450777461096, 10986.670399888017, 11005.0, 11034.834477482844, 4598.839040633628, 4636.629069674418, 4646.558576935186, 4687.179743544866, 4688.976555117202, 9835.75410614726, 9840.065193806577, 9840.60637574489, 9851.359661621971, 9885.456299903575, 5324.307839980777, 5382.327209098863, 5402.51377376038, 5404.405515393303, 5410.1343784994215, 4183.267928112568, 4757.191277482836, 4802.759862006886, 4841.661083724176, 4864.537868902448, 3947.111899822517, 3986.920261594752, 4024.4768180136393, 4039.7374170678813, 4081.0817566047403, 1300.2523548959387, 1310.462710288777, 1311.8360204974379, 1317.538861398522, 1326.4760419634383, 1055.577768892449, 1055.8574592430077, 1057.1331508163387, 1062.8618279623754, 1072.4208927179236, 5865.706714664249, 5940.821775346746, 5970.582059255898, 5973.1936188614845, 6067.513459202523, 475.86675730795434, 483.24131114151146, 486.20020066989605, 487.43214155508434, 487.6927535652516, 4128.2156390285745, 4163.417121602978, 4174.874753757332, 4189.099343641071, 4255.127698821734, 9746.805063898682, 10148.441835698959, 10212.183025358103, 10293.330933489298, 10316.17470602365, 10056.094951454405, 10080.747981300527, 10110.595576176871, 10121.1903047756, 10213.182945364502, 7204.207537170907, 7617.809554761065, 7620.97116889224, 7647.235276472419, 7733.8453230935065, 5778.364379918122, 5859.882802344015, 5863.912041319469, 5989.40105989415, 6036.547258955508, 8963.731088067369, 9030.638774449211, 9082.59128339213, 9096.681616143404, 9139.497327647043, 9146.817063658556, 9463.716088517356, 9486.715398538056, 9613.471259080537, 9669.468179250209, 6386.840328991812, 7090.858182836418, 7093.680784364613, 7201.0, 7293.562386256842, 7568.091828980338, 7610.961945190239, 7616.7334143304715, 7634.427417943787, 7661.540307581563, 6847.0, 7013.123359580052, 7102.5028248022145, 7113.644317784194, 7155.534890232118, 6790.388865002174, 6872.518923675295, 7008.544444611084, 7008.719651213894, 7101.964490177723, 6567.310432404529, 6571.34286571339, 6572.112764776694, 6582.901256481061, 6603.438707709706, 5190.97404512975, 5255.684658920477, 5263.421023687315, 5278.419373868948, 5282.445343238905, 5219.451957544403, 5284.286621306074, 5290.312259406252, 5309.991101690666, 5380.73096345189], "value": 4451.568653309833, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.85805677728905, 358.0993800591512, 360.0817914318488, 366.68648305698645, 367.20866532622193, 6100.420460056288, 6240.7503699852, 6275.592086514384, 6310.0, 6330.905036424458, 6340.968295158529, 6358.554901156921, 6365.713542890569, 6379.617222966625, 6380.585261957981, 4805.591524720403, 4807.471178170407, 4808.567228949394, 4811.206150985084, 4815.66290359675, 4555.794989225493, 4645.094206629708, 4779.545943135397, 4811.855644330676, 4814.398200224972, 4735.242361222206, 4737.786799594027, 4741.976290118545, 4746.288056791474, 4751.643626727992, 4736.3369128322065, 4752.667313288071, 4752.809887604491, 4754.14425403429, 4761.571458568746, 4181.142865712522, 4188.099558594917, 4191.497020357577, 4197.895052623709, 4202.747835129871, 6032.879342413171, 6038.547108966845, 6038.758449662052, 6043.788467403664, 6060.848478788022, 5356.035913535562, 5581.413951535112, 5587.329520457572, 5601.719914004324, 5606.859828504279, 6584.572002819801, 6602.60384376939, 6627.0, 6633.701483433257, 6647.900281495781, 4592.33411155384, 4597.080583883203, 4600.953990460086, 4601.102784956935, 4609.861704148881, 6940.09778728762, 7007.439404847651, 7015.263397343257, 7024.367806897352, 7027.89458158128, 4705.576498115186, 4708.670393072521, 4709.599684026827, 4709.85870423881, 4710.36410084641, 4623.052274283764, 4766.523347665275, 4769.59458446029, 4773.689710168828, 4774.856754297377, 5501.917471237854, 5537.889242215214, 5538.363088244903, 5538.47384498472, 5541.418151094077, 6743.98840173968, 6746.156730408699, 6747.089142965735, 6749.797506074826, 6765.966170169216, 1599.448190374319, 1643.3837311008372, 1676.9916150419415, 1677.270387381493, 1681.041806170471, 1078.8327809189589, 1098.8791232964368, 1100.2298391126244, 1101.8181999970075, 1103.939283339424, 6332.176817013851, 6374.617522948545, 6388.584741991755, 6389.520785941073, 6392.936070639327, 6794.45644348451, 6801.2178599461695, 6811.25076241613, 6814.62519561419, 6815.114035175396, 6368.29948705642, 6370.267419246846, 6377.298497165308, 6378.330275321117, 6384.297727249998, 3692.7415080944074, 3720.5721342046013, 3722.683571896365, 3723.7765734056043, 3733.1227161617, 6960.869715000049, 7028.543144695578, 7104.964475177591, 7106.395956343666, 7111.146662400545, 6931.37617614407, 6944.618046007518, 6968.65156742171, 6973.12835895513, 6974.372306492339, 7016.912378581328, 7020.719171233196, 7031.613261270577, 7079.82300442493, 7091.290870912868, 6862.3137686230975, 6864.759733409307, 6865.244823069358, 6870.828229294308, 6881.0, 6681.465482761465, 6771.052052712723, 6906.136732908387, 6922.58464492132, 6923.757668481579, 7123.893141602776, 7206.495545311778, 7219.6029218391395, 7222.711091556279, 7233.927660723536, 4696.882577935579, 4727.692699974491, 4727.905441891212, 4738.147133516, 4742.359781429601, 6649.202095748541, 6782.728690852311, 6883.449324053963, 6962.268961758942, 6990.685419156252, 6700.0, 6749.0888730020815, 6759.155105611799, 6775.356341147583, 6799.184097908283, 6734.797956061326, 6743.258241593323, 6752.122224110834, 6759.763408280884, 6772.356626120511, 6661.600303981777, 6663.966680166568, 6664.766733164316, 6672.566283191577, 6678.933210667831, 6616.603003819786, 6822.761203357859, 6823.1812182538415, 6832.555883867532, 6833.829154270984, 6574.8356291093105, 6616.040674102132, 6649.035889795856, 6657.833554161185, 6677.3656502632175], "value": 5028.948657978657, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [777.4402430250218, 798.329403301227, 802.3380710913494, 848.8684253940639, 889.484099222451, 14475.203863787487, 14702.264886755673, 14877.107373557594, 16541.66916661669, 16799.748003779954, 15409.383624655, 15554.300056497457, 15572.922135389308, 15600.375984960616, 15605.063696178237, 725.8221735674741, 859.6260626627405, 861.7027125641675, 870.3602851903846, 871.3377832847018, 876.9605367758467, 883.2271762208068, 883.6067949762358, 886.4858382138376, 886.9556522173898, 931.8089791592741, 935.0042205051599, 935.5275585829181, 936.3679516326487, 936.8547875079373, 756.5158298688843, 910.1399177777004, 923.1829830599901, 927.7680579855037, 935.3125452792192, 676.5331920974512, 677.6510097299895, 677.8508728079814, 680.4794332335767, 683.8290427393151, 13869.167849929037, 13892.097013694078, 13900.721985560232, 13944.442222311096, 13951.162930224218, 12466.875331246752, 12942.805857912139, 13366.933165334209, 13540.917767806292, 13802.447902083904, 11518.193726439153, 11733.647990560297, 11783.764324713458, 11829.467673954692, 11939.820902686466, 3935.626115519021, 3952.664023557972, 4029.6373326400767, 4086.5709100544314, 4091.631753142202, 57129.0, 57774.133387999216, 58033.70983145057, 58135.41864581342, 58244.708776455846, 10372.11836993849, 10404.895951040544, 10454.581816727397, 10618.946905265579, 10791.02880740737, 19667.311644092675, 19681.606367872562, 19689.21243150258, 19694.01529923498, 19707.605847882962, 7905.209479052164, 7994.5203287802915, 8015.198480152055, 8233.876491852627, 8255.958720206481, 4935.087008903292, 4991.625628077909, 5000.249962505581, 5030.798768049237, 5133.717645529457, 3463.0130412832223, 3536.3457760314423, 3550.6449355064806, 3552.769070010441, 3565.0730809989072, 596.3916804859019, 612.1552257884091, 617.7961272780062, 628.5254632752243, 649.0718272869841, 721.2571051816637, 811.1726039439857, 817.5094943034132, 831.193742070191, 831.8835363049178, 9034.2320902724, 9302.813943721088, 9391.0, 9664.516774161404, 9874.555644995993, 789.4158322841056, 790.4506368074249, 810.5663470043617, 818.2676504528414, 829.9709510167115, 4433.689641725113, 4457.420535330386, 4510.2783554631105, 4515.209838278288, 4541.659375546781, 66435.0, 66879.66560167167, 67273.66363168153, 67597.32402676009, 68304.65847670729, 57651.711741441024, 58488.0, 58828.41171588229, 59265.407345926855, 59992.400075999554, 53703.0, 53925.73037134789, 54486.727566361915, 54855.451445485036, 55919.44080559224, 8749.956250218707, 8858.557072146496, 8989.955050224708, 9052.411593246417, 9117.5441227937, 38350.0, 38455.80772096122, 38568.0, 38985.220295594496, 39993.40009899912, 47158.0, 51865.22202167046, 52148.739256303474, 52423.73788131035, 52552.47447525629, 11454.0, 11527.596534121265, 11528.308301501602, 11610.245334053598, 11636.36000020007, 13090.14914030585, 13142.60572182836, 13572.0, 13711.520096796565, 13943.0, 10173.338732982333, 11360.375179365214, 12080.39598020113, 12206.877931220573, 12907.965055512917, 12051.638450846489, 12073.456694448596, 12279.754404911673, 12385.814212786636, 12838.871611284141, 12978.935105324414, 13034.283114428797, 13113.213207207598, 13310.134841235289, 13562.38969246406, 11266.887331126583, 11302.378369189773, 11474.541018359172, 11675.708107297385, 11727.413629318671, 10955.56177752881, 11098.0, 11349.205555611028, 11486.540538378371, 11576.710582235175], "value": 7035.592836583337, "unit": "score"}], "name": "dromaeo_css", "value": 7405.534906298627, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 109.0, 108.0, 110.0, 110.0, 110.0, 104.0, 108.0, 108.0, 109.0], "value": 108.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 127.0, 152.0, 179.0, 127.0, 148.0, 148.0, 127.0, 184.0, 133.0], "value": 148.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 163.0, 161.0, 169.0, 161.0, 160.0, 162.0, 159.0, 162.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 76.0, 161.0, 76.0, 76.0, 75.0, 77.0, 182.0, 75.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 150.0, 92.0, 92.0, 91.0, 152.0, 91.0, 91.0, 145.0], "value": 108.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0], "value": 145.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 56.0, 56.0, 54.0, 55.0, 56.0, 79.0, 57.0, 56.0], "value": 57.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 60.0, 58.0, 59.0, 58.0, 57.0, 59.0, 58.0, 58.0, 58.0], "value": 58.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 79.0, 73.0, 74.0, 72.0, 80.0, 72.0, 73.0, 74.0], "value": 74.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 121.0, 118.0, 114.0, 115.0, 112.0, 126.0, 109.0, 126.0, 110.0], "value": 116.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 154.0, 158.0, 158.0, 160.0, 159.0, 157.0, 160.0, 158.0, 157.0], "value": 157.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 65.0, 65.0, 65.0, 64.0, 69.0, 66.0, 65.0, 66.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1507.8000000000002, "alertThreshold": 2.0}]} 00:17:02 INFO - Return code: 0 00:17:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 00:17:02 ERROR - # TBPL SUCCESS # 00:17:02 INFO - Running post-action listener: _resource_record_post_action 00:17:02 INFO - Running post-run listener: _resource_record_post_run 00:17:03 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 458752; Write bytes: 262807552; Read time: 84; Write time: 228252 00:17:03 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 13905920; Read time: 0; Write time: 4504 00:17:03 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 458752; Write bytes: 245608448; Read time: 84; Write time: 221124 00:17:03 INFO - Running post-run listener: _upload_blobber_files 00:17:03 INFO - Blob upload gear active. 00:17:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:17:03 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 00:17:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:17:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:17:03 INFO - (blobuploader) - INFO - Open directory for files ... 00:17:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:17:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:17:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:17:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:17:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:17:04 INFO - (blobuploader) - INFO - Done attempting. 00:17:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:17:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:17:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:17:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:17:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:17:05 INFO - (blobuploader) - INFO - Done attempting. 00:17:05 INFO - (blobuploader) - INFO - Iteration through files over. 00:17:05 INFO - Return code: 0 00:17:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:17:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:17:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/30781cb499c50c0ffebb6313fa3fbf289bdbaf0ec4e61528378056f283a466ca2899b6384b08090bb1bce49417644c8dc6f965230fae054aaad4d4b8d94da4ea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eafe12b1c01a5e1371c191b68eb38975233830683b97b3f73da5aa40aa857aaf5fa40f5c093c3cc285fb0077e9824776ba446e4178683ba76b51be4e28598a85"} 00:17:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:17:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:17:05 INFO - Contents: 00:17:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/30781cb499c50c0ffebb6313fa3fbf289bdbaf0ec4e61528378056f283a466ca2899b6384b08090bb1bce49417644c8dc6f965230fae054aaad4d4b8d94da4ea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eafe12b1c01a5e1371c191b68eb38975233830683b97b3f73da5aa40aa857aaf5fa40f5c093c3cc285fb0077e9824776ba446e4178683ba76b51be4e28598a85"} 00:17:05 INFO - Running post-run listener: copy_logs_to_upload_dir 00:17:05 INFO - Copying logs to upload dir... 00:17:05 INFO - mkdir: /builds/slave/test/build/upload/logs 00:17:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.705724 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-12 00:17:05.145995) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-12 00:17:05.150214) ========= 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=62c568580acbfdaac3eec7be000001dc-1463034321.241424-1720971420 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/30781cb499c50c0ffebb6313fa3fbf289bdbaf0ec4e61528378056f283a466ca2899b6384b08090bb1bce49417644c8dc6f965230fae054aaad4d4b8d94da4ea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eafe12b1c01a5e1371c191b68eb38975233830683b97b3f73da5aa40aa857aaf5fa40f5c093c3cc285fb0077e9824776ba446e4178683ba76b51be4e28598a85"} build_url:https://queue.taskcluster.net/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011075 build_url: 'https://queue.taskcluster.net/v1/task/eXRlJ-CJRjKDz5MY3Ywoqg/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/30781cb499c50c0ffebb6313fa3fbf289bdbaf0ec4e61528378056f283a466ca2899b6384b08090bb1bce49417644c8dc6f965230fae054aaad4d4b8d94da4ea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eafe12b1c01a5e1371c191b68eb38975233830683b97b3f73da5aa40aa857aaf5fa40f5c093c3cc285fb0077e9824776ba446e4178683ba76b51be4e28598a85"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-12 00:17:05.179967) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 00:17:05.180326) ========= 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=62c568580acbfdaac3eec7be000001dc-1463034321.241424-1720971420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004438 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 00:17:05.263053) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-12 00:17:05.263383) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-12 00:17:05.263720) ========= ========= Total master_lag: 0.18 =========