builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-053 starttime: 1464648648.52 results: success (0) buildid: 20160530120549 builduid: 7997d47d310b490c9d491deb39fe4327 revision: 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:48.524703) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:48.525084) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:48.525355) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:48.602604) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:48.602850) ========= 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=920470bf432669ad7e3a5387000001ca-1464647765.631332-1006542387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-30 15:50:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-05-30 15:50:49 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.089748 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:48.710752) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:48.711433) ========= 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=920470bf432669ad7e3a5387000001ca-1464647765.631332-1006542387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021050 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:48.762287) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:48.762645) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 --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 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 --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=920470bf432669ad7e3a5387000001ca-1464647765.631332-1006542387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-30 15:50:49,288 truncating revision to first 12 chars 2016-05-30 15:50:49,288 Setting DEBUG logging. 2016-05-30 15:50:49,288 attempt 1/10 2016-05-30 15:50:49,288 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3c7a33fe0b64?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-30 15:50:49,596 unpacking tar archive at: mozilla-aurora-3c7a33fe0b64/testing/mozharness/ program finished with exit code 0 elapsedTime=0.679643 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:49.460832) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:49.461431) ========= script_repo_revision: 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:49.463130) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:49.463634) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:49.476277) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-30 15:50:49.476574) ========= /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=920470bf432669ad7e3a5387000001ca-1464647765.631332-1006542387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:50:50 INFO - MultiFileLogger online at 20160530 15:50:50 in /builds/slave/test 15:50:50 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 15:50:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:50:50 INFO - {'append_to_log': False, 15:50:50 INFO - 'base_work_dir': '/builds/slave/test', 15:50:50 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:50:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:50:50 INFO - 'branch': 'Mozilla-Aurora', 15:50:50 INFO - 'buildbot_json_path': 'buildprops.json', 15:50:50 INFO - 'config_files': ('talos/linux_config.py',), 15:50:50 INFO - 'default_actions': ('clobber', 15:50:50 INFO - 'read-buildbot-config', 15:50:50 INFO - 'download-and-extract', 15:50:50 INFO - 'populate-webroot', 15:50:50 INFO - 'create-virtualenv', 15:50:50 INFO - 'install', 15:50:50 INFO - 'run-tests'), 15:50:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:50:50 INFO - 'download_minidump_stackwalk': True, 15:50:50 INFO - 'download_symbols': 'ondemand', 15:50:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:50:50 INFO - 'tooltool.py': '/tools/tooltool.py', 15:50:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:50:50 INFO - '/tools/misc-python/virtualenv.py')}, 15:50:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:50:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:50:50 INFO - 'installer_path': 'installer.exe', 15:50:50 INFO - 'log_level': 'info', 15:50:50 INFO - 'log_name': 'talos', 15:50:50 INFO - 'log_to_console': True, 15:50:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:50:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:50:50 INFO - 'opt_config_files': (), 15:50:50 INFO - 'pip_index': False, 15:50:50 INFO - 'sps_profile': False, 15:50:50 INFO - 'sps_profile_interval': 0, 15:50:50 INFO - 'suite': 'dromaeojs', 15:50:50 INFO - 'system_bits': '32', 15:50:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:50:50 INFO - 'title': 'talos-linux64-ix-053', 15:50:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:50:50 INFO - 'use_talos_json': True, 15:50:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:50:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:50:50 INFO - 'work_dir': 'build'} 15:50:50 INFO - ##### 15:50:50 INFO - ##### Running clobber step. 15:50:50 INFO - ##### 15:50:50 INFO - Running pre-action listener: _resource_record_pre_action 15:50:50 INFO - Running main action method: clobber 15:50:50 INFO - rmtree: /builds/slave/test/build 15:50:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:50:50 INFO - Running post-action listener: _resource_record_post_action 15:50:50 INFO - ##### 15:50:50 INFO - ##### Running read-buildbot-config step. 15:50:50 INFO - ##### 15:50:50 INFO - Running pre-action listener: _resource_record_pre_action 15:50:50 INFO - Running main action method: read_buildbot_config 15:50:50 INFO - Using buildbot properties: 15:50:50 INFO - { 15:50:50 INFO - "project": "", 15:50:50 INFO - "product": "firefox", 15:50:50 INFO - "script_repo_revision": "production", 15:50:50 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 15:50:50 INFO - "repository": "", 15:50:50 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 15:50:50 INFO - "buildid": "20160530120549", 15:50:50 INFO - "pgo_build": "True", 15:50:50 INFO - "basedir": "/builds/slave/test", 15:50:50 INFO - "buildnumber": 352, 15:50:50 INFO - "slavename": "talos-linux64-ix-053", 15:50:50 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:50:50 INFO - "platform": "ubuntu64_hw", 15:50:50 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 15:50:50 INFO - "branch": "mozilla-aurora", 15:50:50 INFO - "repo_path": "releases/mozilla-aurora", 15:50:50 INFO - "revision": "3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4", 15:50:50 INFO - "stage_platform": "linux64-pgo", 15:50:50 INFO - "builduid": "7997d47d310b490c9d491deb39fe4327", 15:50:50 INFO - "slavebuilddir": "test" 15:50:50 INFO - } 15:50:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 15:50:50 INFO - Running post-action listener: _resource_record_post_action 15:50:50 INFO - ##### 15:50:50 INFO - ##### Running download-and-extract step. 15:50:50 INFO - ##### 15:50:50 INFO - Running pre-action listener: _resource_record_pre_action 15:50:50 INFO - Running main action method: download_and_extract 15:50:50 INFO - mkdir: /builds/slave/test/build/tests 15:50: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')]} 15:50:50 INFO - https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:50:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 15:50:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 15:50:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/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 15:50:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/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 15:50:54 INFO - Downloaded 1361 bytes. 15:50:54 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 15:50:54 INFO - Using the following test package requirements: 15:50:54 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 15:50:54 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:50:54 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 15:50:54 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:50:54 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 15:50:54 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:50:54 INFO - u'jsshell-linux-x86_64.zip'], 15:50:54 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:50:54 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 15:50:54 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 15:50:54 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:50:54 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 15:50:54 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:50:54 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 15:50:54 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:50:54 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 15:50:54 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:50:54 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 15:50:54 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:50: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')]} 15:50:54 INFO - https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:50:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 15:50:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 15:50:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/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 15:50:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/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 15:50:59 INFO - Downloaded 24173994 bytes. 15:50:59 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'] 15:50:59 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 15:51:00 INFO - Return code: 0 15:51:00 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 15:51: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')]} 15:51:00 INFO - https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:51:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 15:51:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 15:51:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/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 15:51:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/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 15:51:03 INFO - Downloaded 24173994 bytes. 15:51:03 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'] 15:51:03 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 15:51:04 INFO - Return code: 0 15:51:04 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')]} 15:51:04 INFO - https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:51:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 15:51:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 15:51:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/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 15:51:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/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 15:51:05 INFO - Downloaded 10840145 bytes. 15:51:05 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'] 15:51:05 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 15:51:05 INFO - Return code: 0 15:51:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:05 INFO - https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:51:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 15:51:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 15:51:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/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 15:51:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/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 15:51:07 INFO - Downloaded 62800628 bytes. 15:51:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 15:51:07 INFO - mkdir: /builds/slave/test/properties 15:51:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:51:07 INFO - Writing to file /builds/slave/test/properties/build_url 15:51:07 INFO - Contents: 15:51:07 INFO - build_url:https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 15:51:07 INFO - Running post-action listener: _resource_record_post_action 15:51:07 INFO - Running post-action listener: set_extra_try_arguments 15:51:07 INFO - ##### 15:51:07 INFO - ##### Running populate-webroot step. 15:51:07 INFO - ##### 15:51:07 INFO - Running pre-action listener: _resource_record_pre_action 15:51:07 INFO - Running main action method: populate_webroot 15:51:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:51:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:51:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:51:07 INFO - '--tppagecycles', 15:51:07 INFO - '7'], 15:51:07 INFO - 'tests': ['tsvgm']}}, 15:51:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:51:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:51:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:51:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:51:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:51:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:51:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:07 INFO - 'talos_options': ['--disable-e10s'], 15:51:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:51:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:51:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:07 INFO - 'talos_options': ['--disable-e10s'], 15:51:07 INFO - 'tests': ['damp', 'tps']}, 15:51:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:07 INFO - 'tests': ['damp', 'tps']}, 15:51:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:51:07 INFO - 'tests': ['dromaeo_dom']}, 15:51:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:51:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:51:07 INFO - 'tests': ['a11yr', 15:51:07 INFO - 'ts_paint', 15:51:07 INFO - 'tpaint', 15:51:07 INFO - 'sessionrestore', 15:51:07 INFO - 'sessionrestore_no_auto_restore', 15:51:07 INFO - 'tabpaint']}, 15:51:07 INFO - 'other-e10s': {'tests': ['a11yr', 15:51:07 INFO - 'ts_paint', 15:51:07 INFO - 'tpaint', 15:51:07 INFO - 'sessionrestore', 15:51:07 INFO - 'sessionrestore_no_auto_restore', 15:51:07 INFO - 'tabpaint']}, 15:51:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:51:07 INFO - 'ts_paint', 15:51:07 INFO - 'tpaint', 15:51:07 INFO - 'sessionrestore', 15:51:07 INFO - 'sessionrestore_no_auto_restore', 15:51:07 INFO - 'tabpaint']}, 15:51:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:51:07 INFO - 'ts_paint', 15:51:07 INFO - 'tpaint', 15:51:07 INFO - 'sessionrestore', 15:51:07 INFO - 'sessionrestore_no_auto_restore', 15:51:07 INFO - 'tabpaint']}, 15:51:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:51:07 INFO - 'tests': ['a11yr', 15:51:07 INFO - 'ts_paint', 15:51:07 INFO - 'tpaint', 15:51:07 INFO - 'sessionrestore', 15:51:07 INFO - 'sessionrestore_no_auto_restore', 15:51:07 INFO - 'tabpaint']}, 15:51:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:51:07 INFO - 'tests': ['a11yr', 15:51:07 INFO - 'ts_paint', 15:51:07 INFO - 'tpaint', 15:51:07 INFO - 'sessionrestore', 15:51:07 INFO - 'sessionrestore_no_auto_restore', 15:51:07 INFO - 'tabpaint']}, 15:51:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:51:07 INFO - 'tests': ['tsvgx', 15:51:07 INFO - 'tsvgr_opacity', 15:51:07 INFO - 'tart', 15:51:07 INFO - 'tscrollx', 15:51:07 INFO - 'cart']}, 15:51:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:51:07 INFO - 'tsvgr_opacity', 15:51:07 INFO - 'tart', 15:51:07 INFO - 'tscrollx', 15:51:07 INFO - 'cart']}, 15:51:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:07 INFO - 'talos_options': ['--disable-e10s'], 15:51:07 INFO - 'tests': ['tp5o']}, 15:51:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:07 INFO - 'tests': ['tp5o']}, 15:51:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:07 INFO - 'talos_options': ['--disable-e10s', 15:51:07 INFO - '--xperf_path', 15:51:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:51:07 INFO - 'tests': ['tp5n']}, 15:51:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:07 INFO - 'talos_options': ['--xperf_path', 15:51:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:51:07 INFO - 'tests': ['tp5n']}}, 15:51:07 INFO - 'talos.zip': {'path': '', 15:51:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:51:07 INFO - Running post-action listener: _resource_record_post_action 15:51:07 INFO - ##### 15:51:07 INFO - ##### Running create-virtualenv step. 15:51:07 INFO - ##### 15:51:07 INFO - Running pre-action listener: _resource_record_pre_action 15:51:07 INFO - Running main action method: create_virtualenv 15:51:07 INFO - Creating virtualenv /builds/slave/test/build/venv 15:51:07 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 15:51:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:51:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:51:07 INFO - Using real prefix '/usr' 15:51:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:51:08 INFO - Installing distribute.............................................................................................................................................................................................done. 15:51:10 INFO - Installing pip.................done. 15:51:10 INFO - Return code: 0 15:51:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:51: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')]} 15:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51: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')]} 15:51:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4598a73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19bb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4a410>, '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 0x1a4b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4b7a0>, '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': '920470bf432669ad7e3a5387000001ca-1464647765.631332-1006542387', '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 15:51: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', 'pip>=1.5'] in /builds/slave/test/build 15:51: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 pip>=1.5 15:51:10 INFO - Using env: {'DISPLAY': ':0', 15:51:10 INFO - 'HOME': '/home/cltbld', 15:51:10 INFO - 'LANG': 'en_US.UTF-8', 15:51:10 INFO - 'LANGUAGE': 'en_US:en', 15:51:10 INFO - 'LOGNAME': 'cltbld', 15:51:10 INFO - 'MAIL': '/var/mail/cltbld', 15:51:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:10 INFO - 'MOZ_NO_REMOTE': '1', 15:51:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:10 INFO - 'NO_EM_RESTART': '1', 15:51:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:10 INFO - 'PWD': '/builds/slave/test', 15:51:10 INFO - 'SHELL': '/bin/bash', 15:51:10 INFO - 'SHLVL': '1', 15:51:10 INFO - 'TERM': 'linux', 15:51:10 INFO - 'TMOUT': '86400', 15:51:10 INFO - 'USER': 'cltbld', 15:51:10 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1464647765.631332-1006542387', 15:51:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:10 INFO - '_': '/tools/buildbot/bin/python'} 15:51:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:10 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 15:51:10 INFO - Cleaning up... 15:51:10 INFO - Return code: 0 15:51:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:51: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')]} 15:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51: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')]} 15:51:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51: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', '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 0x7f4598a73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19bb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4a410>, '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 0x1a4b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4b7a0>, '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': '920470bf432669ad7e3a5387000001ca-1464647765.631332-1006542387', '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 15:51: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', 'psutil>=0.7.1'] in /builds/slave/test/build 15:51: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 psutil>=0.7.1 15:51:10 INFO - Using env: {'DISPLAY': ':0', 15:51:10 INFO - 'HOME': '/home/cltbld', 15:51:10 INFO - 'LANG': 'en_US.UTF-8', 15:51:10 INFO - 'LANGUAGE': 'en_US:en', 15:51:10 INFO - 'LOGNAME': 'cltbld', 15:51:10 INFO - 'MAIL': '/var/mail/cltbld', 15:51:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:10 INFO - 'MOZ_NO_REMOTE': '1', 15:51:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:10 INFO - 'NO_EM_RESTART': '1', 15:51:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:10 INFO - 'PWD': '/builds/slave/test', 15:51:10 INFO - 'SHELL': '/bin/bash', 15:51:10 INFO - 'SHLVL': '1', 15:51:10 INFO - 'TERM': 'linux', 15:51:10 INFO - 'TMOUT': '86400', 15:51:10 INFO - 'USER': 'cltbld', 15:51:10 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1464647765.631332-1006542387', 15:51:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:10 INFO - '_': '/tools/buildbot/bin/python'} 15:51:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:10 INFO - Downloading/unpacking psutil>=0.7.1 15:51: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 15:51: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 15:51: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 15:51: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 15:51: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 15:51: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 15:51:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:51:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:51:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:51:12 INFO - Installing collected packages: psutil 15:51:12 INFO - Running setup.py install for psutil 15:51:12 INFO - building 'psutil._psutil_linux' extension 15:51:12 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 15:51:13 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 15:51:13 INFO - building 'psutil._psutil_posix' extension 15:51:13 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 15:51:13 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 15:51:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:51:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:51:13 INFO - Successfully installed psutil 15:51:13 INFO - Cleaning up... 15:51:13 INFO - Return code: 0 15:51:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:51:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:13 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 0x7f4598a73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19bb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4a410>, '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 0x1a4b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4b7a0>, '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': '920470bf432669ad7e3a5387000001ca-1464647765.631332-1006542387', '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 15:51:13 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 15:51:13 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 15:51:13 INFO - Using env: {'DISPLAY': ':0', 15:51:13 INFO - 'HOME': '/home/cltbld', 15:51:13 INFO - 'LANG': 'en_US.UTF-8', 15:51:13 INFO - 'LANGUAGE': 'en_US:en', 15:51:13 INFO - 'LOGNAME': 'cltbld', 15:51:13 INFO - 'MAIL': '/var/mail/cltbld', 15:51:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:13 INFO - 'MOZ_NO_REMOTE': '1', 15:51:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:13 INFO - 'NO_EM_RESTART': '1', 15:51:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:13 INFO - 'PWD': '/builds/slave/test', 15:51:13 INFO - 'SHELL': '/bin/bash', 15:51:13 INFO - 'SHLVL': '1', 15:51:13 INFO - 'TERM': 'linux', 15:51:13 INFO - 'TMOUT': '86400', 15:51:13 INFO - 'USER': 'cltbld', 15:51:13 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1464647765.631332-1006542387', 15:51:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:13 INFO - '_': '/tools/buildbot/bin/python'} 15:51:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:51:13 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 15:51:13 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 15:51:13 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 15:51:13 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 15:51:13 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 15:51:13 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 15:51:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:51:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:51:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:51:15 INFO - Installing collected packages: mozsystemmonitor 15:51:15 INFO - Running setup.py install for mozsystemmonitor 15:51:15 INFO - Successfully installed mozsystemmonitor 15:51:15 INFO - Cleaning up... 15:51:15 INFO - Return code: 0 15:51:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:51:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:15 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 0x7f4598a73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19bb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4a410>, '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 0x1a4b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4b7a0>, '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': '920470bf432669ad7e3a5387000001ca-1464647765.631332-1006542387', '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 15:51:15 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 15:51:15 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 15:51:15 INFO - Using env: {'DISPLAY': ':0', 15:51:15 INFO - 'HOME': '/home/cltbld', 15:51:15 INFO - 'LANG': 'en_US.UTF-8', 15:51:15 INFO - 'LANGUAGE': 'en_US:en', 15:51:15 INFO - 'LOGNAME': 'cltbld', 15:51:15 INFO - 'MAIL': '/var/mail/cltbld', 15:51:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:15 INFO - 'MOZ_NO_REMOTE': '1', 15:51:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:15 INFO - 'NO_EM_RESTART': '1', 15:51:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:15 INFO - 'PWD': '/builds/slave/test', 15:51:15 INFO - 'SHELL': '/bin/bash', 15:51:15 INFO - 'SHLVL': '1', 15:51:15 INFO - 'TERM': 'linux', 15:51:15 INFO - 'TMOUT': '86400', 15:51:15 INFO - 'USER': 'cltbld', 15:51:15 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1464647765.631332-1006542387', 15:51:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:15 INFO - '_': '/tools/buildbot/bin/python'} 15:51:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:15 INFO - Downloading/unpacking blobuploader==1.2.4 15:51:15 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 15:51:15 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 15:51:15 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 15:51:15 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 15:51:15 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 15:51:15 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 15:51:17 INFO - Downloading blobuploader-1.2.4.tar.gz 15:51:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:51:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:51:17 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 15:51:17 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 15:51:17 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 15:51:17 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 15:51:17 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 15:51:17 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 15:51:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:51:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:51:18 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 15:51:18 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 15:51:18 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 15:51:18 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 15:51:18 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 15:51:18 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 15:51:18 INFO - Downloading docopt-0.6.1.tar.gz 15:51:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:51:18 INFO - Installing collected packages: blobuploader, requests, docopt 15:51:18 INFO - Running setup.py install for blobuploader 15:51:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:51:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:51:18 INFO - Running setup.py install for requests 15:51:18 INFO - Running setup.py install for docopt 15:51:19 INFO - Successfully installed blobuploader requests docopt 15:51:19 INFO - Cleaning up... 15:51:19 INFO - Return code: 0 15:51:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:19 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 0x7f4598a73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19bb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4a410>, '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 0x1a4b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4b7a0>, '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': '920470bf432669ad7e3a5387000001ca-1464647765.631332-1006542387', '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 15:51:19 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 15:51:19 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 15:51:19 INFO - Using env: {'DISPLAY': ':0', 15:51:19 INFO - 'HOME': '/home/cltbld', 15:51:19 INFO - 'LANG': 'en_US.UTF-8', 15:51:19 INFO - 'LANGUAGE': 'en_US:en', 15:51:19 INFO - 'LOGNAME': 'cltbld', 15:51:19 INFO - 'MAIL': '/var/mail/cltbld', 15:51:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:19 INFO - 'MOZ_NO_REMOTE': '1', 15:51:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:19 INFO - 'NO_EM_RESTART': '1', 15:51:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:19 INFO - 'PWD': '/builds/slave/test', 15:51:19 INFO - 'SHELL': '/bin/bash', 15:51:19 INFO - 'SHLVL': '1', 15:51:19 INFO - 'TERM': 'linux', 15:51:19 INFO - 'TMOUT': '86400', 15:51:19 INFO - 'USER': 'cltbld', 15:51:19 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1464647765.631332-1006542387', 15:51:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:19 INFO - '_': '/tools/buildbot/bin/python'} 15:51:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:51:19 INFO - Running setup.py (path:/tmp/pip-rIFdpZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:51:19 INFO - Running setup.py (path:/tmp/pip-igJdcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:51:19 INFO - Running setup.py (path:/tmp/pip-g5cGas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:51:19 INFO - Running setup.py (path:/tmp/pip-nIIKxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:51:19 INFO - Running setup.py (path:/tmp/pip-NqOFLh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:51:19 INFO - Running setup.py (path:/tmp/pip-99bYCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:51:19 INFO - Running setup.py (path:/tmp/pip-FrN84f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:51:19 INFO - Running setup.py (path:/tmp/pip-XEe_cw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:51:19 INFO - Running setup.py (path:/tmp/pip-5LKUsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:51:19 INFO - Running setup.py (path:/tmp/pip-qjZFAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:51:20 INFO - Running setup.py (path:/tmp/pip-0FLOnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:51:20 INFO - Running setup.py (path:/tmp/pip-Vln09x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:51:20 INFO - Running setup.py (path:/tmp/pip-sCkA4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:51:20 INFO - Running setup.py (path:/tmp/pip-xgrlFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:20 INFO - Running setup.py (path:/tmp/pip-wYcovW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:51:20 INFO - Running setup.py (path:/tmp/pip-tQQjU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:51:20 INFO - Running setup.py (path:/tmp/pip-ThkYjJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:51:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:51:20 INFO - Running setup.py install for manifestparser 15:51:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:51:20 INFO - Running setup.py install for mozcrash 15:51:20 INFO - Running setup.py install for mozdebug 15:51:20 INFO - Running setup.py install for mozdevice 15:51:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:51:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:51:20 INFO - Running setup.py install for mozfile 15:51:21 INFO - Running setup.py install for mozhttpd 15:51:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:51:21 INFO - Running setup.py install for mozinfo 15:51:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:51:21 INFO - Running setup.py install for mozInstall 15:51:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:51:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:51:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:51:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:51:21 INFO - Running setup.py install for mozleak 15:51:21 INFO - Running setup.py install for mozlog 15:51:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:51:21 INFO - Running setup.py install for moznetwork 15:51:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:51:21 INFO - Running setup.py install for mozprocess 15:51:21 INFO - Running setup.py install for mozprofile 15:51:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:51:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:51:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:51:21 INFO - Running setup.py install for mozrunner 15:51:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:51:22 INFO - Running setup.py install for mozscreenshot 15:51:22 INFO - Running setup.py install for moztest 15:51:22 INFO - Running setup.py install for mozversion 15:51:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:51:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:51:22 INFO - Cleaning up... 15:51:22 INFO - Return code: 0 15:51:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:22 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 0x7f4598a73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19bb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4a410>, '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 0x1a4b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4b7a0>, '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': '920470bf432669ad7e3a5387000001ca-1464647765.631332-1006542387', '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 15:51:22 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 15:51:22 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 15:51:22 INFO - Using env: {'DISPLAY': ':0', 15:51:22 INFO - 'HOME': '/home/cltbld', 15:51:22 INFO - 'LANG': 'en_US.UTF-8', 15:51:22 INFO - 'LANGUAGE': 'en_US:en', 15:51:22 INFO - 'LOGNAME': 'cltbld', 15:51:22 INFO - 'MAIL': '/var/mail/cltbld', 15:51:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:22 INFO - 'MOZ_NO_REMOTE': '1', 15:51:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:22 INFO - 'NO_EM_RESTART': '1', 15:51:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:22 INFO - 'PWD': '/builds/slave/test', 15:51:22 INFO - 'SHELL': '/bin/bash', 15:51:22 INFO - 'SHLVL': '1', 15:51:22 INFO - 'TERM': 'linux', 15:51:22 INFO - 'TMOUT': '86400', 15:51:22 INFO - 'USER': 'cltbld', 15:51:22 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1464647765.631332-1006542387', 15:51:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:22 INFO - '_': '/tools/buildbot/bin/python'} 15:51:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:51:22 INFO - Running setup.py (path:/tmp/pip-QJyubp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:51:22 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)) 15:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:51:22 INFO - Running setup.py (path:/tmp/pip-AR77La-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:51:22 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)) 15:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:51:22 INFO - Running setup.py (path:/tmp/pip-fjxTT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:51:22 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)) 15:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:51:22 INFO - Running setup.py (path:/tmp/pip-OiXhIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:51:22 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)) 15:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:51:22 INFO - Running setup.py (path:/tmp/pip-GyLlmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:51:22 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)) 15:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:51:22 INFO - Running setup.py (path:/tmp/pip-Tz8lwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:51:23 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)) 15:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:51:23 INFO - Running setup.py (path:/tmp/pip-8hds0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:51:23 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)) 15:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:51:23 INFO - Running setup.py (path:/tmp/pip-Cdp0Qo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:51:23 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)) 15:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:51:23 INFO - Running setup.py (path:/tmp/pip-LAVKOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:51:23 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)) 15:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:51:23 INFO - Running setup.py (path:/tmp/pip-QLP6gu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:51:23 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)) 15:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:51:23 INFO - Running setup.py (path:/tmp/pip-CFN_rk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:51:23 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)) 15:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:51:23 INFO - Running setup.py (path:/tmp/pip-rbGA5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:51:23 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)) 15:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:51:23 INFO - Running setup.py (path:/tmp/pip-nOzvSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:51:23 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)) 15:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:51:23 INFO - Running setup.py (path:/tmp/pip-rscaL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:51:23 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)) 15:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:23 INFO - Running setup.py (path:/tmp/pip-7X4T6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:23 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)) 15:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:51:23 INFO - Running setup.py (path:/tmp/pip-iWvQ2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:51:23 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)) 15:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:51:23 INFO - Running setup.py (path:/tmp/pip-wxRaG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:51:23 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)) 15:51:23 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)) 15:51:23 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)) 15:51:23 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)) 15:51:23 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)) 15:51:23 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)) 15:51:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:51:23 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 15:51:23 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 15:51:23 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 15:51:23 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 15:51:23 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 15:51:23 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 15:51:25 INFO - Downloading blessings-1.6.tar.gz 15:51:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:51:25 INFO - Installing collected packages: blessings 15:51:25 INFO - Running setup.py install for blessings 15:51:25 INFO - Successfully installed blessings 15:51:25 INFO - Cleaning up... 15:51:26 INFO - Return code: 0 15:51:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:51:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:51:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:51:26 INFO - Reading from file tmpfile_stdout 15:51:26 INFO - Current package versions: 15:51:26 INFO - argparse == 1.2.1 15:51:26 INFO - blessings == 1.6 15:51:26 INFO - blobuploader == 1.2.4 15:51:26 INFO - docopt == 0.6.1 15:51:26 INFO - manifestparser == 1.1 15:51:26 INFO - mozInstall == 1.12 15:51:26 INFO - mozcrash == 0.17 15:51:26 INFO - mozdebug == 0.1 15:51:26 INFO - mozdevice == 0.48 15:51:26 INFO - mozfile == 1.2 15:51:26 INFO - mozhttpd == 0.7 15:51:26 INFO - mozinfo == 0.9 15:51:26 INFO - mozleak == 0.1 15:51:26 INFO - mozlog == 3.1 15:51:26 INFO - moznetwork == 0.27 15:51:26 INFO - mozprocess == 0.22 15:51:26 INFO - mozprofile == 0.28 15:51:26 INFO - mozrunner == 6.11 15:51:26 INFO - mozscreenshot == 0.1 15:51:26 INFO - mozsystemmonitor == 0.0 15:51:26 INFO - moztest == 0.7 15:51:26 INFO - mozversion == 1.4 15:51:26 INFO - psutil == 3.1.1 15:51:26 INFO - requests == 1.2.3 15:51:26 INFO - wsgiref == 0.1.2 15:51:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:26 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 0x7f4598a73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19bb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4a410>, '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 0x1a4b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4b7a0>, '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': '920470bf432669ad7e3a5387000001ca-1464647765.631332-1006542387', '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 15:51:26 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 15:51:26 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 15:51:26 INFO - Using env: {'DISPLAY': ':0', 15:51:26 INFO - 'HOME': '/home/cltbld', 15:51:26 INFO - 'LANG': 'en_US.UTF-8', 15:51:26 INFO - 'LANGUAGE': 'en_US:en', 15:51:26 INFO - 'LOGNAME': 'cltbld', 15:51:26 INFO - 'MAIL': '/var/mail/cltbld', 15:51:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:26 INFO - 'MOZ_NO_REMOTE': '1', 15:51:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:26 INFO - 'NO_EM_RESTART': '1', 15:51:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:26 INFO - 'PWD': '/builds/slave/test', 15:51:26 INFO - 'SHELL': '/bin/bash', 15:51:26 INFO - 'SHLVL': '1', 15:51:26 INFO - 'TERM': 'linux', 15:51:26 INFO - 'TMOUT': '86400', 15:51:26 INFO - 'USER': 'cltbld', 15:51:26 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1464647765.631332-1006542387', 15:51:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:26 INFO - '_': '/tools/buildbot/bin/python'} 15:51:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:26 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)) 15:51:26 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)) 15:51:26 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)) 15:51:26 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)) 15:51:26 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)) 15:51:26 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)) 15:51:26 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)) 15:51:26 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)) 15:51:26 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)) 15:51:26 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)) 15:51:26 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)) 15:51:26 INFO - Cleaning up... 15:51:26 INFO - Return code: 0 15:51:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:51:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:26 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 0x7f4598a73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19bb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4a410>, '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 0x1a4b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4b7a0>, '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': '920470bf432669ad7e3a5387000001ca-1464647765.631332-1006542387', '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 15:51:26 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 15:51:26 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 15:51:26 INFO - Using env: {'DISPLAY': ':0', 15:51:26 INFO - 'HOME': '/home/cltbld', 15:51:26 INFO - 'LANG': 'en_US.UTF-8', 15:51:26 INFO - 'LANGUAGE': 'en_US:en', 15:51:26 INFO - 'LOGNAME': 'cltbld', 15:51:26 INFO - 'MAIL': '/var/mail/cltbld', 15:51:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:26 INFO - 'MOZ_NO_REMOTE': '1', 15:51:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:26 INFO - 'NO_EM_RESTART': '1', 15:51:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:26 INFO - 'PWD': '/builds/slave/test', 15:51:26 INFO - 'SHELL': '/bin/bash', 15:51:26 INFO - 'SHLVL': '1', 15:51:26 INFO - 'TERM': 'linux', 15:51:26 INFO - 'TMOUT': '86400', 15:51:26 INFO - 'USER': 'cltbld', 15:51:26 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1464647765.631332-1006542387', 15:51:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:26 INFO - '_': '/tools/buildbot/bin/python'} 15:51:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:26 INFO - Downloading/unpacking jsonschema 15:51:26 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 15:51:26 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 15:51:26 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 15:51:26 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 15:51:26 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 15:51:26 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 15:51:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:51:28 INFO - Downloading/unpacking functools32 (from jsonschema) 15:51:28 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 15:51:28 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 15:51:28 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 15:51:28 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 15:51:28 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 15:51:28 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 15:51:28 INFO - Downloading functools32-3.2.3-2.tar.gz 15:51:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:51:28 INFO - warning: no files found matching '*.txt' 15:51:28 INFO - no previously-included directories found matching 'build' 15:51:28 INFO - no previously-included directories found matching 'dist' 15:51:28 INFO - no previously-included directories found matching '.git*' 15:51:28 INFO - Installing collected packages: jsonschema, functools32 15:51:28 INFO - Running setup.py install for functools32 15:51:28 INFO - warning: no files found matching '*.txt' 15:51:28 INFO - no previously-included directories found matching 'build' 15:51:28 INFO - no previously-included directories found matching 'dist' 15:51:28 INFO - no previously-included directories found matching '.git*' 15:51:28 INFO - Successfully installed jsonschema functools32 15:51:28 INFO - Cleaning up... 15:51:29 INFO - Return code: 0 15:51:29 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:51: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')]} 15:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51: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')]} 15:51:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:29 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 0x7f4598a73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19bb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4a410>, '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 0x1a4b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4b7a0>, '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': '920470bf432669ad7e3a5387000001ca-1464647765.631332-1006542387', '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 15:51:29 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 15:51:29 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 15:51:29 INFO - Using env: {'DISPLAY': ':0', 15:51:29 INFO - 'HOME': '/home/cltbld', 15:51:29 INFO - 'LANG': 'en_US.UTF-8', 15:51:29 INFO - 'LANGUAGE': 'en_US:en', 15:51:29 INFO - 'LOGNAME': 'cltbld', 15:51:29 INFO - 'MAIL': '/var/mail/cltbld', 15:51:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:29 INFO - 'MOZ_NO_REMOTE': '1', 15:51:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:29 INFO - 'NO_EM_RESTART': '1', 15:51:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:29 INFO - 'PWD': '/builds/slave/test', 15:51:29 INFO - 'SHELL': '/bin/bash', 15:51:29 INFO - 'SHLVL': '1', 15:51:29 INFO - 'TERM': 'linux', 15:51:29 INFO - 'TMOUT': '86400', 15:51:29 INFO - 'USER': 'cltbld', 15:51:29 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1464647765.631332-1006542387', 15:51:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:29 INFO - '_': '/tools/buildbot/bin/python'} 15:51:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:29 INFO - Downloading/unpacking flake8 15:51:29 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 15:51:29 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 15:51:29 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 15:51:29 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 15:51:29 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 15:51:29 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 15:51:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:51:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:51:31 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 15:51:31 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 15:51:31 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 15:51:31 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 15:51:31 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 15:51:31 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 15:51:31 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:51:31 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:51:31 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 15:51:31 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 15:51:31 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 15:51:31 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 15:51:31 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 15:51:31 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 15:51:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:51:31 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 15:51:31 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 15:51:31 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 15:51:31 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 15:51:31 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 15:51:31 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 15:51:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:51:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:51:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:51:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:51:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:51:31 INFO - no previously-included directories found matching 'docs/_build' 15:51:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:51:31 INFO - Running setup.py install for pep8 15:51:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:51:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:51:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:51:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:51:32 INFO - no previously-included directories found matching 'docs/_build' 15:51:32 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:51:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:51:32 INFO - Cleaning up... 15:51:32 INFO - Return code: 0 15:51:32 INFO - Running post-action listener: _resource_record_post_action 15:51:32 INFO - Running post-action listener: _start_resource_monitoring 15:51:32 INFO - Starting resource monitoring. 15:51:32 INFO - ##### 15:51:32 INFO - ##### Running install step. 15:51:32 INFO - ##### 15:51:32 INFO - Running pre-action listener: _resource_record_pre_action 15:51:32 INFO - Running main action method: install 15:51:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:51:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:51:32 INFO - Reading from file tmpfile_stdout 15:51:32 INFO - Detecting whether we're running mozinstall >=1.0... 15:51:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:51:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:51:32 INFO - Reading from file tmpfile_stdout 15:51:32 INFO - Output received: 15:51:32 INFO - Usage: mozinstall [options] installer 15:51:32 INFO - Options: 15:51:32 INFO - -h, --help show this help message and exit 15:51:32 INFO - -d DEST, --destination=DEST 15:51:32 INFO - Directory to install application into. [default: 15:51:32 INFO - "/builds/slave/test"] 15:51:32 INFO - --app=APP Application being installed. [default: firefox] 15:51:32 INFO - mkdir: /builds/slave/test/build/application 15:51:32 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'] 15:51:32 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 15:51:48 INFO - Reading from file tmpfile_stdout 15:51:48 INFO - Output received: 15:51:48 INFO - /builds/slave/test/build/application/firefox/firefox 15:51:48 INFO - Running post-action listener: _resource_record_post_action 15:51:48 INFO - ##### 15:51:48 INFO - ##### Running run-tests step. 15:51:48 INFO - ##### 15:51:48 INFO - Running pre-action listener: _resource_record_pre_action 15:51:48 INFO - Running main action method: run_tests 15:51:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:51:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:51:48 INFO - Python 2.7.3 15:51:48 INFO - Return code: 0 15:51:48 INFO - grabbing minidump binary from tooltool 15:51:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:48 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 0x1a4a410>, '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 0x1a4b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4b7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:51:48 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 15:51:48 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 15:51:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:51:48 INFO - Return code: 0 15:51:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:51:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:51:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:51:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:51:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:51:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:51:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:51:49 INFO - Return code: 0 15:51:49 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/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 15:51:49 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/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --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 15:51:49 INFO - Using env: {'DISPLAY': ':0', 15:51:49 INFO - 'HOME': '/home/cltbld', 15:51:49 INFO - 'LANG': 'en_US.UTF-8', 15:51:49 INFO - 'LANGUAGE': 'en_US:en', 15:51:49 INFO - 'LOGNAME': 'cltbld', 15:51:49 INFO - 'MAIL': '/var/mail/cltbld', 15:51:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:51:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:51:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:49 INFO - 'MOZ_NO_REMOTE': '1', 15:51:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:51:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:49 INFO - 'NO_EM_RESTART': '1', 15:51:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:49 INFO - 'PWD': '/builds/slave/test', 15:51:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:51:49 INFO - 'SHELL': '/bin/bash', 15:51:49 INFO - 'SHLVL': '1', 15:51:49 INFO - 'TERM': 'linux', 15:51:49 INFO - 'TMOUT': '86400', 15:51:49 INFO - 'USER': 'cltbld', 15:51:49 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1464647765.631332-1006542387', 15:51:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:49 INFO - '_': '/tools/buildbot/bin/python'} 15:51:49 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/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 15:51:49 INFO - mozversion application_buildid: 20160530120549 15:51:49 INFO - mozversion application_changeset: 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 15:51:49 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:51:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:51:49 INFO - mozversion application_name: Firefox 15:51:49 INFO - mozversion application_remotingname: firefox-dev 15:51:49 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:51:49 INFO - mozversion application_vendor: Mozilla 15:51:49 INFO - mozversion application_version: 48.0a2 15:51:49 INFO - mozversion platform_buildid: 20160530120549 15:51:49 INFO - mozversion platform_changeset: 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 15:51:49 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:51:49 INFO - mozversion platform_version: 48.0a2 15:51:49 INFO - using testdate: 1464648709 15:51:49 INFO - actual date: 1464648709 15:51:49 INFO - starting webserver on 'localhost:35437' 15:51:49 INFO - SUITE-START | Running 2 tests 15:51:49 INFO - TEST-START | dromaeo_css 15:51:49 INFO - operating with platform_type : linux_ 15:51:49 INFO - Initialising browser for dromaeo_css test... 15:51:49 INFO - TEST-INFO | started process 27263 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQCBwNv/profile http://localhost:35437/getInfo.html) 15:51:53 INFO - PROCESS | 27263 | __metrics Screen width/height:1600/1200 15:51:53 INFO - PROCESS | 27263 | colorDepth:24 15:51:53 INFO - PROCESS | 27263 | Browser inner width/height: 1024/697 15:51:53 INFO - PROCESS | 27263 | __metrics 15:51:54 ERROR - PROCESS | 27263 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:51:55 INFO - TEST-INFO | 27263: exit 0 15:51:55 INFO - Browser initialized. 15:51:55 INFO - Running cycle 1/1 for dromaeo_css test... 15:51:55 INFO - TEST-INFO | started process 27354 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQCBwNv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:52:07 INFO - PROCESS | 27354 | RSS: Main: 141971456 15:52:07 INFO - PROCESS | 27354 | 15:52:58 INFO - PROCESS | 27354 | 1464648778380 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] 15:55:06 INFO - PROCESS | 27354 | Cycle 1(1): loaded http://localhost:35437/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35437/tests/dromaeo/cssquery-ext.html) 15:55:07 INFO - PROCESS | 27354 | RSS: Main: 251174912 15:55:07 INFO - PROCESS | 27354 | 15:58:09 INFO - PROCESS | 27354 | Cycle 1(1): loaded http://localhost:35437/tests/dromaeo/cssquery-ext.html (next: http://localhost:35437/tests/dromaeo/cssquery-jquery.html) 15:58:09 INFO - PROCESS | 27354 | RSS: Main: 221876224 15:58:09 INFO - PROCESS | 27354 | 16:01:11 INFO - PROCESS | 27354 | Cycle 1(1): loaded http://localhost:35437/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35437/tests/dromaeo/cssquery-mootools.html) 16:01:12 INFO - PROCESS | 27354 | RSS: Main: 219451392 16:01:12 INFO - PROCESS | 27354 | 16:04:14 INFO - PROCESS | 27354 | Cycle 1(1): loaded http://localhost:35437/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35437/tests/dromaeo/cssquery-prototype.html) 16:04:14 INFO - PROCESS | 27354 | RSS: Main: 218353664 16:04:14 INFO - PROCESS | 27354 | 16:07:17 INFO - PROCESS | 27354 | Cycle 1(1): loaded http://localhost:35437/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35437/tests/dromaeo/cssquery-yui.html) 16:07:17 INFO - PROCESS | 27354 | RSS: Main: 208416768 16:07:17 INFO - PROCESS | 27354 | 16:10:20 INFO - PROCESS | 27354 | Cycle 1(1): loaded http://localhost:35437/tests/dromaeo/cssquery-yui.html (next: http://localhost:35437/tests/dromaeo/cssquery-dojo.html) 16:10:20 INFO - PROCESS | 27354 | RSS: Main: 258789376 16:10:20 INFO - PROCESS | 27354 | 16:10:20 INFO - PROCESS | 27354 | __start_tp_report 16:10:20 INFO - PROCESS | 27354 | _x_x_mozilla_page_load 16:10:20 INFO - PROCESS | 27354 | _x_x_mozilla_page_load_details 16:10:20 INFO - PROCESS | 27354 | |i|pagename|runs| 16:10:20 INFO - PROCESS | 27354 | |0;dojo.html;3318.469044952808;3413.2661477782285;3425.7601967862242;3436.175317923699;3452.6547345265462;5615.494605485505;5628.521575666063;5638.097904335307;5639.182318563816;5641.266635337405;5628.746706398211;5643.5767317451255;5643.943560564393;5655.745491452884;5662.150677398392;4913.778879950411;5086.898262034757;5208.817691380802;5267.078261304276;5294.92057619136;5084.3644544431945;5133.230015497668;5140.742962851861;5143.408508021588;5148.150555158394;5085.262636917645;5134.768935397916;5150;5185.040767458032;5193.324867767204;5171.818986335479;5218.347706536683;5223.503767142134;5226.189940559219;5258.447862974409;5004.299398084271;5004.374453193351;5040.873978150539;5114;5119.718415487147;5477.698726570077;5492.038893193715;5518.227448157261;5525.0883604205255;5525.861853453655;6004.759809607611;6005.249343832021;6013.248343957005;6013.5489838261865;6016.699165041774;6014.548908831855;6030.547708921848;6043.637381757108;6076.939230607682;6106.48094911933;5649.265595472603;5675.829725108253;5699.544036477072;5704.144378343199;5705.572082093818;6028.728707208186;6201.348858369896;6206.255249370104;6209.782657606962;6209.9068513972325;5942.673152976541;5989.730462129215;5995.190649262381;6013.789517366871;6040.607360521552;6010.579259451796;6014.849628759316;6017.669028203403;6020.006698894721;6020.518358531307;5889.352171261158;5968.46283834457;5970.671613061323;5973.731182096816;5975;5920.585559010828;5924.229850119543;5927.110933360031;5927.8221653350465;5970.820875373745;4522.3442600823355;4522.977385113053;4524.932126018112;4525.773711314421;4553.635709143261;4020.3768415895584;4063.227986682521;4069.8168582413864;4101.815418306183;4143.150654115899;5675.3757086720425;5703.258576385127;5705.657660540381;5706.229658995982;5728.255326807488;5999.940000600025;6051.818445446644;6053.970824959767;6054.757809687651;6059.151718759377;5583.720813959286;5675.659460432387;5730.3410107838135;5741.62679425836;5755.712214389264;5183.766730497136;5198.818041368534;5202.3497062867145;5206.193040078794;5207.270982062514;6286.151369565142;6301.684915754194;6301.7164227608955;6302.590331628429;6306.054091886253;5951.523878089829;5959.553033522417;6054;6081.361457046946;6099.207103076749;6172.894890314469;6206.534509911865;6221.2845522763655;6227.595206311576;6231.2522497298805;5883.176355310346;5897.056470964625;5902.144189092472;5902.940970590239;5917.644941303535;5930.673812940157;6033.668148251888;6079.604825686316;6098.963176260135;6108.144859719731;5773.278340207474;5809.302883653989;5811.506021988178;5816.331121921034;5817.069268916953;5750.827475175752;5776.9133462998925;5797.536197104306;5809.302883653989;5814.622049566765;5786.681732504752;5844.064949608042;5870.295564532284;5871.500922421642;5878.706064696663;5867.325257595431;5892.528597712087;5900.173975643499;5900.409959004237;5904.704764761831;5582.49757521825;5745.2818397700285;5761.423857614205;5800.419958004166;5806.390329015561 16:10:20 INFO - PROCESS | 27354 | |1;ext.html;652.4454213918167;658.9637569933658;679.1849780263684;719.5466855880794;738.6380673469998;31441.528377074334;32301.192470188256;32322.030339089837;32326.838365808137;38740.80629596848;45174.77412612933;45802.77098614511;45831.08337833241;45953.77023114888;45965.54034459654;8965.32760042996;9148.542572871364;9157.175854173123;9157.542122893861;9166.770830729218;8076.434649574532;8978.551072446384;10524.842127368096;10804.405757683324;10804.837927431096;10548.156147508182;10617.203709721764;10625.415602141878;10635.680929572125;10639.734006649856;8144.633491492897;10447.529861156267;10524.526396312145;10527.684169474851;10533.473326333653;10264.948675256575;10437.217208709377;10444.582216711322;10468.947655261674;10472.895271047268;40169.59830401688;40670.59329406697;40713.796431017654;40736.18527629431;40761;3738.2710371477574;3794.582595914447;3852.57621661617;4037.212743515016;4226.492820861486;31229;31643.36713265722;31992.680073199437;32417.35165296681;33648.66351336504;4550.112728018038;4651.2557990721325;4654.348391225231;4697.7181369117625;4723.952760472385;332679;334697.99999999756;335264;335629.96555051696;335761;40055.39916901249;68279.3172068273;68844.6557767218;69127.65436172787;69299;39916;40060.79969600133;40162.39756403656;40188.79905600512;40196.39705404421;15306.38774449032;15371.61570960735;15491.845081549265;15511.767323490156;15513.922430387776;12822.743545129231;12890.67773305675;12899.226046437243;13172.538961136313;13174.73650526984;9276.582553785096;9324.90675093254;9346.0653934606;9379.296552758571;9405.482698451515;3557.181848174934;3689.7417180797624;3693.519842420522;3694.704423646102;3700.0934770980743;1200.3218181727295;1208.1422190245025;1213.8118591618313;1220.134700492119;1229.1027549888631;33612.159696007795;33956.490652640234;34377.48433773495;34697.30605387878;34712;1191.5650787462687;1200.2258543239561;1292.8299888600832;1326.2838067443665;1342.7918672605763;17852.55368615795;17969.550761230814;17979.820201798077;18148.455546333367;18479.81520184808;507412;513871;514398;514479;515132;62253.37746622566;63867.04199437012;63870;63923.68038159872;63928.68035659885;1411.1039489923971;1499.4901733410693;1526.6946610677908;1539.5227479481396;1636.2800367838113;30117.3389837279;33284.50073248952;33499.83250083734;34297.65702342945;34450.48324275088;51479;51486.22770658518;51846.74076629744;51905.22142167795;51957;306728;306846;312551;312866;313271;27705;31091.68908310888;31356;31995;32063.839680801448;45121;45230.54769452263;45422.09155816931;45909;46693.53306467028;37439;38231.2353752929;38297.61702383052;38453.230935381696;39242.411363830135;37521.23598425026;38066;38449.23101538009;38537.80731096327;38915;42815.78592107144;43386.56613433825;43482.56517434912;43512.34731478967;43997.78001109974;36682.63317366792;37059.81470092632;37239.813800930824;38058.809705951295;38339.42490862695;29064.273393164494;29072.563911541765;29100.563491548066;29128.56307155352;29301.560476592444 16:10:20 INFO - PROCESS | 27354 | |2;jquery.html;429.5661382004177;433.56210227670056;437.6651861326084;438.7126432186919;439.7845055922598;19750.40748777537;20043.398698039065;20591.07340169692;21093.894530527326;21116.577668446622;20528.178872845107;20614.793852061473;20765.169393224292;20932;20965.790342096574;5737.397573254801;5949.196858424122;5961.701914904259;5998.700064996755;5998.730057147417;4375.562443755631;5874;5970.910436343458;6308.968455157741;6611.338866113374;6587.044878492616;6604.438622717074;6604.933950660504;6609.900851487231;6622.4370928471135;6332.430081292683;6557.082008518787;6561.901571476432;6577.046328282396;6579.374959378852;3994.1612261425134;4159.604837540429;5512.476314750093;5779.2775903012125;5803.88392232153;23924.880375598186;24111.035558577634;24350.26949191527;24696;24712.25863224106;2619.4368210834573;2626.8817903194404;2642.616820561027;2712.145674112648;2720.8095433319677;14722.63193420173;15107.54677359681;15389.307481163374;15768.132752698597;15783.842161578352;2097.8951052447314;2119.724435823333;2141.4860433496005;2159.373781603333;2174.9021294041804;81185;82535.9999999994;83168.58415707943;84529.57735211284;84593;10396.740081498023;11257.211995160424;11276.94361528187;11397;11626.069914406828;16025.599360016093;16080.67838643244;16124.677506449805;16135.515934521984;16144.192790360436;8640.740777776677;8751.824963500694;9138.634454621873;9147.771305717277;9233.676821311356;8406.327493800482;8451.830963380698;8507.872381914276;8642.30861531076;9155.587998540082;6834.897476537856;7100.893486597705;7199.115793247016;7249.238829922888;7317.451191160684;1812.917901702617;1940.645521031971;1973.8124878136555;2019.1721394228296;2048.2933387981125;1061.6178175856685;1085;1120.3781901045;1178.157617303632;1200.9219400738923;19749.308774192836;20086.991300869795;20230.898845505973;20339.694904576445;20568.485787855425;1088.292609803634;1097.067492631273;1102.2780079048237;1122.1023181454802;1144.456383217965;11048.171387145996;11811.173217874666;11815.409229538489;11861.584844530573;12081.758364832654;509678;535801;539471;567074;570830;85604;85774.57112714522;85962.57018714992;87910.56044719735;88524.5573772127;1076.321917192164;1080.621782376162;1124.0726400719439;1141.08713029576;1141.9257748246337;17712.66323684258;17922.731159032886;17933.193006314486;18043.368482103062;18273.81726182721;37898.43152352662;38141.809290953366;38352.616473836024;38975.22049558936;39550;52014.21978670247;52246;54428.18357724717;54971.450285496634;55322.72338638281;8582.78543036429;8685.95657021736;8903.287736981156;9080.091990800867;9111.496603060421;8410.285125764378;12127.272363658209;12437;13185.340732963505;13495.055346125677;11712.238704484522;11888.76222475563;12043.879561204276;12053.216540924812;12483.500659973499;6538.1827271591055;9209.723708288762;11991;12193.939030304791;12429.813552796535;12112.394380280775;12158.513659453523;12236.694082648006;12515.12394132402;12519.749605008032;8600.526971016654;9024;9026.413283136575;9158.542072896462;9235.76910577241;9768.951155244178;11610.129240306842;11630.767384652429;11634.12744044217;12048.457819397972 16:10:20 INFO - PROCESS | 27354 | |3;mootools.html;1408.2677007955856;1583.9841601583985;1610.8067031956164;1885.5286178455385;1948.9512762180943;8486.702965396205;8727.432716873407;8727.869081963776;8730.345224108201;8746.868796968043;8566.486010839353;8744.300455963523;8744.562771861398;8758.211760941515;8769.342299327544;2145.774693657167;2207.139215705876;2408.963865542018;2431.3313838694366;2470.3330100872754;2476.1457297232428;2488.601823708207;2491.389609545664;2491.501699660066;2493.364192131004;2362.373115696599;2383.8450500717486;2465.174166654173;2486.3411196033067;2489.2283392148493;2101.6742404927186;2401.891914863835;2447.278052974377;2459.9262022139274;2469.345623409798;2405.2423486601665;2442.413820683041;2442.914497992562;2446.522928029035;2446.5963116085823;8586.27016703581;8641.30869530436;8659.523726195057;8667.17661822126;8672.262857657106;5361.758720857571;5511.366192887829;5528.5024347808485;5586.664800112007;5600.103983362683;3560.359135355635;3597.748157628967;3629.818509074562;3641.3991691370893;3705.221903400289;1105.4804242006244;1132.7546579051043;1140.0480598700096;1142.7086093046303;1177.988220117805;12527.87472125267;12606.306653134074;12618.68453288666;12621.810672839914;12633;4894.730789806595;4913.091078150554;4962.404511458648;4972.353594032825;5004.224345226496;10648.89351106479;10659.040686338267;10664.41345725977;10681.732956676145;10701.304415213142;5531.225628412026;5550.0564903965615;5584.162375643605;5600.5799565032785;5604.719764011783;4382.2112019836095;5043.420006699203;5058.291839142523;5068.265101560253;5082.110630639623;4070.137993389342;4110.527289361702;4133.8966525836495;4183.3515805050265;4183.372494125905;1394.5119208277022;1409.8026276321118;1432.2480697633825;1441.7116576684496;1454.2147240490017;1048.4390850894736;1054.5518154784186;1058.1851973979992;1072.7639919217759;1076.424113099488;6241.282252540925;6294.496440284766;6346.238451385863;6371.872562548723;6412.583182093149;494.6735154797888;499.74263254424;500.0998203234164;512.4209643103344;514.4880843560607;4261.914761704748;4349.978250108729;4360.258756011485;4408.184485870124;4424.0709451015;10831.945840270748;11159.609413670483;11299.661010169544;11319;11330.830037549444;11079.833802492969;11105;11118.221724479208;11123.110151188048;11135.276207046516;8151.429399941947;8559.786005349915;8582.055973842873;8593.183647553473;8615.698450554326;5726.685032323262;6050.818475445743;6147.538934579835;6202.34875338101;6242.500599951902;9830.361026533252;9840.261980351646;9922.454265015205;10096.495175241062;10131.696049118538;8935.776605584912;8952;9121.45271283725;10236.641717540148;10279.229057820543;6965.094537710065;7479.102507699111;7661.540307581563;7787.96106019489;7895.289423951872;8386.496810191407;8396.286315663237;8434.578271086544;8479.32165426752;8480.15198480147;7563.394928405824;7724.150343462103;7744.6902123914415;7804.180561041009;7862.095858976062;7512.699492020258;7534.8493030138;7543.547387156788;7589.051368578927;7707.421943354158;7245.311695388929;7266.67299971492;7291.744788932362;7313.122425308997;7323.816904577428;5334.866628334323;5354.7590358434745;5416.295881535375;5481.479259470344;5518;5379.08555545566;5487.067198576331;5520.723963801875;5633.4084921082695;5649.12438572022 16:10:20 INFO - PROCESS | 27354 | |4;prototype.html;340.78871099918047;341.6122700734667;352.8817846021583;362.72251727428505;366.0391472384989;6269.655168965705;6332.651704156276;6352.968235158829;6357.809265722024;6367.713452894619;6245.219347581552;6276.24685037795;6278.215223097113;6284.8743025139465;6296.779612713556;4591.632669386458;4652.418447694038;4801.663883528155;4820.373351464323;4821.686590371614;4770.594499467532;4811.446683631392;4812.374391329122;4817.494163112875;4829.975850120744;4564.835966828454;4763.61891048717;4776.737279449629;4779.80880764769;4781.737004464753;4640.559146881041;4651.674382793206;4656.697314674535;4693.296005599153;4712.528747125294;4138.730982486129;4140.937885931713;4169.666426685888;4173.123644034757;4174.582541745832;5906;5926.585139040226;5926.733297001602;5987;6031.909521357183;5568.99758043552;5589.217509548666;5589.301337332833;5594.776208951637;5609.943900560983;6412.487001039905;6558.606483610999;6562.44219241365;6564.358910272432;6566.179227596551;4605.562471565229;4613.515580864028;4614.661748093049;4620;4621.399218101659;6815.42068924142;6907.585544867274;6922.480813938924;6925.722971081151;6939.340762627542;4765.880852978634;4766.809327626926;4773.498782627844;4777.593904518086;4786.664933454695;4849.199882019428;4849.975750121227;4850.878728031827;4851.51484851512;4852.490488498727;5553.250311208016;5561.63849349791;5561.888762224814;5563.109902415675;5563.942850858324;6512;6645.66771661415;6651.135352404253;6655.134832471747;6657.500687448461;1688.2318545061967;1713.5459103337625;1720.9760192685333;1726.7668864703355;1728.4468969929753;1079.3308148947704;1142.4801715219555;1143.2511704833348;1155;1156.7628636129741;6396.1684980953105;6496.7726129585235;6496.7726129585235;6516.543841931019;6527.902081468782;6888.380045795802;6915.273896240923;6923.826904327331;6929.930700693029;6931.618760968196;6528.151340325822;6530.118434011442;6551.901721474182;6554.852900742351;6556;3692.2615476904725;3718.5165928429133;3725.068732816796;3727;3730.0674831292176;7034.155901291878;7194.352508274175;7201.639918004079;7207.135143782675;7208.24313447091;6975.720971161199;7002.159740831133;7008.474364422586;7015.719371225094;7022.297770223039;7124.46566507514;7170.677319520634;7175.17485489165;7194.712211511585;7196.4962452627815;6881.208661003849;6886.690098945459;6887.931120688729;6903.965480172768;6910.205326387329;6580.605163690194;6779.796606101825;6781.2879647638265;6799.150106236721;6819.147606549182;7113.644317784194;7128.643567821692;7167.713291468492;7181.138263408216;7189.424846012411;4764.380630518011;4765.451973023147;4766.6901651392545;4773.737444440589;4773.928391074067;6902.8619427612175;6905.93094069073;6907.067545881242;6911.827204319932;6912.4815638826285;6515.511336649865;6687.164104486939;6687.331266873273;6704.329567043256;6714.093597364488;6641.734330626721;6672.332766723483;6674.332566743286;6682.46540276767;6688.431483323972;6559.4752419807255;6579.276279609144;6580.374864387875;6585.967070164618;6589.209294884645;6746.684396542627;6756.628385438848;6759.357861003196;6760.492963027694;6761.797146085625;6261.749530018748;6316.905246421215;6381.074744162163;6398.168238129199;6544.607323560602 16:10:20 INFO - PROCESS | 27354 | |5;yui.html;839.8194388206537;889.5374405309238;938.0994245524296;942.5051847779919;957.5451660461282;14786.77819832702;14979.550613481599;15026.624334391645;15039.323230454629;16250.268737906794;15732.056076635381;15831.920840395811;15841;15848.28682709278;15852.76220856688;767.6238643064913;898.4699027573746;921.0283151275402;932.0306880843914;941.3928016429398;926.2682480840128;931.9161275485205;933.8972713001565;934.8737920380763;936.5223735894675;960.1454705312277;962.8266911955845;967.6758285974207;968.0706521739139;968.5689868008739;791.1574173505227;798.996005019977;944.9669261575812;960.4861399151455;963.9518024098767;703.7431337561804;705.4920457270757;705.7847356556248;705.939995100417;706.7985624097107;15665.765013524806;15675.921620391826;15783.921080394639;15799.526014219591;15804.683906321809;14468.276586170754;14918.925405373013;14937.402503899832;14957.177355245458;14973.625659358495;11424.257423267461;11702.2978621283;11776.823347649792;11894.226875253082;12022.69943251417;4038.838446462138;4041.090754580225;4074.7351422157762;4111.773852438115;4171.290880550314;61003.69498152481;61006.69496652533;61026.999999999556;61109.38890611081;61328.38671613316;10945.343279403261;11338.829917551244;11497.942510287563;11622.244554103956;11655.41722913851;20066.297679581436;20090.598188036158;20112.698309525367;20122.29571964974;20172.29396971099;8338.291245244221;8413.95793021031;8423.115572864883;8505.10696376884;8583.957080214559;4902.656814023056;4960.181570040975;4984.476629953875;5059.519345662156;5187.481251874782;3717;3779.1874746929543;3781.489498917611;3781.6785573226034;3795.2978698940783;640.1230314469113;652.2433976587231;667.39934059346;674.9392554670103;689.1041645860462;601.3685630088389;749.1796482851378;793.4208028139375;811.2333844516875;814.4298990706529;9505.192058674951;9585.376950498196;9601.567929443192;9632.711018669452;9774.218062554979;747.174372318591;759.4114561215102;782.5343920367372;785.9371250299962;788.6608758234014;4571.131485017836;4709.95290047102;4795.280707893844;4869.975650121727;4887.535684110004;66162.66918665376;66636;67439.66280168666;67585.66207168932;67590.32409675939;59024.70487647534;59924;61746.38253617406;61998.69000655058;62478;54258.18612720812;54273.72863135738;54686;54699.45300547103;55381;9526.952365238129;9628.66299679508;9639.662611808553;9654.324197306121;9712.271579631697;39170;40072.79963600163;40466;40646.79676601598;42161.789191053846;51066;51449.742751286;51726.22410663918;52403.21395179151;52983;13107.279099649611;13257.138286011379;13379.397927093109;13436.664083397993;13552.390142443417;14381.209033503257;14915.552533424014;15375.692486150438;15608.985415947927;15887.920560397124;14106.083104598169;14283.143011419348;14375.281235937951;14584.270786460847;14716.632084197981;13733.793993089912;14080.295985200493;14221.64445888861;14530.709385812435;14708.705825883637;13315.866841331463;13321.200727956353;13519;13636.250006249751;13873.79189312141;11191.104711622887;11241.437928103725;11277.379744114152;11572.36352000648;11773.705657358634;11597.88402115968;11795.52817887275;11840.633250630095;11900.107491937966;12046.156769026084 16:10:20 INFO - PROCESS | 27354 | __end_tp_report 16:10:20 INFO - PROCESS | 27354 | __start_cc_report 16:10:20 INFO - PROCESS | 27354 | _x_x_mozilla_cycle_collect,818 16:10:20 INFO - PROCESS | 27354 | __end_cc_report 16:10:20 INFO - PROCESS | 27354 | __startTimestamp1464649820395__endTimestamp 16:10:20 INFO - PROCESS | 27354 | 16:10:20 INFO - PROCESS | 27354 | ------- Summary: start ------- 16:10:20 INFO - PROCESS | 27354 | Number of tests: 6 16:10:20 INFO - PROCESS | 27354 | 16:10:20 INFO - PROCESS | 27354 | [#0] dojo.html Cycles:165 Average:5592.61 Median:5797.54 stddev:620.57 (10.7%) stddev-sans-first:596.28 16:10:20 INFO - PROCESS | 27354 | Values: 3318.5 3413.3 3425.8 3436.2 3452.7 5615.5 5628.5 5638.1 5639.2 5641.3 5628.7 5643.6 5643.9 5655.7 5662.2 4913.8 5086.9 5208.8 5267.1 5294.9 5084.4 5133.2 5140.7 5143.4 5148.2 5085.3 5134.8 5150.0 5185.0 5193.3 5171.8 5218.3 5223.5 5226.2 5258.4 5004.3 5004.4 5040.9 5114.0 5119.7 5477.7 5492.0 5518.2 5525.1 5525.9 6004.8 6005.2 6013.2 6013.5 6016.7 6014.5 6030.5 6043.6 6076.9 6106.5 5649.3 5675.8 5699.5 5704.1 5705.6 6028.7 6201.3 6206.3 6209.8 6209.9 5942.7 5989.7 5995.2 6013.8 6040.6 6010.6 6014.8 6017.7 6020.0 6020.5 5889.4 5968.5 5970.7 5973.7 5975.0 5920.6 5924.2 5927.1 5927.8 5970.8 4522.3 4523.0 4524.9 4525.8 4553.6 4020.4 4063.2 4069.8 4101.8 4143.2 5675.4 5703.3 5705.7 5706.2 5728.3 5999.9 6051.8 6054.0 6054.8 6059.2 5583.7 5675.7 5730.3 5741.6 5755.7 5183.8 5198.8 5202.3 5206.2 5207.3 6286.2 6301.7 6301.7 6302.6 6306.1 5951.5 5959.6 6054.0 6081.4 6099.2 6172.9 6206.5 6221.3 6227.6 6231.3 5883.2 5897.1 5902.1 5902.9 5917.6 5930.7 6033.7 6079.6 6099.0 6108.1 5773.3 5809.3 5811.5 5816.3 5817.1 5750.8 5776.9 5797.5 5809.3 5814.6 5786.7 5844.1 5870.3 5871.5 5878.7 5867.3 5892.5 5900.2 5900.4 5904.7 5582.5 5745.3 5761.4 5800.4 5806.4 16:10:20 INFO - PROCESS | 27354 | 16:10:20 INFO - PROCESS | 27354 | [#1] ext.html Cycles:180 Average:55062.49 Median:3697.40 stddev:105000.31 (2839.8%) stddev-sans-first:105215.39 16:10:20 INFO - PROCESS | 27354 | Values: 652.4 659.0 679.2 719.5 738.6 31441.5 32301.2 32322.0 32326.8 38740.8 45174.8 45802.8 45831.1 45953.8 45965.5 8965.3 9148.5 9157.2 9157.5 9166.8 8076.4 8978.6 10524.8 10804.4 10804.8 10548.2 10617.2 10625.4 10635.7 10639.7 8144.6 10447.5 10524.5 10527.7 10533.5 10264.9 10437.2 10444.6 10468.9 10472.9 40169.6 40670.6 40713.8 40736.2 40761.0 3738.3 3794.6 3852.6 4037.2 4226.5 31229.0 31643.4 31992.7 32417.4 33648.7 4550.1 4651.3 4654.3 4697.7 4724.0 332679.0 334698.0 335264.0 335630.0 335761.0 40055.4 68279.3 68844.7 69127.7 69299.0 39916.0 40060.8 40162.4 40188.8 40196.4 15306.4 15371.6 15491.8 15511.8 15513.9 12822.7 12890.7 12899.2 13172.5 13174.7 9276.6 9324.9 9346.1 9379.3 9405.5 3557.2 3689.7 3693.5 3694.7 3700.1 1200.3 1208.1 1213.8 1220.1 1229.1 33612.2 33956.5 34377.5 34697.3 34712.0 1191.6 1200.2 1292.8 1326.3 1342.8 17852.6 17969.6 17979.8 18148.5 18479.8 507412.0 513871.0 514398.0 514479.0 515132.0 62253.4 63867.0 63870.0 63923.7 63928.7 1411.1 1499.5 1526.7 1539.5 1636.3 30117.3 33284.5 33499.8 34297.7 34450.5 51479.0 51486.2 51846.7 51905.2 51957.0 306728.0 306846.0 312551.0 312866.0 313271.0 27705.0 31091.7 31356.0 31995.0 32063.8 45121.0 45230.5 45422.1 45909.0 46693.5 37439.0 38231.2 38297.6 38453.2 39242.4 37521.2 38066.0 38449.2 38537.8 38915.0 42815.8 43386.6 43482.6 43512.3 43997.8 36682.6 37059.8 37239.8 38058.8 38339.4 29064.3 29072.6 29100.6 29128.6 29301.6 16:10:20 INFO - PROCESS | 27354 | 16:10:20 INFO - PROCESS | 27354 | [#2] jquery.html Cycles:180 Average:30730.56 Median:13665.85 stddev:89394.29 (654.1%) stddev-sans-first:89616.11 16:10:20 INFO - PROCESS | 27354 | Values: 429.6 433.6 437.7 438.7 439.8 19750.4 20043.4 20591.1 21093.9 21116.6 20528.2 20614.8 20765.2 20932.0 20965.8 5737.4 5949.2 5961.7 5998.7 5998.7 4375.6 5874.0 5970.9 6309.0 6611.3 6587.0 6604.4 6604.9 6609.9 6622.4 6332.4 6557.1 6561.9 6577.0 6579.4 3994.2 4159.6 5512.5 5779.3 5803.9 23924.9 24111.0 24350.3 24696.0 24712.3 2619.4 2626.9 2642.6 2712.1 2720.8 14722.6 15107.5 15389.3 15768.1 15783.8 2097.9 2119.7 2141.5 2159.4 2174.9 81185.0 82536.0 83168.6 84529.6 84593.0 10396.7 11257.2 11276.9 11397.0 11626.1 16025.6 16080.7 16124.7 16135.5 16144.2 8640.7 8751.8 9138.6 9147.8 9233.7 8406.3 8451.8 8507.9 8642.3 9155.6 6834.9 7100.9 7199.1 7249.2 7317.5 1812.9 1940.6 1973.8 2019.2 2048.3 1061.6 1085.0 1120.4 1178.2 1200.9 19749.3 20087.0 20230.9 20339.7 20568.5 1088.3 1097.1 1102.3 1122.1 1144.5 11048.2 11811.2 11815.4 11861.6 12081.8 509678.0 535801.0 539471.0 567074.0 570830.0 85604.0 85774.6 85962.6 87910.6 88524.6 1076.3 1080.6 1124.1 1141.1 1141.9 17712.7 17922.7 17933.2 18043.4 18273.8 37898.4 38141.8 38352.6 38975.2 39550.0 52014.2 52246.0 54428.2 54971.5 55322.7 8582.8 8686.0 8903.3 9080.1 9111.5 8410.3 12127.3 12437.0 13185.3 13495.1 11712.2 11888.8 12043.9 12053.2 12483.5 6538.2 9209.7 11991.0 12193.9 12429.8 12112.4 12158.5 12236.7 12515.1 12519.7 8600.5 9024.0 9026.4 9158.5 9235.8 9769.0 11610.1 11630.8 11634.1 12048.5 16:10:20 INFO - PROCESS | 27354 | 16:10:20 INFO - PROCESS | 27354 | [#3] mootools.html Cycles:180 Average:5903.68 Median:499.92 stddev:3289.87 (658.1%) stddev-sans-first:3281.75 16:10:20 INFO - PROCESS | 27354 | Values: 1408.3 1584.0 1610.8 1885.5 1949.0 8486.7 8727.4 8727.9 8730.3 8746.9 8566.5 8744.3 8744.6 8758.2 8769.3 2145.8 2207.1 2409.0 2431.3 2470.3 2476.1 2488.6 2491.4 2491.5 2493.4 2362.4 2383.8 2465.2 2486.3 2489.2 2101.7 2401.9 2447.3 2459.9 2469.3 2405.2 2442.4 2442.9 2446.5 2446.6 8586.3 8641.3 8659.5 8667.2 8672.3 5361.8 5511.4 5528.5 5586.7 5600.1 3560.4 3597.7 3629.8 3641.4 3705.2 1105.5 1132.8 1140.0 1142.7 1178.0 12527.9 12606.3 12618.7 12621.8 12633.0 4894.7 4913.1 4962.4 4972.4 5004.2 10648.9 10659.0 10664.4 10681.7 10701.3 5531.2 5550.1 5584.2 5600.6 5604.7 4382.2 5043.4 5058.3 5068.3 5082.1 4070.1 4110.5 4133.9 4183.4 4183.4 1394.5 1409.8 1432.2 1441.7 1454.2 1048.4 1054.6 1058.2 1072.8 1076.4 6241.3 6294.5 6346.2 6371.9 6412.6 494.7 499.7 500.1 512.4 514.5 4261.9 4350.0 4360.3 4408.2 4424.1 10831.9 11159.6 11299.7 11319.0 11330.8 11079.8 11105.0 11118.2 11123.1 11135.3 8151.4 8559.8 8582.1 8593.2 8615.7 5726.7 6050.8 6147.5 6202.3 6242.5 9830.4 9840.3 9922.5 10096.5 10131.7 8935.8 8952.0 9121.5 10236.6 10279.2 6965.1 7479.1 7661.5 7788.0 7895.3 8386.5 8396.3 8434.6 8479.3 8480.2 7563.4 7724.2 7744.7 7804.2 7862.1 7512.7 7534.8 7543.5 7589.1 7707.4 7245.3 7266.7 7291.7 7313.1 7323.8 5334.9 5354.8 5416.3 5481.5 5518.0 5379.1 5487.1 5520.7 5633.4 5649.1 16:10:20 INFO - PROCESS | 27354 | 16:10:20 INFO - PROCESS | 27354 | [#4] prototype.html Cycles:180 Average:5579.85 Median:6362.76 stddev:1683.71 (26.5%) stddev-sans-first:1641.87 16:10:20 INFO - PROCESS | 27354 | Values: 340.8 341.6 352.9 362.7 366.0 6269.7 6332.7 6353.0 6357.8 6367.7 6245.2 6276.2 6278.2 6284.9 6296.8 4591.6 4652.4 4801.7 4820.4 4821.7 4770.6 4811.4 4812.4 4817.5 4830.0 4564.8 4763.6 4776.7 4779.8 4781.7 4640.6 4651.7 4656.7 4693.3 4712.5 4138.7 4140.9 4169.7 4173.1 4174.6 5906.0 5926.6 5926.7 5987.0 6031.9 5569.0 5589.2 5589.3 5594.8 5609.9 6412.5 6558.6 6562.4 6564.4 6566.2 4605.6 4613.5 4614.7 4620.0 4621.4 6815.4 6907.6 6922.5 6925.7 6939.3 4765.9 4766.8 4773.5 4777.6 4786.7 4849.2 4850.0 4850.9 4851.5 4852.5 5553.3 5561.6 5561.9 5563.1 5563.9 6512.0 6645.7 6651.1 6655.1 6657.5 1688.2 1713.5 1721.0 1726.8 1728.4 1079.3 1142.5 1143.3 1155.0 1156.8 6396.2 6496.8 6496.8 6516.5 6527.9 6888.4 6915.3 6923.8 6929.9 6931.6 6528.2 6530.1 6551.9 6554.9 6556.0 3692.3 3718.5 3725.1 3727.0 3730.1 7034.2 7194.4 7201.6 7207.1 7208.2 6975.7 7002.2 7008.5 7015.7 7022.3 7124.5 7170.7 7175.2 7194.7 7196.5 6881.2 6886.7 6887.9 6904.0 6910.2 6580.6 6779.8 6781.3 6799.2 6819.1 7113.6 7128.6 7167.7 7181.1 7189.4 4764.4 4765.5 4766.7 4773.7 4773.9 6902.9 6905.9 6907.1 6911.8 6912.5 6515.5 6687.2 6687.3 6704.3 6714.1 6641.7 6672.3 6674.3 6682.5 6688.4 6559.5 6579.3 6580.4 6586.0 6589.2 6746.7 6756.6 6759.4 6760.5 6761.8 6261.7 6316.9 6381.1 6398.2 6544.6 16:10:20 INFO - PROCESS | 27354 | 16:10:20 INFO - PROCESS | 27354 | [#5] yui.html Cycles:180 Average:16335.99 Median:4931.42 stddev:18997.27 (385.2%) stddev-sans-first:19014.92 16:10:20 INFO - PROCESS | 27354 | Values: 839.8 889.5 938.1 942.5 957.5 14786.8 14979.6 15026.6 15039.3 16250.3 15732.1 15831.9 15841.0 15848.3 15852.8 767.6 898.5 921.0 932.0 941.4 926.3 931.9 933.9 934.9 936.5 960.1 962.8 967.7 968.1 968.6 791.2 799.0 945.0 960.5 964.0 703.7 705.5 705.8 705.9 706.8 15665.8 15675.9 15783.9 15799.5 15804.7 14468.3 14918.9 14937.4 14957.2 14973.6 11424.3 11702.3 11776.8 11894.2 12022.7 4038.8 4041.1 4074.7 4111.8 4171.3 61003.7 61006.7 61027.0 61109.4 61328.4 10945.3 11338.8 11497.9 11622.2 11655.4 20066.3 20090.6 20112.7 20122.3 20172.3 8338.3 8414.0 8423.1 8505.1 8584.0 4902.7 4960.2 4984.5 5059.5 5187.5 3717.0 3779.2 3781.5 3781.7 3795.3 640.1 652.2 667.4 674.9 689.1 601.4 749.2 793.4 811.2 814.4 9505.2 9585.4 9601.6 9632.7 9774.2 747.2 759.4 782.5 785.9 788.7 4571.1 4710.0 4795.3 4870.0 4887.5 66162.7 66636.0 67439.7 67585.7 67590.3 59024.7 59924.0 61746.4 61998.7 62478.0 54258.2 54273.7 54686.0 54699.5 55381.0 9527.0 9628.7 9639.7 9654.3 9712.3 39170.0 40072.8 40466.0 40646.8 42161.8 51066.0 51449.7 51726.2 52403.2 52983.0 13107.3 13257.1 13379.4 13436.7 13552.4 14381.2 14915.6 15375.7 15609.0 15887.9 14106.1 14283.1 14375.3 14584.3 14716.6 13733.8 14080.3 14221.6 14530.7 14708.7 13315.9 13321.2 13519.0 13636.3 13873.8 11191.1 11241.4 11277.4 11572.4 11773.7 11597.9 11795.5 11840.6 11900.1 12046.2 16:10:20 INFO - PROCESS | 27354 | -------- Summary: end -------- 16:10:20 INFO - PROCESS | 27354 | 16:10:21 INFO - TEST-INFO | 27354: exit 0 16:10:21 INFO - TEST-OK | dromaeo_css | took 1111772ms 16:10:21 INFO - TEST-START | kraken 16:10:21 INFO - operating with platform_type : linux_ 16:10:21 INFO - Initialising browser for kraken test... 16:10:21 INFO - TEST-INFO | started process 27548 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcJnw56/profile http://localhost:35437/getInfo.html) 16:10:25 INFO - PROCESS | 27548 | __metrics Screen width/height:1600/1200 16:10:25 INFO - PROCESS | 27548 | colorDepth:24 16:10:25 INFO - PROCESS | 27548 | Browser inner width/height: 1024/697 16:10:25 INFO - PROCESS | 27548 | __metrics 16:10:26 ERROR - PROCESS | 27548 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:10:27 INFO - TEST-INFO | 27548: exit 0 16:10:27 INFO - Browser initialized. 16:10:27 INFO - Running cycle 1/1 for kraken test... 16:10:27 INFO - TEST-INFO | started process 27639 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcJnw56/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:10:38 INFO - PROCESS | 27639 | RSS: Main: 141905920 16:10:38 INFO - PROCESS | 27639 | 16:10:41 INFO - PROCESS | 27639 | Cycle 1(1): loaded http://localhost:35437/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35437/tests/kraken/driver.html?testName=audio-beat-detection) 16:10:42 INFO - PROCESS | 27639 | RSS: Main: 196390912 16:10:42 INFO - PROCESS | 27639 | 16:10:44 INFO - PROCESS | 27639 | Cycle 1(1): loaded http://localhost:35437/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35437/tests/kraken/driver.html?testName=audio-dft) 16:10:45 INFO - PROCESS | 27639 | RSS: Main: 182165504 16:10:45 INFO - PROCESS | 27639 | 16:10:48 INFO - PROCESS | 27639 | Cycle 1(1): loaded http://localhost:35437/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35437/tests/kraken/driver.html?testName=audio-fft) 16:10:48 INFO - PROCESS | 27639 | RSS: Main: 272629760 16:10:48 INFO - PROCESS | 27639 | 16:10:50 INFO - PROCESS | 27639 | Cycle 1(1): loaded http://localhost:35437/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35437/tests/kraken/driver.html?testName=audio-oscillator) 16:10:51 INFO - PROCESS | 27639 | RSS: Main: 179322880 16:10:51 INFO - PROCESS | 27639 | 16:10:53 INFO - PROCESS | 27639 | Cycle 1(1): loaded http://localhost:35437/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35437/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:10:54 INFO - PROCESS | 27639 | RSS: Main: 177496064 16:10:54 INFO - PROCESS | 27639 | 16:10:57 INFO - PROCESS | 27639 | Cycle 1(1): loaded http://localhost:35437/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35437/tests/kraken/driver.html?testName=imaging-darkroom) 16:10:57 INFO - PROCESS | 27639 | RSS: Main: 211718144 16:10:57 INFO - PROCESS | 27639 | 16:11:01 INFO - PROCESS | 27639 | Cycle 1(1): loaded http://localhost:35437/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35437/tests/kraken/driver.html?testName=imaging-desaturate) 16:11:01 INFO - PROCESS | 27639 | RSS: Main: 212365312 16:11:01 INFO - PROCESS | 27639 | 16:11:04 INFO - PROCESS | 27639 | Cycle 1(1): loaded http://localhost:35437/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35437/tests/kraken/driver.html?testName=json-parse-financial) 16:11:05 INFO - PROCESS | 27639 | RSS: Main: 212447232 16:11:05 INFO - PROCESS | 27639 | 16:11:06 INFO - PROCESS | 27639 | Cycle 1(1): loaded http://localhost:35437/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35437/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:11:07 INFO - PROCESS | 27639 | RSS: Main: 189935616 16:11:07 INFO - PROCESS | 27639 | 16:11:08 INFO - PROCESS | 27639 | Cycle 1(1): loaded http://localhost:35437/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35437/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:11:09 INFO - PROCESS | 27639 | RSS: Main: 196059136 16:11:09 INFO - PROCESS | 27639 | 16:11:11 INFO - PROCESS | 27639 | Cycle 1(1): loaded http://localhost:35437/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35437/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:11:12 INFO - PROCESS | 27639 | RSS: Main: 208838656 16:11:12 INFO - PROCESS | 27639 | 16:11:14 INFO - PROCESS | 27639 | Cycle 1(1): loaded http://localhost:35437/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35437/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:11:15 INFO - PROCESS | 27639 | RSS: Main: 215351296 16:11:15 INFO - PROCESS | 27639 | 16:11:17 INFO - PROCESS | 27639 | Cycle 1(1): loaded http://localhost:35437/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35437/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:11:18 INFO - PROCESS | 27639 | RSS: Main: 210890752 16:11:18 INFO - PROCESS | 27639 | 16:11:20 INFO - PROCESS | 27639 | Cycle 1(1): loaded http://localhost:35437/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35437/tests/kraken/driver.html?testName=ai-astar) 16:11:20 INFO - PROCESS | 27639 | RSS: Main: 274493440 16:11:20 INFO - PROCESS | 27639 | 16:11:20 INFO - PROCESS | 27639 | __start_tp_report 16:11:20 INFO - PROCESS | 27639 | _x_x_mozilla_page_load 16:11:20 INFO - PROCESS | 27639 | _x_x_mozilla_page_load_details 16:11:20 INFO - PROCESS | 27639 | |i|pagename|runs| 16:11:20 INFO - PROCESS | 27639 | |0;ai-astar;111;109;110;109;110;109;105;110;110;109 16:11:20 INFO - PROCESS | 27639 | |1;audio-beat-detection;155;126;155;176;126;150;161;127;184;126 16:11:20 INFO - PROCESS | 27639 | |2;audio-dft;159;160;161;160;162;161;163;163;160;161 16:11:20 INFO - PROCESS | 27639 | |3;audio-fft;76;74;77;172;73;84;77;76;171;76 16:11:20 INFO - PROCESS | 27639 | |4;audio-oscillator;90;91;159;91;91;92;153;92;93;146 16:11:20 INFO - PROCESS | 27639 | |5;imaging-gaussian-blur;117;116;117;118;117;117;117;117;117;116 16:11:20 INFO - PROCESS | 27639 | |6;imaging-darkroom;146;146;145;145;146;146;147;145;146;145 16:11:20 INFO - PROCESS | 27639 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 16:11:20 INFO - PROCESS | 27639 | |8;json-parse-financial;54;54;53;53;54;54;56;78;51;52 16:11:20 INFO - PROCESS | 27639 | |9;json-stringify-tinderbox;57;58;58;60;59;57;57;60;58;57 16:11:20 INFO - PROCESS | 27639 | |10;stanford-crypto-aes;71;72;71;79;73;74;75;74;74;74 16:11:20 INFO - PROCESS | 27639 | |11;stanford-crypto-ccm;118;121;112;112;111;112;112;113;141;134 16:11:20 INFO - PROCESS | 27639 | |12;stanford-crypto-pbkdf2;165;154;154;160;156;156;155;155;151;157 16:11:20 INFO - PROCESS | 27639 | |13;stanford-crypto-sha256-iterative;66;65;66;66;64;67;67;64;64;65 16:11:20 INFO - PROCESS | 27639 | __end_tp_report 16:11:20 INFO - PROCESS | 27639 | __start_cc_report 16:11:20 INFO - PROCESS | 27639 | _x_x_mozilla_cycle_collect,1588 16:11:20 INFO - PROCESS | 27639 | __end_cc_report 16:11:20 INFO - PROCESS | 27639 | __startTimestamp1464649880394__endTimestamp 16:11:20 INFO - PROCESS | 27639 | 16:11:20 INFO - PROCESS | 27639 | ------- Summary: start ------- 16:11:20 INFO - PROCESS | 27639 | Number of tests: 14 16:11:20 INFO - PROCESS | 27639 | 16:11:20 INFO - PROCESS | 27639 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.00 stddev:1.62 (1.5%) stddev-sans-first:1.58 16:11:20 INFO - PROCESS | 27639 | Values: 111.0 109.0 110.0 109.0 110.0 109.0 105.0 110.0 110.0 109.0 16:11:20 INFO - PROCESS | 27639 | 16:11:20 INFO - PROCESS | 27639 | [#1] audio-beat-detection Cycles:10 Average:148.60 Median:155.00 stddev:21.71 (14.0%) stddev-sans-first:22.90 16:11:20 INFO - PROCESS | 27639 | Values: 155.0 126.0 155.0 176.0 126.0 150.0 161.0 127.0 184.0 126.0 16:11:20 INFO - PROCESS | 27639 | 16:11:20 INFO - PROCESS | 27639 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.33 (0.8%) stddev-sans-first:1.20 16:11:20 INFO - PROCESS | 27639 | Values: 159.0 160.0 161.0 160.0 162.0 161.0 163.0 163.0 160.0 161.0 16:11:20 INFO - PROCESS | 27639 | 16:11:20 INFO - PROCESS | 27639 | [#3] audio-fft Cycles:10 Average:95.60 Median:76.00 stddev:40.11 (52.8%) stddev-sans-first:41.91 16:11:20 INFO - PROCESS | 27639 | Values: 76.0 74.0 77.0 172.0 73.0 84.0 77.0 76.0 171.0 76.0 16:11:20 INFO - PROCESS | 27639 | 16:11:20 INFO - PROCESS | 27639 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:91.00 stddev:29.75 (32.7%) stddev-sans-first:30.68 16:11:20 INFO - PROCESS | 27639 | Values: 90.0 91.0 159.0 91.0 91.0 92.0 153.0 92.0 93.0 146.0 16:11:20 INFO - PROCESS | 27639 | 16:11:20 INFO - PROCESS | 27639 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 16:11:20 INFO - PROCESS | 27639 | Values: 117.0 116.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 116.0 16:11:20 INFO - PROCESS | 27639 | 16:11:20 INFO - PROCESS | 27639 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 16:11:20 INFO - PROCESS | 27639 | Values: 146.0 146.0 145.0 145.0 146.0 146.0 147.0 145.0 146.0 145.0 16:11:20 INFO - PROCESS | 27639 | 16:11:20 INFO - PROCESS | 27639 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 16:11:20 INFO - PROCESS | 27639 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 16:11:20 INFO - PROCESS | 27639 | 16:11:20 INFO - PROCESS | 27639 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:54.00 stddev:7.88 (14.6%) stddev-sans-first:8.33 16:11:20 INFO - PROCESS | 27639 | Values: 54.0 54.0 53.0 53.0 54.0 54.0 56.0 78.0 51.0 52.0 16:11:20 INFO - PROCESS | 27639 | 16:11:20 INFO - PROCESS | 27639 | [#9] json-stringify-tinderbox Cycles:10 Average:58.10 Median:58.00 stddev:1.20 (2.1%) stddev-sans-first:1.20 16:11:20 INFO - PROCESS | 27639 | Values: 57.0 58.0 58.0 60.0 59.0 57.0 57.0 60.0 58.0 57.0 16:11:20 INFO - PROCESS | 27639 | 16:11:20 INFO - PROCESS | 27639 | [#10] stanford-crypto-aes Cycles:10 Average:73.70 Median:74.00 stddev:2.31 (3.1%) stddev-sans-first:2.24 16:11:20 INFO - PROCESS | 27639 | Values: 71.0 72.0 71.0 79.0 73.0 74.0 75.0 74.0 74.0 74.0 16:11:20 INFO - PROCESS | 27639 | 16:11:20 INFO - PROCESS | 27639 | [#11] stanford-crypto-ccm Cycles:10 Average:118.60 Median:115.50 stddev:10.59 (9.2%) stddev-sans-first:11.22 16:11:20 INFO - PROCESS | 27639 | Values: 118.0 121.0 112.0 112.0 111.0 112.0 112.0 113.0 141.0 134.0 16:11:20 INFO - PROCESS | 27639 | 16:11:20 INFO - PROCESS | 27639 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.30 Median:156.00 stddev:3.83 (2.5%) stddev-sans-first:2.45 16:11:20 INFO - PROCESS | 27639 | Values: 165.0 154.0 154.0 160.0 156.0 156.0 155.0 155.0 151.0 157.0 16:11:20 INFO - PROCESS | 27639 | 16:11:20 INFO - PROCESS | 27639 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:66.00 stddev:1.17 (1.8%) stddev-sans-first:1.22 16:11:20 INFO - PROCESS | 27639 | Values: 66.0 65.0 66.0 66.0 64.0 67.0 67.0 64.0 64.0 65.0 16:11:20 INFO - PROCESS | 27639 | -------- Summary: end -------- 16:11:20 INFO - PROCESS | 27639 | 16:11:21 INFO - TEST-INFO | 27639: exit 0 16:11:21 INFO - TEST-OK | kraken | took 60307ms 16:11:21 INFO - SUITE-END | took 1172s 16:11:21 INFO - Completed test suite (00:19:32) 16:11:21 INFO - javascript benchmark 16:11:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3318.469044952808, 3413.2661477782285, 3425.7601967862242, 3436.175317923699, 3452.6547345265462, 5615.494605485505, 5628.521575666063, 5638.097904335307, 5639.182318563816, 5641.266635337405, 5628.746706398211, 5643.5767317451255, 5643.943560564393, 5655.745491452884, 5662.150677398392, 4913.778879950411, 5086.898262034757, 5208.817691380802, 5267.078261304276, 5294.92057619136, 5084.3644544431945, 5133.230015497668, 5140.742962851861, 5143.408508021588, 5148.150555158394, 5085.262636917645, 5134.768935397916, 5150.0, 5185.040767458032, 5193.324867767204, 5171.818986335479, 5218.347706536683, 5223.503767142134, 5226.189940559219, 5258.447862974409, 5004.299398084271, 5004.374453193351, 5040.873978150539, 5114.0, 5119.718415487147, 5477.698726570077, 5492.038893193715, 5518.227448157261, 5525.0883604205255, 5525.861853453655, 6004.759809607611, 6005.249343832021, 6013.248343957005, 6013.5489838261865, 6016.699165041774, 6014.548908831855, 6030.547708921848, 6043.637381757108, 6076.939230607682, 6106.48094911933, 5649.265595472603, 5675.829725108253, 5699.544036477072, 5704.144378343199, 5705.572082093818, 6028.728707208186, 6201.348858369896, 6206.255249370104, 6209.782657606962, 6209.9068513972325, 5942.673152976541, 5989.730462129215, 5995.190649262381, 6013.789517366871, 6040.607360521552, 6010.579259451796, 6014.849628759316, 6017.669028203403, 6020.006698894721, 6020.518358531307, 5889.352171261158, 5968.46283834457, 5970.671613061323, 5973.731182096816, 5975.0, 5920.585559010828, 5924.229850119543, 5927.110933360031, 5927.8221653350465, 5970.820875373745, 4522.3442600823355, 4522.977385113053, 4524.932126018112, 4525.773711314421, 4553.635709143261, 4020.3768415895584, 4063.227986682521, 4069.8168582413864, 4101.815418306183, 4143.150654115899, 5675.3757086720425, 5703.258576385127, 5705.657660540381, 5706.229658995982, 5728.255326807488, 5999.940000600025, 6051.818445446644, 6053.970824959767, 6054.757809687651, 6059.151718759377, 5583.720813959286, 5675.659460432387, 5730.3410107838135, 5741.62679425836, 5755.712214389264, 5183.766730497136, 5198.818041368534, 5202.3497062867145, 5206.193040078794, 5207.270982062514, 6286.151369565142, 6301.684915754194, 6301.7164227608955, 6302.590331628429, 6306.054091886253, 5951.523878089829, 5959.553033522417, 6054.0, 6081.361457046946, 6099.207103076749, 6172.894890314469, 6206.534509911865, 6221.2845522763655, 6227.595206311576, 6231.2522497298805, 5883.176355310346, 5897.056470964625, 5902.144189092472, 5902.940970590239, 5917.644941303535, 5930.673812940157, 6033.668148251888, 6079.604825686316, 6098.963176260135, 6108.144859719731, 5773.278340207474, 5809.302883653989, 5811.506021988178, 5816.331121921034, 5817.069268916953, 5750.827475175752, 5776.9133462998925, 5797.536197104306, 5809.302883653989, 5814.622049566765, 5786.681732504752, 5844.064949608042, 5870.295564532284, 5871.500922421642, 5878.706064696663, 5867.325257595431, 5892.528597712087, 5900.173975643499, 5900.409959004237, 5904.704764761831, 5582.49757521825, 5745.2818397700285, 5761.423857614205, 5800.419958004166, 5806.390329015561], "value": 5552.330346977723, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [652.4454213918167, 658.9637569933658, 679.1849780263684, 719.5466855880794, 738.6380673469998, 31441.528377074334, 32301.192470188256, 32322.030339089837, 32326.838365808137, 38740.80629596848, 45174.77412612933, 45802.77098614511, 45831.08337833241, 45953.77023114888, 45965.54034459654, 8965.32760042996, 9148.542572871364, 9157.175854173123, 9157.542122893861, 9166.770830729218, 8076.434649574532, 8978.551072446384, 10524.842127368096, 10804.405757683324, 10804.837927431096, 10548.156147508182, 10617.203709721764, 10625.415602141878, 10635.680929572125, 10639.734006649856, 8144.633491492897, 10447.529861156267, 10524.526396312145, 10527.684169474851, 10533.473326333653, 10264.948675256575, 10437.217208709377, 10444.582216711322, 10468.947655261674, 10472.895271047268, 40169.59830401688, 40670.59329406697, 40713.796431017654, 40736.18527629431, 40761.0, 3738.2710371477574, 3794.582595914447, 3852.57621661617, 4037.212743515016, 4226.492820861486, 31229.0, 31643.36713265722, 31992.680073199437, 32417.35165296681, 33648.66351336504, 4550.112728018038, 4651.2557990721325, 4654.348391225231, 4697.7181369117625, 4723.952760472385, 332679.0, 334697.99999999756, 335264.0, 335629.96555051696, 335761.0, 40055.39916901249, 68279.3172068273, 68844.6557767218, 69127.65436172787, 69299.0, 39916.0, 40060.79969600133, 40162.39756403656, 40188.79905600512, 40196.39705404421, 15306.38774449032, 15371.61570960735, 15491.845081549265, 15511.767323490156, 15513.922430387776, 12822.743545129231, 12890.67773305675, 12899.226046437243, 13172.538961136313, 13174.73650526984, 9276.582553785096, 9324.90675093254, 9346.0653934606, 9379.296552758571, 9405.482698451515, 3557.181848174934, 3689.7417180797624, 3693.519842420522, 3694.704423646102, 3700.0934770980743, 1200.3218181727295, 1208.1422190245025, 1213.8118591618313, 1220.134700492119, 1229.1027549888631, 33612.159696007795, 33956.490652640234, 34377.48433773495, 34697.30605387878, 34712.0, 1191.5650787462687, 1200.2258543239561, 1292.8299888600832, 1326.2838067443665, 1342.7918672605763, 17852.55368615795, 17969.550761230814, 17979.820201798077, 18148.455546333367, 18479.81520184808, 507412.0, 513871.0, 514398.0, 514479.0, 515132.0, 62253.37746622566, 63867.04199437012, 63870.0, 63923.68038159872, 63928.68035659885, 1411.1039489923971, 1499.4901733410693, 1526.6946610677908, 1539.5227479481396, 1636.2800367838113, 30117.3389837279, 33284.50073248952, 33499.83250083734, 34297.65702342945, 34450.48324275088, 51479.0, 51486.22770658518, 51846.74076629744, 51905.22142167795, 51957.0, 306728.0, 306846.0, 312551.0, 312866.0, 313271.0, 27705.0, 31091.68908310888, 31356.0, 31995.0, 32063.839680801448, 45121.0, 45230.54769452263, 45422.09155816931, 45909.0, 46693.53306467028, 37439.0, 38231.2353752929, 38297.61702383052, 38453.230935381696, 39242.411363830135, 37521.23598425026, 38066.0, 38449.23101538009, 38537.80731096327, 38915.0, 42815.78592107144, 43386.56613433825, 43482.56517434912, 43512.34731478967, 43997.78001109974, 36682.63317366792, 37059.81470092632, 37239.813800930824, 38058.809705951295, 38339.42490862695, 29064.273393164494, 29072.563911541765, 29100.563491548066, 29128.56307155352, 29301.560476592444], "value": 19650.125656778167, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.5661382004177, 433.56210227670056, 437.6651861326084, 438.7126432186919, 439.7845055922598, 19750.40748777537, 20043.398698039065, 20591.07340169692, 21093.894530527326, 21116.577668446622, 20528.178872845107, 20614.793852061473, 20765.169393224292, 20932.0, 20965.790342096574, 5737.397573254801, 5949.196858424122, 5961.701914904259, 5998.700064996755, 5998.730057147417, 4375.562443755631, 5874.0, 5970.910436343458, 6308.968455157741, 6611.338866113374, 6587.044878492616, 6604.438622717074, 6604.933950660504, 6609.900851487231, 6622.4370928471135, 6332.430081292683, 6557.082008518787, 6561.901571476432, 6577.046328282396, 6579.374959378852, 3994.1612261425134, 4159.604837540429, 5512.476314750093, 5779.2775903012125, 5803.88392232153, 23924.880375598186, 24111.035558577634, 24350.26949191527, 24696.0, 24712.25863224106, 2619.4368210834573, 2626.8817903194404, 2642.616820561027, 2712.145674112648, 2720.8095433319677, 14722.63193420173, 15107.54677359681, 15389.307481163374, 15768.132752698597, 15783.842161578352, 2097.8951052447314, 2119.724435823333, 2141.4860433496005, 2159.373781603333, 2174.9021294041804, 81185.0, 82535.9999999994, 83168.58415707943, 84529.57735211284, 84593.0, 10396.740081498023, 11257.211995160424, 11276.94361528187, 11397.0, 11626.069914406828, 16025.599360016093, 16080.67838643244, 16124.677506449805, 16135.515934521984, 16144.192790360436, 8640.740777776677, 8751.824963500694, 9138.634454621873, 9147.771305717277, 9233.676821311356, 8406.327493800482, 8451.830963380698, 8507.872381914276, 8642.30861531076, 9155.587998540082, 6834.897476537856, 7100.893486597705, 7199.115793247016, 7249.238829922888, 7317.451191160684, 1812.917901702617, 1940.645521031971, 1973.8124878136555, 2019.1721394228296, 2048.2933387981125, 1061.6178175856685, 1085.0, 1120.3781901045, 1178.157617303632, 1200.9219400738923, 19749.308774192836, 20086.991300869795, 20230.898845505973, 20339.694904576445, 20568.485787855425, 1088.292609803634, 1097.067492631273, 1102.2780079048237, 1122.1023181454802, 1144.456383217965, 11048.171387145996, 11811.173217874666, 11815.409229538489, 11861.584844530573, 12081.758364832654, 509678.0, 535801.0, 539471.0, 567074.0, 570830.0, 85604.0, 85774.57112714522, 85962.57018714992, 87910.56044719735, 88524.5573772127, 1076.321917192164, 1080.621782376162, 1124.0726400719439, 1141.08713029576, 1141.9257748246337, 17712.66323684258, 17922.731159032886, 17933.193006314486, 18043.368482103062, 18273.81726182721, 37898.43152352662, 38141.809290953366, 38352.616473836024, 38975.22049558936, 39550.0, 52014.21978670247, 52246.0, 54428.18357724717, 54971.450285496634, 55322.72338638281, 8582.78543036429, 8685.95657021736, 8903.287736981156, 9080.091990800867, 9111.496603060421, 8410.285125764378, 12127.272363658209, 12437.0, 13185.340732963505, 13495.055346125677, 11712.238704484522, 11888.76222475563, 12043.879561204276, 12053.216540924812, 12483.500659973499, 6538.1827271591055, 9209.723708288762, 11991.0, 12193.939030304791, 12429.813552796535, 12112.394380280775, 12158.513659453523, 12236.694082648006, 12515.12394132402, 12519.749605008032, 8600.526971016654, 9024.0, 9026.413283136575, 9158.542072896462, 9235.76910577241, 9768.951155244178, 11610.129240306842, 11630.767384652429, 11634.12744044217, 12048.457819397972], "value": 9795.505514729504, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1408.2677007955856, 1583.9841601583985, 1610.8067031956164, 1885.5286178455385, 1948.9512762180943, 8486.702965396205, 8727.432716873407, 8727.869081963776, 8730.345224108201, 8746.868796968043, 8566.486010839353, 8744.300455963523, 8744.562771861398, 8758.211760941515, 8769.342299327544, 2145.774693657167, 2207.139215705876, 2408.963865542018, 2431.3313838694366, 2470.3330100872754, 2476.1457297232428, 2488.601823708207, 2491.389609545664, 2491.501699660066, 2493.364192131004, 2362.373115696599, 2383.8450500717486, 2465.174166654173, 2486.3411196033067, 2489.2283392148493, 2101.6742404927186, 2401.891914863835, 2447.278052974377, 2459.9262022139274, 2469.345623409798, 2405.2423486601665, 2442.413820683041, 2442.914497992562, 2446.522928029035, 2446.5963116085823, 8586.27016703581, 8641.30869530436, 8659.523726195057, 8667.17661822126, 8672.262857657106, 5361.758720857571, 5511.366192887829, 5528.5024347808485, 5586.664800112007, 5600.103983362683, 3560.359135355635, 3597.748157628967, 3629.818509074562, 3641.3991691370893, 3705.221903400289, 1105.4804242006244, 1132.7546579051043, 1140.0480598700096, 1142.7086093046303, 1177.988220117805, 12527.87472125267, 12606.306653134074, 12618.68453288666, 12621.810672839914, 12633.0, 4894.730789806595, 4913.091078150554, 4962.404511458648, 4972.353594032825, 5004.224345226496, 10648.89351106479, 10659.040686338267, 10664.41345725977, 10681.732956676145, 10701.304415213142, 5531.225628412026, 5550.0564903965615, 5584.162375643605, 5600.5799565032785, 5604.719764011783, 4382.2112019836095, 5043.420006699203, 5058.291839142523, 5068.265101560253, 5082.110630639623, 4070.137993389342, 4110.527289361702, 4133.8966525836495, 4183.3515805050265, 4183.372494125905, 1394.5119208277022, 1409.8026276321118, 1432.2480697633825, 1441.7116576684496, 1454.2147240490017, 1048.4390850894736, 1054.5518154784186, 1058.1851973979992, 1072.7639919217759, 1076.424113099488, 6241.282252540925, 6294.496440284766, 6346.238451385863, 6371.872562548723, 6412.583182093149, 494.6735154797888, 499.74263254424, 500.0998203234164, 512.4209643103344, 514.4880843560607, 4261.914761704748, 4349.978250108729, 4360.258756011485, 4408.184485870124, 4424.0709451015, 10831.945840270748, 11159.609413670483, 11299.661010169544, 11319.0, 11330.830037549444, 11079.833802492969, 11105.0, 11118.221724479208, 11123.110151188048, 11135.276207046516, 8151.429399941947, 8559.786005349915, 8582.055973842873, 8593.183647553473, 8615.698450554326, 5726.685032323262, 6050.818475445743, 6147.538934579835, 6202.34875338101, 6242.500599951902, 9830.361026533252, 9840.261980351646, 9922.454265015205, 10096.495175241062, 10131.696049118538, 8935.776605584912, 8952.0, 9121.45271283725, 10236.641717540148, 10279.229057820543, 6965.094537710065, 7479.102507699111, 7661.540307581563, 7787.96106019489, 7895.289423951872, 8386.496810191407, 8396.286315663237, 8434.578271086544, 8479.32165426752, 8480.15198480147, 7563.394928405824, 7724.150343462103, 7744.6902123914415, 7804.180561041009, 7862.095858976062, 7512.699492020258, 7534.8493030138, 7543.547387156788, 7589.051368578927, 7707.421943354158, 7245.311695388929, 7266.67299971492, 7291.744788932362, 7313.122425308997, 7323.816904577428, 5334.866628334323, 5354.7590358434745, 5416.295881535375, 5481.479259470344, 5518.0, 5379.08555545566, 5487.067198576331, 5520.723963801875, 5633.4084921082695, 5649.12438572022], "value": 4705.9209393803, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.78871099918047, 341.6122700734667, 352.8817846021583, 362.72251727428505, 366.0391472384989, 6269.655168965705, 6332.651704156276, 6352.968235158829, 6357.809265722024, 6367.713452894619, 6245.219347581552, 6276.24685037795, 6278.215223097113, 6284.8743025139465, 6296.779612713556, 4591.632669386458, 4652.418447694038, 4801.663883528155, 4820.373351464323, 4821.686590371614, 4770.594499467532, 4811.446683631392, 4812.374391329122, 4817.494163112875, 4829.975850120744, 4564.835966828454, 4763.61891048717, 4776.737279449629, 4779.80880764769, 4781.737004464753, 4640.559146881041, 4651.674382793206, 4656.697314674535, 4693.296005599153, 4712.528747125294, 4138.730982486129, 4140.937885931713, 4169.666426685888, 4173.123644034757, 4174.582541745832, 5906.0, 5926.585139040226, 5926.733297001602, 5987.0, 6031.909521357183, 5568.99758043552, 5589.217509548666, 5589.301337332833, 5594.776208951637, 5609.943900560983, 6412.487001039905, 6558.606483610999, 6562.44219241365, 6564.358910272432, 6566.179227596551, 4605.562471565229, 4613.515580864028, 4614.661748093049, 4620.0, 4621.399218101659, 6815.42068924142, 6907.585544867274, 6922.480813938924, 6925.722971081151, 6939.340762627542, 4765.880852978634, 4766.809327626926, 4773.498782627844, 4777.593904518086, 4786.664933454695, 4849.199882019428, 4849.975750121227, 4850.878728031827, 4851.51484851512, 4852.490488498727, 5553.250311208016, 5561.63849349791, 5561.888762224814, 5563.109902415675, 5563.942850858324, 6512.0, 6645.66771661415, 6651.135352404253, 6655.134832471747, 6657.500687448461, 1688.2318545061967, 1713.5459103337625, 1720.9760192685333, 1726.7668864703355, 1728.4468969929753, 1079.3308148947704, 1142.4801715219555, 1143.2511704833348, 1155.0, 1156.7628636129741, 6396.1684980953105, 6496.7726129585235, 6496.7726129585235, 6516.543841931019, 6527.902081468782, 6888.380045795802, 6915.273896240923, 6923.826904327331, 6929.930700693029, 6931.618760968196, 6528.151340325822, 6530.118434011442, 6551.901721474182, 6554.852900742351, 6556.0, 3692.2615476904725, 3718.5165928429133, 3725.068732816796, 3727.0, 3730.0674831292176, 7034.155901291878, 7194.352508274175, 7201.639918004079, 7207.135143782675, 7208.24313447091, 6975.720971161199, 7002.159740831133, 7008.474364422586, 7015.719371225094, 7022.297770223039, 7124.46566507514, 7170.677319520634, 7175.17485489165, 7194.712211511585, 7196.4962452627815, 6881.208661003849, 6886.690098945459, 6887.931120688729, 6903.965480172768, 6910.205326387329, 6580.605163690194, 6779.796606101825, 6781.2879647638265, 6799.150106236721, 6819.147606549182, 7113.644317784194, 7128.643567821692, 7167.713291468492, 7181.138263408216, 7189.424846012411, 4764.380630518011, 4765.451973023147, 4766.6901651392545, 4773.737444440589, 4773.928391074067, 6902.8619427612175, 6905.93094069073, 6907.067545881242, 6911.827204319932, 6912.4815638826285, 6515.511336649865, 6687.164104486939, 6687.331266873273, 6704.329567043256, 6714.093597364488, 6641.734330626721, 6672.332766723483, 6674.332566743286, 6682.46540276767, 6688.431483323972, 6559.4752419807255, 6579.276279609144, 6580.374864387875, 6585.967070164618, 6589.209294884645, 6746.684396542627, 6756.628385438848, 6759.357861003196, 6760.492963027694, 6761.797146085625, 6261.749530018748, 6316.905246421215, 6381.074744162163, 6398.168238129199, 6544.607323560602], "value": 5033.175620339154, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [839.8194388206537, 889.5374405309238, 938.0994245524296, 942.5051847779919, 957.5451660461282, 14786.77819832702, 14979.550613481599, 15026.624334391645, 15039.323230454629, 16250.268737906794, 15732.056076635381, 15831.920840395811, 15841.0, 15848.28682709278, 15852.76220856688, 767.6238643064913, 898.4699027573746, 921.0283151275402, 932.0306880843914, 941.3928016429398, 926.2682480840128, 931.9161275485205, 933.8972713001565, 934.8737920380763, 936.5223735894675, 960.1454705312277, 962.8266911955845, 967.6758285974207, 968.0706521739139, 968.5689868008739, 791.1574173505227, 798.996005019977, 944.9669261575812, 960.4861399151455, 963.9518024098767, 703.7431337561804, 705.4920457270757, 705.7847356556248, 705.939995100417, 706.7985624097107, 15665.765013524806, 15675.921620391826, 15783.921080394639, 15799.526014219591, 15804.683906321809, 14468.276586170754, 14918.925405373013, 14937.402503899832, 14957.177355245458, 14973.625659358495, 11424.257423267461, 11702.2978621283, 11776.823347649792, 11894.226875253082, 12022.69943251417, 4038.838446462138, 4041.090754580225, 4074.7351422157762, 4111.773852438115, 4171.290880550314, 61003.69498152481, 61006.69496652533, 61026.999999999556, 61109.38890611081, 61328.38671613316, 10945.343279403261, 11338.829917551244, 11497.942510287563, 11622.244554103956, 11655.41722913851, 20066.297679581436, 20090.598188036158, 20112.698309525367, 20122.29571964974, 20172.29396971099, 8338.291245244221, 8413.95793021031, 8423.115572864883, 8505.10696376884, 8583.957080214559, 4902.656814023056, 4960.181570040975, 4984.476629953875, 5059.519345662156, 5187.481251874782, 3717.0, 3779.1874746929543, 3781.489498917611, 3781.6785573226034, 3795.2978698940783, 640.1230314469113, 652.2433976587231, 667.39934059346, 674.9392554670103, 689.1041645860462, 601.3685630088389, 749.1796482851378, 793.4208028139375, 811.2333844516875, 814.4298990706529, 9505.192058674951, 9585.376950498196, 9601.567929443192, 9632.711018669452, 9774.218062554979, 747.174372318591, 759.4114561215102, 782.5343920367372, 785.9371250299962, 788.6608758234014, 4571.131485017836, 4709.95290047102, 4795.280707893844, 4869.975650121727, 4887.535684110004, 66162.66918665376, 66636.0, 67439.66280168666, 67585.66207168932, 67590.32409675939, 59024.70487647534, 59924.0, 61746.38253617406, 61998.69000655058, 62478.0, 54258.18612720812, 54273.72863135738, 54686.0, 54699.45300547103, 55381.0, 9526.952365238129, 9628.66299679508, 9639.662611808553, 9654.324197306121, 9712.271579631697, 39170.0, 40072.79963600163, 40466.0, 40646.79676601598, 42161.789191053846, 51066.0, 51449.742751286, 51726.22410663918, 52403.21395179151, 52983.0, 13107.279099649611, 13257.138286011379, 13379.397927093109, 13436.664083397993, 13552.390142443417, 14381.209033503257, 14915.552533424014, 15375.692486150438, 15608.985415947927, 15887.920560397124, 14106.083104598169, 14283.143011419348, 14375.281235937951, 14584.270786460847, 14716.632084197981, 13733.793993089912, 14080.295985200493, 14221.64445888861, 14530.709385812435, 14708.705825883637, 13315.866841331463, 13321.200727956353, 13519.0, 13636.250006249751, 13873.79189312141, 11191.104711622887, 11241.437928103725, 11277.379744114152, 11572.36352000648, 11773.705657358634, 11597.88402115968, 11795.52817887275, 11840.633250630095, 11900.107491937966, 12046.156769026084], "value": 7375.386921179688, "unit": "score"}], "name": "dromaeo_css", "value": 7560.1324765596255, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 109.0, 110.0, 109.0, 110.0, 109.0, 105.0, 110.0, 110.0, 109.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 126.0, 155.0, 176.0, 126.0, 150.0, 161.0, 127.0, 184.0, 126.0], "value": 148.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 161.0, 160.0, 162.0, 161.0, 163.0, 163.0, 160.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 77.0, 172.0, 73.0, 84.0, 77.0, 76.0, 171.0, 76.0], "value": 95.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 91.0, 159.0, 91.0, 91.0, 92.0, 153.0, 92.0, 93.0, 146.0], "value": 109.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 147.0, 145.0, 146.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 53.0, 54.0, 54.0, 56.0, 78.0, 51.0, 52.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 60.0, 59.0, 57.0, 57.0, 60.0, 58.0, 57.0], "value": 58.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 71.0, 79.0, 73.0, 74.0, 75.0, 74.0, 74.0, 74.0], "value": 73.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 121.0, 112.0, 112.0, 111.0, 112.0, 112.0, 113.0, 141.0, 134.0], "value": 118.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 154.0, 154.0, 160.0, 156.0, 156.0, 155.0, 155.0, 151.0, 157.0], "value": 156.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 66.0, 64.0, 67.0, 67.0, 64.0, 64.0, 65.0], "value": 65.4, "unit": "score"}], "name": "kraken", "value": 1509.8, "alertThreshold": 2.0}]} 16:11:21 INFO - Return code: 0 16:11:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:11:21 ERROR - # TBPL SUCCESS # 16:11:21 INFO - Running post-action listener: _resource_record_post_action 16:11:21 INFO - Running post-run listener: _resource_record_post_run 16:11:22 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 498724864; Read time: 24; Write time: 420720 16:11:22 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 249204736; Read time: 0; Write time: 218920 16:11:22 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 249520128; Read time: 24; Write time: 201800 16:11:22 INFO - Running post-run listener: _upload_blobber_files 16:11:22 INFO - Blob upload gear active. 16:11:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:11:22 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 16:11:22 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'] 16:11:22 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 16:11:23 INFO - (blobuploader) - INFO - Open directory for files ... 16:11:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:11:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:11:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:24 INFO - (blobuploader) - INFO - Done attempting. 16:11:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:11:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:11:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:24 INFO - (blobuploader) - INFO - Done attempting. 16:11:24 INFO - (blobuploader) - INFO - Iteration through files over. 16:11:24 INFO - Return code: 0 16:11:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:11:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:11:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/12a41519301ef3224f4477ed0f1f93cbe52eacf7d94ac8f59dd4f9ef61d591d8b7cb0ccfa1139281aa09a6d157a28990d5e7aff33d668c340d9ae201f23dfcd0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ae839ec8ecf44a44510df48a5b50dd9841342b64c99062384e4ee25cb3fd8127a650d3c3036d11eaca426883beae1967f0146b951e1b96a70953f9c330f057ee"} 16:11:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:11:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:11:24 INFO - Contents: 16:11:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/12a41519301ef3224f4477ed0f1f93cbe52eacf7d94ac8f59dd4f9ef61d591d8b7cb0ccfa1139281aa09a6d157a28990d5e7aff33d668c340d9ae201f23dfcd0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ae839ec8ecf44a44510df48a5b50dd9841342b64c99062384e4ee25cb3fd8127a650d3c3036d11eaca426883beae1967f0146b951e1b96a70953f9c330f057ee"} 16:11:24 INFO - Running post-run listener: copy_logs_to_upload_dir 16:11:24 INFO - Copying logs to upload dir... 16:11:24 INFO - mkdir: /builds/slave/test/build/upload/logs 16:11:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.952876 ========= master_lag: 0.47 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-30 16:11:24.895381) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 16:11:24.899850) ========= 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=920470bf432669ad7e3a5387000001ca-1464647765.631332-1006542387 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/12a41519301ef3224f4477ed0f1f93cbe52eacf7d94ac8f59dd4f9ef61d591d8b7cb0ccfa1139281aa09a6d157a28990d5e7aff33d668c340d9ae201f23dfcd0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ae839ec8ecf44a44510df48a5b50dd9841342b64c99062384e4ee25cb3fd8127a650d3c3036d11eaca426883beae1967f0146b951e1b96a70953f9c330f057ee"} build_url:https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011401 build_url: 'https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/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/12a41519301ef3224f4477ed0f1f93cbe52eacf7d94ac8f59dd4f9ef61d591d8b7cb0ccfa1139281aa09a6d157a28990d5e7aff33d668c340d9ae201f23dfcd0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ae839ec8ecf44a44510df48a5b50dd9841342b64c99062384e4ee25cb3fd8127a650d3c3036d11eaca426883beae1967f0146b951e1b96a70953f9c330f057ee"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 16:11:24.930046) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-05-30 16:11:24.932798) ========= 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=920470bf432669ad7e3a5387000001ca-1464647765.631332-1006542387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004484 ========= master_lag: 1.91 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-05-30 16:11:26.843784) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 16:11:26.844430) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 16:11:26.853717) ========= ========= Total master_lag: 2.46 =========