builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-042 starttime: 1462761762.57 results: success (0) buildid: 20160508171039 builduid: 3306465be335497baad1b1b2525e4336 revision: 450bf777896c63ae590821487f918b7e90dab075 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-08 19:42:42.572004) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-08 19:42:42.572472) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-08 19:42:42.572769) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-08 19:42:42.589636) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-08 19:42:42.590038) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1462754264.151561-1199475792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-08 19:42:43-- 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% 219M=0s 2016-05-08 19:42:43 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116760 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-08 19:42:42.719953) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-08 19:42:42.720297) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1462754264.151561-1199475792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015252 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-08 19:42:42.769925) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-08 19:42:42.770270) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 450bf777896c63ae590821487f918b7e90dab075 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 450bf777896c63ae590821487f918b7e90dab075 --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=74d6aec007b0fa31a864ebd7000001f8-1462754264.151561-1199475792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-08 19:42:43,250 truncating revision to first 12 chars 2016-05-08 19:42:43,250 Setting DEBUG logging. 2016-05-08 19:42:43,250 attempt 1/10 2016-05-08 19:42:43,250 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/450bf777896c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-08 19:42:43,517 unpacking tar archive at: mozilla-aurora-450bf777896c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.550481 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-08 19:42:43.333572) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-08 19:42:43.333893) ========= script_repo_revision: 450bf777896c63ae590821487f918b7e90dab075 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-08 19:42:43.334313) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-08 19:42:43.334585) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-08 19:42:43.342280) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 24 secs) (at 2016-05-08 19:42:43.342595) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1462754264.151561-1199475792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:42:43 INFO - MultiFileLogger online at 20160508 19:42:43 in /builds/slave/test 19:42:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 19:42:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:42:43 INFO - {'append_to_log': False, 19:42:43 INFO - 'base_work_dir': '/builds/slave/test', 19:42:43 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 19:42:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:42:43 INFO - 'branch': 'Mozilla-Aurora', 19:42:43 INFO - 'buildbot_json_path': 'buildprops.json', 19:42:43 INFO - 'config_files': ('talos/linux_config.py',), 19:42:43 INFO - 'default_actions': ('clobber', 19:42:43 INFO - 'read-buildbot-config', 19:42:43 INFO - 'download-and-extract', 19:42:43 INFO - 'populate-webroot', 19:42:43 INFO - 'create-virtualenv', 19:42:43 INFO - 'install', 19:42:43 INFO - 'run-tests'), 19:42:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:42:43 INFO - 'download_minidump_stackwalk': True, 19:42:43 INFO - 'download_symbols': 'ondemand', 19:42:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:42:43 INFO - 'tooltool.py': '/tools/tooltool.py', 19:42:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:42:43 INFO - '/tools/misc-python/virtualenv.py')}, 19:42:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:42:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:42:43 INFO - 'installer_path': 'installer.exe', 19:42:43 INFO - 'log_level': 'info', 19:42:43 INFO - 'log_name': 'talos', 19:42:43 INFO - 'log_to_console': True, 19:42:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:42:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:42:43 INFO - 'opt_config_files': (), 19:42:43 INFO - 'pip_index': False, 19:42:43 INFO - 'sps_profile': False, 19:42:43 INFO - 'sps_profile_interval': 0, 19:42:43 INFO - 'suite': 'dromaeojs', 19:42:43 INFO - 'system_bits': '32', 19:42:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:42:43 INFO - 'title': 'talos-linux64-ix-042', 19:42:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:42:43 INFO - 'use_talos_json': True, 19:42:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:42:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:42:43 INFO - 'work_dir': 'build'} 19:42:43 INFO - ##### 19:42:43 INFO - ##### Running clobber step. 19:42:43 INFO - ##### 19:42:43 INFO - Running pre-action listener: _resource_record_pre_action 19:42:43 INFO - Running main action method: clobber 19:42:43 INFO - rmtree: /builds/slave/test/build 19:42:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:42:44 INFO - Running post-action listener: _resource_record_post_action 19:42:44 INFO - ##### 19:42:44 INFO - ##### Running read-buildbot-config step. 19:42:44 INFO - ##### 19:42:44 INFO - Running pre-action listener: _resource_record_pre_action 19:42:44 INFO - Running main action method: read_buildbot_config 19:42:44 INFO - Using buildbot properties: 19:42:44 INFO - { 19:42:44 INFO - "project": "", 19:42:44 INFO - "product": "firefox", 19:42:44 INFO - "script_repo_revision": "production", 19:42:44 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 19:42:44 INFO - "repository": "", 19:42:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 19:42:44 INFO - "buildid": "20160508171039", 19:42:44 INFO - "pgo_build": "True", 19:42:44 INFO - "basedir": "/builds/slave/test", 19:42:44 INFO - "buildnumber": 493, 19:42:44 INFO - "slavename": "talos-linux64-ix-042", 19:42:44 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:42:44 INFO - "platform": "ubuntu64_hw", 19:42:44 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 19:42:44 INFO - "branch": "mozilla-aurora", 19:42:44 INFO - "repo_path": "releases/mozilla-aurora", 19:42:44 INFO - "revision": "450bf777896c63ae590821487f918b7e90dab075", 19:42:44 INFO - "stage_platform": "linux64-pgo", 19:42:44 INFO - "builduid": "3306465be335497baad1b1b2525e4336", 19:42:44 INFO - "slavebuilddir": "test" 19:42:44 INFO - } 19:42:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/SKqi5soRR0mR8W9-WGpxqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 19:42:44 INFO - Running post-action listener: _resource_record_post_action 19:42:44 INFO - ##### 19:42:44 INFO - ##### Running download-and-extract step. 19:42:44 INFO - ##### 19:42:44 INFO - Running pre-action listener: _resource_record_pre_action 19:42:44 INFO - Running main action method: download_and_extract 19:42:44 INFO - mkdir: /builds/slave/test/build/tests 19:42:44 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')]} 19:42:44 INFO - https://queue.taskcluster.net/v1/task/SKqi5soRR0mR8W9-WGpxqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:42:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKqi5soRR0mR8W9-WGpxqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 19:42:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKqi5soRR0mR8W9-WGpxqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 19:42:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKqi5soRR0mR8W9-WGpxqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 19:42:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKqi5soRR0mR8W9-WGpxqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:42:48 INFO - Downloaded 1361 bytes. 19:42:48 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 19:42:48 INFO - Using the following test package requirements: 19:42:48 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 19:42:48 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:42:48 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 19:42:48 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:42:48 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 19:42:48 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:42:48 INFO - u'jsshell-linux-x86_64.zip'], 19:42:48 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:42:48 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 19:42:48 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 19:42:48 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:42:48 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 19:42:48 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:42:48 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 19:42:48 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:42:48 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 19:42:48 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:42:48 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 19:42:48 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:42:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:42:48 INFO - https://queue.taskcluster.net/v1/task/SKqi5soRR0mR8W9-WGpxqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:42:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKqi5soRR0mR8W9-WGpxqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 19:42:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKqi5soRR0mR8W9-WGpxqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 19:42:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKqi5soRR0mR8W9-WGpxqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 19:42:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKqi5soRR0mR8W9-WGpxqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:42:59 INFO - Downloaded 23799377 bytes. 19:42:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:42:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:43:00 INFO - Return code: 0 19:43:00 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:43: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')]} 19:43:00 INFO - https://queue.taskcluster.net/v1/task/SKqi5soRR0mR8W9-WGpxqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:43:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKqi5soRR0mR8W9-WGpxqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 19:43:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKqi5soRR0mR8W9-WGpxqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 19:43:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKqi5soRR0mR8W9-WGpxqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 19:43:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKqi5soRR0mR8W9-WGpxqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:43:01 INFO - Downloaded 23799377 bytes. 19:43:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:43:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:43:03 INFO - Return code: 0 19:43: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')]} 19:43:03 INFO - https://queue.taskcluster.net/v1/task/SKqi5soRR0mR8W9-WGpxqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:43:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKqi5soRR0mR8W9-WGpxqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 19:43:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKqi5soRR0mR8W9-WGpxqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 19:43:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKqi5soRR0mR8W9-WGpxqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 19:43:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKqi5soRR0mR8W9-WGpxqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:43:04 INFO - Downloaded 10840145 bytes. 19:43:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:43:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 19:43:04 INFO - Return code: 0 19:43:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:43:04 INFO - https://queue.taskcluster.net/v1/task/SKqi5soRR0mR8W9-WGpxqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:43:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKqi5soRR0mR8W9-WGpxqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 19:43:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKqi5soRR0mR8W9-WGpxqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 19:43:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKqi5soRR0mR8W9-WGpxqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 19:43:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SKqi5soRR0mR8W9-WGpxqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:43:05 INFO - Downloaded 62696982 bytes. 19:43:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SKqi5soRR0mR8W9-WGpxqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 19:43:05 INFO - mkdir: /builds/slave/test/properties 19:43:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:43:05 INFO - Writing to file /builds/slave/test/properties/build_url 19:43:05 INFO - Contents: 19:43:05 INFO - build_url:https://queue.taskcluster.net/v1/task/SKqi5soRR0mR8W9-WGpxqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 19:43:06 INFO - Running post-action listener: _resource_record_post_action 19:43:06 INFO - Running post-action listener: set_extra_try_arguments 19:43:06 INFO - ##### 19:43:06 INFO - ##### Running populate-webroot step. 19:43:06 INFO - ##### 19:43:06 INFO - Running pre-action listener: _resource_record_pre_action 19:43:06 INFO - Running main action method: populate_webroot 19:43:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:43:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:43:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:43:06 INFO - '--tppagecycles', 19:43:06 INFO - '7'], 19:43:06 INFO - 'tests': ['tsvgm']}}, 19:43:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:43:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:43:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:43:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:43:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:43:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:43:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:43:06 INFO - 'talos_options': ['--disable-e10s'], 19:43:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:43:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:43:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:43:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:43:06 INFO - 'talos_options': ['--disable-e10s'], 19:43:06 INFO - 'tests': ['damp', 'tps']}, 19:43:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:43:06 INFO - 'tests': ['damp', 'tps']}, 19:43:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:43:06 INFO - 'tests': ['dromaeo_dom']}, 19:43:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:43:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:43:06 INFO - 'tests': ['a11yr', 19:43:06 INFO - 'ts_paint', 19:43:06 INFO - 'tpaint', 19:43:06 INFO - 'sessionrestore', 19:43:06 INFO - 'sessionrestore_no_auto_restore', 19:43:06 INFO - 'tabpaint']}, 19:43:06 INFO - 'other-e10s': {'tests': ['a11yr', 19:43:06 INFO - 'ts_paint', 19:43:06 INFO - 'tpaint', 19:43:06 INFO - 'sessionrestore', 19:43:06 INFO - 'sessionrestore_no_auto_restore', 19:43:06 INFO - 'tabpaint']}, 19:43:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:43:06 INFO - 'ts_paint', 19:43:06 INFO - 'tpaint', 19:43:06 INFO - 'sessionrestore', 19:43:06 INFO - 'sessionrestore_no_auto_restore', 19:43:06 INFO - 'tabpaint']}, 19:43:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:43:06 INFO - 'ts_paint', 19:43:06 INFO - 'tpaint', 19:43:06 INFO - 'sessionrestore', 19:43:06 INFO - 'sessionrestore_no_auto_restore', 19:43:06 INFO - 'tabpaint']}, 19:43:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:43:06 INFO - 'tests': ['a11yr', 19:43:06 INFO - 'ts_paint', 19:43:06 INFO - 'tpaint', 19:43:06 INFO - 'sessionrestore', 19:43:06 INFO - 'sessionrestore_no_auto_restore', 19:43:06 INFO - 'tabpaint']}, 19:43:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:43:06 INFO - 'tests': ['a11yr', 19:43:06 INFO - 'ts_paint', 19:43:06 INFO - 'tpaint', 19:43:06 INFO - 'sessionrestore', 19:43:06 INFO - 'sessionrestore_no_auto_restore', 19:43:06 INFO - 'tabpaint']}, 19:43:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:43:06 INFO - 'tests': ['tsvgx', 19:43:06 INFO - 'tsvgr_opacity', 19:43:06 INFO - 'tart', 19:43:06 INFO - 'tscrollx', 19:43:06 INFO - 'cart']}, 19:43:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:43:06 INFO - 'tsvgr_opacity', 19:43:06 INFO - 'tart', 19:43:06 INFO - 'tscrollx', 19:43:06 INFO - 'cart']}, 19:43:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:43:06 INFO - 'talos_options': ['--disable-e10s'], 19:43:06 INFO - 'tests': ['tp5o']}, 19:43:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:43:06 INFO - 'tests': ['tp5o']}, 19:43:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:43:06 INFO - 'talos_options': ['--disable-e10s', 19:43:06 INFO - '--xperf_path', 19:43:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:43:06 INFO - 'tests': ['tp5n']}, 19:43:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:43:06 INFO - 'talos_options': ['--xperf_path', 19:43:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:43:06 INFO - 'tests': ['tp5n']}}, 19:43:06 INFO - 'talos.zip': {'path': '', 19:43:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:43:06 INFO - Running post-action listener: _resource_record_post_action 19:43:06 INFO - ##### 19:43:06 INFO - ##### Running create-virtualenv step. 19:43:06 INFO - ##### 19:43:06 INFO - Running pre-action listener: _resource_record_pre_action 19:43:06 INFO - Running main action method: create_virtualenv 19:43:06 INFO - Creating virtualenv /builds/slave/test/build/venv 19:43:06 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 19:43:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:43:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:43:06 INFO - Using real prefix '/usr' 19:43:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:43:07 INFO - Installing distribute.............................................................................................................................................................................................done. 19:43:09 INFO - Installing pip.................done. 19:43:09 INFO - Return code: 0 19:43:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:43:09 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')]} 19:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:09 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')]} 19:43:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:09 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 0x7f98f4844f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c715a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d00410>, '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 0x1d01310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d017a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1462754264.151561-1199475792', '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 19:43:09 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 19:43:09 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 19:43:09 INFO - Using env: {'DISPLAY': ':0', 19:43:09 INFO - 'HOME': '/home/cltbld', 19:43:09 INFO - 'LANG': 'en_US.UTF-8', 19:43:09 INFO - 'LANGUAGE': 'en_US:en', 19:43:09 INFO - 'LOGNAME': 'cltbld', 19:43:09 INFO - 'MAIL': '/var/mail/cltbld', 19:43:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:09 INFO - 'MOZ_NO_REMOTE': '1', 19:43:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:09 INFO - 'NO_EM_RESTART': '1', 19:43:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:09 INFO - 'PWD': '/builds/slave/test', 19:43:09 INFO - 'SHELL': '/bin/bash', 19:43:09 INFO - 'SHLVL': '1', 19:43:09 INFO - 'TERM': 'linux', 19:43:09 INFO - 'TMOUT': '86400', 19:43:09 INFO - 'USER': 'cltbld', 19:43:09 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1462754264.151561-1199475792', 19:43:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:09 INFO - '_': '/tools/buildbot/bin/python'} 19:43:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:09 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 19:43:09 INFO - Cleaning up... 19:43:09 INFO - Return code: 0 19:43:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:43:09 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')]} 19:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:09 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')]} 19:43:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:09 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 0x7f98f4844f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c715a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d00410>, '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 0x1d01310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d017a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1462754264.151561-1199475792', '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 19:43:09 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 19:43:09 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 19:43:09 INFO - Using env: {'DISPLAY': ':0', 19:43:09 INFO - 'HOME': '/home/cltbld', 19:43:09 INFO - 'LANG': 'en_US.UTF-8', 19:43:09 INFO - 'LANGUAGE': 'en_US:en', 19:43:09 INFO - 'LOGNAME': 'cltbld', 19:43:09 INFO - 'MAIL': '/var/mail/cltbld', 19:43:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:09 INFO - 'MOZ_NO_REMOTE': '1', 19:43:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:09 INFO - 'NO_EM_RESTART': '1', 19:43:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:09 INFO - 'PWD': '/builds/slave/test', 19:43:09 INFO - 'SHELL': '/bin/bash', 19:43:09 INFO - 'SHLVL': '1', 19:43:09 INFO - 'TERM': 'linux', 19:43:09 INFO - 'TMOUT': '86400', 19:43:09 INFO - 'USER': 'cltbld', 19:43:09 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1462754264.151561-1199475792', 19:43:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:09 INFO - '_': '/tools/buildbot/bin/python'} 19:43:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:09 INFO - Downloading/unpacking psutil>=0.7.1 19:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:43:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:43:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:43:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:43:11 INFO - Installing collected packages: psutil 19:43:11 INFO - Running setup.py install for psutil 19:43:11 INFO - building 'psutil._psutil_linux' extension 19:43:11 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 19:43:11 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 19:43:11 INFO - building 'psutil._psutil_posix' extension 19:43:11 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 19:43:12 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 19:43:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:43:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:43:12 INFO - Successfully installed psutil 19:43:12 INFO - Cleaning up... 19:43:12 INFO - Return code: 0 19:43:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:43:12 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')]} 19:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:12 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')]} 19:43:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:12 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 0x7f98f4844f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c715a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d00410>, '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 0x1d01310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d017a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1462754264.151561-1199475792', '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 19:43:12 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 19:43:12 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 19:43:12 INFO - Using env: {'DISPLAY': ':0', 19:43:12 INFO - 'HOME': '/home/cltbld', 19:43:12 INFO - 'LANG': 'en_US.UTF-8', 19:43:12 INFO - 'LANGUAGE': 'en_US:en', 19:43:12 INFO - 'LOGNAME': 'cltbld', 19:43:12 INFO - 'MAIL': '/var/mail/cltbld', 19:43:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:12 INFO - 'MOZ_NO_REMOTE': '1', 19:43:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:12 INFO - 'NO_EM_RESTART': '1', 19:43:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:12 INFO - 'PWD': '/builds/slave/test', 19:43:12 INFO - 'SHELL': '/bin/bash', 19:43:12 INFO - 'SHLVL': '1', 19:43:12 INFO - 'TERM': 'linux', 19:43:12 INFO - 'TMOUT': '86400', 19:43:12 INFO - 'USER': 'cltbld', 19:43:12 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1462754264.151561-1199475792', 19:43:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:12 INFO - '_': '/tools/buildbot/bin/python'} 19:43:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:43:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:43:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:43:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:43:14 INFO - Installing collected packages: mozsystemmonitor 19:43:14 INFO - Running setup.py install for mozsystemmonitor 19:43:14 INFO - Successfully installed mozsystemmonitor 19:43:14 INFO - Cleaning up... 19:43:14 INFO - Return code: 0 19:43:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:43:14 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')]} 19:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:14 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')]} 19:43:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:14 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 0x7f98f4844f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c715a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d00410>, '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 0x1d01310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d017a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1462754264.151561-1199475792', '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 19:43:14 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 19:43:14 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 19:43:14 INFO - Using env: {'DISPLAY': ':0', 19:43:14 INFO - 'HOME': '/home/cltbld', 19:43:14 INFO - 'LANG': 'en_US.UTF-8', 19:43:14 INFO - 'LANGUAGE': 'en_US:en', 19:43:14 INFO - 'LOGNAME': 'cltbld', 19:43:14 INFO - 'MAIL': '/var/mail/cltbld', 19:43:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:14 INFO - 'MOZ_NO_REMOTE': '1', 19:43:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:14 INFO - 'NO_EM_RESTART': '1', 19:43:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:14 INFO - 'PWD': '/builds/slave/test', 19:43:14 INFO - 'SHELL': '/bin/bash', 19:43:14 INFO - 'SHLVL': '1', 19:43:14 INFO - 'TERM': 'linux', 19:43:14 INFO - 'TMOUT': '86400', 19:43:14 INFO - 'USER': 'cltbld', 19:43:14 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1462754264.151561-1199475792', 19:43:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:14 INFO - '_': '/tools/buildbot/bin/python'} 19:43:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:14 INFO - Downloading/unpacking blobuploader==1.2.4 19:43:14 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 19:43:14 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 19:43:14 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 19:43:14 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 19:43:14 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 19:43:14 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 19:43:16 INFO - Downloading blobuploader-1.2.4.tar.gz 19:43:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:43:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:43:16 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 19:43:16 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 19:43:16 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 19:43:16 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 19:43:16 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 19:43:16 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 19:43:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:43:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:43:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:43:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:43:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:17 INFO - Downloading docopt-0.6.1.tar.gz 19:43:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:43:17 INFO - Installing collected packages: blobuploader, requests, docopt 19:43:17 INFO - Running setup.py install for blobuploader 19:43:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:43:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:43:17 INFO - Running setup.py install for requests 19:43:17 INFO - Running setup.py install for docopt 19:43:17 INFO - Successfully installed blobuploader requests docopt 19:43:18 INFO - Cleaning up... 19:43:18 INFO - Return code: 0 19:43:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:43:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:43:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:43:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:18 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 0x7f98f4844f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c715a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d00410>, '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 0x1d01310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d017a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1462754264.151561-1199475792', '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 19:43:18 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 19:43:18 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 19:43:18 INFO - Using env: {'DISPLAY': ':0', 19:43:18 INFO - 'HOME': '/home/cltbld', 19:43:18 INFO - 'LANG': 'en_US.UTF-8', 19:43:18 INFO - 'LANGUAGE': 'en_US:en', 19:43:18 INFO - 'LOGNAME': 'cltbld', 19:43:18 INFO - 'MAIL': '/var/mail/cltbld', 19:43:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:18 INFO - 'MOZ_NO_REMOTE': '1', 19:43:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:18 INFO - 'NO_EM_RESTART': '1', 19:43:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:18 INFO - 'PWD': '/builds/slave/test', 19:43:18 INFO - 'SHELL': '/bin/bash', 19:43:18 INFO - 'SHLVL': '1', 19:43:18 INFO - 'TERM': 'linux', 19:43:18 INFO - 'TMOUT': '86400', 19:43:18 INFO - 'USER': 'cltbld', 19:43:18 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1462754264.151561-1199475792', 19:43:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:18 INFO - '_': '/tools/buildbot/bin/python'} 19:43:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:43:18 INFO - Running setup.py (path:/tmp/pip-gPrWTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:43:18 INFO - Running setup.py (path:/tmp/pip-kgWKHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:43:18 INFO - Running setup.py (path:/tmp/pip-NlJPH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:43:18 INFO - Running setup.py (path:/tmp/pip-uX1wNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:43:18 INFO - Running setup.py (path:/tmp/pip-McKW2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:43:18 INFO - Running setup.py (path:/tmp/pip-AIhwfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:43:18 INFO - Running setup.py (path:/tmp/pip-PZtkDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:43:18 INFO - Running setup.py (path:/tmp/pip-NVm1Ru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:43:18 INFO - Running setup.py (path:/tmp/pip-WVjhyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:43:18 INFO - Running setup.py (path:/tmp/pip-3fZjaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:43:18 INFO - Running setup.py (path:/tmp/pip-T9wtd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:43:19 INFO - Running setup.py (path:/tmp/pip-ULcb0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:43:19 INFO - Running setup.py (path:/tmp/pip-H5W1GK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:43:19 INFO - Running setup.py (path:/tmp/pip-fdREPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:43:19 INFO - Running setup.py (path:/tmp/pip-u_oVmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:43:19 INFO - Running setup.py (path:/tmp/pip-fw1Xiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:43:19 INFO - Running setup.py (path:/tmp/pip-byC6eZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:43:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:43:19 INFO - Running setup.py install for manifestparser 19:43:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:43:19 INFO - Running setup.py install for mozcrash 19:43:19 INFO - Running setup.py install for mozdebug 19:43:19 INFO - Running setup.py install for mozdevice 19:43:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:43:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:43:19 INFO - Running setup.py install for mozfile 19:43:19 INFO - Running setup.py install for mozhttpd 19:43:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:43:20 INFO - Running setup.py install for mozinfo 19:43:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:43:20 INFO - Running setup.py install for mozInstall 19:43:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:43:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:43:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:43:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:43:20 INFO - Running setup.py install for mozleak 19:43:20 INFO - Running setup.py install for mozlog 19:43:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:43:20 INFO - Running setup.py install for moznetwork 19:43:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:43:20 INFO - Running setup.py install for mozprocess 19:43:20 INFO - Running setup.py install for mozprofile 19:43:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:43:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:43:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:43:20 INFO - Running setup.py install for mozrunner 19:43:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:43:20 INFO - Running setup.py install for mozscreenshot 19:43:21 INFO - Running setup.py install for moztest 19:43:21 INFO - Running setup.py install for mozversion 19:43:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:43:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:43:21 INFO - Cleaning up... 19:43:21 INFO - Return code: 0 19:43:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:43:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:43:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:43:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:21 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 0x7f98f4844f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c715a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d00410>, '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 0x1d01310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d017a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1462754264.151561-1199475792', '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 19:43:21 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 19:43:21 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 19:43:21 INFO - Using env: {'DISPLAY': ':0', 19:43:21 INFO - 'HOME': '/home/cltbld', 19:43:21 INFO - 'LANG': 'en_US.UTF-8', 19:43:21 INFO - 'LANGUAGE': 'en_US:en', 19:43:21 INFO - 'LOGNAME': 'cltbld', 19:43:21 INFO - 'MAIL': '/var/mail/cltbld', 19:43:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:21 INFO - 'MOZ_NO_REMOTE': '1', 19:43:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:21 INFO - 'NO_EM_RESTART': '1', 19:43:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:21 INFO - 'PWD': '/builds/slave/test', 19:43:21 INFO - 'SHELL': '/bin/bash', 19:43:21 INFO - 'SHLVL': '1', 19:43:21 INFO - 'TERM': 'linux', 19:43:21 INFO - 'TMOUT': '86400', 19:43:21 INFO - 'USER': 'cltbld', 19:43:21 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1462754264.151561-1199475792', 19:43:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:21 INFO - '_': '/tools/buildbot/bin/python'} 19:43:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:43:21 INFO - Running setup.py (path:/tmp/pip-vT9SnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:43:21 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)) 19:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:43:21 INFO - Running setup.py (path:/tmp/pip-JjxDMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:43:21 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)) 19:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:43:21 INFO - Running setup.py (path:/tmp/pip-ko9UWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:43:21 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)) 19:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:43:21 INFO - Running setup.py (path:/tmp/pip-Im1fBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:43:21 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)) 19:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:43:21 INFO - Running setup.py (path:/tmp/pip-j9LBvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:43:21 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)) 19:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:43:21 INFO - Running setup.py (path:/tmp/pip-TlLyge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:43:21 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)) 19:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:43:21 INFO - Running setup.py (path:/tmp/pip-WAPPF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:43:22 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)) 19:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:43:22 INFO - Running setup.py (path:/tmp/pip-vSYN72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:43:22 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)) 19:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:43:22 INFO - Running setup.py (path:/tmp/pip-oWSyrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:43:22 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)) 19:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:43:22 INFO - Running setup.py (path:/tmp/pip-UQ9KB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:43:22 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)) 19:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:43:22 INFO - Running setup.py (path:/tmp/pip-gBSzHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:43:22 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)) 19:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:43:22 INFO - Running setup.py (path:/tmp/pip-x69Jcf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:43:22 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)) 19:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:43:22 INFO - Running setup.py (path:/tmp/pip-MNUray-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:43:22 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)) 19:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:43:22 INFO - Running setup.py (path:/tmp/pip-8ge4CL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:43:22 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)) 19:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:43:22 INFO - Running setup.py (path:/tmp/pip-vQiOHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:43:22 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)) 19:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:43:22 INFO - Running setup.py (path:/tmp/pip-N2iMV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:43:22 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)) 19:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:43:22 INFO - Running setup.py (path:/tmp/pip-aBvE1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:43:22 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)) 19:43:22 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)) 19:43:22 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)) 19:43:22 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)) 19:43:22 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)) 19:43:22 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)) 19:43:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:43:22 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 19:43:22 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 19:43:22 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 19:43:22 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 19:43:22 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 19:43:22 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 19:43:24 INFO - Downloading blessings-1.6.tar.gz 19:43:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:43:24 INFO - Installing collected packages: blessings 19:43:24 INFO - Running setup.py install for blessings 19:43:24 INFO - Successfully installed blessings 19:43:24 INFO - Cleaning up... 19:43:24 INFO - Return code: 0 19:43:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:43:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:43:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:43:25 INFO - Reading from file tmpfile_stdout 19:43:25 INFO - Current package versions: 19:43:25 INFO - argparse == 1.2.1 19:43:25 INFO - blessings == 1.6 19:43:25 INFO - blobuploader == 1.2.4 19:43:25 INFO - docopt == 0.6.1 19:43:25 INFO - manifestparser == 1.1 19:43:25 INFO - mozInstall == 1.12 19:43:25 INFO - mozcrash == 0.17 19:43:25 INFO - mozdebug == 0.1 19:43:25 INFO - mozdevice == 0.48 19:43:25 INFO - mozfile == 1.2 19:43:25 INFO - mozhttpd == 0.7 19:43:25 INFO - mozinfo == 0.9 19:43:25 INFO - mozleak == 0.1 19:43:25 INFO - mozlog == 3.1 19:43:25 INFO - moznetwork == 0.27 19:43:25 INFO - mozprocess == 0.22 19:43:25 INFO - mozprofile == 0.28 19:43:25 INFO - mozrunner == 6.11 19:43:25 INFO - mozscreenshot == 0.1 19:43:25 INFO - mozsystemmonitor == 0.0 19:43:25 INFO - moztest == 0.7 19:43:25 INFO - mozversion == 1.4 19:43:25 INFO - psutil == 3.1.1 19:43:25 INFO - requests == 1.2.3 19:43:25 INFO - wsgiref == 0.1.2 19:43:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:43: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')]} 19:43:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43: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')]} 19:43:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:25 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 0x7f98f4844f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c715a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d00410>, '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 0x1d01310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d017a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1462754264.151561-1199475792', '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 19:43:25 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 19:43:25 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 19:43:25 INFO - Using env: {'DISPLAY': ':0', 19:43:25 INFO - 'HOME': '/home/cltbld', 19:43:25 INFO - 'LANG': 'en_US.UTF-8', 19:43:25 INFO - 'LANGUAGE': 'en_US:en', 19:43:25 INFO - 'LOGNAME': 'cltbld', 19:43:25 INFO - 'MAIL': '/var/mail/cltbld', 19:43:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:25 INFO - 'MOZ_NO_REMOTE': '1', 19:43:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:25 INFO - 'NO_EM_RESTART': '1', 19:43:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:25 INFO - 'PWD': '/builds/slave/test', 19:43:25 INFO - 'SHELL': '/bin/bash', 19:43:25 INFO - 'SHLVL': '1', 19:43:25 INFO - 'TERM': 'linux', 19:43:25 INFO - 'TMOUT': '86400', 19:43:25 INFO - 'USER': 'cltbld', 19:43:25 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1462754264.151561-1199475792', 19:43:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:25 INFO - '_': '/tools/buildbot/bin/python'} 19:43:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:25 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)) 19:43:25 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)) 19:43:25 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)) 19:43:25 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)) 19:43:25 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)) 19:43:25 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)) 19:43:25 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)) 19:43:25 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)) 19:43:25 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)) 19:43:25 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)) 19:43:25 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)) 19:43:25 INFO - Cleaning up... 19:43:25 INFO - Return code: 0 19:43:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:43: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')]} 19:43:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43: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')]} 19:43:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:25 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 0x7f98f4844f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c715a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d00410>, '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 0x1d01310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d017a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1462754264.151561-1199475792', '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 19:43:25 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 19:43:25 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 19:43:25 INFO - Using env: {'DISPLAY': ':0', 19:43:25 INFO - 'HOME': '/home/cltbld', 19:43:25 INFO - 'LANG': 'en_US.UTF-8', 19:43:25 INFO - 'LANGUAGE': 'en_US:en', 19:43:25 INFO - 'LOGNAME': 'cltbld', 19:43:25 INFO - 'MAIL': '/var/mail/cltbld', 19:43:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:25 INFO - 'MOZ_NO_REMOTE': '1', 19:43:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:25 INFO - 'NO_EM_RESTART': '1', 19:43:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:25 INFO - 'PWD': '/builds/slave/test', 19:43:25 INFO - 'SHELL': '/bin/bash', 19:43:25 INFO - 'SHLVL': '1', 19:43:25 INFO - 'TERM': 'linux', 19:43:25 INFO - 'TMOUT': '86400', 19:43:25 INFO - 'USER': 'cltbld', 19:43:25 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1462754264.151561-1199475792', 19:43:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:25 INFO - '_': '/tools/buildbot/bin/python'} 19:43:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:25 INFO - Downloading/unpacking jsonschema 19:43:25 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 19:43:25 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 19:43:25 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 19:43:25 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 19:43:25 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 19:43:25 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 19:43:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:43:27 INFO - Downloading/unpacking functools32 (from jsonschema) 19:43:27 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 19:43:27 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 19:43:27 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 19:43:27 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 19:43:27 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 19:43:27 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 19:43:27 INFO - Downloading functools32-3.2.3-2.tar.gz 19:43:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:43:27 INFO - warning: no files found matching '*.txt' 19:43:27 INFO - no previously-included directories found matching 'build' 19:43:27 INFO - no previously-included directories found matching 'dist' 19:43:27 INFO - no previously-included directories found matching '.git*' 19:43:27 INFO - Installing collected packages: jsonschema, functools32 19:43:27 INFO - Running setup.py install for functools32 19:43:27 INFO - warning: no files found matching '*.txt' 19:43:27 INFO - no previously-included directories found matching 'build' 19:43:27 INFO - no previously-included directories found matching 'dist' 19:43:27 INFO - no previously-included directories found matching '.git*' 19:43:27 INFO - Successfully installed jsonschema functools32 19:43:27 INFO - Cleaning up... 19:43:27 INFO - Return code: 0 19:43:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:43:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:43:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:43:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:27 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 0x7f98f4844f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c715a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d00410>, '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 0x1d01310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d017a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1462754264.151561-1199475792', '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 19:43:27 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 19:43:27 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 19:43:27 INFO - Using env: {'DISPLAY': ':0', 19:43:27 INFO - 'HOME': '/home/cltbld', 19:43:27 INFO - 'LANG': 'en_US.UTF-8', 19:43:27 INFO - 'LANGUAGE': 'en_US:en', 19:43:27 INFO - 'LOGNAME': 'cltbld', 19:43:27 INFO - 'MAIL': '/var/mail/cltbld', 19:43:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:27 INFO - 'MOZ_NO_REMOTE': '1', 19:43:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:27 INFO - 'NO_EM_RESTART': '1', 19:43:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:27 INFO - 'PWD': '/builds/slave/test', 19:43:27 INFO - 'SHELL': '/bin/bash', 19:43:27 INFO - 'SHLVL': '1', 19:43:27 INFO - 'TERM': 'linux', 19:43:27 INFO - 'TMOUT': '86400', 19:43:27 INFO - 'USER': 'cltbld', 19:43:27 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1462754264.151561-1199475792', 19:43:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:27 INFO - '_': '/tools/buildbot/bin/python'} 19:43:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:28 INFO - Downloading/unpacking flake8 19:43:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:43:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:43:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:43:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:43:30 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 19:43:30 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 19:43:30 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 19:43:30 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 19:43:30 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 19:43:30 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 19:43:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:43:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:43:30 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 19:43:30 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 19:43:30 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 19:43:30 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 19:43:30 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 19:43:30 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 19:43:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:43:30 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 19:43:30 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 19:43:30 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 19:43:30 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 19:43:30 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 19:43:30 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 19:43:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:43:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:43:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:43:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:43:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:43:30 INFO - no previously-included directories found matching 'docs/_build' 19:43:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:43:30 INFO - Running setup.py install for pep8 19:43:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:43:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:43:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:43:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:43:30 INFO - no previously-included directories found matching 'docs/_build' 19:43:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:43:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:43:31 INFO - Cleaning up... 19:43:31 INFO - Return code: 0 19:43:31 INFO - Running post-action listener: _resource_record_post_action 19:43:31 INFO - Running post-action listener: _start_resource_monitoring 19:43:31 INFO - Starting resource monitoring. 19:43:31 INFO - ##### 19:43:31 INFO - ##### Running install step. 19:43:31 INFO - ##### 19:43:31 INFO - Running pre-action listener: _resource_record_pre_action 19:43:31 INFO - Running main action method: install 19:43:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:43:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:43:31 INFO - Reading from file tmpfile_stdout 19:43:31 INFO - Detecting whether we're running mozinstall >=1.0... 19:43:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:43:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:43:31 INFO - Reading from file tmpfile_stdout 19:43:31 INFO - Output received: 19:43:31 INFO - Usage: mozinstall [options] installer 19:43:31 INFO - Options: 19:43:31 INFO - -h, --help show this help message and exit 19:43:31 INFO - -d DEST, --destination=DEST 19:43:31 INFO - Directory to install application into. [default: 19:43:31 INFO - "/builds/slave/test"] 19:43:31 INFO - --app=APP Application being installed. [default: firefox] 19:43:31 INFO - mkdir: /builds/slave/test/build/application 19:43:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:43:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:43:47 INFO - Reading from file tmpfile_stdout 19:43:47 INFO - Output received: 19:43:47 INFO - /builds/slave/test/build/application/firefox/firefox 19:43:47 INFO - Running post-action listener: _resource_record_post_action 19:43:47 INFO - ##### 19:43:47 INFO - ##### Running run-tests step. 19:43:47 INFO - ##### 19:43:47 INFO - Running pre-action listener: _resource_record_pre_action 19:43:47 INFO - Running main action method: run_tests 19:43:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:43:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:43:47 INFO - Python 2.7.3 19:43:47 INFO - Return code: 0 19:43:47 INFO - grabbing minidump binary from tooltool 19:43: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')]} 19:43:47 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 0x1d00410>, '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 0x1d01310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d017a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:43:47 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 19:43:47 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 19:43:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:43:47 INFO - Return code: 0 19:43:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:43:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:43:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:43:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:43:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:43:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:43:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:43:47 INFO - Return code: 0 19:43:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SKqi5soRR0mR8W9-WGpxqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 19:43:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SKqi5soRR0mR8W9-WGpxqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 19:43:47 INFO - Using env: {'DISPLAY': ':0', 19:43:47 INFO - 'HOME': '/home/cltbld', 19:43:47 INFO - 'LANG': 'en_US.UTF-8', 19:43:47 INFO - 'LANGUAGE': 'en_US:en', 19:43:47 INFO - 'LOGNAME': 'cltbld', 19:43:47 INFO - 'MAIL': '/var/mail/cltbld', 19:43:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:43:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:43:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:47 INFO - 'MOZ_NO_REMOTE': '1', 19:43:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:43:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:47 INFO - 'NO_EM_RESTART': '1', 19:43:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:48 INFO - 'PWD': '/builds/slave/test', 19:43:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:43:48 INFO - 'SHELL': '/bin/bash', 19:43:48 INFO - 'SHLVL': '1', 19:43:48 INFO - 'TERM': 'linux', 19:43:48 INFO - 'TMOUT': '86400', 19:43:48 INFO - 'USER': 'cltbld', 19:43:48 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1462754264.151561-1199475792', 19:43:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:48 INFO - '_': '/tools/buildbot/bin/python'} 19:43:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SKqi5soRR0mR8W9-WGpxqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 19:43:48 INFO - mozversion application_buildid: 20160508171039 19:43:48 INFO - mozversion application_changeset: 450bf777896c63ae590821487f918b7e90dab075 19:43:48 INFO - mozversion application_display_name: FirefoxDeveloperEdition 19:43:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:43:48 INFO - mozversion application_name: Firefox 19:43:48 INFO - mozversion application_remotingname: firefox-dev 19:43:48 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:43:48 INFO - mozversion application_vendor: Mozilla 19:43:48 INFO - mozversion application_version: 48.0a2 19:43:48 INFO - mozversion platform_buildid: 20160508171039 19:43:48 INFO - mozversion platform_changeset: 450bf777896c63ae590821487f918b7e90dab075 19:43:48 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:43:48 INFO - mozversion platform_version: 48.0a2 19:43:48 INFO - using testdate: 1462761828 19:43:48 INFO - actual date: 1462761828 19:43:48 INFO - starting webserver on 'localhost:56722' 19:43:48 INFO - SUITE-START | Running 2 tests 19:43:48 INFO - TEST-START | dromaeo_css 19:43:48 INFO - operating with platform_type : linux_ 19:43:48 INFO - Initialising browser for dromaeo_css test... 19:43:48 INFO - TEST-INFO | started process 30805 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY5uA_Y/profile http://localhost:56722/getInfo.html) 19:43:52 INFO - PROCESS | 30805 | __metrics Screen width/height:1600/1200 19:43:52 INFO - PROCESS | 30805 | colorDepth:24 19:43:52 INFO - PROCESS | 30805 | Browser inner width/height: 1024/697 19:43:52 INFO - PROCESS | 30805 | __metrics 19:43:53 ERROR - PROCESS | 30805 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:43:54 INFO - TEST-INFO | 30805: exit 0 19:43:54 INFO - Browser initialized. 19:43:54 INFO - Running cycle 1/1 for dromaeo_css test... 19:43:54 INFO - TEST-INFO | started process 30896 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY5uA_Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:44:06 INFO - PROCESS | 30896 | RSS: Main: 141537280 19:44:06 INFO - PROCESS | 30896 | 19:44:57 INFO - PROCESS | 30896 | 1462761897933 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] 19:47:04 INFO - PROCESS | 30896 | Cycle 1(1): loaded http://localhost:56722/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56722/tests/dromaeo/cssquery-ext.html) 19:47:06 INFO - PROCESS | 30896 | RSS: Main: 254169088 19:47:06 INFO - PROCESS | 30896 | 19:50:08 INFO - PROCESS | 30896 | Cycle 1(1): loaded http://localhost:56722/tests/dromaeo/cssquery-ext.html (next: http://localhost:56722/tests/dromaeo/cssquery-jquery.html) 19:50:08 INFO - PROCESS | 30896 | RSS: Main: 227647488 19:50:08 INFO - PROCESS | 30896 | 19:53:10 INFO - PROCESS | 30896 | Cycle 1(1): loaded http://localhost:56722/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56722/tests/dromaeo/cssquery-mootools.html) 19:53:11 INFO - PROCESS | 30896 | RSS: Main: 215592960 19:53:11 INFO - PROCESS | 30896 | 19:56:13 INFO - PROCESS | 30896 | Cycle 1(1): loaded http://localhost:56722/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56722/tests/dromaeo/cssquery-prototype.html) 19:56:13 INFO - PROCESS | 30896 | RSS: Main: 216698880 19:56:13 INFO - PROCESS | 30896 | 19:59:16 INFO - PROCESS | 30896 | Cycle 1(1): loaded http://localhost:56722/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56722/tests/dromaeo/cssquery-yui.html) 19:59:16 INFO - PROCESS | 30896 | RSS: Main: 185720832 19:59:16 INFO - PROCESS | 30896 | 20:02:19 INFO - PROCESS | 30896 | Cycle 1(1): loaded http://localhost:56722/tests/dromaeo/cssquery-yui.html (next: http://localhost:56722/tests/dromaeo/cssquery-dojo.html) 20:02:19 INFO - PROCESS | 30896 | RSS: Main: 255860736 20:02:19 INFO - PROCESS | 30896 | 20:02:19 INFO - PROCESS | 30896 | __start_tp_report 20:02:19 INFO - PROCESS | 30896 | _x_x_mozilla_page_load 20:02:19 INFO - PROCESS | 30896 | _x_x_mozilla_page_load_details 20:02:19 INFO - PROCESS | 30896 | |i|pagename|runs| 20:02:19 INFO - PROCESS | 30896 | |0;dojo.html;3343.598768147822;3389.813560254185;3405.5743032120986;3411.3518431498023;3420.743444241681;5596.384397716253;5605.1872478490595;5608.10270356743;5623;5625.437456254373;5631.71841407929;5638.984982703112;5650.773969041234;5662.575306851982;5667.518260947824;4931.038447502739;5005.399352077738;5140.691558506493;5177.58579313654;5273.103572392683;5007.899842003158;5097.898042039157;5131.255967884655;5151.922721159186;5162.716050617215;5097.821576244833;5101.107306221415;5110.080185566597;5118.10433174193;5128.179516249065;5066.468020857794;5079.060373830853;5141.280220769077;5144.639875208737;5193.428722840485;4988.800447982113;5039.118154323016;5101.6173786965755;5112.488751124858;5125.051865404912;5362.839114826562;5383.75773090208;5393.83818485446;5414.10667239905;5441.319835020622;5754.913676294859;5860.677662728548;5866.325372582165;5868.383819698913;5868.647881127146;5965.194698715704;6019.69901504923;6021;6026.78906238284;6034.788782392639;5596.300462442195;5598.552115830724;5609.523190528769;5612.747426365782;5613.971930140364;5995.760169593167;6013.278406591149;6063.423974722395;6082.330943596201;6125.816225513242;5846.093855452412;5847.883042339129;5848.3274423441;5857.736401861926;5861.589688721749;5921.052631578927;5932.584719069624;5935.970320148372;5938;5939.673317967467;5775.826725198251;5823.417658234142;5877.52979761618;5907.409259074058;5908.704564771744;5877.9118313225335;5930.762769489258;5932.169496270526;5937.406259374115;5950.196723442366;4513.977430112828;4516.390287311171;4519.0058187198765;4519.615832654261;4542.659300552472;3931.312020396419;4052.250333688277;4057.350823868167;4107.116969851496;4137.97931010343;5588.30146231721;5589.80435684749;5593.552515798808;5598.86002849932;5599.80400685974;5918.644881307136;5924.792632257937;5928.407159284124;5929.851753706105;5932.110183472513;5521.613487055948;5560.77756889728;5605.075162598126;5637.859053523613;5646.124850648156;5046.243063540498;5055.9494405055475;5057.494250574913;5062.696238225644;5089.3638295213095;5905.320888097838;6056.666883321372;6095.359987201368;6095.786647467317;6107.206063211754;6045.153678484928;6069.36271691466;6070.939290607037;6092.299385570716;6096.055111457731;6230.314665386894;6264.655443950626;6265.624062556261;6267.717952692049;6276.058591211355;5720.570957178312;5896.321922978912;5932.9915107993;5950.523958083257;5971.850703732442;5967.8209653710455;5968.045112781934;5969.970150149222;5980.611260268069;6000.669963151894;5764.740586673526;5776.249087618583;5782.421757824184;5788.21859049023;5799.217105690678;5695.088785794253;5754.856128596819;5767.9134812977;5849.64902105875;5930.7924222652;5648.378678345297;5672.943270567242;5674.2623458950075;5683.318001839806;5698.629589076697;5744.913826292525;5782.10377391505;5784.479396854304;5786.07422812348;5786.9131963019745;5544.445555444423;5653.152027195789;5702.942970570407;5715.742791574472;5738.799142030009 20:02:19 INFO - PROCESS | 30896 | |1;ext.html;667.4126768443772;674.1977047313698;678.9728410863563;735.7204262380296;757.7991832164474;32889.67110328896;37925.810370948144;38722.225555488905;38791.41812872809;38802.8059859701;42845.14309713804;43344.566554334444;43384;43394.56605433945;43435.34846977298;8176.1006289308125;8547.487150770958;8745.387822852403;10268.127209187229;10492.842607360857;10246.53890574926;10351.430671313075;10357.171426285917;10365.533550990223;10367.274290799647;10348.068673819354;10428.843567346496;10433;10434.582616695361;10439.530221140029;8395.076541580422;10747.193960452998;11040.944795276053;11044.779104417947;11048.281861679046;10346.948265258701;10453.21600879937;10463.738406539822;10466.790664186674;10481.109105725945;39247.8037609813;39793.60206397928;39833.80083099595;39836.402453963216;39848.80075599632;3808.7143464240294;3812.1994381179984;4076.7961601919787;4226.894327641803;4468.419105516295;29806;30229;30410.239744006354;33757.324853503036;33900.49149262763;4620.699654522446;4624.745638989854;4625.987695352533;4725.503822098664;4730.510297574017;289021;289330;289655;290816;291505;37641.24717505635;38538.229235415136;54553.181702274494;54897;55315;38565.61434385677;38648.80675596604;38753.22493550113;38879.41680874789;38951.80524097361;13954.302284885918;16504.917475412545;16808.91595542039;16809.495715128567;16817.579560511083;13987.860121398655;14210.21843798601;14213.43146274158;14216.857831421761;14240.643983900485;8980.416272942239;9034.412763170372;9034.63861445548;9090.090990900857;9104.13510716481;3415.9658403416147;3475.721942244614;3533.699635531009;3536.0629433200224;3545.2023294758988;1040.1938497664219;1112.6884472347756;1122.2256642916361;1162.1574358589955;1238.8327575777155;29193.85403072971;29383.412331753247;29444.705552944626;30069.39861202764;30411;1148.2593727046176;1207.6739280394245;1232.6918270432393;1233.6360773571819;1295.6890346316816;15543.18161369979;16397.508074757538;16715.41496047657;16738.916305418395;17000.319987200375;491673;496158;499456;499856;500448;60689.393106069256;60752.392476074674;61220.69389653023;61391.693041534505;61436.69281653563;1483.9629009274854;1492.9626759331104;1500.6173425776358;1502.9549113526612;1533.4709525213784;29882.50568640804;32881.34237315288;34010;34324;34602.65397345994;49729.75135124301;50548;50741.492585073676;50778;50826.74586627043;369848;378371;378440;378772;379158;26959.86520067387;29135;29676.703232967393;29935.401291974475;30500.847495763268;43338;43454.56545434632;43642.56357436385;44101;44696.55303446924;37090;37177;37232.81383593065;37358.62641373552;37624.43563346497;38729.806350968065;38953.610463895;39870.20259594734;40237.798811005756;40599.3910091343;36597;37094.62905370912;37110;37203.6279637211;41674.791626041675;35088.24334752156;35795.82102089473;36273.63726362808;36517.45223821698;36739.26521469502;28003.71996280011;28077.57883631706;28189.718102818708;28462.288442789097;28472.572911405932 20:02:19 INFO - PROCESS | 30896 | |2;jquery.html;423.46854697354814;424.7621332054049;427.39096787078427;436.8056214984332;441.668748438671;18473.63052738946;19114.713279300788;19159.808401915976;19595.118219680113;20411.387658370237;12225.266484010966;12486.875131248686;13257.867421325807;20129.29547465839;20140.697889531668;5200.5059519345605;5239.816606418785;5343.412224655285;5358.008768377863;5383.865403364908;5278.6568873023325;5285;5310.123829568117;5311.521963023327;5317.46825317469;5291.444398338158;5323.840284791462;5323.973380133094;5333.120035194208;5333.973330133364;5181.1710126379785;5242.161254199329;5276.050310944029;5304.36347638282;5362.35651721794;5152.098382782998;5162.948370516285;5163.251328557376;5164.664296820694;5180.0157969985585;13584.796228056586;14068.577942661737;14078.014538982174;14078.71842563143;14091.154530728189;2365.8343915925893;2429.161939130997;2446.351716795033;2949.3953739483354;3115.5949726535405;9837.803243935154;9931.404115753077;10152.746181345452;10579.153667706641;10613.787724245472;1968.3406058970263;2040.673492241249;2090.299749583876;2097.4232086176426;2176.086043861582;60786.696066519384;61004.694976524836;72966.63516682436;75726;77912.61043694745;10899.237053406345;11050.226484146033;11079.72300692489;11119.55521779136;11162.832557511643;15238.923805380902;15281;15371.769423458658;15376.384944602314;15392.923035384976;8537.402381833212;8554.486730796172;8587.398882078194;8597.699080532151;8656.48061116335;8478.23695867375;8519.74440766778;8547.35894807892;8575.699850505202;8579.227869491775;4870.366852309177;4912.336834527293;4935.383077115361;4945.085159245551;4984.40187177541;2077.4494758888904;2090.4042347930767;2129.648607979666;2142.9035693393835;2164.9891750541146;992.2359782967075;1037.5590374090982;1040.604570263295;1040.8022475729588;1048.6224959014748;19024.239030438905;19406.2237510498;19718.507037324183;19737.60524789496;19760.110795014258;1026.3944272879037;1046.1421634259834;1058.142904247562;1081.1134869407167;1128.0918860317358;9732.70801875945;10828.729281768019;11000.669979900616;11131.053860421955;11140.33158010522;569795;587468;598761;599201;635046;83284.58357708172;90877.54561227151;93124.53437732904;96303.51848240713;96948.51525742467;1141.2581821815886;1169.1173164260929;1174.2426135142955;1188.3167178872184;1188.4592510407745;17679.558011049314;17933.05402076538;18257.908710456362;18290.634187316446;18638.440846774618;40760.59239407568;41052.38421423621;42506.78746606371;42825;42984.78507607442;60356.39643603508;66325.66837165783;66448;66549.33450665431;66671.66664166648;8719.91280087191;8816.426932249384;8816.426932249384;8958.014618392102;8976.955115224382;12412.441440135035;13060.085793994329;13173.93413032967;13424.664383390493;13539.255340956342;11842.881571184522;11861.703457413634;12173.20874143178;12326.938365308117;12406.193597416139;11895.643130706092;12099.75800484003;12151.939240303742;12288.938555307166;12577.182483138567;12353.197042192229;12588.11883168206;12596.370181491073;12639.304838233618;12780.1053926228;9162.862557061517;9235.676751313671;9294.163525282756;9358.4384936904;9373.812523749622;11815.40922953866;12606.55877044299;12612.43244054038;12690.238585684889;12754.61736147917 20:02:19 INFO - PROCESS | 30896 | |3;mootools.html;1345.74430858137;1497.0418931883594;1532.494276888627;1700.2094026277778;1825.8721889467733;8135.755927322182;8367.2469477747;8372.41393102483;8377.078521362653;8393.53835539045;8222.547759873205;8383.664653413856;8391.790205244872;8401.663933442655;8402.201790829862;2065.1429656692453;2266.875321857297;2324;2365.9881700591473;2366.526694661066;2424.8908799103992;2426.162973774045;2429.8056155507606;2432.8540287582714;2435.5737745894485;2278.8632682039047;2339.099446713019;2340.8595484270913;2341.812654987597;2346.038124369009;2061.690746388039;2326.255598208574;2361.669366288721;2373.6914201153913;2376.6316220985773;2346.0615753698485;2351.259353303704;2391.5934291170543;2392.0910054179476;2392.545416370884;8119.75640730779;8163.877541836877;8216.21945915137;8218.794530136734;8220.136885626984;5109.591232701375;5233.345831771028;5239.842804715865;5248.0553500369915;5263.421023687391;3490.0576844252164;3514.2444374459615;3539.026767638894;3548.538689970287;3552.8934131976084;1128.1482480727082;1131.1064259235195;1164.749578840545;1164.7845148647527;1219.7560487902456;11665.066794656406;11846.111541634325;11872.287662740264;11899.345535995517;11905.404729763477;4496.100779844044;4502.257127573979;4579.038401935564;4580.725156490621;4645.070985802853;10234.437105959094;10253.58985640566;10254.6410875619;10269.794604107876;10271.332363396356;4663.253879379351;5262.02652509287;5287.629865909349;5287.973560132252;5290.947090529045;4311.202427550913;4634.907301853944;4644.2801365788355;4709.788059537329;4715.599174070242;4022.5719869445925;4063;4098.262312783668;4188.6230239278;4189.664826813848;1313.5468263449095;1330.8003799430162;1343.6775173958179;1344.8924086073287;1345.773197927118;922.3727865051695;939.9378702066621;1015.8425444056184;1025.7486915705551;1033.5452400943561;6009.399060093956;6047.727852246571;6096.817095487142;6153.261608606996;6153.569250152446;403.4835410674283;404.0686218266923;410.7186577194631;1108.3903852880883;1119.2333251722434;4094.0992981544014;4094.815733292009;4096.426500289962;4122.814473348646;4150.107726838744;10155.949220253999;10375.221858360654;10475;10480.318779279323;10499.370037797604;10317.48412579368;10357.326773759682;10366;10366.792664146826;10405.687829365132;7926.603669816486;7942.563159026309;8095.150009249061;8112.594370281462;8203.671853125808;5602.775888964559;5896.439838215363;5899.557533185114;5931.851703707442;6059.303180134341;9281.257499400166;9396;9448.527573621428;9597.664081757104;9610.51947402641;9372.1565059145;9499.762505937408;9708.75728106803;9726.562304696447;9930.751731206488;6591.34086591337;6974.58152510851;7214.494985350975;7364.3372096511575;7471.402287816853;8024.2376974187355;8119.066307374491;8147.266745992889;8170.223828736498;8185.467944583583;6971.5468494547695;7135.357817796424;7167.498275120692;7249.311315425026;7281.708731650675;7203.243659415895;7255.419566434778;7256.2018178001435;7311.232320606472;7354.96322518384;6981;6985.126859142607;7026.086608740831;7035.859282814417;7043.788686339418;4978;5071.467495912876;5071.847844564669;5085.4406015337545;5099.515546023122;5198.818041368534;5213.869653258699;5237.057329680694;5247.265382846481;5314.070037743457 20:02:19 INFO - PROCESS | 30896 | |4;prototype.html;336.6683816440806;339.3078120633906;343.01597784195644;351.64659517185225;356.97322700797446;6084.817455476332;6261.3738626137365;6279.748810047604;6308.495320374371;6318.652474113922;6321.178246827917;6337.207849018872;6341.682915854212;6359.459445947088;6370.872582548346;4810.735409552473;4813.735244561548;4815.253635686457;4817.735024573647;4819.7590120494015;4660.254359302512;4702.106599746055;4815.422149342084;4822.035592881421;4834.105690447279;4753.857384278477;4758.095961767271;4761.166795810736;4762.880927976811;4769.046190761844;4739.976300118495;4751.64362672801;4752.287156926454;4758.072175925713;4765.952340476586;4157.397177409259;4161.375793630949;4163.729357591777;4182.309918863384;4183.142455796555;6059.66671833049;6073.453389194994;6083.756649734005;6086.330503644595;6104.236970378703;5351.839444816662;5526.889462210774;5544.528715059225;5565.30433695788;5568.610197286192;6653.002049692536;6667.233268174174;6667.299933506961;6671.966640166768;6693.6318502482345;4521.208788462006;4550;4554.567316104964;4562.247229207177;4562.520935301779;6928;7003.439724822002;7014.088168538057;7019.227884932653;7073.540219885691;4647.814087436533;4700.059988002413;4705.694129881546;4711.693739906895;4712.057588482317;4454.621357184676;4757.857264282077;4762.6189904808225;4768.189407800683;4769.809207631656;5350.8127215547265;5384.6769193848495;5388.272583201296;5398.595105367113;5398.973005135028;6666.166729158856;6698.732050718014;6714.093597364391;6714.328567143247;6729.764458243938;1561.2271925397001;1585.9841401586068;1600.2638786158266;1600.8639265662316;1605.727026405514;1042.1766804224578;1049.7533079726259;1067.013012963006;1068.3643232276784;1078.3637653784306;6328.208973878265;6366.140571022946;6402.679866006681;6434.356564343529;6436.35636436362;6858.348456896587;6859.5541289816;6863.416609588241;6876.965615171892;6890.379865812;6437.034444833313;6437.0988061671405;6443.130177425987;6445.742170313229;6449.355064493513;3636.1818590816856;3695.6858667013603;3699.7040236780995;3702.6852717518773;3702.703783697352;6957.588940496723;7032.5428847125795;7110.57336559808;7111.431085513146;7119.96440017807;6989.33601307875;7023.7892863213165;7027.402670772939;7032.5428847125795;7035.366816986393;7100.644967751592;7102.822429439202;7103.680334384965;7106.431485481149;7109.253528379549;6837.521373503807;6842.247352791289;6847.315268473113;6851.794446166623;6859;6620.3710647488415;6726.159230096238;6842.93157068423;6851.794446166623;6905.827354316182;7253.347198752138;7268.781936541912;7272.41820654357;7275.090613673291;7287.052683151369;4703.576678098988;4754.168020596451;4760.452547956891;4761.190597598347;4761.714297142044;6676.232233293039;6853.417459515997;6974.58152510851;7045.894311585228;7053.823654408681;6607;6761.86476270462;6774.254831968578;6780.898286525608;6791.117154770046;6708.798736037927;6749.561278517077;6755.459563234831;6758.594484330956;6766.729330826909;6617.239017513048;6626.56927299724;6639.468842492685;6639.966800165968;6654.567453115532;6599.60402375859;6784.423324017514;6786.660666966731;6808.353206445379;6822.931770682429;6606.8017959461295;6618.238902526271;6635.701393437404;6638.20341559016;6654.83362915931 20:02:19 INFO - PROCESS | 30896 | |5;yui.html;903.7288813355992;905.239598737061;907.1790030022831;910.3218102513629;929.5584597316272;14782.482613108543;14852.925735371322;15193.620159496018;15222.467213647524;15227.92386038071;14150.858491415083;14210.360533775978;14232.430702771902;14234.928825355884;14257.857421425782;742.5730205132044;846.0355195077616;852.21170417364;853.9402241843073;876.6581033396981;864.6843901975765;866.2377108144824;867.9305655547572;868.1882439918664;868.3227082875368;912.7216199059284;916.1754421021101;917.0920788419484;917.1149840404042;917.2936838634248;784.9921500785005;905.0225756183306;916.3036092569629;917.4541148016953;921.9907800922039;672.6334147889412;673.3939454490949;673.8315421144714;674.4941294029478;674.6323253826677;14952.700945981129;14966.850331496655;14969.625759356104;14983.775243371249;15002.69994600102;15048.097114173075;15396.307166177548;15402.614934626612;15504.534863954099;15520.456784012618;11801.94099029508;11953.342566158944;11958.461869215906;12212.694682632917;12261.877381226162;4014.859479918218;4047.4738284023183;4061.5532291447917;4065.125997910434;4187.748735075875;57495.71252143754;57521.424785752024;58316.41683583152;58505.414945850425;58628.7068564663;11354.26197297173;11566.768664626661;11675.182737208484;11759.588414405454;11779.646610601696;21683.241086561895;21685.13259469635;21735.13059477603;21755.34733957984;21756;8626.698065567674;8670.436421632574;8919.063498332582;8928;9003.864942025875;5030.195168772979;5133.25567792668;5150.742462876841;5180.119379705459;5190.8183213587345;3557.3596752584785;3602.9279414411567;3610.1696609779897;3614.548181477315;3620.9275814483562;632.1718548701216;634.755619086655;643.3662842100528;688.2566827825935;708.1572928215408;719.3813320544327;722.5556282886092;739.3161325773638;768.9846203076019;776.704852156177;9374.531273436301;9436.669716559887;9660.227181825438;9663.951680241695;9682.467464289532;735.4116706634671;758.0259366713747;758.3591864874172;761.1285078584989;777.8133248020434;4429.357743127293;4464.04023135021;4487.416635837386;4545.454545454567;4624.421947256593;69194.65402672955;70165.29834701588;70240.64879675671;70250;71014.64492677503;58197.41802582004;60273.69863150744;60341;60516.69741651264;61075.38924610697;53984.73007634937;54245;54370.184447233325;55065.9999999992;56347.43652563422;8993.460392376479;9019.14318139802;9121.133492318218;9132.771680708036;9141.131592498701;37952.810235948644;38074;38558.61441385662;40434.39348409717;40863.7956810214;49072.75463622659;49364.25953610627;49941.500584993686;51292;53375;12155.45300461499;12156.088293377856;12167.574134905235;12367;12414.255144691348;12872.088462092464;12888.935555322163;12949.287789171309;13417.127886687724;13559.186448813103;10484.266101373136;12821.679458013625;12887.986202738904;13619.684653609109;13734.175949443066;12594.370281485706;12648.873511265137;12849.486020559072;12963.935180324415;13278.867211327763;12346.753064938472;12745.17156384832;12991.805122922975;13128.934355328161;13179;10543.42011189392;10652.795734888256;10773;10779.407132607781;10873.619423320146;11081.889181108085;11103.888961110608;11194.944025280147;11352.375619340684;11427.542898283975 20:02:19 INFO - PROCESS | 30896 | __end_tp_report 20:02:19 INFO - PROCESS | 30896 | __start_cc_report 20:02:19 INFO - PROCESS | 30896 | _x_x_mozilla_cycle_collect,879 20:02:19 INFO - PROCESS | 30896 | __end_cc_report 20:02:19 INFO - PROCESS | 30896 | __startTimestamp1462762939592__endTimestamp 20:02:19 INFO - PROCESS | 30896 | 20:02:19 INFO - PROCESS | 30896 | ------- Summary: start ------- 20:02:19 INFO - PROCESS | 30896 | Number of tests: 6 20:02:19 INFO - PROCESS | 30896 | 20:02:19 INFO - PROCESS | 30896 | [#0] dojo.html Cycles:165 Average:5527.04 Median:5698.63 stddev:603.87 (10.6%) stddev-sans-first:580.93 20:02:19 INFO - PROCESS | 30896 | Values: 3343.6 3389.8 3405.6 3411.4 3420.7 5596.4 5605.2 5608.1 5623.0 5625.4 5631.7 5639.0 5650.8 5662.6 5667.5 4931.0 5005.4 5140.7 5177.6 5273.1 5007.9 5097.9 5131.3 5151.9 5162.7 5097.8 5101.1 5110.1 5118.1 5128.2 5066.5 5079.1 5141.3 5144.6 5193.4 4988.8 5039.1 5101.6 5112.5 5125.1 5362.8 5383.8 5393.8 5414.1 5441.3 5754.9 5860.7 5866.3 5868.4 5868.6 5965.2 6019.7 6021.0 6026.8 6034.8 5596.3 5598.6 5609.5 5612.7 5614.0 5995.8 6013.3 6063.4 6082.3 6125.8 5846.1 5847.9 5848.3 5857.7 5861.6 5921.1 5932.6 5936.0 5938.0 5939.7 5775.8 5823.4 5877.5 5907.4 5908.7 5877.9 5930.8 5932.2 5937.4 5950.2 4514.0 4516.4 4519.0 4519.6 4542.7 3931.3 4052.3 4057.4 4107.1 4138.0 5588.3 5589.8 5593.6 5598.9 5599.8 5918.6 5924.8 5928.4 5929.9 5932.1 5521.6 5560.8 5605.1 5637.9 5646.1 5046.2 5055.9 5057.5 5062.7 5089.4 5905.3 6056.7 6095.4 6095.8 6107.2 6045.2 6069.4 6070.9 6092.3 6096.1 6230.3 6264.7 6265.6 6267.7 6276.1 5720.6 5896.3 5933.0 5950.5 5971.9 5967.8 5968.0 5970.0 5980.6 6000.7 5764.7 5776.2 5782.4 5788.2 5799.2 5695.1 5754.9 5767.9 5849.6 5930.8 5648.4 5672.9 5674.3 5683.3 5698.6 5744.9 5782.1 5784.5 5786.1 5786.9 5544.4 5653.2 5702.9 5715.7 5738.8 20:02:19 INFO - PROCESS | 30896 | 20:02:19 INFO - PROCESS | 30896 | [#1] ext.html Cycles:180 Average:54274.02 Median:36557.23 stddev:105228.43 (287.8%) stddev-sans-first:105446.65 20:02:19 INFO - PROCESS | 30896 | Values: 667.4 674.2 679.0 735.7 757.8 32889.7 37925.8 38722.2 38791.4 38802.8 42845.1 43344.6 43384.0 43394.6 43435.3 8176.1 8547.5 8745.4 10268.1 10492.8 10246.5 10351.4 10357.2 10365.5 10367.3 10348.1 10428.8 10433.0 10434.6 10439.5 8395.1 10747.2 11040.9 11044.8 11048.3 10346.9 10453.2 10463.7 10466.8 10481.1 39247.8 39793.6 39833.8 39836.4 39848.8 3808.7 3812.2 4076.8 4226.9 4468.4 29806.0 30229.0 30410.2 33757.3 33900.5 4620.7 4624.7 4626.0 4725.5 4730.5 289021.0 289330.0 289655.0 290816.0 291505.0 37641.2 38538.2 54553.2 54897.0 55315.0 38565.6 38648.8 38753.2 38879.4 38951.8 13954.3 16504.9 16808.9 16809.5 16817.6 13987.9 14210.2 14213.4 14216.9 14240.6 8980.4 9034.4 9034.6 9090.1 9104.1 3416.0 3475.7 3533.7 3536.1 3545.2 1040.2 1112.7 1122.2 1162.2 1238.8 29193.9 29383.4 29444.7 30069.4 30411.0 1148.3 1207.7 1232.7 1233.6 1295.7 15543.2 16397.5 16715.4 16738.9 17000.3 491673.0 496158.0 499456.0 499856.0 500448.0 60689.4 60752.4 61220.7 61391.7 61436.7 1484.0 1493.0 1500.6 1503.0 1533.5 29882.5 32881.3 34010.0 34324.0 34602.7 49729.8 50548.0 50741.5 50778.0 50826.7 369848.0 378371.0 378440.0 378772.0 379158.0 26959.9 29135.0 29676.7 29935.4 30500.8 43338.0 43454.6 43642.6 44101.0 44696.6 37090.0 37177.0 37232.8 37358.6 37624.4 38729.8 38953.6 39870.2 40237.8 40599.4 36597.0 37094.6 37110.0 37203.6 41674.8 35088.2 35795.8 36273.6 36517.5 36739.3 28003.7 28077.6 28189.7 28462.3 28472.6 20:02:19 INFO - PROCESS | 30896 | 20:02:19 INFO - PROCESS | 30896 | [#2] jquery.html Cycles:180 Average:31690.22 Median:2270.96 stddev:98141.64 (4321.6%) stddev-sans-first:98388.87 20:02:19 INFO - PROCESS | 30896 | Values: 423.5 424.8 427.4 436.8 441.7 18473.6 19114.7 19159.8 19595.1 20411.4 12225.3 12486.9 13257.9 20129.3 20140.7 5200.5 5239.8 5343.4 5358.0 5383.9 5278.7 5285.0 5310.1 5311.5 5317.5 5291.4 5323.8 5324.0 5333.1 5334.0 5181.2 5242.2 5276.1 5304.4 5362.4 5152.1 5162.9 5163.3 5164.7 5180.0 13584.8 14068.6 14078.0 14078.7 14091.2 2365.8 2429.2 2446.4 2949.4 3115.6 9837.8 9931.4 10152.7 10579.2 10613.8 1968.3 2040.7 2090.3 2097.4 2176.1 60786.7 61004.7 72966.6 75726.0 77912.6 10899.2 11050.2 11079.7 11119.6 11162.8 15238.9 15281.0 15371.8 15376.4 15392.9 8537.4 8554.5 8587.4 8597.7 8656.5 8478.2 8519.7 8547.4 8575.7 8579.2 4870.4 4912.3 4935.4 4945.1 4984.4 2077.4 2090.4 2129.6 2142.9 2165.0 992.2 1037.6 1040.6 1040.8 1048.6 19024.2 19406.2 19718.5 19737.6 19760.1 1026.4 1046.1 1058.1 1081.1 1128.1 9732.7 10828.7 11000.7 11131.1 11140.3 569795.0 587468.0 598761.0 599201.0 635046.0 83284.6 90877.5 93124.5 96303.5 96948.5 1141.3 1169.1 1174.2 1188.3 1188.5 17679.6 17933.1 18257.9 18290.6 18638.4 40760.6 41052.4 42506.8 42825.0 42984.8 60356.4 66325.7 66448.0 66549.3 66671.7 8719.9 8816.4 8816.4 8958.0 8977.0 12412.4 13060.1 13173.9 13424.7 13539.3 11842.9 11861.7 12173.2 12326.9 12406.2 11895.6 12099.8 12151.9 12288.9 12577.2 12353.2 12588.1 12596.4 12639.3 12780.1 9162.9 9235.7 9294.2 9358.4 9373.8 11815.4 12606.6 12612.4 12690.2 12754.6 20:02:19 INFO - PROCESS | 30896 | 20:02:19 INFO - PROCESS | 30896 | [#3] mootools.html Cycles:180 Average:5628.89 Median:4654.16 stddev:3110.00 (66.8%) stddev-sans-first:3102.07 20:02:19 INFO - PROCESS | 30896 | Values: 1345.7 1497.0 1532.5 1700.2 1825.9 8135.8 8367.2 8372.4 8377.1 8393.5 8222.5 8383.7 8391.8 8401.7 8402.2 2065.1 2266.9 2324.0 2366.0 2366.5 2424.9 2426.2 2429.8 2432.9 2435.6 2278.9 2339.1 2340.9 2341.8 2346.0 2061.7 2326.3 2361.7 2373.7 2376.6 2346.1 2351.3 2391.6 2392.1 2392.5 8119.8 8163.9 8216.2 8218.8 8220.1 5109.6 5233.3 5239.8 5248.1 5263.4 3490.1 3514.2 3539.0 3548.5 3552.9 1128.1 1131.1 1164.7 1164.8 1219.8 11665.1 11846.1 11872.3 11899.3 11905.4 4496.1 4502.3 4579.0 4580.7 4645.1 10234.4 10253.6 10254.6 10269.8 10271.3 4663.3 5262.0 5287.6 5288.0 5290.9 4311.2 4634.9 4644.3 4709.8 4715.6 4022.6 4063.0 4098.3 4188.6 4189.7 1313.5 1330.8 1343.7 1344.9 1345.8 922.4 939.9 1015.8 1025.7 1033.5 6009.4 6047.7 6096.8 6153.3 6153.6 403.5 404.1 410.7 1108.4 1119.2 4094.1 4094.8 4096.4 4122.8 4150.1 10155.9 10375.2 10475.0 10480.3 10499.4 10317.5 10357.3 10366.0 10366.8 10405.7 7926.6 7942.6 8095.2 8112.6 8203.7 5602.8 5896.4 5899.6 5931.9 6059.3 9281.3 9396.0 9448.5 9597.7 9610.5 9372.2 9499.8 9708.8 9726.6 9930.8 6591.3 6974.6 7214.5 7364.3 7471.4 8024.2 8119.1 8147.3 8170.2 8185.5 6971.5 7135.4 7167.5 7249.3 7281.7 7203.2 7255.4 7256.2 7311.2 7355.0 6981.0 6985.1 7026.1 7035.9 7043.8 4978.0 5071.5 5071.8 5085.4 5099.5 5198.8 5213.9 5237.1 5247.3 5314.1 20:02:19 INFO - PROCESS | 30896 | 20:02:19 INFO - PROCESS | 30896 | [#4] prototype.html Cycles:180 Average:5579.16 Median:6368.51 stddev:1711.44 (26.9%) stddev-sans-first:1670.40 20:02:19 INFO - PROCESS | 30896 | Values: 336.7 339.3 343.0 351.6 357.0 6084.8 6261.4 6279.7 6308.5 6318.7 6321.2 6337.2 6341.7 6359.5 6370.9 4810.7 4813.7 4815.3 4817.7 4819.8 4660.3 4702.1 4815.4 4822.0 4834.1 4753.9 4758.1 4761.2 4762.9 4769.0 4740.0 4751.6 4752.3 4758.1 4766.0 4157.4 4161.4 4163.7 4182.3 4183.1 6059.7 6073.5 6083.8 6086.3 6104.2 5351.8 5526.9 5544.5 5565.3 5568.6 6653.0 6667.2 6667.3 6672.0 6693.6 4521.2 4550.0 4554.6 4562.2 4562.5 6928.0 7003.4 7014.1 7019.2 7073.5 4647.8 4700.1 4705.7 4711.7 4712.1 4454.6 4757.9 4762.6 4768.2 4769.8 5350.8 5384.7 5388.3 5398.6 5399.0 6666.2 6698.7 6714.1 6714.3 6729.8 1561.2 1586.0 1600.3 1600.9 1605.7 1042.2 1049.8 1067.0 1068.4 1078.4 6328.2 6366.1 6402.7 6434.4 6436.4 6858.3 6859.6 6863.4 6877.0 6890.4 6437.0 6437.1 6443.1 6445.7 6449.4 3636.2 3695.7 3699.7 3702.7 3702.7 6957.6 7032.5 7110.6 7111.4 7120.0 6989.3 7023.8 7027.4 7032.5 7035.4 7100.6 7102.8 7103.7 7106.4 7109.3 6837.5 6842.2 6847.3 6851.8 6859.0 6620.4 6726.2 6842.9 6851.8 6905.8 7253.3 7268.8 7272.4 7275.1 7287.1 4703.6 4754.2 4760.5 4761.2 4761.7 6676.2 6853.4 6974.6 7045.9 7053.8 6607.0 6761.9 6774.3 6780.9 6791.1 6708.8 6749.6 6755.5 6758.6 6766.7 6617.2 6626.6 6639.5 6640.0 6654.6 6599.6 6784.4 6786.7 6808.4 6822.9 6606.8 6618.2 6635.7 6638.2 6654.8 20:02:19 INFO - PROCESS | 30896 | 20:02:19 INFO - PROCESS | 30896 | [#5] yui.html Cycles:180 Average:15994.51 Median:49218.51 stddev:18937.61 (38.5%) stddev-sans-first:18956.83 20:02:19 INFO - PROCESS | 30896 | Values: 903.7 905.2 907.2 910.3 929.6 14782.5 14852.9 15193.6 15222.5 15227.9 14150.9 14210.4 14232.4 14234.9 14257.9 742.6 846.0 852.2 853.9 876.7 864.7 866.2 867.9 868.2 868.3 912.7 916.2 917.1 917.1 917.3 785.0 905.0 916.3 917.5 922.0 672.6 673.4 673.8 674.5 674.6 14952.7 14966.9 14969.6 14983.8 15002.7 15048.1 15396.3 15402.6 15504.5 15520.5 11801.9 11953.3 11958.5 12212.7 12261.9 4014.9 4047.5 4061.6 4065.1 4187.7 57495.7 57521.4 58316.4 58505.4 58628.7 11354.3 11566.8 11675.2 11759.6 11779.6 21683.2 21685.1 21735.1 21755.3 21756.0 8626.7 8670.4 8919.1 8928.0 9003.9 5030.2 5133.3 5150.7 5180.1 5190.8 3557.4 3602.9 3610.2 3614.5 3620.9 632.2 634.8 643.4 688.3 708.2 719.4 722.6 739.3 769.0 776.7 9374.5 9436.7 9660.2 9664.0 9682.5 735.4 758.0 758.4 761.1 777.8 4429.4 4464.0 4487.4 4545.5 4624.4 69194.7 70165.3 70240.6 70250.0 71014.6 58197.4 60273.7 60341.0 60516.7 61075.4 53984.7 54245.0 54370.2 55066.0 56347.4 8993.5 9019.1 9121.1 9132.8 9141.1 37952.8 38074.0 38558.6 40434.4 40863.8 49072.8 49364.3 49941.5 51292.0 53375.0 12155.5 12156.1 12167.6 12367.0 12414.3 12872.1 12888.9 12949.3 13417.1 13559.2 10484.3 12821.7 12888.0 13619.7 13734.2 12594.4 12648.9 12849.5 12963.9 13278.9 12346.8 12745.2 12991.8 13128.9 13179.0 10543.4 10652.8 10773.0 10779.4 10873.6 11081.9 11103.9 11194.9 11352.4 11427.5 20:02:19 INFO - PROCESS | 30896 | -------- Summary: end -------- 20:02:19 INFO - PROCESS | 30896 | 20:02:20 INFO - TEST-INFO | 30896: exit 0 20:02:20 INFO - TEST-OK | dromaeo_css | took 1112097ms 20:02:20 INFO - TEST-START | kraken 20:02:20 INFO - operating with platform_type : linux_ 20:02:20 INFO - Initialising browser for kraken test... 20:02:20 INFO - TEST-INFO | started process 31083 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWLrepR/profile http://localhost:56722/getInfo.html) 20:02:24 INFO - PROCESS | 31083 | __metrics Screen width/height:1600/1200 20:02:24 INFO - PROCESS | 31083 | colorDepth:24 20:02:24 INFO - PROCESS | 31083 | Browser inner width/height: 1024/697 20:02:24 INFO - PROCESS | 31083 | __metrics 20:02:25 ERROR - PROCESS | 31083 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:02:26 INFO - TEST-INFO | 31083: exit 0 20:02:26 INFO - Browser initialized. 20:02:26 INFO - Running cycle 1/1 for kraken test... 20:02:26 INFO - TEST-INFO | started process 31173 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWLrepR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:02:37 INFO - PROCESS | 31173 | RSS: Main: 142409728 20:02:37 INFO - PROCESS | 31173 | 20:02:40 INFO - PROCESS | 31173 | Cycle 1(1): loaded http://localhost:56722/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56722/tests/kraken/driver.html?testName=audio-beat-detection) 20:02:41 INFO - PROCESS | 31173 | RSS: Main: 196857856 20:02:41 INFO - PROCESS | 31173 | 20:02:43 INFO - PROCESS | 31173 | Cycle 1(1): loaded http://localhost:56722/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56722/tests/kraken/driver.html?testName=audio-dft) 20:02:44 INFO - PROCESS | 31173 | RSS: Main: 182120448 20:02:44 INFO - PROCESS | 31173 | 20:02:47 INFO - PROCESS | 31173 | Cycle 1(1): loaded http://localhost:56722/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56722/tests/kraken/driver.html?testName=audio-fft) 20:02:47 INFO - PROCESS | 31173 | RSS: Main: 272609280 20:02:47 INFO - PROCESS | 31173 | 20:02:49 INFO - PROCESS | 31173 | Cycle 1(1): loaded http://localhost:56722/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56722/tests/kraken/driver.html?testName=audio-oscillator) 20:02:50 INFO - PROCESS | 31173 | RSS: Main: 178606080 20:02:50 INFO - PROCESS | 31173 | 20:02:52 INFO - PROCESS | 31173 | Cycle 1(1): loaded http://localhost:56722/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56722/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:02:53 INFO - PROCESS | 31173 | RSS: Main: 177315840 20:02:53 INFO - PROCESS | 31173 | 20:02:56 INFO - PROCESS | 31173 | Cycle 1(1): loaded http://localhost:56722/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56722/tests/kraken/driver.html?testName=imaging-darkroom) 20:02:56 INFO - PROCESS | 31173 | RSS: Main: 212332544 20:02:56 INFO - PROCESS | 31173 | 20:03:00 INFO - PROCESS | 31173 | Cycle 1(1): loaded http://localhost:56722/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56722/tests/kraken/driver.html?testName=imaging-desaturate) 20:03:00 INFO - PROCESS | 31173 | RSS: Main: 211951616 20:03:00 INFO - PROCESS | 31173 | 20:03:03 INFO - PROCESS | 31173 | Cycle 1(1): loaded http://localhost:56722/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56722/tests/kraken/driver.html?testName=json-parse-financial) 20:03:04 INFO - PROCESS | 31173 | RSS: Main: 212738048 20:03:04 INFO - PROCESS | 31173 | 20:03:05 INFO - PROCESS | 31173 | Cycle 1(1): loaded http://localhost:56722/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56722/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:03:06 INFO - PROCESS | 31173 | RSS: Main: 192958464 20:03:06 INFO - PROCESS | 31173 | 20:03:07 INFO - PROCESS | 31173 | Cycle 1(1): loaded http://localhost:56722/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56722/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:03:08 INFO - PROCESS | 31173 | RSS: Main: 196448256 20:03:08 INFO - PROCESS | 31173 | 20:03:10 INFO - PROCESS | 31173 | Cycle 1(1): loaded http://localhost:56722/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56722/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:03:11 INFO - PROCESS | 31173 | RSS: Main: 209887232 20:03:11 INFO - PROCESS | 31173 | 20:03:13 INFO - PROCESS | 31173 | Cycle 1(1): loaded http://localhost:56722/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56722/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:03:14 INFO - PROCESS | 31173 | RSS: Main: 213446656 20:03:14 INFO - PROCESS | 31173 | 20:03:16 INFO - PROCESS | 31173 | Cycle 1(1): loaded http://localhost:56722/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56722/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:03:17 INFO - PROCESS | 31173 | RSS: Main: 208977920 20:03:17 INFO - PROCESS | 31173 | 20:03:19 INFO - PROCESS | 31173 | Cycle 1(1): loaded http://localhost:56722/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56722/tests/kraken/driver.html?testName=ai-astar) 20:03:19 INFO - PROCESS | 31173 | RSS: Main: 272502784 20:03:19 INFO - PROCESS | 31173 | 20:03:19 INFO - PROCESS | 31173 | __start_tp_report 20:03:19 INFO - PROCESS | 31173 | _x_x_mozilla_page_load 20:03:19 INFO - PROCESS | 31173 | _x_x_mozilla_page_load_details 20:03:19 INFO - PROCESS | 31173 | |i|pagename|runs| 20:03:19 INFO - PROCESS | 31173 | |0;ai-astar;110;111;111;109;109;109;105;109;109;111 20:03:19 INFO - PROCESS | 31173 | |1;audio-beat-detection;156;127;152;170;132;155;155;137;187;133 20:03:19 INFO - PROCESS | 31173 | |2;audio-dft;164;160;160;160;163;160;160;163;161;161 20:03:19 INFO - PROCESS | 31173 | |3;audio-fft;75;74;74;173;80;76;77;76;153;77 20:03:19 INFO - PROCESS | 31173 | |4;audio-oscillator;95;91;146;92;94;92;146;91;91;153 20:03:19 INFO - PROCESS | 31173 | |5;imaging-gaussian-blur;116;117;116;116;117;117;117;117;116;117 20:03:19 INFO - PROCESS | 31173 | |6;imaging-darkroom;145;146;147;145;146;147;145;145;146;146 20:03:19 INFO - PROCESS | 31173 | |7;imaging-desaturate;95;96;95;97;95;95;95;95;96;95 20:03:19 INFO - PROCESS | 31173 | |8;json-parse-financial;54;55;54;55;55;56;58;77;54;54 20:03:19 INFO - PROCESS | 31173 | |9;json-stringify-tinderbox;57;58;58;63;58;58;58;57;58;59 20:03:19 INFO - PROCESS | 31173 | |10;stanford-crypto-aes;72;72;74;72;73;73;81;73;75;73 20:03:19 INFO - PROCESS | 31173 | |11;stanford-crypto-ccm;116;117;110;114;115;110;110;114;130;113 20:03:19 INFO - PROCESS | 31173 | |12;stanford-crypto-pbkdf2;164;160;164;159;166;162;162;163;157;164 20:03:19 INFO - PROCESS | 31173 | |13;stanford-crypto-sha256-iterative;65;73;65;66;65;67;68;66;65;64 20:03:19 INFO - PROCESS | 31173 | __end_tp_report 20:03:19 INFO - PROCESS | 31173 | __start_cc_report 20:03:19 INFO - PROCESS | 31173 | _x_x_mozilla_cycle_collect,1594 20:03:19 INFO - PROCESS | 31173 | __end_cc_report 20:03:19 INFO - PROCESS | 31173 | __startTimestamp1462762999296__endTimestamp 20:03:19 INFO - PROCESS | 31173 | 20:03:19 INFO - PROCESS | 31173 | ------- Summary: start ------- 20:03:19 INFO - PROCESS | 31173 | Number of tests: 14 20:03:19 INFO - PROCESS | 31173 | 20:03:19 INFO - PROCESS | 31173 | [#0] ai-astar Cycles:10 Average:109.30 Median:109.50 stddev:1.77 (1.6%) stddev-sans-first:1.86 20:03:19 INFO - PROCESS | 31173 | Values: 110.0 111.0 111.0 109.0 109.0 109.0 105.0 109.0 109.0 111.0 20:03:19 INFO - PROCESS | 31173 | 20:03:19 INFO - PROCESS | 31173 | [#1] audio-beat-detection Cycles:10 Average:150.40 Median:155.00 stddev:18.76 (12.1%) stddev-sans-first:19.79 20:03:19 INFO - PROCESS | 31173 | Values: 156.0 127.0 152.0 170.0 132.0 155.0 155.0 137.0 187.0 133.0 20:03:19 INFO - PROCESS | 31173 | 20:03:19 INFO - PROCESS | 31173 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:1.55 (1.0%) stddev-sans-first:1.27 20:03:19 INFO - PROCESS | 31173 | Values: 164.0 160.0 160.0 160.0 163.0 160.0 160.0 163.0 161.0 161.0 20:03:19 INFO - PROCESS | 31173 | 20:03:19 INFO - PROCESS | 31173 | [#3] audio-fft Cycles:10 Average:93.50 Median:76.00 stddev:36.97 (48.6%) stddev-sans-first:38.60 20:03:19 INFO - PROCESS | 31173 | Values: 75.0 74.0 74.0 173.0 80.0 76.0 77.0 76.0 153.0 77.0 20:03:19 INFO - PROCESS | 31173 | 20:03:19 INFO - PROCESS | 31173 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:91.50 stddev:27.17 (29.7%) stddev-sans-first:28.34 20:03:19 INFO - PROCESS | 31173 | Values: 95.0 91.0 146.0 92.0 94.0 92.0 146.0 91.0 91.0 153.0 20:03:19 INFO - PROCESS | 31173 | 20:03:19 INFO - PROCESS | 31173 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 20:03:19 INFO - PROCESS | 31173 | Values: 116.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 20:03:19 INFO - PROCESS | 31173 | 20:03:19 INFO - PROCESS | 31173 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 20:03:19 INFO - PROCESS | 31173 | Values: 145.0 146.0 147.0 145.0 146.0 147.0 145.0 145.0 146.0 146.0 20:03:19 INFO - PROCESS | 31173 | 20:03:19 INFO - PROCESS | 31173 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 20:03:19 INFO - PROCESS | 31173 | Values: 95.0 96.0 95.0 97.0 95.0 95.0 95.0 95.0 96.0 95.0 20:03:19 INFO - PROCESS | 31173 | 20:03:19 INFO - PROCESS | 31173 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:55.00 stddev:7.07 (12.9%) stddev-sans-first:7.40 20:03:19 INFO - PROCESS | 31173 | Values: 54.0 55.0 54.0 55.0 55.0 56.0 58.0 77.0 54.0 54.0 20:03:19 INFO - PROCESS | 31173 | 20:03:19 INFO - PROCESS | 31173 | [#9] json-stringify-tinderbox Cycles:10 Average:58.40 Median:58.00 stddev:1.71 (3.0%) stddev-sans-first:1.74 20:03:19 INFO - PROCESS | 31173 | Values: 57.0 58.0 58.0 63.0 58.0 58.0 58.0 57.0 58.0 59.0 20:03:19 INFO - PROCESS | 31173 | 20:03:19 INFO - PROCESS | 31173 | [#10] stanford-crypto-aes Cycles:10 Average:73.80 Median:73.00 stddev:2.70 (3.7%) stddev-sans-first:2.78 20:03:19 INFO - PROCESS | 31173 | Values: 72.0 72.0 74.0 72.0 73.0 73.0 81.0 73.0 75.0 73.0 20:03:19 INFO - PROCESS | 31173 | 20:03:19 INFO - PROCESS | 31173 | [#11] stanford-crypto-ccm Cycles:10 Average:114.90 Median:114.50 stddev:5.88 (5.1%) stddev-sans-first:6.22 20:03:19 INFO - PROCESS | 31173 | Values: 116.0 117.0 110.0 114.0 115.0 110.0 110.0 114.0 130.0 113.0 20:03:19 INFO - PROCESS | 31173 | 20:03:19 INFO - PROCESS | 31173 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.10 Median:163.50 stddev:2.73 (1.7%) stddev-sans-first:2.80 20:03:19 INFO - PROCESS | 31173 | Values: 164.0 160.0 164.0 159.0 166.0 162.0 162.0 163.0 157.0 164.0 20:03:19 INFO - PROCESS | 31173 | 20:03:19 INFO - PROCESS | 31173 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.00 stddev:2.59 (3.9%) stddev-sans-first:2.70 20:03:19 INFO - PROCESS | 31173 | Values: 65.0 73.0 65.0 66.0 65.0 67.0 68.0 66.0 65.0 64.0 20:03:19 INFO - PROCESS | 31173 | -------- Summary: end -------- 20:03:19 INFO - PROCESS | 31173 | 20:03:20 INFO - TEST-INFO | 31173: exit 0 20:03:20 INFO - TEST-OK | kraken | took 59973ms 20:03:20 INFO - SUITE-END | took 1172s 20:03:20 INFO - Completed test suite (00:19:32) 20:03:20 INFO - javascript benchmark 20:03:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3343.598768147822, 3389.813560254185, 3405.5743032120986, 3411.3518431498023, 3420.743444241681, 5596.384397716253, 5605.1872478490595, 5608.10270356743, 5623.0, 5625.437456254373, 5631.71841407929, 5638.984982703112, 5650.773969041234, 5662.575306851982, 5667.518260947824, 4931.038447502739, 5005.399352077738, 5140.691558506493, 5177.58579313654, 5273.103572392683, 5007.899842003158, 5097.898042039157, 5131.255967884655, 5151.922721159186, 5162.716050617215, 5097.821576244833, 5101.107306221415, 5110.080185566597, 5118.10433174193, 5128.179516249065, 5066.468020857794, 5079.060373830853, 5141.280220769077, 5144.639875208737, 5193.428722840485, 4988.800447982113, 5039.118154323016, 5101.6173786965755, 5112.488751124858, 5125.051865404912, 5362.839114826562, 5383.75773090208, 5393.83818485446, 5414.10667239905, 5441.319835020622, 5754.913676294859, 5860.677662728548, 5866.325372582165, 5868.383819698913, 5868.647881127146, 5965.194698715704, 6019.69901504923, 6021.0, 6026.78906238284, 6034.788782392639, 5596.300462442195, 5598.552115830724, 5609.523190528769, 5612.747426365782, 5613.971930140364, 5995.760169593167, 6013.278406591149, 6063.423974722395, 6082.330943596201, 6125.816225513242, 5846.093855452412, 5847.883042339129, 5848.3274423441, 5857.736401861926, 5861.589688721749, 5921.052631578927, 5932.584719069624, 5935.970320148372, 5938.0, 5939.673317967467, 5775.826725198251, 5823.417658234142, 5877.52979761618, 5907.409259074058, 5908.704564771744, 5877.9118313225335, 5930.762769489258, 5932.169496270526, 5937.406259374115, 5950.196723442366, 4513.977430112828, 4516.390287311171, 4519.0058187198765, 4519.615832654261, 4542.659300552472, 3931.312020396419, 4052.250333688277, 4057.350823868167, 4107.116969851496, 4137.97931010343, 5588.30146231721, 5589.80435684749, 5593.552515798808, 5598.86002849932, 5599.80400685974, 5918.644881307136, 5924.792632257937, 5928.407159284124, 5929.851753706105, 5932.110183472513, 5521.613487055948, 5560.77756889728, 5605.075162598126, 5637.859053523613, 5646.124850648156, 5046.243063540498, 5055.9494405055475, 5057.494250574913, 5062.696238225644, 5089.3638295213095, 5905.320888097838, 6056.666883321372, 6095.359987201368, 6095.786647467317, 6107.206063211754, 6045.153678484928, 6069.36271691466, 6070.939290607037, 6092.299385570716, 6096.055111457731, 6230.314665386894, 6264.655443950626, 6265.624062556261, 6267.717952692049, 6276.058591211355, 5720.570957178312, 5896.321922978912, 5932.9915107993, 5950.523958083257, 5971.850703732442, 5967.8209653710455, 5968.045112781934, 5969.970150149222, 5980.611260268069, 6000.669963151894, 5764.740586673526, 5776.249087618583, 5782.421757824184, 5788.21859049023, 5799.217105690678, 5695.088785794253, 5754.856128596819, 5767.9134812977, 5849.64902105875, 5930.7924222652, 5648.378678345297, 5672.943270567242, 5674.2623458950075, 5683.318001839806, 5698.629589076697, 5744.913826292525, 5782.10377391505, 5784.479396854304, 5786.07422812348, 5786.9131963019745, 5544.445555444423, 5653.152027195789, 5702.942970570407, 5715.742791574472, 5738.799142030009], "value": 5488.591303681755, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [667.4126768443772, 674.1977047313698, 678.9728410863563, 735.7204262380296, 757.7991832164474, 32889.67110328896, 37925.810370948144, 38722.225555488905, 38791.41812872809, 38802.8059859701, 42845.14309713804, 43344.566554334444, 43384.0, 43394.56605433945, 43435.34846977298, 8176.1006289308125, 8547.487150770958, 8745.387822852403, 10268.127209187229, 10492.842607360857, 10246.53890574926, 10351.430671313075, 10357.171426285917, 10365.533550990223, 10367.274290799647, 10348.068673819354, 10428.843567346496, 10433.0, 10434.582616695361, 10439.530221140029, 8395.076541580422, 10747.193960452998, 11040.944795276053, 11044.779104417947, 11048.281861679046, 10346.948265258701, 10453.21600879937, 10463.738406539822, 10466.790664186674, 10481.109105725945, 39247.8037609813, 39793.60206397928, 39833.80083099595, 39836.402453963216, 39848.80075599632, 3808.7143464240294, 3812.1994381179984, 4076.7961601919787, 4226.894327641803, 4468.419105516295, 29806.0, 30229.0, 30410.239744006354, 33757.324853503036, 33900.49149262763, 4620.699654522446, 4624.745638989854, 4625.987695352533, 4725.503822098664, 4730.510297574017, 289021.0, 289330.0, 289655.0, 290816.0, 291505.0, 37641.24717505635, 38538.229235415136, 54553.181702274494, 54897.0, 55315.0, 38565.61434385677, 38648.80675596604, 38753.22493550113, 38879.41680874789, 38951.80524097361, 13954.302284885918, 16504.917475412545, 16808.91595542039, 16809.495715128567, 16817.579560511083, 13987.860121398655, 14210.21843798601, 14213.43146274158, 14216.857831421761, 14240.643983900485, 8980.416272942239, 9034.412763170372, 9034.63861445548, 9090.090990900857, 9104.13510716481, 3415.9658403416147, 3475.721942244614, 3533.699635531009, 3536.0629433200224, 3545.2023294758988, 1040.1938497664219, 1112.6884472347756, 1122.2256642916361, 1162.1574358589955, 1238.8327575777155, 29193.85403072971, 29383.412331753247, 29444.705552944626, 30069.39861202764, 30411.0, 1148.2593727046176, 1207.6739280394245, 1232.6918270432393, 1233.6360773571819, 1295.6890346316816, 15543.18161369979, 16397.508074757538, 16715.41496047657, 16738.916305418395, 17000.319987200375, 491673.0, 496158.0, 499456.0, 499856.0, 500448.0, 60689.393106069256, 60752.392476074674, 61220.69389653023, 61391.693041534505, 61436.69281653563, 1483.9629009274854, 1492.9626759331104, 1500.6173425776358, 1502.9549113526612, 1533.4709525213784, 29882.50568640804, 32881.34237315288, 34010.0, 34324.0, 34602.65397345994, 49729.75135124301, 50548.0, 50741.492585073676, 50778.0, 50826.74586627043, 369848.0, 378371.0, 378440.0, 378772.0, 379158.0, 26959.86520067387, 29135.0, 29676.703232967393, 29935.401291974475, 30500.847495763268, 43338.0, 43454.56545434632, 43642.56357436385, 44101.0, 44696.55303446924, 37090.0, 37177.0, 37232.81383593065, 37358.62641373552, 37624.43563346497, 38729.806350968065, 38953.610463895, 39870.20259594734, 40237.798811005756, 40599.3910091343, 36597.0, 37094.62905370912, 37110.0, 37203.6279637211, 41674.791626041675, 35088.24334752156, 35795.82102089473, 36273.63726362808, 36517.45223821698, 36739.26521469502, 28003.71996280011, 28077.57883631706, 28189.718102818708, 28462.288442789097, 28472.572911405932], "value": 19232.502874903574, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [423.46854697354814, 424.7621332054049, 427.39096787078427, 436.8056214984332, 441.668748438671, 18473.63052738946, 19114.713279300788, 19159.808401915976, 19595.118219680113, 20411.387658370237, 12225.266484010966, 12486.875131248686, 13257.867421325807, 20129.29547465839, 20140.697889531668, 5200.5059519345605, 5239.816606418785, 5343.412224655285, 5358.008768377863, 5383.865403364908, 5278.6568873023325, 5285.0, 5310.123829568117, 5311.521963023327, 5317.46825317469, 5291.444398338158, 5323.840284791462, 5323.973380133094, 5333.120035194208, 5333.973330133364, 5181.1710126379785, 5242.161254199329, 5276.050310944029, 5304.36347638282, 5362.35651721794, 5152.098382782998, 5162.948370516285, 5163.251328557376, 5164.664296820694, 5180.0157969985585, 13584.796228056586, 14068.577942661737, 14078.014538982174, 14078.71842563143, 14091.154530728189, 2365.8343915925893, 2429.161939130997, 2446.351716795033, 2949.3953739483354, 3115.5949726535405, 9837.803243935154, 9931.404115753077, 10152.746181345452, 10579.153667706641, 10613.787724245472, 1968.3406058970263, 2040.673492241249, 2090.299749583876, 2097.4232086176426, 2176.086043861582, 60786.696066519384, 61004.694976524836, 72966.63516682436, 75726.0, 77912.61043694745, 10899.237053406345, 11050.226484146033, 11079.72300692489, 11119.55521779136, 11162.832557511643, 15238.923805380902, 15281.0, 15371.769423458658, 15376.384944602314, 15392.923035384976, 8537.402381833212, 8554.486730796172, 8587.398882078194, 8597.699080532151, 8656.48061116335, 8478.23695867375, 8519.74440766778, 8547.35894807892, 8575.699850505202, 8579.227869491775, 4870.366852309177, 4912.336834527293, 4935.383077115361, 4945.085159245551, 4984.40187177541, 2077.4494758888904, 2090.4042347930767, 2129.648607979666, 2142.9035693393835, 2164.9891750541146, 992.2359782967075, 1037.5590374090982, 1040.604570263295, 1040.8022475729588, 1048.6224959014748, 19024.239030438905, 19406.2237510498, 19718.507037324183, 19737.60524789496, 19760.110795014258, 1026.3944272879037, 1046.1421634259834, 1058.142904247562, 1081.1134869407167, 1128.0918860317358, 9732.70801875945, 10828.729281768019, 11000.669979900616, 11131.053860421955, 11140.33158010522, 569795.0, 587468.0, 598761.0, 599201.0, 635046.0, 83284.58357708172, 90877.54561227151, 93124.53437732904, 96303.51848240713, 96948.51525742467, 1141.2581821815886, 1169.1173164260929, 1174.2426135142955, 1188.3167178872184, 1188.4592510407745, 17679.558011049314, 17933.05402076538, 18257.908710456362, 18290.634187316446, 18638.440846774618, 40760.59239407568, 41052.38421423621, 42506.78746606371, 42825.0, 42984.78507607442, 60356.39643603508, 66325.66837165783, 66448.0, 66549.33450665431, 66671.66664166648, 8719.91280087191, 8816.426932249384, 8816.426932249384, 8958.014618392102, 8976.955115224382, 12412.441440135035, 13060.085793994329, 13173.93413032967, 13424.664383390493, 13539.255340956342, 11842.881571184522, 11861.703457413634, 12173.20874143178, 12326.938365308117, 12406.193597416139, 11895.643130706092, 12099.75800484003, 12151.939240303742, 12288.938555307166, 12577.182483138567, 12353.197042192229, 12588.11883168206, 12596.370181491073, 12639.304838233618, 12780.1053926228, 9162.862557061517, 9235.676751313671, 9294.163525282756, 9358.4384936904, 9373.812523749622, 11815.40922953866, 12606.55877044299, 12612.43244054038, 12690.238585684889, 12754.61736147917], "value": 9293.569457334685, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1345.74430858137, 1497.0418931883594, 1532.494276888627, 1700.2094026277778, 1825.8721889467733, 8135.755927322182, 8367.2469477747, 8372.41393102483, 8377.078521362653, 8393.53835539045, 8222.547759873205, 8383.664653413856, 8391.790205244872, 8401.663933442655, 8402.201790829862, 2065.1429656692453, 2266.875321857297, 2324.0, 2365.9881700591473, 2366.526694661066, 2424.8908799103992, 2426.162973774045, 2429.8056155507606, 2432.8540287582714, 2435.5737745894485, 2278.8632682039047, 2339.099446713019, 2340.8595484270913, 2341.812654987597, 2346.038124369009, 2061.690746388039, 2326.255598208574, 2361.669366288721, 2373.6914201153913, 2376.6316220985773, 2346.0615753698485, 2351.259353303704, 2391.5934291170543, 2392.0910054179476, 2392.545416370884, 8119.75640730779, 8163.877541836877, 8216.21945915137, 8218.794530136734, 8220.136885626984, 5109.591232701375, 5233.345831771028, 5239.842804715865, 5248.0553500369915, 5263.421023687391, 3490.0576844252164, 3514.2444374459615, 3539.026767638894, 3548.538689970287, 3552.8934131976084, 1128.1482480727082, 1131.1064259235195, 1164.749578840545, 1164.7845148647527, 1219.7560487902456, 11665.066794656406, 11846.111541634325, 11872.287662740264, 11899.345535995517, 11905.404729763477, 4496.100779844044, 4502.257127573979, 4579.038401935564, 4580.725156490621, 4645.070985802853, 10234.437105959094, 10253.58985640566, 10254.6410875619, 10269.794604107876, 10271.332363396356, 4663.253879379351, 5262.02652509287, 5287.629865909349, 5287.973560132252, 5290.947090529045, 4311.202427550913, 4634.907301853944, 4644.2801365788355, 4709.788059537329, 4715.599174070242, 4022.5719869445925, 4063.0, 4098.262312783668, 4188.6230239278, 4189.664826813848, 1313.5468263449095, 1330.8003799430162, 1343.6775173958179, 1344.8924086073287, 1345.773197927118, 922.3727865051695, 939.9378702066621, 1015.8425444056184, 1025.7486915705551, 1033.5452400943561, 6009.399060093956, 6047.727852246571, 6096.817095487142, 6153.261608606996, 6153.569250152446, 403.4835410674283, 404.0686218266923, 410.7186577194631, 1108.3903852880883, 1119.2333251722434, 4094.0992981544014, 4094.815733292009, 4096.426500289962, 4122.814473348646, 4150.107726838744, 10155.949220253999, 10375.221858360654, 10475.0, 10480.318779279323, 10499.370037797604, 10317.48412579368, 10357.326773759682, 10366.0, 10366.792664146826, 10405.687829365132, 7926.603669816486, 7942.563159026309, 8095.150009249061, 8112.594370281462, 8203.671853125808, 5602.775888964559, 5896.439838215363, 5899.557533185114, 5931.851703707442, 6059.303180134341, 9281.257499400166, 9396.0, 9448.527573621428, 9597.664081757104, 9610.51947402641, 9372.1565059145, 9499.762505937408, 9708.75728106803, 9726.562304696447, 9930.751731206488, 6591.34086591337, 6974.58152510851, 7214.494985350975, 7364.3372096511575, 7471.402287816853, 8024.2376974187355, 8119.066307374491, 8147.266745992889, 8170.223828736498, 8185.467944583583, 6971.5468494547695, 7135.357817796424, 7167.498275120692, 7249.311315425026, 7281.708731650675, 7203.243659415895, 7255.419566434778, 7256.2018178001435, 7311.232320606472, 7354.96322518384, 6981.0, 6985.126859142607, 7026.086608740831, 7035.859282814417, 7043.788686339418, 4978.0, 5071.467495912876, 5071.847844564669, 5085.4406015337545, 5099.515546023122, 5198.818041368534, 5213.869653258699, 5237.057329680694, 5247.265382846481, 5314.070037743457], "value": 4536.530350308746, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.6683816440806, 339.3078120633906, 343.01597784195644, 351.64659517185225, 356.97322700797446, 6084.817455476332, 6261.3738626137365, 6279.748810047604, 6308.495320374371, 6318.652474113922, 6321.178246827917, 6337.207849018872, 6341.682915854212, 6359.459445947088, 6370.872582548346, 4810.735409552473, 4813.735244561548, 4815.253635686457, 4817.735024573647, 4819.7590120494015, 4660.254359302512, 4702.106599746055, 4815.422149342084, 4822.035592881421, 4834.105690447279, 4753.857384278477, 4758.095961767271, 4761.166795810736, 4762.880927976811, 4769.046190761844, 4739.976300118495, 4751.64362672801, 4752.287156926454, 4758.072175925713, 4765.952340476586, 4157.397177409259, 4161.375793630949, 4163.729357591777, 4182.309918863384, 4183.142455796555, 6059.66671833049, 6073.453389194994, 6083.756649734005, 6086.330503644595, 6104.236970378703, 5351.839444816662, 5526.889462210774, 5544.528715059225, 5565.30433695788, 5568.610197286192, 6653.002049692536, 6667.233268174174, 6667.299933506961, 6671.966640166768, 6693.6318502482345, 4521.208788462006, 4550.0, 4554.567316104964, 4562.247229207177, 4562.520935301779, 6928.0, 7003.439724822002, 7014.088168538057, 7019.227884932653, 7073.540219885691, 4647.814087436533, 4700.059988002413, 4705.694129881546, 4711.693739906895, 4712.057588482317, 4454.621357184676, 4757.857264282077, 4762.6189904808225, 4768.189407800683, 4769.809207631656, 5350.8127215547265, 5384.6769193848495, 5388.272583201296, 5398.595105367113, 5398.973005135028, 6666.166729158856, 6698.732050718014, 6714.093597364391, 6714.328567143247, 6729.764458243938, 1561.2271925397001, 1585.9841401586068, 1600.2638786158266, 1600.8639265662316, 1605.727026405514, 1042.1766804224578, 1049.7533079726259, 1067.013012963006, 1068.3643232276784, 1078.3637653784306, 6328.208973878265, 6366.140571022946, 6402.679866006681, 6434.356564343529, 6436.35636436362, 6858.348456896587, 6859.5541289816, 6863.416609588241, 6876.965615171892, 6890.379865812, 6437.034444833313, 6437.0988061671405, 6443.130177425987, 6445.742170313229, 6449.355064493513, 3636.1818590816856, 3695.6858667013603, 3699.7040236780995, 3702.6852717518773, 3702.703783697352, 6957.588940496723, 7032.5428847125795, 7110.57336559808, 7111.431085513146, 7119.96440017807, 6989.33601307875, 7023.7892863213165, 7027.402670772939, 7032.5428847125795, 7035.366816986393, 7100.644967751592, 7102.822429439202, 7103.680334384965, 7106.431485481149, 7109.253528379549, 6837.521373503807, 6842.247352791289, 6847.315268473113, 6851.794446166623, 6859.0, 6620.3710647488415, 6726.159230096238, 6842.93157068423, 6851.794446166623, 6905.827354316182, 7253.347198752138, 7268.781936541912, 7272.41820654357, 7275.090613673291, 7287.052683151369, 4703.576678098988, 4754.168020596451, 4760.452547956891, 4761.190597598347, 4761.714297142044, 6676.232233293039, 6853.417459515997, 6974.58152510851, 7045.894311585228, 7053.823654408681, 6607.0, 6761.86476270462, 6774.254831968578, 6780.898286525608, 6791.117154770046, 6708.798736037927, 6749.561278517077, 6755.459563234831, 6758.594484330956, 6766.729330826909, 6617.239017513048, 6626.56927299724, 6639.468842492685, 6639.966800165968, 6654.567453115532, 6599.60402375859, 6784.423324017514, 6786.660666966731, 6808.353206445379, 6822.931770682429, 6606.8017959461295, 6618.238902526271, 6635.701393437404, 6638.20341559016, 6654.83362915931], "value": 5011.407961776641, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [903.7288813355992, 905.239598737061, 907.1790030022831, 910.3218102513629, 929.5584597316272, 14782.482613108543, 14852.925735371322, 15193.620159496018, 15222.467213647524, 15227.92386038071, 14150.858491415083, 14210.360533775978, 14232.430702771902, 14234.928825355884, 14257.857421425782, 742.5730205132044, 846.0355195077616, 852.21170417364, 853.9402241843073, 876.6581033396981, 864.6843901975765, 866.2377108144824, 867.9305655547572, 868.1882439918664, 868.3227082875368, 912.7216199059284, 916.1754421021101, 917.0920788419484, 917.1149840404042, 917.2936838634248, 784.9921500785005, 905.0225756183306, 916.3036092569629, 917.4541148016953, 921.9907800922039, 672.6334147889412, 673.3939454490949, 673.8315421144714, 674.4941294029478, 674.6323253826677, 14952.700945981129, 14966.850331496655, 14969.625759356104, 14983.775243371249, 15002.69994600102, 15048.097114173075, 15396.307166177548, 15402.614934626612, 15504.534863954099, 15520.456784012618, 11801.94099029508, 11953.342566158944, 11958.461869215906, 12212.694682632917, 12261.877381226162, 4014.859479918218, 4047.4738284023183, 4061.5532291447917, 4065.125997910434, 4187.748735075875, 57495.71252143754, 57521.424785752024, 58316.41683583152, 58505.414945850425, 58628.7068564663, 11354.26197297173, 11566.768664626661, 11675.182737208484, 11759.588414405454, 11779.646610601696, 21683.241086561895, 21685.13259469635, 21735.13059477603, 21755.34733957984, 21756.0, 8626.698065567674, 8670.436421632574, 8919.063498332582, 8928.0, 9003.864942025875, 5030.195168772979, 5133.25567792668, 5150.742462876841, 5180.119379705459, 5190.8183213587345, 3557.3596752584785, 3602.9279414411567, 3610.1696609779897, 3614.548181477315, 3620.9275814483562, 632.1718548701216, 634.755619086655, 643.3662842100528, 688.2566827825935, 708.1572928215408, 719.3813320544327, 722.5556282886092, 739.3161325773638, 768.9846203076019, 776.704852156177, 9374.531273436301, 9436.669716559887, 9660.227181825438, 9663.951680241695, 9682.467464289532, 735.4116706634671, 758.0259366713747, 758.3591864874172, 761.1285078584989, 777.8133248020434, 4429.357743127293, 4464.04023135021, 4487.416635837386, 4545.454545454567, 4624.421947256593, 69194.65402672955, 70165.29834701588, 70240.64879675671, 70250.0, 71014.64492677503, 58197.41802582004, 60273.69863150744, 60341.0, 60516.69741651264, 61075.38924610697, 53984.73007634937, 54245.0, 54370.184447233325, 55065.9999999992, 56347.43652563422, 8993.460392376479, 9019.14318139802, 9121.133492318218, 9132.771680708036, 9141.131592498701, 37952.810235948644, 38074.0, 38558.61441385662, 40434.39348409717, 40863.7956810214, 49072.75463622659, 49364.25953610627, 49941.500584993686, 51292.0, 53375.0, 12155.45300461499, 12156.088293377856, 12167.574134905235, 12367.0, 12414.255144691348, 12872.088462092464, 12888.935555322163, 12949.287789171309, 13417.127886687724, 13559.186448813103, 10484.266101373136, 12821.679458013625, 12887.986202738904, 13619.684653609109, 13734.175949443066, 12594.370281485706, 12648.873511265137, 12849.486020559072, 12963.935180324415, 13278.867211327763, 12346.753064938472, 12745.17156384832, 12991.805122922975, 13128.934355328161, 13179.0, 10543.42011189392, 10652.795734888256, 10773.0, 10779.407132607781, 10873.619423320146, 11081.889181108085, 11103.888961110608, 11194.944025280147, 11352.375619340684, 11427.542898283975], "value": 7153.5361898547435, "unit": "score"}], "name": "dromaeo_css", "value": 7364.67443941346, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 111.0, 109.0, 109.0, 109.0, 105.0, 109.0, 109.0, 111.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 127.0, 152.0, 170.0, 132.0, 155.0, 155.0, 137.0, 187.0, 133.0], "value": 150.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 160.0, 160.0, 160.0, 163.0, 160.0, 160.0, 163.0, 161.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 173.0, 80.0, 76.0, 77.0, 76.0, 153.0, 77.0], "value": 93.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 91.0, 146.0, 92.0, 94.0, 92.0, 146.0, 91.0, 91.0, 153.0], "value": 109.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 147.0, 145.0, 146.0, 147.0, 145.0, 145.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 97.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 55.0, 55.0, 56.0, 58.0, 77.0, 54.0, 54.0], "value": 57.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 63.0, 58.0, 58.0, 58.0, 57.0, 58.0, 59.0], "value": 58.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 74.0, 72.0, 73.0, 73.0, 81.0, 73.0, 75.0, 73.0], "value": 73.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 110.0, 114.0, 115.0, 110.0, 110.0, 114.0, 130.0, 113.0], "value": 114.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 160.0, 164.0, 159.0, 166.0, 162.0, 162.0, 163.0, 157.0, 164.0], "value": 162.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 73.0, 65.0, 66.0, 65.0, 67.0, 68.0, 66.0, 65.0, 64.0], "value": 66.4, "unit": "score"}], "name": "kraken", "value": 1514.1000000000001, "alertThreshold": 2.0}]} 20:03:20 INFO - Return code: 0 20:03:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:03:20 ERROR - # TBPL SUCCESS # 20:03:20 INFO - Running post-action listener: _resource_record_post_action 20:03:20 INFO - Running post-run listener: _resource_record_post_run 20:03:21 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 262144; Write bytes: 500035584; Read time: 32; Write time: 478196 20:03:21 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 248500224; Read time: 0; Write time: 309980 20:03:21 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 262144; Write bytes: 251535360; Read time: 32; Write time: 168216 20:03:21 INFO - Running post-run listener: _upload_blobber_files 20:03:21 INFO - Blob upload gear active. 20:03:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:03:21 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 20:03:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:03:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:03:22 INFO - (blobuploader) - INFO - Open directory for files ... 20:03:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:03:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:03:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:03:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:03:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:03:22 INFO - (blobuploader) - INFO - Done attempting. 20:03:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:03:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:03:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:03:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:03:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:03:23 INFO - (blobuploader) - INFO - Done attempting. 20:03:23 INFO - (blobuploader) - INFO - Iteration through files over. 20:03:23 INFO - Return code: 0 20:03:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:03:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:03:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5f2632c43ff60a0c445562a129b66468bc42739a0a7728ca7871b6e3eb321aed6c70cec1df239d8155290c48649501d1f10a9f44ba54ee69e4a220dbcb70454a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/81d39847ff8b4a2d043e4cf8c58d1aa5f6db441278c694905a34302201f7234c1880d3310dc5601bb8f6afd683accb3a88c1b9526f03938c633500993cd3e30b"} 20:03:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:03:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:03:23 INFO - Contents: 20:03:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5f2632c43ff60a0c445562a129b66468bc42739a0a7728ca7871b6e3eb321aed6c70cec1df239d8155290c48649501d1f10a9f44ba54ee69e4a220dbcb70454a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/81d39847ff8b4a2d043e4cf8c58d1aa5f6db441278c694905a34302201f7234c1880d3310dc5601bb8f6afd683accb3a88c1b9526f03938c633500993cd3e30b"} 20:03:23 INFO - Running post-run listener: copy_logs_to_upload_dir 20:03:23 INFO - Copying logs to upload dir... 20:03:23 INFO - mkdir: /builds/slave/test/build/upload/logs 20:03:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.163512 ========= master_lag: 104.56 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 24 secs) (at 2016-05-08 20:05:08.065045) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-08 20:05:08.068159) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1462754264.151561-1199475792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5f2632c43ff60a0c445562a129b66468bc42739a0a7728ca7871b6e3eb321aed6c70cec1df239d8155290c48649501d1f10a9f44ba54ee69e4a220dbcb70454a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/81d39847ff8b4a2d043e4cf8c58d1aa5f6db441278c694905a34302201f7234c1880d3310dc5601bb8f6afd683accb3a88c1b9526f03938c633500993cd3e30b"} build_url:https://queue.taskcluster.net/v1/task/SKqi5soRR0mR8W9-WGpxqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011307 build_url: 'https://queue.taskcluster.net/v1/task/SKqi5soRR0mR8W9-WGpxqg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5f2632c43ff60a0c445562a129b66468bc42739a0a7728ca7871b6e3eb321aed6c70cec1df239d8155290c48649501d1f10a9f44ba54ee69e4a220dbcb70454a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/81d39847ff8b4a2d043e4cf8c58d1aa5f6db441278c694905a34302201f7234c1880d3310dc5601bb8f6afd683accb3a88c1b9526f03938c633500993cd3e30b"}' ========= master_lag: 0.42 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-08 20:05:08.498471) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-08 20:05:08.501864) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1462754264.151561-1199475792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004474 ========= master_lag: 0.06 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-08 20:05:08.567856) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-08 20:05:08.568133) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-08 20:05:08.568437) ========= ========= Total master_lag: 105.10 =========