builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1467061578.11 results: success (0) buildid: 20160627113417 builduid: b5d91ee60b1646bb80795b03d4471af7 revision: 35e0d7dd7cd7bff301b75756361b36b275102404 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 14:06:18.107553) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 14:06:18.108262) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 14:06:18.108700) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 14:06:18.144635) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 14:06:18.144912) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1467061532.908448-1147855932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 14:06:18-- 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-06-27 14:06:18 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.205656 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 14:06:18.391276) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 14:06:18.391587) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1467061532.908448-1147855932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.171388 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 14:06:18.575118) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 14:06:18.575490) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 35e0d7dd7cd7bff301b75756361b36b275102404 --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-beta --rev 35e0d7dd7cd7bff301b75756361b36b275102404 --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=edae0fb5fee9fb758e8af6d3000002a4-1467061532.908448-1147855932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 14:06:18,773 truncating revision to first 12 chars 2016-06-27 14:06:18,773 Setting DEBUG logging. 2016-06-27 14:06:18,773 attempt 1/10 2016-06-27 14:06:18,773 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/35e0d7dd7cd7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 14:06:19,085 unpacking tar archive at: mozilla-beta-35e0d7dd7cd7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.656841 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 14:06:19.249603) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 14:06:19.250342) ========= script_repo_revision: 35e0d7dd7cd7bff301b75756361b36b275102404 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 14:06:19.251161) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 14:06:19.251453) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 14:06:19.262674) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-27 14:06:19.263368) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=edae0fb5fee9fb758e8af6d3000002a4-1467061532.908448-1147855932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:06:19 INFO - MultiFileLogger online at 20160627 14:06:19 in /builds/slave/test 14:06:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 14:06:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:06:19 INFO - {'append_to_log': False, 14:06:19 INFO - 'base_work_dir': '/builds/slave/test', 14:06:19 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:06:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:06:19 INFO - 'branch': 'Mozilla-Beta', 14:06:19 INFO - 'buildbot_json_path': 'buildprops.json', 14:06:19 INFO - 'config_files': ('talos/linux_config.py',), 14:06:19 INFO - 'default_actions': ('clobber', 14:06:19 INFO - 'read-buildbot-config', 14:06:19 INFO - 'download-and-extract', 14:06:19 INFO - 'populate-webroot', 14:06:19 INFO - 'create-virtualenv', 14:06:19 INFO - 'install', 14:06:19 INFO - 'run-tests'), 14:06:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:06:19 INFO - 'download_minidump_stackwalk': True, 14:06:19 INFO - 'download_symbols': 'ondemand', 14:06:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:06:19 INFO - 'tooltool.py': '/tools/tooltool.py', 14:06:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:06:19 INFO - '/tools/misc-python/virtualenv.py')}, 14:06:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:06:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:06:19 INFO - 'installer_path': 'installer.exe', 14:06:19 INFO - 'log_level': 'info', 14:06:19 INFO - 'log_name': 'talos', 14:06:19 INFO - 'log_to_console': True, 14:06:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:06:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:06:19 INFO - 'opt_config_files': (), 14:06:19 INFO - 'pip_index': False, 14:06:19 INFO - 'sps_profile': False, 14:06:19 INFO - 'sps_profile_interval': 0, 14:06:19 INFO - 'suite': 'dromaeojs', 14:06:19 INFO - 'system_bits': '32', 14:06:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:06:19 INFO - 'title': 'talos-linux64-ix-033', 14:06:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:06:19 INFO - 'use_talos_json': True, 14:06:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:06:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:06:19 INFO - 'work_dir': 'build'} 14:06:19 INFO - ##### 14:06:19 INFO - ##### Running clobber step. 14:06:19 INFO - ##### 14:06:19 INFO - Running pre-action listener: _resource_record_pre_action 14:06:19 INFO - Running main action method: clobber 14:06:19 INFO - rmtree: /builds/slave/test/build 14:06:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:06:21 INFO - Running post-action listener: _resource_record_post_action 14:06:21 INFO - ##### 14:06:21 INFO - ##### Running read-buildbot-config step. 14:06:21 INFO - ##### 14:06:21 INFO - Running pre-action listener: _resource_record_pre_action 14:06:21 INFO - Running main action method: read_buildbot_config 14:06:21 INFO - Using buildbot properties: 14:06:21 INFO - { 14:06:21 INFO - "project": "", 14:06:21 INFO - "product": "firefox", 14:06:21 INFO - "script_repo_revision": "production", 14:06:21 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 14:06:21 INFO - "repository": "", 14:06:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 14:06:21 INFO - "buildid": "20160627113417", 14:06:21 INFO - "pgo_build": "True", 14:06:21 INFO - "basedir": "/builds/slave/test", 14:06:21 INFO - "buildnumber": 139, 14:06:21 INFO - "slavename": "talos-linux64-ix-033", 14:06:21 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:06:21 INFO - "platform": "ubuntu64_hw", 14:06:21 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 14:06:21 INFO - "branch": "mozilla-beta", 14:06:21 INFO - "repo_path": "releases/mozilla-beta", 14:06:21 INFO - "revision": "35e0d7dd7cd7bff301b75756361b36b275102404", 14:06:21 INFO - "stage_platform": "linux64-pgo", 14:06:21 INFO - "builduid": "b5d91ee60b1646bb80795b03d4471af7", 14:06:21 INFO - "slavebuilddir": "test" 14:06:21 INFO - } 14:06:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/dydLOsyBTMOQL2I-aXSGhA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 14:06:21 INFO - Running post-action listener: _resource_record_post_action 14:06:21 INFO - ##### 14:06:21 INFO - ##### Running download-and-extract step. 14:06:21 INFO - ##### 14:06:21 INFO - Running pre-action listener: _resource_record_pre_action 14:06:21 INFO - Running main action method: download_and_extract 14:06:21 INFO - mkdir: /builds/slave/test/build/tests 14:06:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:06:21 INFO - https://queue.taskcluster.net/v1/task/dydLOsyBTMOQL2I-aXSGhA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:06:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dydLOsyBTMOQL2I-aXSGhA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 14:06:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dydLOsyBTMOQL2I-aXSGhA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 14:06:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dydLOsyBTMOQL2I-aXSGhA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 14:06:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dydLOsyBTMOQL2I-aXSGhA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:06:25 INFO - Downloaded 1327 bytes. 14:06:25 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 14:06:25 INFO - Using the following test package requirements: 14:06:25 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 14:06:25 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:06:25 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 14:06:25 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:06:25 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 14:06:25 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:06:25 INFO - u'jsshell-linux-x86_64.zip'], 14:06:25 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:06:25 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 14:06:25 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 14:06:25 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:06:25 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 14:06:25 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:06:25 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 14:06:25 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:06:25 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 14:06:25 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:06:25 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 14:06:25 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:06:25 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')]} 14:06:25 INFO - https://queue.taskcluster.net/v1/task/dydLOsyBTMOQL2I-aXSGhA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:06:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dydLOsyBTMOQL2I-aXSGhA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 14:06:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dydLOsyBTMOQL2I-aXSGhA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 14:06:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dydLOsyBTMOQL2I-aXSGhA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 14:06:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dydLOsyBTMOQL2I-aXSGhA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:06:27 INFO - Downloaded 24236181 bytes. 14:06:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:06:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:06:29 INFO - Return code: 0 14:06:29 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:06: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')]} 14:06:29 INFO - https://queue.taskcluster.net/v1/task/dydLOsyBTMOQL2I-aXSGhA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:06:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dydLOsyBTMOQL2I-aXSGhA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 14:06:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dydLOsyBTMOQL2I-aXSGhA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 14:06:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dydLOsyBTMOQL2I-aXSGhA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 14:06:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dydLOsyBTMOQL2I-aXSGhA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:06:30 INFO - Downloaded 24236181 bytes. 14:06:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:06:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:06:32 INFO - Return code: 0 14:06:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:06:32 INFO - https://queue.taskcluster.net/v1/task/dydLOsyBTMOQL2I-aXSGhA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:06:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dydLOsyBTMOQL2I-aXSGhA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 14:06:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dydLOsyBTMOQL2I-aXSGhA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 14:06:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dydLOsyBTMOQL2I-aXSGhA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 14:06:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dydLOsyBTMOQL2I-aXSGhA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:06:33 INFO - Downloaded 10840145 bytes. 14:06:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:06:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:06:34 INFO - Return code: 0 14:06:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:06:34 INFO - https://queue.taskcluster.net/v1/task/dydLOsyBTMOQL2I-aXSGhA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:06:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dydLOsyBTMOQL2I-aXSGhA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 14:06:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dydLOsyBTMOQL2I-aXSGhA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 14:06:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dydLOsyBTMOQL2I-aXSGhA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 14:06:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dydLOsyBTMOQL2I-aXSGhA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:06:36 INFO - Downloaded 56014947 bytes. 14:06:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dydLOsyBTMOQL2I-aXSGhA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 14:06:36 INFO - mkdir: /builds/slave/test/properties 14:06:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:06:36 INFO - Writing to file /builds/slave/test/properties/build_url 14:06:36 INFO - Contents: 14:06:36 INFO - build_url:https://queue.taskcluster.net/v1/task/dydLOsyBTMOQL2I-aXSGhA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 14:06:37 INFO - Running post-action listener: _resource_record_post_action 14:06:37 INFO - Running post-action listener: set_extra_try_arguments 14:06:37 INFO - ##### 14:06:37 INFO - ##### Running populate-webroot step. 14:06:37 INFO - ##### 14:06:37 INFO - Running pre-action listener: _resource_record_pre_action 14:06:37 INFO - Running main action method: populate_webroot 14:06:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:06:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:06:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:06:37 INFO - '--tppagecycles', 14:06:37 INFO - '7'], 14:06:37 INFO - 'tests': ['tsvgm']}}, 14:06:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:06:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:06:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:06:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:06:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:06:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:06:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:06:37 INFO - 'talos_options': ['--disable-e10s'], 14:06:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:06:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:06:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:06:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:06:37 INFO - 'talos_options': ['--disable-e10s'], 14:06:37 INFO - 'tests': ['damp', 'tps']}, 14:06:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:06:37 INFO - 'tests': ['damp', 'tps']}, 14:06:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:06:37 INFO - 'tests': ['dromaeo_dom']}, 14:06:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:06:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:06:37 INFO - 'tests': ['a11yr', 14:06:37 INFO - 'ts_paint', 14:06:37 INFO - 'tpaint', 14:06:37 INFO - 'sessionrestore', 14:06:37 INFO - 'sessionrestore_no_auto_restore', 14:06:37 INFO - 'tabpaint']}, 14:06:37 INFO - 'other-e10s': {'tests': ['a11yr', 14:06:37 INFO - 'ts_paint', 14:06:37 INFO - 'tpaint', 14:06:37 INFO - 'sessionrestore', 14:06:37 INFO - 'sessionrestore_no_auto_restore', 14:06:37 INFO - 'tabpaint']}, 14:06:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:06:37 INFO - 'ts_paint', 14:06:37 INFO - 'tpaint', 14:06:37 INFO - 'sessionrestore', 14:06:37 INFO - 'sessionrestore_no_auto_restore', 14:06:37 INFO - 'tabpaint']}, 14:06:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:06:37 INFO - 'ts_paint', 14:06:37 INFO - 'tpaint', 14:06:37 INFO - 'sessionrestore', 14:06:37 INFO - 'sessionrestore_no_auto_restore', 14:06:37 INFO - 'tabpaint']}, 14:06:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:06:37 INFO - 'tests': ['a11yr', 14:06:37 INFO - 'ts_paint', 14:06:37 INFO - 'tpaint', 14:06:37 INFO - 'sessionrestore', 14:06:37 INFO - 'sessionrestore_no_auto_restore', 14:06:37 INFO - 'tabpaint']}, 14:06:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:06:37 INFO - 'tests': ['a11yr', 14:06:37 INFO - 'ts_paint', 14:06:37 INFO - 'tpaint', 14:06:37 INFO - 'sessionrestore', 14:06:37 INFO - 'sessionrestore_no_auto_restore', 14:06:37 INFO - 'tabpaint']}, 14:06:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:06:37 INFO - 'tests': ['tsvgx', 14:06:37 INFO - 'tsvgr_opacity', 14:06:37 INFO - 'tart', 14:06:37 INFO - 'tscrollx', 14:06:37 INFO - 'cart']}, 14:06:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:06:37 INFO - 'tsvgr_opacity', 14:06:37 INFO - 'tart', 14:06:37 INFO - 'tscrollx', 14:06:37 INFO - 'cart']}, 14:06:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:06:37 INFO - 'talos_options': ['--disable-e10s'], 14:06:37 INFO - 'tests': ['tp5o']}, 14:06:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:06:37 INFO - 'tests': ['tp5o']}, 14:06:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:06:37 INFO - 'talos_options': ['--disable-e10s', 14:06:37 INFO - '--xperf_path', 14:06:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:06:37 INFO - 'tests': ['tp5n']}, 14:06:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:06:37 INFO - 'talos_options': ['--xperf_path', 14:06:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:06:37 INFO - 'tests': ['tp5n']}}, 14:06:37 INFO - 'talos.zip': {'path': '', 14:06:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:06:37 INFO - Running post-action listener: _resource_record_post_action 14:06:37 INFO - ##### 14:06:37 INFO - ##### Running create-virtualenv step. 14:06:37 INFO - ##### 14:06:37 INFO - Running pre-action listener: _resource_record_pre_action 14:06:37 INFO - Running main action method: create_virtualenv 14:06:37 INFO - Creating virtualenv /builds/slave/test/build/venv 14:06:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:06:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:06:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:06:37 INFO - Using real prefix '/usr' 14:06:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:06:37 INFO - Installing distribute.............................................................................................................................................................................................done. 14:06:40 INFO - Installing pip.................done. 14:06:40 INFO - Return code: 0 14:06:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:06:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:06:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:06:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f60e2023f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcf5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e410>, '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 0x105f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1467061532.908448-1147855932', '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 14:06:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:06:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:06:40 INFO - Using env: {'DISPLAY': ':0', 14:06:40 INFO - 'HOME': '/home/cltbld', 14:06:40 INFO - 'LANG': 'en_US.UTF-8', 14:06:40 INFO - 'LANGUAGE': 'en_US:en', 14:06:40 INFO - 'LOGNAME': 'cltbld', 14:06:40 INFO - 'MAIL': '/var/mail/cltbld', 14:06:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:40 INFO - 'MOZ_NO_REMOTE': '1', 14:06:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:06:40 INFO - 'NO_EM_RESTART': '1', 14:06:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:06:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:40 INFO - 'PWD': '/builds/slave/test', 14:06:40 INFO - 'SHELL': '/bin/bash', 14:06:40 INFO - 'SHLVL': '1', 14:06:40 INFO - 'TERM': 'linux', 14:06:40 INFO - 'TMOUT': '86400', 14:06:40 INFO - 'USER': 'cltbld', 14:06:40 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1467061532.908448-1147855932', 14:06:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:40 INFO - '_': '/tools/buildbot/bin/python'} 14:06:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:41 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 14:06:41 INFO - Cleaning up... 14:06:41 INFO - Return code: 0 14:06:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:06:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:06:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:41 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 0x7f60e2023f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcf5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e410>, '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 0x105f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1467061532.908448-1147855932', '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 14:06:41 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 14:06:41 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 14:06:41 INFO - Using env: {'DISPLAY': ':0', 14:06:41 INFO - 'HOME': '/home/cltbld', 14:06:41 INFO - 'LANG': 'en_US.UTF-8', 14:06:41 INFO - 'LANGUAGE': 'en_US:en', 14:06:41 INFO - 'LOGNAME': 'cltbld', 14:06:41 INFO - 'MAIL': '/var/mail/cltbld', 14:06:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:41 INFO - 'MOZ_NO_REMOTE': '1', 14:06:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:06:41 INFO - 'NO_EM_RESTART': '1', 14:06:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:06:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:41 INFO - 'PWD': '/builds/slave/test', 14:06:41 INFO - 'SHELL': '/bin/bash', 14:06:41 INFO - 'SHLVL': '1', 14:06:41 INFO - 'TERM': 'linux', 14:06:41 INFO - 'TMOUT': '86400', 14:06:41 INFO - 'USER': 'cltbld', 14:06:41 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1467061532.908448-1147855932', 14:06:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:41 INFO - '_': '/tools/buildbot/bin/python'} 14:06:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:42 INFO - Downloading/unpacking psutil>=0.7.1 14:06:42 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 14:06:42 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 14:06:42 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 14:06:42 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 14:06:42 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 14:06:42 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 14:06:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:06:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:06:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:06:44 INFO - Installing collected packages: psutil 14:06:44 INFO - Running setup.py install for psutil 14:06:44 INFO - building 'psutil._psutil_linux' extension 14:06:44 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 14:06:46 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 14:06:47 INFO - building 'psutil._psutil_posix' extension 14:06:47 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 14:06:47 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 14:06:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:06:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:06:47 INFO - Successfully installed psutil 14:06:47 INFO - Cleaning up... 14:06:47 INFO - Return code: 0 14:06:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:06:47 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')]} 14:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:47 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')]} 14:06:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:47 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 0x7f60e2023f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcf5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e410>, '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 0x105f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1467061532.908448-1147855932', '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 14:06:47 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 14:06:47 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 14:06:47 INFO - Using env: {'DISPLAY': ':0', 14:06:47 INFO - 'HOME': '/home/cltbld', 14:06:47 INFO - 'LANG': 'en_US.UTF-8', 14:06:47 INFO - 'LANGUAGE': 'en_US:en', 14:06:47 INFO - 'LOGNAME': 'cltbld', 14:06:47 INFO - 'MAIL': '/var/mail/cltbld', 14:06:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:47 INFO - 'MOZ_NO_REMOTE': '1', 14:06:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:06:47 INFO - 'NO_EM_RESTART': '1', 14:06:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:06:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:47 INFO - 'PWD': '/builds/slave/test', 14:06:47 INFO - 'SHELL': '/bin/bash', 14:06:47 INFO - 'SHLVL': '1', 14:06:47 INFO - 'TERM': 'linux', 14:06:47 INFO - 'TMOUT': '86400', 14:06:47 INFO - 'USER': 'cltbld', 14:06:47 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1467061532.908448-1147855932', 14:06:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:47 INFO - '_': '/tools/buildbot/bin/python'} 14:06:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:06:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:06:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:06:49 INFO - Installing collected packages: mozsystemmonitor 14:06:49 INFO - Running setup.py install for mozsystemmonitor 14:06:49 INFO - Successfully installed mozsystemmonitor 14:06:49 INFO - Cleaning up... 14:06:49 INFO - Return code: 0 14:06:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:06:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:06:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f60e2023f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcf5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e410>, '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 0x105f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1467061532.908448-1147855932', '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 14:06:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:06:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:06:49 INFO - Using env: {'DISPLAY': ':0', 14:06:49 INFO - 'HOME': '/home/cltbld', 14:06:49 INFO - 'LANG': 'en_US.UTF-8', 14:06:49 INFO - 'LANGUAGE': 'en_US:en', 14:06:49 INFO - 'LOGNAME': 'cltbld', 14:06:49 INFO - 'MAIL': '/var/mail/cltbld', 14:06:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:49 INFO - 'MOZ_NO_REMOTE': '1', 14:06:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:06:49 INFO - 'NO_EM_RESTART': '1', 14:06:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:06:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:49 INFO - 'PWD': '/builds/slave/test', 14:06:49 INFO - 'SHELL': '/bin/bash', 14:06:49 INFO - 'SHLVL': '1', 14:06:49 INFO - 'TERM': 'linux', 14:06:49 INFO - 'TMOUT': '86400', 14:06:49 INFO - 'USER': 'cltbld', 14:06:49 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1467061532.908448-1147855932', 14:06:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:49 INFO - '_': '/tools/buildbot/bin/python'} 14:06:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:49 INFO - Downloading/unpacking blobuploader==1.2.4 14:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:51 INFO - Downloading blobuploader-1.2.4.tar.gz 14:06:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:06:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:06:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:52 INFO - Downloading docopt-0.6.1.tar.gz 14:06:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:06:52 INFO - Installing collected packages: blobuploader, requests, docopt 14:06:52 INFO - Running setup.py install for blobuploader 14:06:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:06:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:06:52 INFO - Running setup.py install for requests 14:06:53 INFO - Running setup.py install for docopt 14:06:53 INFO - Successfully installed blobuploader requests docopt 14:06:53 INFO - Cleaning up... 14:06:53 INFO - Return code: 0 14:06:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:06:53 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')]} 14:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:53 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')]} 14:06:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:53 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 0x7f60e2023f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcf5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e410>, '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 0x105f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1467061532.908448-1147855932', '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 14:06:53 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 14:06:53 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 14:06:53 INFO - Using env: {'DISPLAY': ':0', 14:06:53 INFO - 'HOME': '/home/cltbld', 14:06:53 INFO - 'LANG': 'en_US.UTF-8', 14:06:53 INFO - 'LANGUAGE': 'en_US:en', 14:06:53 INFO - 'LOGNAME': 'cltbld', 14:06:53 INFO - 'MAIL': '/var/mail/cltbld', 14:06:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:53 INFO - 'MOZ_NO_REMOTE': '1', 14:06:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:06:53 INFO - 'NO_EM_RESTART': '1', 14:06:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:06:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:53 INFO - 'PWD': '/builds/slave/test', 14:06:53 INFO - 'SHELL': '/bin/bash', 14:06:53 INFO - 'SHLVL': '1', 14:06:53 INFO - 'TERM': 'linux', 14:06:53 INFO - 'TMOUT': '86400', 14:06:53 INFO - 'USER': 'cltbld', 14:06:53 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1467061532.908448-1147855932', 14:06:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:53 INFO - '_': '/tools/buildbot/bin/python'} 14:06:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:06:53 INFO - Running setup.py (path:/tmp/pip-RDiyVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:06:53 INFO - Running setup.py (path:/tmp/pip-2EICh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:06:53 INFO - Running setup.py (path:/tmp/pip-rBCmuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:06:53 INFO - Running setup.py (path:/tmp/pip-D5ZPMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:06:53 INFO - Running setup.py (path:/tmp/pip-tVPLFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:06:53 INFO - Running setup.py (path:/tmp/pip-9NZk3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:06:53 INFO - Running setup.py (path:/tmp/pip-LcoLa6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:06:53 INFO - Running setup.py (path:/tmp/pip-dQVRbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:06:54 INFO - Running setup.py (path:/tmp/pip-noyp35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:06:54 INFO - Running setup.py (path:/tmp/pip-mZmYYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:06:54 INFO - Running setup.py (path:/tmp/pip-xI6za1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:06:54 INFO - Running setup.py (path:/tmp/pip-LVl8nI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:06:54 INFO - Running setup.py (path:/tmp/pip-TBo5f3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:06:54 INFO - Running setup.py (path:/tmp/pip-Rz6yZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:06:54 INFO - Running setup.py (path:/tmp/pip-2nexMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:06:54 INFO - Running setup.py (path:/tmp/pip-H89RAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:06:54 INFO - Running setup.py (path:/tmp/pip-HBcycA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:06:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:06:54 INFO - Running setup.py install for manifestparser 14:06:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:06:54 INFO - Running setup.py install for mozcrash 14:06:54 INFO - Running setup.py install for mozdebug 14:06:54 INFO - Running setup.py install for mozdevice 14:06:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:06:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:06:55 INFO - Running setup.py install for mozfile 14:06:55 INFO - Running setup.py install for mozhttpd 14:06:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:06:55 INFO - Running setup.py install for mozinfo 14:06:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:06:55 INFO - Running setup.py install for mozInstall 14:06:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:06:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:06:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:06:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:06:55 INFO - Running setup.py install for mozleak 14:06:55 INFO - Running setup.py install for mozlog 14:06:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:06:55 INFO - Running setup.py install for moznetwork 14:06:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:06:55 INFO - Running setup.py install for mozprocess 14:06:55 INFO - Running setup.py install for mozprofile 14:06:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:06:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:06:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:06:55 INFO - Running setup.py install for mozrunner 14:06:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:06:56 INFO - Running setup.py install for mozscreenshot 14:06:56 INFO - Running setup.py install for moztest 14:06:56 INFO - Running setup.py install for mozversion 14:06:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:06:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:06:56 INFO - Cleaning up... 14:06:56 INFO - Return code: 0 14:06:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:06:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:06:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:56 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 0x7f60e2023f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcf5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e410>, '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 0x105f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1467061532.908448-1147855932', '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 14:06:56 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 14:06:56 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 14:06:56 INFO - Using env: {'DISPLAY': ':0', 14:06:56 INFO - 'HOME': '/home/cltbld', 14:06:56 INFO - 'LANG': 'en_US.UTF-8', 14:06:56 INFO - 'LANGUAGE': 'en_US:en', 14:06:56 INFO - 'LOGNAME': 'cltbld', 14:06:56 INFO - 'MAIL': '/var/mail/cltbld', 14:06:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:56 INFO - 'MOZ_NO_REMOTE': '1', 14:06:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:06:56 INFO - 'NO_EM_RESTART': '1', 14:06:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:06:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:56 INFO - 'PWD': '/builds/slave/test', 14:06:56 INFO - 'SHELL': '/bin/bash', 14:06:56 INFO - 'SHLVL': '1', 14:06:56 INFO - 'TERM': 'linux', 14:06:56 INFO - 'TMOUT': '86400', 14:06:56 INFO - 'USER': 'cltbld', 14:06:56 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1467061532.908448-1147855932', 14:06:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:56 INFO - '_': '/tools/buildbot/bin/python'} 14:06:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:06:56 INFO - Running setup.py (path:/tmp/pip-Dc1vuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:06:56 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)) 14:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:06:56 INFO - Running setup.py (path:/tmp/pip-trszG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:06:56 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)) 14:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:06:56 INFO - Running setup.py (path:/tmp/pip-7S_c48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:06:56 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)) 14:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:06:56 INFO - Running setup.py (path:/tmp/pip-cl2B_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:06:56 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)) 14:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:06:56 INFO - Running setup.py (path:/tmp/pip-_4v0EI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:06:57 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)) 14:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:06:57 INFO - Running setup.py (path:/tmp/pip-SyFUSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:06:57 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)) 14:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:06:57 INFO - Running setup.py (path:/tmp/pip-OfsXhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:06:57 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)) 14:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:06:57 INFO - Running setup.py (path:/tmp/pip-kV3B2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:06:57 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)) 14:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:06:57 INFO - Running setup.py (path:/tmp/pip-98Eq6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:06:57 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)) 14:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:06:57 INFO - Running setup.py (path:/tmp/pip-o7sh4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:06:57 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)) 14:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:06:57 INFO - Running setup.py (path:/tmp/pip-6HAbxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:06:57 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)) 14:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:06:57 INFO - Running setup.py (path:/tmp/pip-BHizOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:06:57 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)) 14:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:06:57 INFO - Running setup.py (path:/tmp/pip-LsoWOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:06:57 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)) 14:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:06:57 INFO - Running setup.py (path:/tmp/pip-NrLThK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:06:57 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)) 14:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:06:57 INFO - Running setup.py (path:/tmp/pip-V49sK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:06:57 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)) 14:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:06:57 INFO - Running setup.py (path:/tmp/pip-ee8qaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:06:57 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)) 14:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:06:57 INFO - Running setup.py (path:/tmp/pip-GFLeOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:06:57 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)) 14:06:57 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)) 14:06:57 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)) 14:06:57 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)) 14:06:57 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)) 14:06:57 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)) 14:06:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:59 INFO - Downloading blessings-1.6.tar.gz 14:06:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:06:59 INFO - Installing collected packages: blessings 14:06:59 INFO - Running setup.py install for blessings 14:07:00 INFO - Successfully installed blessings 14:07:00 INFO - Cleaning up... 14:07:00 INFO - Return code: 0 14:07:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:07:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:07:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:07:00 INFO - Reading from file tmpfile_stdout 14:07:00 INFO - Current package versions: 14:07:00 INFO - argparse == 1.2.1 14:07:00 INFO - blessings == 1.6 14:07:00 INFO - blobuploader == 1.2.4 14:07:00 INFO - docopt == 0.6.1 14:07:00 INFO - manifestparser == 1.1 14:07:00 INFO - mozInstall == 1.12 14:07:00 INFO - mozcrash == 0.17 14:07:00 INFO - mozdebug == 0.1 14:07:00 INFO - mozdevice == 0.48 14:07:00 INFO - mozfile == 1.2 14:07:00 INFO - mozhttpd == 0.7 14:07:00 INFO - mozinfo == 0.9 14:07:00 INFO - mozleak == 0.1 14:07:00 INFO - mozlog == 3.1 14:07:00 INFO - moznetwork == 0.27 14:07:00 INFO - mozprocess == 0.22 14:07:00 INFO - mozprofile == 0.28 14:07:00 INFO - mozrunner == 6.11 14:07:00 INFO - mozscreenshot == 0.1 14:07:00 INFO - mozsystemmonitor == 0.0 14:07:00 INFO - moztest == 0.7 14:07:00 INFO - mozversion == 1.4 14:07:00 INFO - psutil == 3.1.1 14:07:00 INFO - requests == 1.2.3 14:07:00 INFO - wsgiref == 0.1.2 14:07:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:07: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')]} 14:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07: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')]} 14:07:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:00 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 0x7f60e2023f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcf5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e410>, '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 0x105f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1467061532.908448-1147855932', '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 14:07:00 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 14:07:00 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 14:07:00 INFO - Using env: {'DISPLAY': ':0', 14:07:00 INFO - 'HOME': '/home/cltbld', 14:07:00 INFO - 'LANG': 'en_US.UTF-8', 14:07:00 INFO - 'LANGUAGE': 'en_US:en', 14:07:00 INFO - 'LOGNAME': 'cltbld', 14:07:00 INFO - 'MAIL': '/var/mail/cltbld', 14:07:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:00 INFO - 'MOZ_NO_REMOTE': '1', 14:07:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:00 INFO - 'NO_EM_RESTART': '1', 14:07:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:00 INFO - 'PWD': '/builds/slave/test', 14:07:00 INFO - 'SHELL': '/bin/bash', 14:07:00 INFO - 'SHLVL': '1', 14:07:00 INFO - 'TERM': 'linux', 14:07:00 INFO - 'TMOUT': '86400', 14:07:00 INFO - 'USER': 'cltbld', 14:07:00 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1467061532.908448-1147855932', 14:07:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:00 INFO - '_': '/tools/buildbot/bin/python'} 14:07:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:00 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)) 14:07:00 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)) 14:07:00 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)) 14:07:00 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)) 14:07:00 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)) 14:07:00 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)) 14:07:00 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)) 14:07:00 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)) 14:07:00 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)) 14:07:00 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)) 14:07:00 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)) 14:07:00 INFO - Cleaning up... 14:07:00 INFO - Return code: 0 14:07:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:07: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')]} 14:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07: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')]} 14:07:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:00 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 0x7f60e2023f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcf5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e410>, '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 0x105f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1467061532.908448-1147855932', '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 14:07:00 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 14:07:00 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 14:07:00 INFO - Using env: {'DISPLAY': ':0', 14:07:00 INFO - 'HOME': '/home/cltbld', 14:07:00 INFO - 'LANG': 'en_US.UTF-8', 14:07:00 INFO - 'LANGUAGE': 'en_US:en', 14:07:00 INFO - 'LOGNAME': 'cltbld', 14:07:00 INFO - 'MAIL': '/var/mail/cltbld', 14:07:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:00 INFO - 'MOZ_NO_REMOTE': '1', 14:07:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:00 INFO - 'NO_EM_RESTART': '1', 14:07:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:00 INFO - 'PWD': '/builds/slave/test', 14:07:00 INFO - 'SHELL': '/bin/bash', 14:07:00 INFO - 'SHLVL': '1', 14:07:00 INFO - 'TERM': 'linux', 14:07:00 INFO - 'TMOUT': '86400', 14:07:00 INFO - 'USER': 'cltbld', 14:07:00 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1467061532.908448-1147855932', 14:07:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:00 INFO - '_': '/tools/buildbot/bin/python'} 14:07:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:00 INFO - Downloading/unpacking jsonschema 14:07:00 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 14:07:00 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 14:07:00 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 14:07:00 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 14:07:00 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 14:07:00 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 14:07:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:07:02 INFO - Downloading/unpacking functools32 (from jsonschema) 14:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:02 INFO - Downloading functools32-3.2.3-2.tar.gz 14:07:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:07:02 INFO - warning: no files found matching '*.txt' 14:07:02 INFO - no previously-included directories found matching 'build' 14:07:02 INFO - no previously-included directories found matching 'dist' 14:07:02 INFO - no previously-included directories found matching '.git*' 14:07:02 INFO - Installing collected packages: jsonschema, functools32 14:07:02 INFO - Running setup.py install for functools32 14:07:03 INFO - warning: no files found matching '*.txt' 14:07:03 INFO - no previously-included directories found matching 'build' 14:07:03 INFO - no previously-included directories found matching 'dist' 14:07:03 INFO - no previously-included directories found matching '.git*' 14:07:03 INFO - Successfully installed jsonschema functools32 14:07:03 INFO - Cleaning up... 14:07:03 INFO - Return code: 0 14:07:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:03 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 0x7f60e2023f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcf5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e410>, '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 0x105f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1467061532.908448-1147855932', '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 14:07:03 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 14:07:03 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 14:07:03 INFO - Using env: {'DISPLAY': ':0', 14:07:03 INFO - 'HOME': '/home/cltbld', 14:07:03 INFO - 'LANG': 'en_US.UTF-8', 14:07:03 INFO - 'LANGUAGE': 'en_US:en', 14:07:03 INFO - 'LOGNAME': 'cltbld', 14:07:03 INFO - 'MAIL': '/var/mail/cltbld', 14:07:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:03 INFO - 'MOZ_NO_REMOTE': '1', 14:07:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:03 INFO - 'NO_EM_RESTART': '1', 14:07:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:03 INFO - 'PWD': '/builds/slave/test', 14:07:03 INFO - 'SHELL': '/bin/bash', 14:07:03 INFO - 'SHLVL': '1', 14:07:03 INFO - 'TERM': 'linux', 14:07:03 INFO - 'TMOUT': '86400', 14:07:03 INFO - 'USER': 'cltbld', 14:07:03 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1467061532.908448-1147855932', 14:07:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:03 INFO - '_': '/tools/buildbot/bin/python'} 14:07:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:03 INFO - Downloading/unpacking flake8 14:07:03 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 14:07:03 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 14:07:03 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 14:07:03 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 14:07:03 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 14:07:03 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 14:07:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:07:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:07:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:07:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:07:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:07:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:07:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:07:05 INFO - no previously-included directories found matching 'docs/_build' 14:07:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:07:06 INFO - Running setup.py install for pep8 14:07:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:07:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:07:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:07:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:07:06 INFO - no previously-included directories found matching 'docs/_build' 14:07:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:07:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:07:06 INFO - Cleaning up... 14:07:06 INFO - Return code: 0 14:07:06 INFO - Running post-action listener: _resource_record_post_action 14:07:06 INFO - Running post-action listener: _start_resource_monitoring 14:07:06 INFO - Starting resource monitoring. 14:07:06 INFO - ##### 14:07:06 INFO - ##### Running install step. 14:07:06 INFO - ##### 14:07:06 INFO - Running pre-action listener: _resource_record_pre_action 14:07:06 INFO - Running main action method: install 14:07:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:07:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:07:06 INFO - Reading from file tmpfile_stdout 14:07:06 INFO - Detecting whether we're running mozinstall >=1.0... 14:07:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:07:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:07:06 INFO - Reading from file tmpfile_stdout 14:07:06 INFO - Output received: 14:07:06 INFO - Usage: mozinstall [options] installer 14:07:06 INFO - Options: 14:07:06 INFO - -h, --help show this help message and exit 14:07:06 INFO - -d DEST, --destination=DEST 14:07:06 INFO - Directory to install application into. [default: 14:07:06 INFO - "/builds/slave/test"] 14:07:06 INFO - --app=APP Application being installed. [default: firefox] 14:07:06 INFO - mkdir: /builds/slave/test/build/application 14:07:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:07:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:07:19 INFO - Reading from file tmpfile_stdout 14:07:19 INFO - Output received: 14:07:19 INFO - /builds/slave/test/build/application/firefox/firefox 14:07:19 INFO - Running post-action listener: _resource_record_post_action 14:07:19 INFO - ##### 14:07:19 INFO - ##### Running run-tests step. 14:07:19 INFO - ##### 14:07:19 INFO - Running pre-action listener: _resource_record_pre_action 14:07:19 INFO - Running main action method: run_tests 14:07:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:07:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:07:19 INFO - Python 2.7.3 14:07:19 INFO - Return code: 0 14:07:19 INFO - grabbing minidump binary from tooltool 14:07: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')]} 14:07:19 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 0x105e410>, '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 0x105f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:07:19 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 14:07:19 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 14:07:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:07:19 INFO - Return code: 0 14:07:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:07:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:07:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:07:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:07:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:07:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:07:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:07:20 INFO - Return code: 0 14:07:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dydLOsyBTMOQL2I-aXSGhA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 14:07:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dydLOsyBTMOQL2I-aXSGhA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --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 14:07:20 INFO - Using env: {'DISPLAY': ':0', 14:07:20 INFO - 'HOME': '/home/cltbld', 14:07:20 INFO - 'LANG': 'en_US.UTF-8', 14:07:20 INFO - 'LANGUAGE': 'en_US:en', 14:07:20 INFO - 'LOGNAME': 'cltbld', 14:07:20 INFO - 'MAIL': '/var/mail/cltbld', 14:07:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:07:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:07:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:20 INFO - 'MOZ_NO_REMOTE': '1', 14:07:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:07:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:20 INFO - 'NO_EM_RESTART': '1', 14:07:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:20 INFO - 'PWD': '/builds/slave/test', 14:07:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:07:20 INFO - 'SHELL': '/bin/bash', 14:07:20 INFO - 'SHLVL': '1', 14:07:20 INFO - 'TERM': 'linux', 14:07:20 INFO - 'TMOUT': '86400', 14:07:20 INFO - 'USER': 'cltbld', 14:07:20 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1467061532.908448-1147855932', 14:07:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:20 INFO - '_': '/tools/buildbot/bin/python'} 14:07:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dydLOsyBTMOQL2I-aXSGhA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 14:07:21 INFO - mozversion application_buildid: 20160627113417 14:07:21 INFO - mozversion application_changeset: 35e0d7dd7cd7bff301b75756361b36b275102404 14:07:21 INFO - mozversion application_display_name: Firefox 14:07:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:07:21 INFO - mozversion application_name: Firefox 14:07:21 INFO - mozversion application_remotingname: firefox 14:07:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:07:21 INFO - mozversion application_vendor: Mozilla 14:07:21 INFO - mozversion application_version: 48.0 14:07:21 INFO - mozversion platform_buildid: 20160627113417 14:07:21 INFO - mozversion platform_changeset: 35e0d7dd7cd7bff301b75756361b36b275102404 14:07:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:07:21 INFO - mozversion platform_version: 48.0 14:07:21 INFO - using testdate: 1467061641 14:07:21 INFO - actual date: 1467061641 14:07:21 INFO - starting webserver on 'localhost:56286' 14:07:21 INFO - SUITE-START | Running 2 tests 14:07:21 INFO - TEST-START | dromaeo_css 14:07:21 INFO - operating with platform_type : linux_ 14:07:21 INFO - Initialising browser for dromaeo_css test... 14:07:21 INFO - TEST-INFO | started process 3330 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyzOtmX/profile http://localhost:56286/getInfo.html) 14:07:26 INFO - PROCESS | 3330 | __metrics Screen width/height:1600/1200 14:07:26 INFO - PROCESS | 3330 | colorDepth:24 14:07:26 INFO - PROCESS | 3330 | Browser inner width/height: 1024/697 14:07:26 INFO - PROCESS | 3330 | __metrics 14:07:28 ERROR - PROCESS | 3330 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:07:28 INFO - TEST-INFO | 3330: exit 0 14:07:28 INFO - Browser initialized. 14:07:28 INFO - Running cycle 1/1 for dromaeo_css test... 14:07:28 INFO - TEST-INFO | started process 3423 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyzOtmX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:07:40 INFO - PROCESS | 3423 | RSS: Main: 139681792 14:07:40 INFO - PROCESS | 3423 | 14:08:31 INFO - PROCESS | 3423 | 1467061711694 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] 14:10:39 INFO - PROCESS | 3423 | Cycle 1(1): loaded http://localhost:56286/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56286/tests/dromaeo/cssquery-ext.html) 14:10:40 INFO - PROCESS | 3423 | RSS: Main: 244273152 14:10:40 INFO - PROCESS | 3423 | 14:13:42 INFO - PROCESS | 3423 | Cycle 1(1): loaded http://localhost:56286/tests/dromaeo/cssquery-ext.html (next: http://localhost:56286/tests/dromaeo/cssquery-jquery.html) 14:13:43 INFO - PROCESS | 3423 | RSS: Main: 226705408 14:13:43 INFO - PROCESS | 3423 | 14:16:45 INFO - PROCESS | 3423 | Cycle 1(1): loaded http://localhost:56286/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56286/tests/dromaeo/cssquery-mootools.html) 14:16:45 INFO - PROCESS | 3423 | RSS: Main: 217305088 14:16:45 INFO - PROCESS | 3423 | 14:19:47 INFO - PROCESS | 3423 | Cycle 1(1): loaded http://localhost:56286/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56286/tests/dromaeo/cssquery-prototype.html) 14:19:48 INFO - PROCESS | 3423 | RSS: Main: 218808320 14:19:48 INFO - PROCESS | 3423 | 14:22:50 INFO - PROCESS | 3423 | Cycle 1(1): loaded http://localhost:56286/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56286/tests/dromaeo/cssquery-yui.html) 14:22:51 INFO - PROCESS | 3423 | RSS: Main: 215056384 14:22:51 INFO - PROCESS | 3423 | 14:25:53 INFO - PROCESS | 3423 | Cycle 1(1): loaded http://localhost:56286/tests/dromaeo/cssquery-yui.html (next: http://localhost:56286/tests/dromaeo/cssquery-dojo.html) 14:25:53 INFO - PROCESS | 3423 | RSS: Main: 247283712 14:25:53 INFO - PROCESS | 3423 | 14:25:53 INFO - PROCESS | 3423 | __start_tp_report 14:25:53 INFO - PROCESS | 3423 | _x_x_mozilla_page_load 14:25:53 INFO - PROCESS | 3423 | _x_x_mozilla_page_load_details 14:25:53 INFO - PROCESS | 3423 | |i|pagename|runs| 14:25:53 INFO - PROCESS | 3423 | |0;dojo.html;3279.3277378137486;3316.7014968652816;3322.053214833772;3346.33073385323;3356.16095976006;5480;5493.313335833021;5527.364353099395;5538.086215774398;5553.527950124234;5509.393966663663;5519.420460851613;5532.1425179097205;5538.695371754552;5565.0817615093465;4906;4918.508149185071;4990.176620857564;5008.649394542384;5048.7728052237735;4906.435759887605;4997.625178111638;5002.12462819007;5003.099442100421;5003.14946459101;4933.555979961803;4990.27640992056;5012.924806127911;5025.3969523657215;5049.3940727112795;4985.52637499437;5014.498550144975;5015.122353588107;5017.523335283142;5042.117629414856;4842.515748425165;4871.658983871131;4928.33467481889;4941.555260026615;4988.02733466974;5370.382406023318;5372.677639341613;5432.266644003049;5432.483914028161;5439;5822.301323841124;5830.3586605473365;5833.2416785817995;5839.065749480105;5844.064949608085;5781.421857814227;5832.650040997553;5889.322727886305;5890.558208134407;5917.171595976567;5436.075867102602;5468.152436372368;5474.069408200616;5478.945210547923;5488.286522752017;5878.353381128072;5978.641281523122;5984.222051133412;5985.880282394328;5987.042073268256;5727.455891690282;5766.971165144231;5795.507381872588;5806.30324361071;5815.73829177688;5764.510016648548;5807.361190269067;5808.883822323614;5811.738471768781;5812.912806307909;5693.975084484832;5749.3963133871175;5765.365809760923;5768.855778605484;5769.423057694197;5821.592488525763;5838.795642152504;5841.240638716939;5851.882962340729;5879.353271140171;4486.887827804331;4487.842925497592;4488.483824360175;4507.954920450819;4508.571685689854;3971.900702482461;3990.3016972029777;4044.4539987101366;4053.594640535982;4068.532118806316;5557.055300598908;5573.832785016456;5576.302962129734;5580.051391263495;5600.383957764642;5876.559258055578;5883.441073098049;5886.293644762656;5890.970545147333;5905.911411328833;5451.073317536028;5556.444355564492;5556.638818476786;5567.582431317667;5627.915581266284;5045.621578381636;5050.141475949097;5061.746912654353;5065.189569668835;5085.2372144177925;6088.330283668793;6097.298810636745;6100.054491553817;6100.450959413674;6103.633781973096;5784;5848.941510584839;5855.38518455556;5881.794137205177;5977.043673012297;6110.7555697771595;6143.235544005305;6175.505959523138;6178.7219575120125;6200.875982480416;5799.536037117105;5803.47768700819;5804.854878628068;5811.593188476935;5819.447152520504;5741.081426971665;5883.146943693055;5910.7931222407005;5966.134910438049;5978.671173085522;5681.977244096102;5725.6850873202375;5726.914096288642;5748.597598168088;5752.71236438168;5688.232088667977;5721.485066344049;5742.913856292075;5747.137929310469;5747.74135163927;5587.525060369914;5666.943330566642;5736.541076713769;5752.022156233366;5781.277340332458;5709.34342550612;5721.313442386941;5725.742341594555;5731.828045158652;5734.569907256889;5544.667319960815;5573.247611572386;5606.943930560642;5615.634983726045;5645.830625081254 14:25:53 INFO - PROCESS | 3423 | |1;ext.html;596.6002778138646;651.1372431528225;664.5414663881924;668.8762578922903;671.4930227678102;32091.19772005698;32524;32571.348573028525;32575.67424325759;39078;42355;42629;42876.78561607187;42878.35682464766;43023.784881075626;8856.291496680282;9041.593128309209;9045.773855653595;9046.185843274105;9048;8091;8844.911550884506;10770.838437423445;11011.889881101166;11024.228304018721;10649.627263045795;10751;10759.731006724855;10768.676939691823;10770.29993050453;10582.629607963723;10663.893361066444;10664.306820056672;10666.839997400046;10669.893301066968;10490.685279441628;10573.73565660857;10600.575976960912;10603.363798172135;10605.628802991858;38629.22741545153;42615.786921065504;42672;42695.78652106751;42757.358639620434;3816.8777720062267;3835.1562656215588;3850.942235866464;3870.665323586032;3988.282109220339;33193.502097468554;33250.833745831114;33779;33851.322973540635;33876.49185262223;4394.36281739146;4566.977165114186;4606.56237657422;4608.5621865922685;4615.630749540029;313637;314039.99999999773;315283;315520;315646;64597.67701161464;64983;65236.34763652303;65252;65274.673626631564;68502.65748671225;68900.65549672219;69330.65334673294;69961.65019174872;69987.3001269991;16431.753523697153;16523.586910327096;16627.418040368528;16638.50084497467;16641.833581664272;11004.284721493077;12088.214266072677;12165.452554635063;12174.452149653287;12176.81734773979;20436.79563204349;21121.78878211229;21254.25610103639;21295;21333;7426.14599321085;7440.590767507731;7491.513051651626;7503.62481875904;7629.8855517167285;1044.4568824211367;1058.2645061682058;1098.5228310160537;1101.7906597746403;1160.489384670742;29157.125286241448;29463;29886.701132988394;29987.550186747216;30457.847710761747;1114.5876025870318;1115.8828323026128;1158.0330424095973;1193.367515216919;1227.2391117507202;15525.611859703371;15812.92093539548;15869.603259918595;15884.285207165705;16019.43931962399;462263;468901;469699;470351;471373;62767.686161569814;63271.36728632747;63408;63440.36559634437;63440.68279658572;1424.4587056918306;1458.824941007086;1488.8660020597981;1519.4454024281058;1580.3678528588657;27550.44899102047;29495;29560.704392956657;29951;30461.23846903845;50408;50862.23706644329;50890.23664645107;50924.745376272884;51057.74471127621;284009;288704;289662.55168724863;289841;290123;27125.72874271232;27593.86203069052;30650.846745766128;30661.386772263984;31062.22344441407;44202;49298.75350623224;49420.258696118864;50107.49892501028;50337;39282.80358598303;41003.58996409998;41471.7926410366;42088.57911420846;42785;40201.798991004856;40247;40726.18547628971;40825.1834963305;41582.376264356666;34010.489842651885;34415.82792086023;37994;38274.425883612326;38611.806940965114;34795.65204347924;37089.44365834461;37393.6260637401;37930.43104353492;38021;28091;28213;28223;28463.43073138567;28612 14:25:53 INFO - PROCESS | 3423 | |2;jquery.html;428.60365441010595;429.7163871844582;437.8861496011036;443.1933880337785;452.2176634422451;18495.44513664589;18599.814001859995;19248.23007079715;20667.586648267024;20671.896640516778;19160.712589311137;19187.808121918777;19384.806151938476;19444.513887152792;19445.319413820518;5673.829785106433;5732.0828667413225;5943.3462319144855;5963.105534169866;5966.701664916758;4195.979020104895;5877.529797616202;5955.910661340084;6183.505319574423;6544.836379090513;6516.283208847047;6535.771248006321;6536.248331441898;6537.869242615145;6542.1495205623205;6404.327545607714;6407.871842563146;6489.929161688316;6555.0822884795925;6561.704723287464;3898.6101389860787;4033.052232725307;5646.802361917313;5880;5888.911666325009;24048.278551643478;24160.516789664107;24320.756792432025;24538.509229815303;24583.508329833305;2463.5935070713313;2495.4759500504915;2778.944001279521;2825.872835722397;2880.251134704971;14752.55742327732;15270.847291527054;15273.083614983136;15578.298976546082;15674.843251567452;1997.3808119482862;2033.1155947163031;2033.2680235115347;2069.2550681754556;2111.883846388448;78412.60793696051;80935.5953220236;81804;82053;83658.16341836625;11158.274712143848;11283.887161128283;11553.884461155449;11610.477528511237;11856.347900865536;16386.75419868703;16413.67172656564;16419;16434;16436.096014719067;8416;8483.618237179342;8507.404481686346;8543.188397102265;8604.182602652738;8134.145914678874;8259.917400826034;8335.749927502186;8397.370197235232;8422.578871056423;7034.452420467489;7035.296470353026;7221.602811845399;7242.529235599669;7272.927270727225;1812.5073839247016;1968.586596814685;1982.8116328948727;2033.5322875738664;2086.2698055680694;1014.1683819268277;1083.9458027098613;1138.9886101139048;1145.169751929861;1169.4678921090883;19093.904530477535;19411.223551058083;19727.4081777544;19922.161262849357;20070.698939515918;1049.7008352619466;1089.9237053406343;1100.7743412600398;1182.4678894497338;1206.6681662542696;11310.547578096948;11559.942200289113;11594.536218551164;11596.710082247842;11606.477708503138;495835.0832983392;499773;521899;523641;524270;79056;84718;84885;85397.57301213454;86775.1322486767;1069.2034434346463;1086.7337502311984;1089.5097206257217;1090.465671820802;1119.9552017919193;16874.240659170613;17379.391721289696;17534.73697894507;17643.20605572778;17696.29214831392;37570.8121459391;38226.61773382342;38713.2257354857;38742;39775.403368950065;52837.735811320694;54088.45911540992;54384.45615543794;54389.456105440026;54537.454625454826;9316.813663726824;9473.47895865734;9483.810323793623;9513.429194248367;9549.188318992963;14032.158070515801;14157.716845662822;14265.786013209603;14389.496367627084;14489.78265326;12421.130520863453;12434;12611.117221794753;12641.494340226656;12669.303188324731;12261.448234829633;12331.568395106127;12351.258924464202;12461.813072803734;12525.123241373016;11762.294262344287;12228.633141005785;12359.073069520002;12504.312262825631;12527.624171274876;9001.54992250398;9093.863267091614;9113.350651414845;9290.95354523223;9490.478023708762;12455.190412623151;12697.746045078862;12806.48774049065;12859.935700321439;12916.677083072998 14:25:53 INFO - PROCESS | 3423 | |3;mootools.html;1466.882649388049;1584.4137669062445;1601.7196990526659;1790.8030116687162;1895.6777347850855;8582.570871456433;8758.605862736169;8760.737177884657;8762.912370876289;8767.6054577544;8642.17899299567;8798.98811636662;8803.295736341093;8814.030456649763;8816.911830881689;2461.150902938488;2493.775560199582;2497.438076432797;2500.7999360051244;2502.011705376375;2472.5673007223754;2559.4881023795224;2561.2316305108393;2564.756348146923;2564.8845801938955;2465.469923966347;2477.256822953107;2525.027864272259;2528.9873550632315;2531.0761572026263;2512.484940587184;2537;2539.200151952129;2544.6946366436146;2556.833805802617;2452.3869032741813;2526.1284856724583;2549.847009179455;2560.974390256111;2565.294544000415;8242.29940455062;8504.957475212646;8961.596728147184;8980.865287020635;8991.370604057718;5309.389420216686;5419.864503387407;5424.430434804368;5427.050266203399;5427.402985671573;3520.1551627609447;3556.3598552260582;3620.873269435557;3671.192337685705;3674.889753307405;1133.4332833583208;1174.5830230268302;1188.0673671168092;1215.1493954232074;1221.7861874172074;12661.430235639418;12733.299668518228;12776.936115319457;12809.167404118702;12835.422405991752;4804;4972.303877457159;5013.348264725635;5036.32009678696;5075.771590278447;10746.516406761715;10808.135349172047;10824.13406927444;10834.404107773991;10836;5582.8325150245555;5638.04153293941;5638.915416268759;5639.069553523623;5655.066913959233;4350.216960946997;4484.035932274512;4879.756012199447;4943.752812359367;5170.1727723564045;4266.658667306608;4331.415258940003;4370.104128653618;4388.714733542373;4524.6832721709825;1382.8064071030064;1429.0711037825497;1443.527601846111;1444.2201211345966;1455.9490417835325;1042.5464922758624;1048.2138396202847;1054.6466933577185;1060.1095080132725;1067.3489171605315;5652.18043383707;5832.825015249549;5962.612430192024;6120.12737018326;6243.094751261133;972.557486343712;975.9268054895912;1040.557762950743;1046.6964580271788;1060.188955449082;4002.679785617144;4063.7561746294728;4077.26609210345;4143.875683729493;4207.873763787091;10846.45767711627;11231.326120432801;11282.041026512674;11314.830277545843;11315.321080735182;11113.611023614134;11115.944420278009;11118.166137539716;11133.498992545356;11142.665720028412;7822.1786712395515;8423.115572864883;8529.786755331166;8544.31645468361;8638.697645582375;5708.286464191976;5733.655980641175;5756.395578464201;5825.097109947965;5872.471477567039;9446.102620251066;9676.080772326617;9702;9750.75623109428;9806.06842350004;9544.618215271588;9795.804083918425;9829.901700982899;9877.950610246902;10061.748456288651;6861.897071544031;7036.824079398056;7038.788836334918;7746.380289576708;7868.763937081897;8230.62962166716;8410.453320534145;8422.578871056545;8478.957605211934;8488.702895398632;7487.138979017483;7706.3449606781805;7714.537127772352;7796.259355361231;7869.213078692085;7402.814929626802;7534.510256833289;7566;7585.127710313164;7669;7141;7189.2810718927685;7202.567845929261;7320.084989376328;7360.889586656097;5064.493550645054;5236.711980840938;5309.946900530946;5351.010063138332;5365.865853353697;5072.619553533426;5097.8215762448135;5098.056859481007;5126.256692779601;5184.896302074013 14:25:53 INFO - PROCESS | 3423 | |4;prototype.html;362.52509212931045;369.4126339120798;371.1426604543503;372.8378155502357;382.2183634467512;6253.937460625392;6281.277653069898;6285.497160227183;6307.180066591342;6313.873722525553;6163.691815409223;6207.4723648489935;6237.3450787667325;6238.688065596724;6239.251289845213;4577.176108300521;4648.535146485341;4801.591864691488;4806.663533552653;4827.468978412372;4821.758912054401;4822.951770482286;4834.516548345155;4843.467218605951;4844.055409195191;4777.187878060738;4791;4798.040391921612;4799;4802.687825291362;4570.33730109134;4649.651276154302;4698.647601429906;4741.905161896742;4794.304825800257;4233.216854881856;4251.06476575153;4252.659787217015;4255.723377980421;4269.765162916038;6024.668643224665;6026.186464827236;6043.365446628129;6046.758129674808;6066.817995460143;5608.6073974821775;5616.775328986836;5620.803271885465;5623.493885550321;5625.634333768292;6578.703958321839;6612.86774264512;6619.801405957829;6630.436412904909;6631.33686631333;4496.820127194908;4663.044075964453;4675.251959686434;4679.60223381013;4736.502667219961;6843;6904.654767261617;6908.792736217922;6921.861562768767;6922;4755.358026666356;4757.500462451462;4761.238201887751;4763.54746299101;4766.809327626926;4820.493848145964;4821.445533763592;4824;4828.686135401188;4835.975820120877;5542.501174894279;5556.722163891789;5562.3881373048935;5565.30433695788;5567.749451274703;6404.903926441107;6626.171728533934;6634.402903738686;6659.167604049494;6670.433013193933;1669.540876259014;1687.8143404225525;1696.8218337074677;1697.9575510612333;1703.1143805221216;1071.5392381276126;1078.6063086973197;1100.6477927063263;1106.5573770491867;1115.2806439846254;6223.96888015557;6327.715252813635;6384.6169229846355;6507.284198738135;6513.12072870166;6939.340762627542;6940.548864323803;6943.409810166091;6945.583265004116;6969.1985421676145;6455.644939528371;6479.157709497735;6490.415862572391;6508.707108180143;6515.54391192612;3700.9629903701157;3739.9065023374087;3740.5698344690163;3743.6630703236838;3743.756655817363;6969.825754356181;7278.417726581861;7284.599347035858;7289.963550182215;7311.122665280201;7019.403350715246;7039.648017599099;7051.400630946427;7053.89419158713;7054.717811287491;7246.275372462817;7251.41988640918;7259.4918355715645;7259.818504537428;7259.891101633374;6880.827979300558;6920.515563910478;6924.58452492852;6926.896096558657;6954.061201737903;6622.536422450382;6804.4896632753735;6824.249332573314;6872.862542749017;6877.243503214542;7278.199398066315;7308.049953506223;7311.963440182765;7314.08573928259;7317.12194536659;4735.763211839463;4758.2386818108935;4759.7858096386435;4767.046590681947;4768.66619336657;6914.896276555956;6916.51584389108;6923.099997000358;6925.27284635106;6926.0649812276715;6449.677516124269;6644.833879152867;6686.966565167143;6689.832754181184;6709.161354830646;6645.700943457653;6670.533062685566;6674.032265321404;6674.199096108304;6681.198256209092;6574.506911981716;6580.539362244597;6586.637734924625;6587.80236592903;6591.044298576776;6729.932700672931;6731.293214212633;6740.191177058784;6742.359475849787;6746.291639377795;6448;6551.344865513411;6555.082288479522;6597.60414375139;6607.867842643216 14:25:53 INFO - PROCESS | 3423 | |5;yui.html;876.522295349035;915.4507295622627;918.5590916360147;931.5575101826632;941.6892425499586;14001;14825.258737063145;15091.39634414625;15120;15204.619884502892;13876.791848122286;14679.119252844837;14729.779053314209;14748.557543273691;14785.964982451233;746.9178390377054;891.9331050171263;897.9326550508705;906.9002409734924;915.0026471146449;901.9413738107002;903.1104362203224;903.2322525853039;903.2773780975226;903.5346796399859;950.9286803489731;951.096458364553;951.6621599332241;952.4190243951184;952.7808604021079;783.2872086401376;792.1603100713262;915.3683958068912;932.9486878221695;948.4451595816421;679.2256827216977;679.3715812873072;679.8878185099453;682.5222344358968;682.8429461223947;15092.39630414782;15160.090394576251;15173;15187.544373668698;15208.847911520854;13746.793798093036;13984.790228146587;14028;14037.859621403757;14143.151410915378;11339.886601134049;11420.885791142066;11491.942540287246;11581;11619.535218591247;4045.292073887058;4089.815958281855;4115.650169735576;4158.521769996459;4192.28731115708;55127.44872551263;55437;55463.16805247884;55846.72076639631;56088.719556402364;10457.163426925828;10631.94684026575;10713.625023124154;10923.180761442924;10961.506732197071;20531.692024619642;20642.793572064085;20644.793552064286;20674;21087.578248434944;8487.745367638981;8528.147185281423;8634.352423568258;8662.566871656518;8728.127187281349;4585.312203169551;4595.109937036953;4679.719216847;4778.259369797687;4792.592629626451;3563.1804684922095;3633.218857945554;3636.3272794533095;3637.0361854108683;3638.2177831765766;560.9130584759369;600.6636283681065;607.9209702738616;628.0422355907186;633.2211380002531;725.6661935509619;729.8686236477484;735.8638651849425;739.903812504371;753.3859904178078;8889.288856891433;8889.377743558018;9195.908040919505;9252.722418327461;9355.158035776676;668.7893313606296;739.5270788680415;763.522798251093;778.3461892010738;779.3531368963746;3942.1918506706056;4123.443335149776;4279.144171165717;4388.29787234041;4393.956060439355;66010;66219.33780662228;66866.66566667135;66929.33070669329;66940.33059669439;55693;58502;58516;58679.70660146672;58784.41215587789;50951.49048509468;51516.74241628768;51574.226386604234;51944.48055519472;52489;8563;8578.528180950108;8634.05025447213;8641;8967.955160224157;39794.60205397909;40105.79947100246;40314.596854031086;41210.79394603008;41428.58571414247;47275;47786.76106619445;51445;51817.7409112952;51884.74057629688;10393.636222732168;10610.840837387292;10667;10711.303765255234;10780.137588993019;12094.213876098378;12384;12436.253824770543;12454.128211025503;12467.189632673848;11645.184837061324;11646.534138634359;11653.30080195191;11658;11665.066794656577;11290.887091128983;11421.543138274708;11445.599404021152;11448.198626096093;11476.942615287204;10066.748331291776;11331.433428328386;11459.31244125355;11623.941880290544;11784.292942423483;9632.22942164611;9845.901540984498;10215.182785377003;10450.529726162493;10623.468826558486;10424.583016679248;10477;10666.73333166677;10670.946645266724;10706.357618542912 14:25:53 INFO - PROCESS | 3423 | __end_tp_report 14:25:53 INFO - PROCESS | 3423 | __start_cc_report 14:25:53 INFO - PROCESS | 3423 | _x_x_mozilla_cycle_collect,852 14:25:53 INFO - PROCESS | 3423 | __end_cc_report 14:25:53 INFO - PROCESS | 3423 | __startTimestamp1467062753722__endTimestamp 14:25:53 INFO - PROCESS | 3423 | 14:25:53 INFO - PROCESS | 3423 | ------- Summary: start ------- 14:25:53 INFO - PROCESS | 3423 | Number of tests: 6 14:25:53 INFO - PROCESS | 3423 | 14:25:53 INFO - PROCESS | 3423 | [#0] dojo.html Cycles:165 Average:5451.47 Median:5681.98 stddev:600.14 (10.6%) stddev-sans-first:577.29 14:25:53 INFO - PROCESS | 3423 | Values: 3279.3 3316.7 3322.1 3346.3 3356.2 5480.0 5493.3 5527.4 5538.1 5553.5 5509.4 5519.4 5532.1 5538.7 5565.1 4906.0 4918.5 4990.2 5008.6 5048.8 4906.4 4997.6 5002.1 5003.1 5003.1 4933.6 4990.3 5012.9 5025.4 5049.4 4985.5 5014.5 5015.1 5017.5 5042.1 4842.5 4871.7 4928.3 4941.6 4988.0 5370.4 5372.7 5432.3 5432.5 5439.0 5822.3 5830.4 5833.2 5839.1 5844.1 5781.4 5832.7 5889.3 5890.6 5917.2 5436.1 5468.2 5474.1 5478.9 5488.3 5878.4 5978.6 5984.2 5985.9 5987.0 5727.5 5767.0 5795.5 5806.3 5815.7 5764.5 5807.4 5808.9 5811.7 5812.9 5694.0 5749.4 5765.4 5768.9 5769.4 5821.6 5838.8 5841.2 5851.9 5879.4 4486.9 4487.8 4488.5 4508.0 4508.6 3971.9 3990.3 4044.5 4053.6 4068.5 5557.1 5573.8 5576.3 5580.1 5600.4 5876.6 5883.4 5886.3 5891.0 5905.9 5451.1 5556.4 5556.6 5567.6 5627.9 5045.6 5050.1 5061.7 5065.2 5085.2 6088.3 6097.3 6100.1 6100.5 6103.6 5784.0 5848.9 5855.4 5881.8 5977.0 6110.8 6143.2 6175.5 6178.7 6200.9 5799.5 5803.5 5804.9 5811.6 5819.4 5741.1 5883.1 5910.8 5966.1 5978.7 5682.0 5725.7 5726.9 5748.6 5752.7 5688.2 5721.5 5742.9 5747.1 5747.7 5587.5 5666.9 5736.5 5752.0 5781.3 5709.3 5721.3 5725.7 5731.8 5734.6 5544.7 5573.2 5606.9 5615.6 5645.8 14:25:53 INFO - PROCESS | 3423 | 14:25:53 INFO - PROCESS | 3423 | [#1] ext.html Cycles:180 Average:53619.60 Median:33863.91 stddev:96511.47 (285.0%) stddev-sans-first:96700.11 14:25:53 INFO - PROCESS | 3423 | Values: 596.6 651.1 664.5 668.9 671.5 32091.2 32524.0 32571.3 32575.7 39078.0 42355.0 42629.0 42876.8 42878.4 43023.8 8856.3 9041.6 9045.8 9046.2 9048.0 8091.0 8844.9 10770.8 11011.9 11024.2 10649.6 10751.0 10759.7 10768.7 10770.3 10582.6 10663.9 10664.3 10666.8 10669.9 10490.7 10573.7 10600.6 10603.4 10605.6 38629.2 42615.8 42672.0 42695.8 42757.4 3816.9 3835.2 3850.9 3870.7 3988.3 33193.5 33250.8 33779.0 33851.3 33876.5 4394.4 4567.0 4606.6 4608.6 4615.6 313637.0 314040.0 315283.0 315520.0 315646.0 64597.7 64983.0 65236.3 65252.0 65274.7 68502.7 68900.7 69330.7 69961.7 69987.3 16431.8 16523.6 16627.4 16638.5 16641.8 11004.3 12088.2 12165.5 12174.5 12176.8 20436.8 21121.8 21254.3 21295.0 21333.0 7426.1 7440.6 7491.5 7503.6 7629.9 1044.5 1058.3 1098.5 1101.8 1160.5 29157.1 29463.0 29886.7 29987.6 30457.8 1114.6 1115.9 1158.0 1193.4 1227.2 15525.6 15812.9 15869.6 15884.3 16019.4 462263.0 468901.0 469699.0 470351.0 471373.0 62767.7 63271.4 63408.0 63440.4 63440.7 1424.5 1458.8 1488.9 1519.4 1580.4 27550.4 29495.0 29560.7 29951.0 30461.2 50408.0 50862.2 50890.2 50924.7 51057.7 284009.0 288704.0 289662.6 289841.0 290123.0 27125.7 27593.9 30650.8 30661.4 31062.2 44202.0 49298.8 49420.3 50107.5 50337.0 39282.8 41003.6 41471.8 42088.6 42785.0 40201.8 40247.0 40726.2 40825.2 41582.4 34010.5 34415.8 37994.0 38274.4 38611.8 34795.7 37089.4 37393.6 37930.4 38021.0 28091.0 28213.0 28223.0 28463.4 28612.0 14:25:53 INFO - PROCESS | 3423 | 14:25:53 INFO - PROCESS | 3423 | [#2] jquery.html Cycles:180 Average:29815.18 Median:24104.40 stddev:84188.40 (349.3%) stddev-sans-first:84395.66 14:25:53 INFO - PROCESS | 3423 | Values: 428.6 429.7 437.9 443.2 452.2 18495.4 18599.8 19248.2 20667.6 20671.9 19160.7 19187.8 19384.8 19444.5 19445.3 5673.8 5732.1 5943.3 5963.1 5966.7 4196.0 5877.5 5955.9 6183.5 6544.8 6516.3 6535.8 6536.2 6537.9 6542.1 6404.3 6407.9 6489.9 6555.1 6561.7 3898.6 4033.1 5646.8 5880.0 5888.9 24048.3 24160.5 24320.8 24538.5 24583.5 2463.6 2495.5 2778.9 2825.9 2880.3 14752.6 15270.8 15273.1 15578.3 15674.8 1997.4 2033.1 2033.3 2069.3 2111.9 78412.6 80935.6 81804.0 82053.0 83658.2 11158.3 11283.9 11553.9 11610.5 11856.3 16386.8 16413.7 16419.0 16434.0 16436.1 8416.0 8483.6 8507.4 8543.2 8604.2 8134.1 8259.9 8335.7 8397.4 8422.6 7034.5 7035.3 7221.6 7242.5 7272.9 1812.5 1968.6 1982.8 2033.5 2086.3 1014.2 1083.9 1139.0 1145.2 1169.5 19093.9 19411.2 19727.4 19922.2 20070.7 1049.7 1089.9 1100.8 1182.5 1206.7 11310.5 11559.9 11594.5 11596.7 11606.5 495835.1 499773.0 521899.0 523641.0 524270.0 79056.0 84718.0 84885.0 85397.6 86775.1 1069.2 1086.7 1089.5 1090.5 1120.0 16874.2 17379.4 17534.7 17643.2 17696.3 37570.8 38226.6 38713.2 38742.0 39775.4 52837.7 54088.5 54384.5 54389.5 54537.5 9316.8 9473.5 9483.8 9513.4 9549.2 14032.2 14157.7 14265.8 14389.5 14489.8 12421.1 12434.0 12611.1 12641.5 12669.3 12261.4 12331.6 12351.3 12461.8 12525.1 11762.3 12228.6 12359.1 12504.3 12527.6 9001.5 9093.9 9113.4 9291.0 9490.5 12455.2 12697.7 12806.5 12859.9 12916.7 14:25:53 INFO - PROCESS | 3423 | 14:25:53 INFO - PROCESS | 3423 | [#3] mootools.html Cycles:180 Average:5894.56 Median:5024.83 stddev:3267.71 (65.0%) stddev-sans-first:3259.93 14:25:53 INFO - PROCESS | 3423 | Values: 1466.9 1584.4 1601.7 1790.8 1895.7 8582.6 8758.6 8760.7 8762.9 8767.6 8642.2 8799.0 8803.3 8814.0 8816.9 2461.2 2493.8 2497.4 2500.8 2502.0 2472.6 2559.5 2561.2 2564.8 2564.9 2465.5 2477.3 2525.0 2529.0 2531.1 2512.5 2537.0 2539.2 2544.7 2556.8 2452.4 2526.1 2549.8 2561.0 2565.3 8242.3 8505.0 8961.6 8980.9 8991.4 5309.4 5419.9 5424.4 5427.1 5427.4 3520.2 3556.4 3620.9 3671.2 3674.9 1133.4 1174.6 1188.1 1215.1 1221.8 12661.4 12733.3 12776.9 12809.2 12835.4 4804.0 4972.3 5013.3 5036.3 5075.8 10746.5 10808.1 10824.1 10834.4 10836.0 5582.8 5638.0 5638.9 5639.1 5655.1 4350.2 4484.0 4879.8 4943.8 5170.2 4266.7 4331.4 4370.1 4388.7 4524.7 1382.8 1429.1 1443.5 1444.2 1455.9 1042.5 1048.2 1054.6 1060.1 1067.3 5652.2 5832.8 5962.6 6120.1 6243.1 972.6 975.9 1040.6 1046.7 1060.2 4002.7 4063.8 4077.3 4143.9 4207.9 10846.5 11231.3 11282.0 11314.8 11315.3 11113.6 11115.9 11118.2 11133.5 11142.7 7822.2 8423.1 8529.8 8544.3 8638.7 5708.3 5733.7 5756.4 5825.1 5872.5 9446.1 9676.1 9702.0 9750.8 9806.1 9544.6 9795.8 9829.9 9878.0 10061.7 6861.9 7036.8 7038.8 7746.4 7868.8 8230.6 8410.5 8422.6 8479.0 8488.7 7487.1 7706.3 7714.5 7796.3 7869.2 7402.8 7534.5 7566.0 7585.1 7669.0 7141.0 7189.3 7202.6 7320.1 7360.9 5064.5 5236.7 5309.9 5351.0 5365.9 5072.6 5097.8 5098.1 5126.3 5184.9 14:25:53 INFO - PROCESS | 3423 | 14:25:53 INFO - PROCESS | 3423 | [#4] prototype.html Cycles:180 Average:5597.52 Median:6320.79 stddev:1694.03 (26.8%) stddev-sans-first:1652.58 14:25:53 INFO - PROCESS | 3423 | Values: 362.5 369.4 371.1 372.8 382.2 6253.9 6281.3 6285.5 6307.2 6313.9 6163.7 6207.5 6237.3 6238.7 6239.3 4577.2 4648.5 4801.6 4806.7 4827.5 4821.8 4823.0 4834.5 4843.5 4844.1 4777.2 4791.0 4798.0 4799.0 4802.7 4570.3 4649.7 4698.6 4741.9 4794.3 4233.2 4251.1 4252.7 4255.7 4269.8 6024.7 6026.2 6043.4 6046.8 6066.8 5608.6 5616.8 5620.8 5623.5 5625.6 6578.7 6612.9 6619.8 6630.4 6631.3 4496.8 4663.0 4675.3 4679.6 4736.5 6843.0 6904.7 6908.8 6921.9 6922.0 4755.4 4757.5 4761.2 4763.5 4766.8 4820.5 4821.4 4824.0 4828.7 4836.0 5542.5 5556.7 5562.4 5565.3 5567.7 6404.9 6626.2 6634.4 6659.2 6670.4 1669.5 1687.8 1696.8 1698.0 1703.1 1071.5 1078.6 1100.6 1106.6 1115.3 6224.0 6327.7 6384.6 6507.3 6513.1 6939.3 6940.5 6943.4 6945.6 6969.2 6455.6 6479.2 6490.4 6508.7 6515.5 3701.0 3739.9 3740.6 3743.7 3743.8 6969.8 7278.4 7284.6 7290.0 7311.1 7019.4 7039.6 7051.4 7053.9 7054.7 7246.3 7251.4 7259.5 7259.8 7259.9 6880.8 6920.5 6924.6 6926.9 6954.1 6622.5 6804.5 6824.2 6872.9 6877.2 7278.2 7308.0 7312.0 7314.1 7317.1 4735.8 4758.2 4759.8 4767.0 4768.7 6914.9 6916.5 6923.1 6925.3 6926.1 6449.7 6644.8 6687.0 6689.8 6709.2 6645.7 6670.5 6674.0 6674.2 6681.2 6574.5 6580.5 6586.6 6587.8 6591.0 6729.9 6731.3 6740.2 6742.4 6746.3 6448.0 6551.3 6555.1 6597.6 6607.9 14:25:53 INFO - PROCESS | 3423 | 14:25:53 INFO - PROCESS | 3423 | [#5] yui.html Cycles:180 Average:15345.73 Median:25977.36 stddev:18280.04 (70.4%) stddev-sans-first:18299.03 14:25:53 INFO - PROCESS | 3423 | Values: 876.5 915.5 918.6 931.6 941.7 14001.0 14825.3 15091.4 15120.0 15204.6 13876.8 14679.1 14729.8 14748.6 14786.0 746.9 891.9 897.9 906.9 915.0 901.9 903.1 903.2 903.3 903.5 950.9 951.1 951.7 952.4 952.8 783.3 792.2 915.4 932.9 948.4 679.2 679.4 679.9 682.5 682.8 15092.4 15160.1 15173.0 15187.5 15208.8 13746.8 13984.8 14028.0 14037.9 14143.2 11339.9 11420.9 11491.9 11581.0 11619.5 4045.3 4089.8 4115.7 4158.5 4192.3 55127.4 55437.0 55463.2 55846.7 56088.7 10457.2 10631.9 10713.6 10923.2 10961.5 20531.7 20642.8 20644.8 20674.0 21087.6 8487.7 8528.1 8634.4 8662.6 8728.1 4585.3 4595.1 4679.7 4778.3 4792.6 3563.2 3633.2 3636.3 3637.0 3638.2 560.9 600.7 607.9 628.0 633.2 725.7 729.9 735.9 739.9 753.4 8889.3 8889.4 9195.9 9252.7 9355.2 668.8 739.5 763.5 778.3 779.4 3942.2 4123.4 4279.1 4388.3 4394.0 66010.0 66219.3 66866.7 66929.3 66940.3 55693.0 58502.0 58516.0 58679.7 58784.4 50951.5 51516.7 51574.2 51944.5 52489.0 8563.0 8578.5 8634.1 8641.0 8968.0 39794.6 40105.8 40314.6 41210.8 41428.6 47275.0 47786.8 51445.0 51817.7 51884.7 10393.6 10610.8 10667.0 10711.3 10780.1 12094.2 12384.0 12436.3 12454.1 12467.2 11645.2 11646.5 11653.3 11658.0 11665.1 11290.9 11421.5 11445.6 11448.2 11476.9 10066.7 11331.4 11459.3 11623.9 11784.3 9632.2 9845.9 10215.2 10450.5 10623.5 10424.6 10477.0 10666.7 10670.9 10706.4 14:25:53 INFO - PROCESS | 3423 | -------- Summary: end -------- 14:25:53 INFO - PROCESS | 3423 | 14:25:54 INFO - TEST-INFO | 3423: exit 0 14:25:54 INFO - TEST-OK | dromaeo_css | took 1113238ms 14:25:54 INFO - TEST-START | kraken 14:25:54 INFO - operating with platform_type : linux_ 14:25:54 INFO - Initialising browser for kraken test... 14:25:54 INFO - TEST-INFO | started process 3617 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSW7Ya2/profile http://localhost:56286/getInfo.html) 14:25:58 INFO - PROCESS | 3617 | __metrics Screen width/height:1600/1200 14:25:58 INFO - PROCESS | 3617 | colorDepth:24 14:25:58 INFO - PROCESS | 3617 | Browser inner width/height: 1024/697 14:25:58 INFO - PROCESS | 3617 | __metrics 14:25:59 ERROR - PROCESS | 3617 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:26:00 INFO - TEST-INFO | 3617: exit 0 14:26:00 INFO - Browser initialized. 14:26:00 INFO - Running cycle 1/1 for kraken test... 14:26:00 INFO - TEST-INFO | started process 3705 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSW7Ya2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:26:12 INFO - PROCESS | 3705 | RSS: Main: 139923456 14:26:12 INFO - PROCESS | 3705 | 14:26:14 INFO - PROCESS | 3705 | Cycle 1(1): loaded http://localhost:56286/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56286/tests/kraken/driver.html?testName=audio-beat-detection) 14:26:15 INFO - PROCESS | 3705 | RSS: Main: 197750784 14:26:15 INFO - PROCESS | 3705 | 14:26:18 INFO - PROCESS | 3705 | Cycle 1(1): loaded http://localhost:56286/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56286/tests/kraken/driver.html?testName=audio-dft) 14:26:18 INFO - PROCESS | 3705 | RSS: Main: 185016320 14:26:18 INFO - PROCESS | 3705 | 14:26:21 INFO - PROCESS | 3705 | Cycle 1(1): loaded http://localhost:56286/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56286/tests/kraken/driver.html?testName=audio-fft) 14:26:22 INFO - PROCESS | 3705 | RSS: Main: 274497536 14:26:22 INFO - PROCESS | 3705 | 14:26:24 INFO - PROCESS | 3705 | Cycle 1(1): loaded http://localhost:56286/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56286/tests/kraken/driver.html?testName=audio-oscillator) 14:26:24 INFO - PROCESS | 3705 | RSS: Main: 180940800 14:26:24 INFO - PROCESS | 3705 | 14:26:27 INFO - PROCESS | 3705 | Cycle 1(1): loaded http://localhost:56286/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56286/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:26:27 INFO - PROCESS | 3705 | RSS: Main: 179310592 14:26:27 INFO - PROCESS | 3705 | 14:26:30 INFO - PROCESS | 3705 | Cycle 1(1): loaded http://localhost:56286/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56286/tests/kraken/driver.html?testName=imaging-darkroom) 14:26:31 INFO - PROCESS | 3705 | RSS: Main: 214085632 14:26:31 INFO - PROCESS | 3705 | 14:26:34 INFO - PROCESS | 3705 | Cycle 1(1): loaded http://localhost:56286/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56286/tests/kraken/driver.html?testName=imaging-desaturate) 14:26:35 INFO - PROCESS | 3705 | RSS: Main: 213327872 14:26:35 INFO - PROCESS | 3705 | 14:26:37 INFO - PROCESS | 3705 | Cycle 1(1): loaded http://localhost:56286/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56286/tests/kraken/driver.html?testName=json-parse-financial) 14:26:38 INFO - PROCESS | 3705 | RSS: Main: 213794816 14:26:38 INFO - PROCESS | 3705 | 14:26:40 INFO - PROCESS | 3705 | Cycle 1(1): loaded http://localhost:56286/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56286/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:26:40 INFO - PROCESS | 3705 | RSS: Main: 194125824 14:26:40 INFO - PROCESS | 3705 | 14:26:42 INFO - PROCESS | 3705 | Cycle 1(1): loaded http://localhost:56286/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56286/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:26:42 INFO - PROCESS | 3705 | RSS: Main: 197308416 14:26:42 INFO - PROCESS | 3705 | 14:26:45 INFO - PROCESS | 3705 | Cycle 1(1): loaded http://localhost:56286/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56286/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:26:45 INFO - PROCESS | 3705 | RSS: Main: 209428480 14:26:45 INFO - PROCESS | 3705 | 14:26:48 INFO - PROCESS | 3705 | Cycle 1(1): loaded http://localhost:56286/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56286/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:26:49 INFO - PROCESS | 3705 | RSS: Main: 218157056 14:26:49 INFO - PROCESS | 3705 | 14:26:52 INFO - PROCESS | 3705 | Cycle 1(1): loaded http://localhost:56286/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56286/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:26:52 INFO - PROCESS | 3705 | RSS: Main: 214327296 14:26:52 INFO - PROCESS | 3705 | 14:26:54 INFO - PROCESS | 3705 | Cycle 1(1): loaded http://localhost:56286/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56286/tests/kraken/driver.html?testName=ai-astar) 14:26:54 INFO - PROCESS | 3705 | RSS: Main: 274046976 14:26:54 INFO - PROCESS | 3705 | 14:26:54 INFO - PROCESS | 3705 | __start_tp_report 14:26:54 INFO - PROCESS | 3705 | _x_x_mozilla_page_load 14:26:54 INFO - PROCESS | 3705 | _x_x_mozilla_page_load_details 14:26:54 INFO - PROCESS | 3705 | |i|pagename|runs| 14:26:54 INFO - PROCESS | 3705 | |0;ai-astar;109;110;110;109;110;111;105;109;109;108 14:26:54 INFO - PROCESS | 3705 | |1;audio-beat-detection;152;125;154;180;125;162;147;125;184;126 14:26:54 INFO - PROCESS | 3705 | |2;audio-dft;160;160;160;162;160;164;159;160;162;159 14:26:54 INFO - PROCESS | 3705 | |3;audio-fft;74;76;75;172;76;76;77;75;171;76 14:26:54 INFO - PROCESS | 3705 | |4;audio-oscillator;91;93;163;91;92;93;149;92;91;156 14:26:54 INFO - PROCESS | 3705 | |5;imaging-gaussian-blur;117;117;117;116;117;117;116;117;117;116 14:26:54 INFO - PROCESS | 3705 | |6;imaging-darkroom;145;145;145;146;146;146;145;146;153;145 14:26:54 INFO - PROCESS | 3705 | |7;imaging-desaturate;94;95;94;95;95;94;95;94;95;94 14:26:54 INFO - PROCESS | 3705 | |8;json-parse-financial;55;53;55;55;53;56;56;73;53;58 14:26:54 INFO - PROCESS | 3705 | |9;json-stringify-tinderbox;58;58;60;57;58;58;58;58;59;59 14:26:54 INFO - PROCESS | 3705 | |10;stanford-crypto-aes;74;72;71;72;73;73;75;73;73;72 14:26:54 INFO - PROCESS | 3705 | |11;stanford-crypto-ccm;112;112;112;111;109;108;116;110;134;113 14:26:54 INFO - PROCESS | 3705 | |12;stanford-crypto-pbkdf2;163;166;160;160;164;166;156;159;160;160 14:26:54 INFO - PROCESS | 3705 | |13;stanford-crypto-sha256-iterative;68;67;68;66;66;68;67;66;73;67 14:26:54 INFO - PROCESS | 3705 | __end_tp_report 14:26:54 INFO - PROCESS | 3705 | __start_cc_report 14:26:54 INFO - PROCESS | 3705 | _x_x_mozilla_cycle_collect,1607 14:26:54 INFO - PROCESS | 3705 | __end_cc_report 14:26:54 INFO - PROCESS | 3705 | __startTimestamp1467062814683__endTimestamp 14:26:54 INFO - PROCESS | 3705 | 14:26:54 INFO - PROCESS | 3705 | ------- Summary: start ------- 14:26:54 INFO - PROCESS | 3705 | Number of tests: 14 14:26:54 INFO - PROCESS | 3705 | 14:26:54 INFO - PROCESS | 3705 | [#0] ai-astar Cycles:10 Average:109.00 Median:109.50 stddev:1.63 (1.5%) stddev-sans-first:1.73 14:26:54 INFO - PROCESS | 3705 | Values: 109.0 110.0 110.0 109.0 110.0 111.0 105.0 109.0 109.0 108.0 14:26:54 INFO - PROCESS | 3705 | 14:26:54 INFO - PROCESS | 3705 | [#1] audio-beat-detection Cycles:10 Average:148.00 Median:153.00 stddev:22.71 (14.8%) stddev-sans-first:24.04 14:26:54 INFO - PROCESS | 3705 | Values: 152.0 125.0 154.0 180.0 125.0 162.0 147.0 125.0 184.0 126.0 14:26:54 INFO - PROCESS | 3705 | 14:26:54 INFO - PROCESS | 3705 | [#2] audio-dft Cycles:10 Average:160.60 Median:160.00 stddev:1.58 (1.0%) stddev-sans-first:1.66 14:26:54 INFO - PROCESS | 3705 | Values: 160.0 160.0 160.0 162.0 160.0 164.0 159.0 160.0 162.0 159.0 14:26:54 INFO - PROCESS | 3705 | 14:26:54 INFO - PROCESS | 3705 | [#3] audio-fft Cycles:10 Average:94.80 Median:76.00 stddev:40.43 (53.2%) stddev-sans-first:42.18 14:26:54 INFO - PROCESS | 3705 | Values: 74.0 76.0 75.0 172.0 76.0 76.0 77.0 75.0 171.0 76.0 14:26:54 INFO - PROCESS | 3705 | 14:26:54 INFO - PROCESS | 3705 | [#4] audio-oscillator Cycles:10 Average:111.10 Median:91.50 stddev:31.17 (34.1%) stddev-sans-first:32.20 14:26:54 INFO - PROCESS | 3705 | Values: 91.0 93.0 163.0 91.0 92.0 93.0 149.0 92.0 91.0 156.0 14:26:54 INFO - PROCESS | 3705 | 14:26:54 INFO - PROCESS | 3705 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 14:26:54 INFO - PROCESS | 3705 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 116.0 14:26:54 INFO - PROCESS | 3705 | 14:26:54 INFO - PROCESS | 3705 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:2.44 (1.7%) stddev-sans-first:2.55 14:26:54 INFO - PROCESS | 3705 | Values: 145.0 145.0 145.0 146.0 146.0 146.0 145.0 146.0 153.0 145.0 14:26:54 INFO - PROCESS | 3705 | 14:26:54 INFO - PROCESS | 3705 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 14:26:54 INFO - PROCESS | 3705 | Values: 94.0 95.0 94.0 95.0 95.0 94.0 95.0 94.0 95.0 94.0 14:26:54 INFO - PROCESS | 3705 | 14:26:54 INFO - PROCESS | 3705 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:55.50 stddev:5.95 (10.7%) stddev-sans-first:6.27 14:26:54 INFO - PROCESS | 3705 | Values: 55.0 53.0 55.0 55.0 53.0 56.0 56.0 73.0 53.0 58.0 14:26:54 INFO - PROCESS | 3705 | 14:26:54 INFO - PROCESS | 3705 | [#9] json-stringify-tinderbox Cycles:10 Average:58.30 Median:58.00 stddev:0.82 (1.4%) stddev-sans-first:0.87 14:26:54 INFO - PROCESS | 3705 | Values: 58.0 58.0 60.0 57.0 58.0 58.0 58.0 58.0 59.0 59.0 14:26:54 INFO - PROCESS | 3705 | 14:26:54 INFO - PROCESS | 3705 | [#10] stanford-crypto-aes Cycles:10 Average:72.80 Median:73.00 stddev:1.14 (1.6%) stddev-sans-first:1.12 14:26:54 INFO - PROCESS | 3705 | Values: 74.0 72.0 71.0 72.0 73.0 73.0 75.0 73.0 73.0 72.0 14:26:54 INFO - PROCESS | 3705 | 14:26:54 INFO - PROCESS | 3705 | [#11] stanford-crypto-ccm Cycles:10 Average:113.70 Median:112.00 stddev:7.47 (6.7%) stddev-sans-first:7.90 14:26:54 INFO - PROCESS | 3705 | Values: 112.0 112.0 112.0 111.0 109.0 108.0 116.0 110.0 134.0 113.0 14:26:54 INFO - PROCESS | 3705 | 14:26:54 INFO - PROCESS | 3705 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.40 Median:161.50 stddev:3.24 (2.0%) stddev-sans-first:3.38 14:26:54 INFO - PROCESS | 3705 | Values: 163.0 166.0 160.0 160.0 164.0 166.0 156.0 159.0 160.0 160.0 14:26:54 INFO - PROCESS | 3705 | 14:26:54 INFO - PROCESS | 3705 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.50 stddev:2.07 (3.1%) stddev-sans-first:2.19 14:26:54 INFO - PROCESS | 3705 | Values: 68.0 67.0 68.0 66.0 66.0 68.0 67.0 66.0 73.0 67.0 14:26:54 INFO - PROCESS | 3705 | -------- Summary: end -------- 14:26:54 INFO - PROCESS | 3705 | 14:26:55 INFO - TEST-INFO | 3705: exit 0 14:26:55 INFO - TEST-OK | kraken | took 61183ms 14:26:55 INFO - SUITE-END | took 1174s 14:26:55 INFO - Completed test suite (00:19:34) 14:26:55 INFO - javascript benchmark 14:26:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3279.3277378137486, 3316.7014968652816, 3322.053214833772, 3346.33073385323, 3356.16095976006, 5480.0, 5493.313335833021, 5527.364353099395, 5538.086215774398, 5553.527950124234, 5509.393966663663, 5519.420460851613, 5532.1425179097205, 5538.695371754552, 5565.0817615093465, 4906.0, 4918.508149185071, 4990.176620857564, 5008.649394542384, 5048.7728052237735, 4906.435759887605, 4997.625178111638, 5002.12462819007, 5003.099442100421, 5003.14946459101, 4933.555979961803, 4990.27640992056, 5012.924806127911, 5025.3969523657215, 5049.3940727112795, 4985.52637499437, 5014.498550144975, 5015.122353588107, 5017.523335283142, 5042.117629414856, 4842.515748425165, 4871.658983871131, 4928.33467481889, 4941.555260026615, 4988.02733466974, 5370.382406023318, 5372.677639341613, 5432.266644003049, 5432.483914028161, 5439.0, 5822.301323841124, 5830.3586605473365, 5833.2416785817995, 5839.065749480105, 5844.064949608085, 5781.421857814227, 5832.650040997553, 5889.322727886305, 5890.558208134407, 5917.171595976567, 5436.075867102602, 5468.152436372368, 5474.069408200616, 5478.945210547923, 5488.286522752017, 5878.353381128072, 5978.641281523122, 5984.222051133412, 5985.880282394328, 5987.042073268256, 5727.455891690282, 5766.971165144231, 5795.507381872588, 5806.30324361071, 5815.73829177688, 5764.510016648548, 5807.361190269067, 5808.883822323614, 5811.738471768781, 5812.912806307909, 5693.975084484832, 5749.3963133871175, 5765.365809760923, 5768.855778605484, 5769.423057694197, 5821.592488525763, 5838.795642152504, 5841.240638716939, 5851.882962340729, 5879.353271140171, 4486.887827804331, 4487.842925497592, 4488.483824360175, 4507.954920450819, 4508.571685689854, 3971.900702482461, 3990.3016972029777, 4044.4539987101366, 4053.594640535982, 4068.532118806316, 5557.055300598908, 5573.832785016456, 5576.302962129734, 5580.051391263495, 5600.383957764642, 5876.559258055578, 5883.441073098049, 5886.293644762656, 5890.970545147333, 5905.911411328833, 5451.073317536028, 5556.444355564492, 5556.638818476786, 5567.582431317667, 5627.915581266284, 5045.621578381636, 5050.141475949097, 5061.746912654353, 5065.189569668835, 5085.2372144177925, 6088.330283668793, 6097.298810636745, 6100.054491553817, 6100.450959413674, 6103.633781973096, 5784.0, 5848.941510584839, 5855.38518455556, 5881.794137205177, 5977.043673012297, 6110.7555697771595, 6143.235544005305, 6175.505959523138, 6178.7219575120125, 6200.875982480416, 5799.536037117105, 5803.47768700819, 5804.854878628068, 5811.593188476935, 5819.447152520504, 5741.081426971665, 5883.146943693055, 5910.7931222407005, 5966.134910438049, 5978.671173085522, 5681.977244096102, 5725.6850873202375, 5726.914096288642, 5748.597598168088, 5752.71236438168, 5688.232088667977, 5721.485066344049, 5742.913856292075, 5747.137929310469, 5747.74135163927, 5587.525060369914, 5666.943330566642, 5736.541076713769, 5752.022156233366, 5781.277340332458, 5709.34342550612, 5721.313442386941, 5725.742341594555, 5731.828045158652, 5734.569907256889, 5544.667319960815, 5573.247611572386, 5606.943930560642, 5615.634983726045, 5645.830625081254], "value": 5412.893340632498, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.6002778138646, 651.1372431528225, 664.5414663881924, 668.8762578922903, 671.4930227678102, 32091.19772005698, 32524.0, 32571.348573028525, 32575.67424325759, 39078.0, 42355.0, 42629.0, 42876.78561607187, 42878.35682464766, 43023.784881075626, 8856.291496680282, 9041.593128309209, 9045.773855653595, 9046.185843274105, 9048.0, 8091.0, 8844.911550884506, 10770.838437423445, 11011.889881101166, 11024.228304018721, 10649.627263045795, 10751.0, 10759.731006724855, 10768.676939691823, 10770.29993050453, 10582.629607963723, 10663.893361066444, 10664.306820056672, 10666.839997400046, 10669.893301066968, 10490.685279441628, 10573.73565660857, 10600.575976960912, 10603.363798172135, 10605.628802991858, 38629.22741545153, 42615.786921065504, 42672.0, 42695.78652106751, 42757.358639620434, 3816.8777720062267, 3835.1562656215588, 3850.942235866464, 3870.665323586032, 3988.282109220339, 33193.502097468554, 33250.833745831114, 33779.0, 33851.322973540635, 33876.49185262223, 4394.36281739146, 4566.977165114186, 4606.56237657422, 4608.5621865922685, 4615.630749540029, 313637.0, 314039.99999999773, 315283.0, 315520.0, 315646.0, 64597.67701161464, 64983.0, 65236.34763652303, 65252.0, 65274.673626631564, 68502.65748671225, 68900.65549672219, 69330.65334673294, 69961.65019174872, 69987.3001269991, 16431.753523697153, 16523.586910327096, 16627.418040368528, 16638.50084497467, 16641.833581664272, 11004.284721493077, 12088.214266072677, 12165.452554635063, 12174.452149653287, 12176.81734773979, 20436.79563204349, 21121.78878211229, 21254.25610103639, 21295.0, 21333.0, 7426.14599321085, 7440.590767507731, 7491.513051651626, 7503.62481875904, 7629.8855517167285, 1044.4568824211367, 1058.2645061682058, 1098.5228310160537, 1101.7906597746403, 1160.489384670742, 29157.125286241448, 29463.0, 29886.701132988394, 29987.550186747216, 30457.847710761747, 1114.5876025870318, 1115.8828323026128, 1158.0330424095973, 1193.367515216919, 1227.2391117507202, 15525.611859703371, 15812.92093539548, 15869.603259918595, 15884.285207165705, 16019.43931962399, 462263.0, 468901.0, 469699.0, 470351.0, 471373.0, 62767.686161569814, 63271.36728632747, 63408.0, 63440.36559634437, 63440.68279658572, 1424.4587056918306, 1458.824941007086, 1488.8660020597981, 1519.4454024281058, 1580.3678528588657, 27550.44899102047, 29495.0, 29560.704392956657, 29951.0, 30461.23846903845, 50408.0, 50862.23706644329, 50890.23664645107, 50924.745376272884, 51057.74471127621, 284009.0, 288704.0, 289662.55168724863, 289841.0, 290123.0, 27125.72874271232, 27593.86203069052, 30650.846745766128, 30661.386772263984, 31062.22344441407, 44202.0, 49298.75350623224, 49420.258696118864, 50107.49892501028, 50337.0, 39282.80358598303, 41003.58996409998, 41471.7926410366, 42088.57911420846, 42785.0, 40201.798991004856, 40247.0, 40726.18547628971, 40825.1834963305, 41582.376264356666, 34010.489842651885, 34415.82792086023, 37994.0, 38274.425883612326, 38611.806940965114, 34795.65204347924, 37089.44365834461, 37393.6260637401, 37930.43104353492, 38021.0, 28091.0, 28213.0, 28223.0, 28463.43073138567, 28612.0], "value": 20308.571594996258, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [428.60365441010595, 429.7163871844582, 437.8861496011036, 443.1933880337785, 452.2176634422451, 18495.44513664589, 18599.814001859995, 19248.23007079715, 20667.586648267024, 20671.896640516778, 19160.712589311137, 19187.808121918777, 19384.806151938476, 19444.513887152792, 19445.319413820518, 5673.829785106433, 5732.0828667413225, 5943.3462319144855, 5963.105534169866, 5966.701664916758, 4195.979020104895, 5877.529797616202, 5955.910661340084, 6183.505319574423, 6544.836379090513, 6516.283208847047, 6535.771248006321, 6536.248331441898, 6537.869242615145, 6542.1495205623205, 6404.327545607714, 6407.871842563146, 6489.929161688316, 6555.0822884795925, 6561.704723287464, 3898.6101389860787, 4033.052232725307, 5646.802361917313, 5880.0, 5888.911666325009, 24048.278551643478, 24160.516789664107, 24320.756792432025, 24538.509229815303, 24583.508329833305, 2463.5935070713313, 2495.4759500504915, 2778.944001279521, 2825.872835722397, 2880.251134704971, 14752.55742327732, 15270.847291527054, 15273.083614983136, 15578.298976546082, 15674.843251567452, 1997.3808119482862, 2033.1155947163031, 2033.2680235115347, 2069.2550681754556, 2111.883846388448, 78412.60793696051, 80935.5953220236, 81804.0, 82053.0, 83658.16341836625, 11158.274712143848, 11283.887161128283, 11553.884461155449, 11610.477528511237, 11856.347900865536, 16386.75419868703, 16413.67172656564, 16419.0, 16434.0, 16436.096014719067, 8416.0, 8483.618237179342, 8507.404481686346, 8543.188397102265, 8604.182602652738, 8134.145914678874, 8259.917400826034, 8335.749927502186, 8397.370197235232, 8422.578871056423, 7034.452420467489, 7035.296470353026, 7221.602811845399, 7242.529235599669, 7272.927270727225, 1812.5073839247016, 1968.586596814685, 1982.8116328948727, 2033.5322875738664, 2086.2698055680694, 1014.1683819268277, 1083.9458027098613, 1138.9886101139048, 1145.169751929861, 1169.4678921090883, 19093.904530477535, 19411.223551058083, 19727.4081777544, 19922.161262849357, 20070.698939515918, 1049.7008352619466, 1089.9237053406343, 1100.7743412600398, 1182.4678894497338, 1206.6681662542696, 11310.547578096948, 11559.942200289113, 11594.536218551164, 11596.710082247842, 11606.477708503138, 495835.0832983392, 499773.0, 521899.0, 523641.0, 524270.0, 79056.0, 84718.0, 84885.0, 85397.57301213454, 86775.1322486767, 1069.2034434346463, 1086.7337502311984, 1089.5097206257217, 1090.465671820802, 1119.9552017919193, 16874.240659170613, 17379.391721289696, 17534.73697894507, 17643.20605572778, 17696.29214831392, 37570.8121459391, 38226.61773382342, 38713.2257354857, 38742.0, 39775.403368950065, 52837.735811320694, 54088.45911540992, 54384.45615543794, 54389.456105440026, 54537.454625454826, 9316.813663726824, 9473.47895865734, 9483.810323793623, 9513.429194248367, 9549.188318992963, 14032.158070515801, 14157.716845662822, 14265.786013209603, 14389.496367627084, 14489.78265326, 12421.130520863453, 12434.0, 12611.117221794753, 12641.494340226656, 12669.303188324731, 12261.448234829633, 12331.568395106127, 12351.258924464202, 12461.813072803734, 12525.123241373016, 11762.294262344287, 12228.633141005785, 12359.073069520002, 12504.312262825631, 12527.624171274876, 9001.54992250398, 9093.863267091614, 9113.350651414845, 9290.95354523223, 9490.478023708762, 12455.190412623151, 12697.746045078862, 12806.48774049065, 12859.935700321439, 12916.677083072998], "value": 9838.720395436987, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1466.882649388049, 1584.4137669062445, 1601.7196990526659, 1790.8030116687162, 1895.6777347850855, 8582.570871456433, 8758.605862736169, 8760.737177884657, 8762.912370876289, 8767.6054577544, 8642.17899299567, 8798.98811636662, 8803.295736341093, 8814.030456649763, 8816.911830881689, 2461.150902938488, 2493.775560199582, 2497.438076432797, 2500.7999360051244, 2502.011705376375, 2472.5673007223754, 2559.4881023795224, 2561.2316305108393, 2564.756348146923, 2564.8845801938955, 2465.469923966347, 2477.256822953107, 2525.027864272259, 2528.9873550632315, 2531.0761572026263, 2512.484940587184, 2537.0, 2539.200151952129, 2544.6946366436146, 2556.833805802617, 2452.3869032741813, 2526.1284856724583, 2549.847009179455, 2560.974390256111, 2565.294544000415, 8242.29940455062, 8504.957475212646, 8961.596728147184, 8980.865287020635, 8991.370604057718, 5309.389420216686, 5419.864503387407, 5424.430434804368, 5427.050266203399, 5427.402985671573, 3520.1551627609447, 3556.3598552260582, 3620.873269435557, 3671.192337685705, 3674.889753307405, 1133.4332833583208, 1174.5830230268302, 1188.0673671168092, 1215.1493954232074, 1221.7861874172074, 12661.430235639418, 12733.299668518228, 12776.936115319457, 12809.167404118702, 12835.422405991752, 4804.0, 4972.303877457159, 5013.348264725635, 5036.32009678696, 5075.771590278447, 10746.516406761715, 10808.135349172047, 10824.13406927444, 10834.404107773991, 10836.0, 5582.8325150245555, 5638.04153293941, 5638.915416268759, 5639.069553523623, 5655.066913959233, 4350.216960946997, 4484.035932274512, 4879.756012199447, 4943.752812359367, 5170.1727723564045, 4266.658667306608, 4331.415258940003, 4370.104128653618, 4388.714733542373, 4524.6832721709825, 1382.8064071030064, 1429.0711037825497, 1443.527601846111, 1444.2201211345966, 1455.9490417835325, 1042.5464922758624, 1048.2138396202847, 1054.6466933577185, 1060.1095080132725, 1067.3489171605315, 5652.18043383707, 5832.825015249549, 5962.612430192024, 6120.12737018326, 6243.094751261133, 972.557486343712, 975.9268054895912, 1040.557762950743, 1046.6964580271788, 1060.188955449082, 4002.679785617144, 4063.7561746294728, 4077.26609210345, 4143.875683729493, 4207.873763787091, 10846.45767711627, 11231.326120432801, 11282.041026512674, 11314.830277545843, 11315.321080735182, 11113.611023614134, 11115.944420278009, 11118.166137539716, 11133.498992545356, 11142.665720028412, 7822.1786712395515, 8423.115572864883, 8529.786755331166, 8544.31645468361, 8638.697645582375, 5708.286464191976, 5733.655980641175, 5756.395578464201, 5825.097109947965, 5872.471477567039, 9446.102620251066, 9676.080772326617, 9702.0, 9750.75623109428, 9806.06842350004, 9544.618215271588, 9795.804083918425, 9829.901700982899, 9877.950610246902, 10061.748456288651, 6861.897071544031, 7036.824079398056, 7038.788836334918, 7746.380289576708, 7868.763937081897, 8230.62962166716, 8410.453320534145, 8422.578871056545, 8478.957605211934, 8488.702895398632, 7487.138979017483, 7706.3449606781805, 7714.537127772352, 7796.259355361231, 7869.213078692085, 7402.814929626802, 7534.510256833289, 7566.0, 7585.127710313164, 7669.0, 7141.0, 7189.2810718927685, 7202.567845929261, 7320.084989376328, 7360.889586656097, 5064.493550645054, 5236.711980840938, 5309.946900530946, 5351.010063138332, 5365.865853353697, 5072.619553533426, 5097.8215762448135, 5098.056859481007, 5126.256692779601, 5184.896302074013], "value": 4794.474253434512, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.52509212931045, 369.4126339120798, 371.1426604543503, 372.8378155502357, 382.2183634467512, 6253.937460625392, 6281.277653069898, 6285.497160227183, 6307.180066591342, 6313.873722525553, 6163.691815409223, 6207.4723648489935, 6237.3450787667325, 6238.688065596724, 6239.251289845213, 4577.176108300521, 4648.535146485341, 4801.591864691488, 4806.663533552653, 4827.468978412372, 4821.758912054401, 4822.951770482286, 4834.516548345155, 4843.467218605951, 4844.055409195191, 4777.187878060738, 4791.0, 4798.040391921612, 4799.0, 4802.687825291362, 4570.33730109134, 4649.651276154302, 4698.647601429906, 4741.905161896742, 4794.304825800257, 4233.216854881856, 4251.06476575153, 4252.659787217015, 4255.723377980421, 4269.765162916038, 6024.668643224665, 6026.186464827236, 6043.365446628129, 6046.758129674808, 6066.817995460143, 5608.6073974821775, 5616.775328986836, 5620.803271885465, 5623.493885550321, 5625.634333768292, 6578.703958321839, 6612.86774264512, 6619.801405957829, 6630.436412904909, 6631.33686631333, 4496.820127194908, 4663.044075964453, 4675.251959686434, 4679.60223381013, 4736.502667219961, 6843.0, 6904.654767261617, 6908.792736217922, 6921.861562768767, 6922.0, 4755.358026666356, 4757.500462451462, 4761.238201887751, 4763.54746299101, 4766.809327626926, 4820.493848145964, 4821.445533763592, 4824.0, 4828.686135401188, 4835.975820120877, 5542.501174894279, 5556.722163891789, 5562.3881373048935, 5565.30433695788, 5567.749451274703, 6404.903926441107, 6626.171728533934, 6634.402903738686, 6659.167604049494, 6670.433013193933, 1669.540876259014, 1687.8143404225525, 1696.8218337074677, 1697.9575510612333, 1703.1143805221216, 1071.5392381276126, 1078.6063086973197, 1100.6477927063263, 1106.5573770491867, 1115.2806439846254, 6223.96888015557, 6327.715252813635, 6384.6169229846355, 6507.284198738135, 6513.12072870166, 6939.340762627542, 6940.548864323803, 6943.409810166091, 6945.583265004116, 6969.1985421676145, 6455.644939528371, 6479.157709497735, 6490.415862572391, 6508.707108180143, 6515.54391192612, 3700.9629903701157, 3739.9065023374087, 3740.5698344690163, 3743.6630703236838, 3743.756655817363, 6969.825754356181, 7278.417726581861, 7284.599347035858, 7289.963550182215, 7311.122665280201, 7019.403350715246, 7039.648017599099, 7051.400630946427, 7053.89419158713, 7054.717811287491, 7246.275372462817, 7251.41988640918, 7259.4918355715645, 7259.818504537428, 7259.891101633374, 6880.827979300558, 6920.515563910478, 6924.58452492852, 6926.896096558657, 6954.061201737903, 6622.536422450382, 6804.4896632753735, 6824.249332573314, 6872.862542749017, 6877.243503214542, 7278.199398066315, 7308.049953506223, 7311.963440182765, 7314.08573928259, 7317.12194536659, 4735.763211839463, 4758.2386818108935, 4759.7858096386435, 4767.046590681947, 4768.66619336657, 6914.896276555956, 6916.51584389108, 6923.099997000358, 6925.27284635106, 6926.0649812276715, 6449.677516124269, 6644.833879152867, 6686.966565167143, 6689.832754181184, 6709.161354830646, 6645.700943457653, 6670.533062685566, 6674.032265321404, 6674.199096108304, 6681.198256209092, 6574.506911981716, 6580.539362244597, 6586.637734924625, 6587.80236592903, 6591.044298576776, 6729.932700672931, 6731.293214212633, 6740.191177058784, 6742.359475849787, 6746.291639377795, 6448.0, 6551.344865513411, 6555.082288479522, 6597.60414375139, 6607.867842643216], "value": 5049.422835533094, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [876.522295349035, 915.4507295622627, 918.5590916360147, 931.5575101826632, 941.6892425499586, 14001.0, 14825.258737063145, 15091.39634414625, 15120.0, 15204.619884502892, 13876.791848122286, 14679.119252844837, 14729.779053314209, 14748.557543273691, 14785.964982451233, 746.9178390377054, 891.9331050171263, 897.9326550508705, 906.9002409734924, 915.0026471146449, 901.9413738107002, 903.1104362203224, 903.2322525853039, 903.2773780975226, 903.5346796399859, 950.9286803489731, 951.096458364553, 951.6621599332241, 952.4190243951184, 952.7808604021079, 783.2872086401376, 792.1603100713262, 915.3683958068912, 932.9486878221695, 948.4451595816421, 679.2256827216977, 679.3715812873072, 679.8878185099453, 682.5222344358968, 682.8429461223947, 15092.39630414782, 15160.090394576251, 15173.0, 15187.544373668698, 15208.847911520854, 13746.793798093036, 13984.790228146587, 14028.0, 14037.859621403757, 14143.151410915378, 11339.886601134049, 11420.885791142066, 11491.942540287246, 11581.0, 11619.535218591247, 4045.292073887058, 4089.815958281855, 4115.650169735576, 4158.521769996459, 4192.28731115708, 55127.44872551263, 55437.0, 55463.16805247884, 55846.72076639631, 56088.719556402364, 10457.163426925828, 10631.94684026575, 10713.625023124154, 10923.180761442924, 10961.506732197071, 20531.692024619642, 20642.793572064085, 20644.793552064286, 20674.0, 21087.578248434944, 8487.745367638981, 8528.147185281423, 8634.352423568258, 8662.566871656518, 8728.127187281349, 4585.312203169551, 4595.109937036953, 4679.719216847, 4778.259369797687, 4792.592629626451, 3563.1804684922095, 3633.218857945554, 3636.3272794533095, 3637.0361854108683, 3638.2177831765766, 560.9130584759369, 600.6636283681065, 607.9209702738616, 628.0422355907186, 633.2211380002531, 725.6661935509619, 729.8686236477484, 735.8638651849425, 739.903812504371, 753.3859904178078, 8889.288856891433, 8889.377743558018, 9195.908040919505, 9252.722418327461, 9355.158035776676, 668.7893313606296, 739.5270788680415, 763.522798251093, 778.3461892010738, 779.3531368963746, 3942.1918506706056, 4123.443335149776, 4279.144171165717, 4388.29787234041, 4393.956060439355, 66010.0, 66219.33780662228, 66866.66566667135, 66929.33070669329, 66940.33059669439, 55693.0, 58502.0, 58516.0, 58679.70660146672, 58784.41215587789, 50951.49048509468, 51516.74241628768, 51574.226386604234, 51944.48055519472, 52489.0, 8563.0, 8578.528180950108, 8634.05025447213, 8641.0, 8967.955160224157, 39794.60205397909, 40105.79947100246, 40314.596854031086, 41210.79394603008, 41428.58571414247, 47275.0, 47786.76106619445, 51445.0, 51817.7409112952, 51884.74057629688, 10393.636222732168, 10610.840837387292, 10667.0, 10711.303765255234, 10780.137588993019, 12094.213876098378, 12384.0, 12436.253824770543, 12454.128211025503, 12467.189632673848, 11645.184837061324, 11646.534138634359, 11653.30080195191, 11658.0, 11665.066794656577, 11290.887091128983, 11421.543138274708, 11445.599404021152, 11448.198626096093, 11476.942615287204, 10066.748331291776, 11331.433428328386, 11459.31244125355, 11623.941880290544, 11784.292942423483, 9632.22942164611, 9845.901540984498, 10215.182785377003, 10450.529726162493, 10623.468826558486, 10424.583016679248, 10477.0, 10666.73333166677, 10670.946645266724, 10706.357618542912], "value": 6896.039246885929, "unit": "score"}], "name": "dromaeo_css", "value": 7518.15786220335, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 110.0, 109.0, 110.0, 111.0, 105.0, 109.0, 109.0, 108.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 125.0, 154.0, 180.0, 125.0, 162.0, 147.0, 125.0, 184.0, 126.0], "value": 148.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 162.0, 160.0, 164.0, 159.0, 160.0, 162.0, 159.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 172.0, 76.0, 76.0, 77.0, 75.0, 171.0, 76.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 93.0, 163.0, 91.0, 92.0, 93.0, 149.0, 92.0, 91.0, 156.0], "value": 111.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 153.0, 145.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 55.0, 55.0, 53.0, 56.0, 56.0, 73.0, 53.0, 58.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 60.0, 57.0, 58.0, 58.0, 58.0, 58.0, 59.0, 59.0], "value": 58.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 71.0, 72.0, 73.0, 73.0, 75.0, 73.0, 73.0, 72.0], "value": 72.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 112.0, 111.0, 109.0, 108.0, 116.0, 110.0, 134.0, 113.0], "value": 113.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 160.0, 160.0, 164.0, 166.0, 156.0, 159.0, 160.0, 160.0], "value": 161.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 66.0, 66.0, 68.0, 67.0, 66.0, 73.0, 67.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1511.4, "alertThreshold": 2.0}]} 14:26:55 INFO - Return code: 0 14:26:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:26:55 ERROR - # TBPL SUCCESS # 14:26:55 INFO - Running post-action listener: _resource_record_post_action 14:26:55 INFO - Running post-run listener: _resource_record_post_run 14:26:57 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 7860224; Write bytes: 345186304; Read time: 2832; Write time: 549312 14:26:57 INFO - install - Wall time: 13s; CPU: 13.0%; Read bytes: 0; Write bytes: 704512; Read time: 0; Write time: 60 14:26:57 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 6098944; Write bytes: 326070272; Read time: 2772; Write time: 546284 14:26:57 INFO - Running post-run listener: _upload_blobber_files 14:26:57 INFO - Blob upload gear active. 14:26:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:26:57 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 14:26:57 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:26:57 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:26:57 INFO - (blobuploader) - INFO - Open directory for files ... 14:26:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:26:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:26:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:26:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:26:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:26:58 INFO - (blobuploader) - INFO - Done attempting. 14:26:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:26:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:26:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:26:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:26:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:26:58 INFO - (blobuploader) - INFO - Done attempting. 14:26:58 INFO - (blobuploader) - INFO - Iteration through files over. 14:26:58 INFO - Return code: 0 14:26:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:26:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:26:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e66f1f336b0e5aad8f558c15e13f615b9b326645a397343bb57ceb9cb195ec1ff1aec8541b64bba526f6b251c4e8c7316abce5eb5c933ea27afae9b23f8b4185", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6cdf29af645d76f7cfa54a1b1b5ede80f60a01665a43608a4e4bd3a73298a8b48ffea8f7022838792e1373449d1141e6f7ef2d44bf0aadb3d484b74cf279ea90"} 14:26:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:26:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:26:58 INFO - Contents: 14:26:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e66f1f336b0e5aad8f558c15e13f615b9b326645a397343bb57ceb9cb195ec1ff1aec8541b64bba526f6b251c4e8c7316abce5eb5c933ea27afae9b23f8b4185", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6cdf29af645d76f7cfa54a1b1b5ede80f60a01665a43608a4e4bd3a73298a8b48ffea8f7022838792e1373449d1141e6f7ef2d44bf0aadb3d484b74cf279ea90"} 14:26:58 INFO - Running post-run listener: copy_logs_to_upload_dir 14:26:58 INFO - Copying logs to upload dir... 14:26:58 INFO - mkdir: /builds/slave/test/build/upload/logs 14:26:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.600838 ========= master_lag: 0.24 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-27 14:26:59.107513) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 14:26:59.114696) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1467061532.908448-1147855932 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-Beta/sha512/e66f1f336b0e5aad8f558c15e13f615b9b326645a397343bb57ceb9cb195ec1ff1aec8541b64bba526f6b251c4e8c7316abce5eb5c933ea27afae9b23f8b4185", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6cdf29af645d76f7cfa54a1b1b5ede80f60a01665a43608a4e4bd3a73298a8b48ffea8f7022838792e1373449d1141e6f7ef2d44bf0aadb3d484b74cf279ea90"} build_url:https://queue.taskcluster.net/v1/task/dydLOsyBTMOQL2I-aXSGhA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011270 build_url: 'https://queue.taskcluster.net/v1/task/dydLOsyBTMOQL2I-aXSGhA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e66f1f336b0e5aad8f558c15e13f615b9b326645a397343bb57ceb9cb195ec1ff1aec8541b64bba526f6b251c4e8c7316abce5eb5c933ea27afae9b23f8b4185", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6cdf29af645d76f7cfa54a1b1b5ede80f60a01665a43608a4e4bd3a73298a8b48ffea8f7022838792e1373449d1141e6f7ef2d44bf0aadb3d484b74cf279ea90"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 14:26:59.143067) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 14:26:59.143475) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1467061532.908448-1147855932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004482 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 14:26:59.224987) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 14:26:59.228353) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 14:26:59.228712) ========= ========= Total master_lag: 0.41 =========