builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-063 starttime: 1464628495.38 results: success (0) buildid: 20160530073151 builduid: 931f49bf727d468790e98b2743145d93 revision: ed1c3aae460813241ce2c3480df30fae2268ab1f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 10:14:55.383849) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 10:14:55.384325) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 10:14:55.384622) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 10:14:55.399250) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 10:14:55.399596) ========= 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=33d5923976266a1c518c4bf7000001ab-1464628494.941087-1800182361 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-30 10:14:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 36.9M=0s 2016-05-30 10:14:55 (36.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.076120 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 10:14:55.489462) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 10:14:55.489790) ========= 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=33d5923976266a1c518c4bf7000001ab-1464628494.941087-1800182361 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015417 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 10:14:55.540122) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-30 10:14:55.540544) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ed1c3aae460813241ce2c3480df30fae2268ab1f --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 ed1c3aae460813241ce2c3480df30fae2268ab1f --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=33d5923976266a1c518c4bf7000001ab-1464628494.941087-1800182361 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-30 10:14:55,795 truncating revision to first 12 chars 2016-05-30 10:14:55,795 Setting DEBUG logging. 2016-05-30 10:14:55,795 attempt 1/10 2016-05-30 10:14:55,795 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ed1c3aae4608?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-30 10:14:56,847 unpacking tar archive at: mozilla-aurora-ed1c3aae4608/testing/mozharness/ program finished with exit code 0 elapsedTime=1.367876 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-30 10:14:56.921845) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 10:14:56.922176) ========= script_repo_revision: ed1c3aae460813241ce2c3480df30fae2268ab1f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 10:14:56.922627) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 10:14:56.922903) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 10:14:56.932318) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-05-30 10:14:56.932821) ========= /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=33d5923976266a1c518c4bf7000001ab-1464628494.941087-1800182361 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:14:57 INFO - MultiFileLogger online at 20160530 10:14:57 in /builds/slave/test 10:14:57 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 10:14:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:14:57 INFO - {'append_to_log': False, 10:14:57 INFO - 'base_work_dir': '/builds/slave/test', 10:14:57 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:14:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:14:57 INFO - 'branch': 'Mozilla-Aurora', 10:14:57 INFO - 'buildbot_json_path': 'buildprops.json', 10:14:57 INFO - 'config_files': ('talos/linux_config.py',), 10:14:57 INFO - 'default_actions': ('clobber', 10:14:57 INFO - 'read-buildbot-config', 10:14:57 INFO - 'download-and-extract', 10:14:57 INFO - 'populate-webroot', 10:14:57 INFO - 'create-virtualenv', 10:14:57 INFO - 'install', 10:14:57 INFO - 'run-tests'), 10:14:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:14:57 INFO - 'download_minidump_stackwalk': True, 10:14:57 INFO - 'download_symbols': 'ondemand', 10:14:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:14:57 INFO - 'tooltool.py': '/tools/tooltool.py', 10:14:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:14:57 INFO - '/tools/misc-python/virtualenv.py')}, 10:14:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:14:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:14:57 INFO - 'installer_path': 'installer.exe', 10:14:57 INFO - 'log_level': 'info', 10:14:57 INFO - 'log_name': 'talos', 10:14:57 INFO - 'log_to_console': True, 10:14:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:14:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:14:57 INFO - 'opt_config_files': (), 10:14:57 INFO - 'pip_index': False, 10:14:57 INFO - 'sps_profile': False, 10:14:57 INFO - 'sps_profile_interval': 0, 10:14:57 INFO - 'suite': 'dromaeojs', 10:14:57 INFO - 'system_bits': '32', 10:14:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:14:57 INFO - 'title': 'talos-linux64-ix-063', 10:14:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:14:57 INFO - 'use_talos_json': True, 10:14:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:14:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:14:57 INFO - 'work_dir': 'build'} 10:14:57 INFO - ##### 10:14:57 INFO - ##### Running clobber step. 10:14:57 INFO - ##### 10:14:57 INFO - Running pre-action listener: _resource_record_pre_action 10:14:57 INFO - Running main action method: clobber 10:14:57 INFO - rmtree: /builds/slave/test/build 10:14:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:14:57 INFO - Running post-action listener: _resource_record_post_action 10:14:57 INFO - ##### 10:14:57 INFO - ##### Running read-buildbot-config step. 10:14:57 INFO - ##### 10:14:57 INFO - Running pre-action listener: _resource_record_pre_action 10:14:57 INFO - Running main action method: read_buildbot_config 10:14:57 INFO - Using buildbot properties: 10:14:57 INFO - { 10:14:57 INFO - "project": "", 10:14:57 INFO - "product": "firefox", 10:14:57 INFO - "script_repo_revision": "production", 10:14:57 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 10:14:57 INFO - "repository": "", 10:14:57 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 10:14:57 INFO - "buildid": "20160530073151", 10:14:57 INFO - "pgo_build": "True", 10:14:57 INFO - "basedir": "/builds/slave/test", 10:14:57 INFO - "buildnumber": 272, 10:14:57 INFO - "slavename": "talos-linux64-ix-063", 10:14:57 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:14:57 INFO - "platform": "ubuntu64_hw", 10:14:57 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 10:14:57 INFO - "branch": "mozilla-aurora", 10:14:57 INFO - "repo_path": "releases/mozilla-aurora", 10:14:57 INFO - "revision": "ed1c3aae460813241ce2c3480df30fae2268ab1f", 10:14:57 INFO - "stage_platform": "linux64-pgo", 10:14:57 INFO - "builduid": "931f49bf727d468790e98b2743145d93", 10:14:57 INFO - "slavebuilddir": "test" 10:14:57 INFO - } 10:14:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/boa9F7RPQdGTqlMknlJH_w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 10:14:57 INFO - Running post-action listener: _resource_record_post_action 10:14:57 INFO - ##### 10:14:57 INFO - ##### Running download-and-extract step. 10:14:57 INFO - ##### 10:14:57 INFO - Running pre-action listener: _resource_record_pre_action 10:14:57 INFO - Running main action method: download_and_extract 10:14:57 INFO - mkdir: /builds/slave/test/build/tests 10:14:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:57 INFO - https://queue.taskcluster.net/v1/task/boa9F7RPQdGTqlMknlJH_w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:14:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/boa9F7RPQdGTqlMknlJH_w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 10:14:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/boa9F7RPQdGTqlMknlJH_w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 10:14:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/boa9F7RPQdGTqlMknlJH_w/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 10:14:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/boa9F7RPQdGTqlMknlJH_w/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 10:14:58 INFO - Downloaded 1361 bytes. 10:14:58 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 10:14:58 INFO - Using the following test package requirements: 10:14:58 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 10:14:58 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:14:58 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 10:14:58 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:14:58 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 10:14:58 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:14:58 INFO - u'jsshell-linux-x86_64.zip'], 10:14:58 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:14:58 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 10:14:58 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 10:14:58 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:14:58 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 10:14:58 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:14:58 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 10:14:58 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:14:58 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 10:14:58 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:14:58 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 10:14:58 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:14:58 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')]} 10:14:58 INFO - https://queue.taskcluster.net/v1/task/boa9F7RPQdGTqlMknlJH_w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:14:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/boa9F7RPQdGTqlMknlJH_w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:14:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/boa9F7RPQdGTqlMknlJH_w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:14:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/boa9F7RPQdGTqlMknlJH_w/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 10:14:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/boa9F7RPQdGTqlMknlJH_w/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 10:14:59 INFO - Downloaded 24136275 bytes. 10:14: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'] 10:14: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 10:15:00 INFO - Return code: 0 10:15: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 10:15: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')]} 10:15:00 INFO - https://queue.taskcluster.net/v1/task/boa9F7RPQdGTqlMknlJH_w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:15:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/boa9F7RPQdGTqlMknlJH_w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:15:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/boa9F7RPQdGTqlMknlJH_w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:15:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/boa9F7RPQdGTqlMknlJH_w/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 10:15:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/boa9F7RPQdGTqlMknlJH_w/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 10:15:03 INFO - Downloaded 24136275 bytes. 10:15:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:15:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:15:04 INFO - Return code: 0 10:15: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')]} 10:15:04 INFO - https://queue.taskcluster.net/v1/task/boa9F7RPQdGTqlMknlJH_w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:15:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/boa9F7RPQdGTqlMknlJH_w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 10:15:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/boa9F7RPQdGTqlMknlJH_w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 10:15:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/boa9F7RPQdGTqlMknlJH_w/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 10:15:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/boa9F7RPQdGTqlMknlJH_w/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 10:15:05 INFO - Downloaded 10840145 bytes. 10:15:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:15:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:15:05 INFO - Return code: 0 10:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:05 INFO - https://queue.taskcluster.net/v1/task/boa9F7RPQdGTqlMknlJH_w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:15:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/boa9F7RPQdGTqlMknlJH_w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:15:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/boa9F7RPQdGTqlMknlJH_w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:15:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/boa9F7RPQdGTqlMknlJH_w/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 10:15:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/boa9F7RPQdGTqlMknlJH_w/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 10:15:07 INFO - Downloaded 62748770 bytes. 10:15:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/boa9F7RPQdGTqlMknlJH_w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:15:07 INFO - mkdir: /builds/slave/test/properties 10:15:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:15:07 INFO - Writing to file /builds/slave/test/properties/build_url 10:15:07 INFO - Contents: 10:15:07 INFO - build_url:https://queue.taskcluster.net/v1/task/boa9F7RPQdGTqlMknlJH_w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:15:08 INFO - Running post-action listener: _resource_record_post_action 10:15:08 INFO - Running post-action listener: set_extra_try_arguments 10:15:08 INFO - ##### 10:15:08 INFO - ##### Running populate-webroot step. 10:15:08 INFO - ##### 10:15:08 INFO - Running pre-action listener: _resource_record_pre_action 10:15:08 INFO - Running main action method: populate_webroot 10:15:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:15:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:15:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:15:08 INFO - '--tppagecycles', 10:15:08 INFO - '7'], 10:15:08 INFO - 'tests': ['tsvgm']}}, 10:15:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:15:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:15:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:15:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:15:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:15:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:15:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:08 INFO - 'talos_options': ['--disable-e10s'], 10:15:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:15:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:15:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:08 INFO - 'talos_options': ['--disable-e10s'], 10:15:08 INFO - 'tests': ['damp', 'tps']}, 10:15:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:08 INFO - 'tests': ['damp', 'tps']}, 10:15:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:15:08 INFO - 'tests': ['dromaeo_dom']}, 10:15:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:15:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:15:08 INFO - 'tests': ['a11yr', 10:15:08 INFO - 'ts_paint', 10:15:08 INFO - 'tpaint', 10:15:08 INFO - 'sessionrestore', 10:15:08 INFO - 'sessionrestore_no_auto_restore', 10:15:08 INFO - 'tabpaint']}, 10:15:08 INFO - 'other-e10s': {'tests': ['a11yr', 10:15:08 INFO - 'ts_paint', 10:15:08 INFO - 'tpaint', 10:15:08 INFO - 'sessionrestore', 10:15:08 INFO - 'sessionrestore_no_auto_restore', 10:15:08 INFO - 'tabpaint']}, 10:15:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:15:08 INFO - 'ts_paint', 10:15:08 INFO - 'tpaint', 10:15:08 INFO - 'sessionrestore', 10:15:08 INFO - 'sessionrestore_no_auto_restore', 10:15:08 INFO - 'tabpaint']}, 10:15:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:15:08 INFO - 'ts_paint', 10:15:08 INFO - 'tpaint', 10:15:08 INFO - 'sessionrestore', 10:15:08 INFO - 'sessionrestore_no_auto_restore', 10:15:08 INFO - 'tabpaint']}, 10:15:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:15:08 INFO - 'tests': ['a11yr', 10:15:08 INFO - 'ts_paint', 10:15:08 INFO - 'tpaint', 10:15:08 INFO - 'sessionrestore', 10:15:08 INFO - 'sessionrestore_no_auto_restore', 10:15:08 INFO - 'tabpaint']}, 10:15:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:15:08 INFO - 'tests': ['a11yr', 10:15:08 INFO - 'ts_paint', 10:15:08 INFO - 'tpaint', 10:15:08 INFO - 'sessionrestore', 10:15:08 INFO - 'sessionrestore_no_auto_restore', 10:15:08 INFO - 'tabpaint']}, 10:15:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:15:08 INFO - 'tests': ['tsvgx', 10:15:08 INFO - 'tsvgr_opacity', 10:15:08 INFO - 'tart', 10:15:08 INFO - 'tscrollx', 10:15:08 INFO - 'cart']}, 10:15:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:15:08 INFO - 'tsvgr_opacity', 10:15:08 INFO - 'tart', 10:15:08 INFO - 'tscrollx', 10:15:08 INFO - 'cart']}, 10:15:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:08 INFO - 'talos_options': ['--disable-e10s'], 10:15:08 INFO - 'tests': ['tp5o']}, 10:15:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:08 INFO - 'tests': ['tp5o']}, 10:15:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:08 INFO - 'talos_options': ['--disable-e10s', 10:15:08 INFO - '--xperf_path', 10:15:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:15:08 INFO - 'tests': ['tp5n']}, 10:15:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:08 INFO - 'talos_options': ['--xperf_path', 10:15:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:15:08 INFO - 'tests': ['tp5n']}}, 10:15:08 INFO - 'talos.zip': {'path': '', 10:15:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:15:08 INFO - Running post-action listener: _resource_record_post_action 10:15:08 INFO - ##### 10:15:08 INFO - ##### Running create-virtualenv step. 10:15:08 INFO - ##### 10:15:08 INFO - Running pre-action listener: _resource_record_pre_action 10:15:08 INFO - Running main action method: create_virtualenv 10:15:08 INFO - Creating virtualenv /builds/slave/test/build/venv 10:15:08 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 10:15:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:15:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:15:08 INFO - Using real prefix '/usr' 10:15:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:15:09 INFO - Installing distribute.............................................................................................................................................................................................done. 10:15:11 INFO - Installing pip.................done. 10:15:11 INFO - Return code: 0 10:15:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:15:11 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')]} 10:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:11 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')]} 10:15:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:11 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 0x7f8c943baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2580410>, '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 0x2581310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25817a0>, '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': '33d5923976266a1c518c4bf7000001ab-1464628494.941087-1800182361', '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 10:15:11 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 10:15:11 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 10:15:11 INFO - Using env: {'DISPLAY': ':0', 10:15:11 INFO - 'HOME': '/home/cltbld', 10:15:11 INFO - 'LANG': 'en_US.UTF-8', 10:15:11 INFO - 'LANGUAGE': 'en_US:en', 10:15:11 INFO - 'LOGNAME': 'cltbld', 10:15:11 INFO - 'MAIL': '/var/mail/cltbld', 10:15:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:11 INFO - 'MOZ_NO_REMOTE': '1', 10:15:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:11 INFO - 'NO_EM_RESTART': '1', 10:15:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:11 INFO - 'PWD': '/builds/slave/test', 10:15:11 INFO - 'SHELL': '/bin/bash', 10:15:11 INFO - 'SHLVL': '1', 10:15:11 INFO - 'TERM': 'linux', 10:15:11 INFO - 'TMOUT': '86400', 10:15:11 INFO - 'USER': 'cltbld', 10:15:11 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464628494.941087-1800182361', 10:15:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:11 INFO - '_': '/tools/buildbot/bin/python'} 10:15:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:11 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 10:15:11 INFO - Cleaning up... 10:15:11 INFO - Return code: 0 10:15:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:15:11 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')]} 10:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:11 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')]} 10:15:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:11 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 0x7f8c943baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2580410>, '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 0x2581310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25817a0>, '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': '33d5923976266a1c518c4bf7000001ab-1464628494.941087-1800182361', '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 10:15:11 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 10:15:11 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 10:15:11 INFO - Using env: {'DISPLAY': ':0', 10:15:11 INFO - 'HOME': '/home/cltbld', 10:15:11 INFO - 'LANG': 'en_US.UTF-8', 10:15:11 INFO - 'LANGUAGE': 'en_US:en', 10:15:11 INFO - 'LOGNAME': 'cltbld', 10:15:11 INFO - 'MAIL': '/var/mail/cltbld', 10:15:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:11 INFO - 'MOZ_NO_REMOTE': '1', 10:15:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:11 INFO - 'NO_EM_RESTART': '1', 10:15:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:11 INFO - 'PWD': '/builds/slave/test', 10:15:11 INFO - 'SHELL': '/bin/bash', 10:15:11 INFO - 'SHLVL': '1', 10:15:11 INFO - 'TERM': 'linux', 10:15:11 INFO - 'TMOUT': '86400', 10:15:11 INFO - 'USER': 'cltbld', 10:15:11 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464628494.941087-1800182361', 10:15:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:11 INFO - '_': '/tools/buildbot/bin/python'} 10:15:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:11 INFO - Downloading/unpacking psutil>=0.7.1 10:15:11 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 10:15:11 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 10:15:11 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 10:15:11 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 10:15:11 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 10:15:11 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 10:15:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:15:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:15:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:15:13 INFO - Installing collected packages: psutil 10:15:13 INFO - Running setup.py install for psutil 10:15:13 INFO - building 'psutil._psutil_linux' extension 10:15:13 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 10:15:13 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:15:13 INFO - building 'psutil._psutil_posix' extension 10:15:13 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:15:14 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 10:15:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:15:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:15:14 INFO - Successfully installed psutil 10:15:14 INFO - Cleaning up... 10:15:14 INFO - Return code: 0 10:15:14 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:15: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')]} 10:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15: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')]} 10:15:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15: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', '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 0x7f8c943baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2580410>, '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 0x2581310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25817a0>, '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': '33d5923976266a1c518c4bf7000001ab-1464628494.941087-1800182361', '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 10:15: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:15: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 mozsystemmonitor==0.0.0 10:15:14 INFO - Using env: {'DISPLAY': ':0', 10:15:14 INFO - 'HOME': '/home/cltbld', 10:15:14 INFO - 'LANG': 'en_US.UTF-8', 10:15:14 INFO - 'LANGUAGE': 'en_US:en', 10:15:14 INFO - 'LOGNAME': 'cltbld', 10:15:14 INFO - 'MAIL': '/var/mail/cltbld', 10:15:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:14 INFO - 'MOZ_NO_REMOTE': '1', 10:15:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:14 INFO - 'NO_EM_RESTART': '1', 10:15:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:14 INFO - 'PWD': '/builds/slave/test', 10:15:14 INFO - 'SHELL': '/bin/bash', 10:15:14 INFO - 'SHLVL': '1', 10:15:14 INFO - 'TERM': 'linux', 10:15:14 INFO - 'TMOUT': '86400', 10:15:14 INFO - 'USER': 'cltbld', 10:15:14 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464628494.941087-1800182361', 10:15:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:14 INFO - '_': '/tools/buildbot/bin/python'} 10:15:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:14 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:15: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 10:15: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 10:15: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 10:15: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 10:15: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 10:15: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 10:15:16 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:15:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:15:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:15:16 INFO - Installing collected packages: mozsystemmonitor 10:15:16 INFO - Running setup.py install for mozsystemmonitor 10:15:16 INFO - Successfully installed mozsystemmonitor 10:15:16 INFO - Cleaning up... 10:15:16 INFO - Return code: 0 10:15:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:15:16 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')]} 10:15:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:16 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')]} 10:15:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:16 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 0x7f8c943baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2580410>, '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 0x2581310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25817a0>, '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': '33d5923976266a1c518c4bf7000001ab-1464628494.941087-1800182361', '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 10:15:16 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 10:15:16 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 10:15:16 INFO - Using env: {'DISPLAY': ':0', 10:15:16 INFO - 'HOME': '/home/cltbld', 10:15:16 INFO - 'LANG': 'en_US.UTF-8', 10:15:16 INFO - 'LANGUAGE': 'en_US:en', 10:15:16 INFO - 'LOGNAME': 'cltbld', 10:15:16 INFO - 'MAIL': '/var/mail/cltbld', 10:15:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:16 INFO - 'MOZ_NO_REMOTE': '1', 10:15:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:16 INFO - 'NO_EM_RESTART': '1', 10:15:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:16 INFO - 'PWD': '/builds/slave/test', 10:15:16 INFO - 'SHELL': '/bin/bash', 10:15:16 INFO - 'SHLVL': '1', 10:15:16 INFO - 'TERM': 'linux', 10:15:16 INFO - 'TMOUT': '86400', 10:15:16 INFO - 'USER': 'cltbld', 10:15:16 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464628494.941087-1800182361', 10:15:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:16 INFO - '_': '/tools/buildbot/bin/python'} 10:15:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:16 INFO - Downloading/unpacking blobuploader==1.2.4 10:15: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 10:15: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 10:15: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 10:15: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 10:15: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 10:15: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 10:15:18 INFO - Downloading blobuploader-1.2.4.tar.gz 10:15:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:15:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:15:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:15:19 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 10:15:19 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 10:15:19 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 10:15:19 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 10:15:19 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 10:15:19 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 10:15:19 INFO - Downloading docopt-0.6.1.tar.gz 10:15:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:15:19 INFO - Installing collected packages: blobuploader, requests, docopt 10:15:19 INFO - Running setup.py install for blobuploader 10:15:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:15:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:15:19 INFO - Running setup.py install for requests 10:15:19 INFO - Running setup.py install for docopt 10:15:19 INFO - Successfully installed blobuploader requests docopt 10:15:19 INFO - Cleaning up... 10:15:19 INFO - Return code: 0 10:15:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:15:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c943baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2580410>, '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 0x2581310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25817a0>, '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': '33d5923976266a1c518c4bf7000001ab-1464628494.941087-1800182361', '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 10:15:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:15:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:15:19 INFO - Using env: {'DISPLAY': ':0', 10:15:19 INFO - 'HOME': '/home/cltbld', 10:15:19 INFO - 'LANG': 'en_US.UTF-8', 10:15:19 INFO - 'LANGUAGE': 'en_US:en', 10:15:19 INFO - 'LOGNAME': 'cltbld', 10:15:19 INFO - 'MAIL': '/var/mail/cltbld', 10:15:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:19 INFO - 'MOZ_NO_REMOTE': '1', 10:15:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:19 INFO - 'NO_EM_RESTART': '1', 10:15:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:19 INFO - 'PWD': '/builds/slave/test', 10:15:19 INFO - 'SHELL': '/bin/bash', 10:15:19 INFO - 'SHLVL': '1', 10:15:19 INFO - 'TERM': 'linux', 10:15:19 INFO - 'TMOUT': '86400', 10:15:19 INFO - 'USER': 'cltbld', 10:15:19 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464628494.941087-1800182361', 10:15:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:19 INFO - '_': '/tools/buildbot/bin/python'} 10:15:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:15:20 INFO - Running setup.py (path:/tmp/pip-ZkmLwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:15:20 INFO - Running setup.py (path:/tmp/pip-QITaBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:15:20 INFO - Running setup.py (path:/tmp/pip-bXyph0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:15:20 INFO - Running setup.py (path:/tmp/pip-kDtUsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:15:20 INFO - Running setup.py (path:/tmp/pip-zn52t0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:15:20 INFO - Running setup.py (path:/tmp/pip-lkBA35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:15:20 INFO - Running setup.py (path:/tmp/pip-V7GyZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:15:20 INFO - Running setup.py (path:/tmp/pip-BaTDVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:15:20 INFO - Running setup.py (path:/tmp/pip-p4SN6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:15:20 INFO - Running setup.py (path:/tmp/pip-TBJI_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:15:20 INFO - Running setup.py (path:/tmp/pip-JRFX5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:15:20 INFO - Running setup.py (path:/tmp/pip-Bkmfxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:15:21 INFO - Running setup.py (path:/tmp/pip-Bd2CfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:15:21 INFO - Running setup.py (path:/tmp/pip-xY84mu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:15:21 INFO - Running setup.py (path:/tmp/pip-iTsuTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:15:21 INFO - Running setup.py (path:/tmp/pip-HWmphs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:15:21 INFO - Running setup.py (path:/tmp/pip-aldcyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:15:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:15:21 INFO - Running setup.py install for manifestparser 10:15:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:15:21 INFO - Running setup.py install for mozcrash 10:15:21 INFO - Running setup.py install for mozdebug 10:15:21 INFO - Running setup.py install for mozdevice 10:15:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:15:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:15:21 INFO - Running setup.py install for mozfile 10:15:21 INFO - Running setup.py install for mozhttpd 10:15:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:15:21 INFO - Running setup.py install for mozinfo 10:15:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:15:22 INFO - Running setup.py install for mozInstall 10:15:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:15:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:15:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:15:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:15:22 INFO - Running setup.py install for mozleak 10:15:22 INFO - Running setup.py install for mozlog 10:15:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:15:22 INFO - Running setup.py install for moznetwork 10:15:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:15:22 INFO - Running setup.py install for mozprocess 10:15:22 INFO - Running setup.py install for mozprofile 10:15:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:15:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:15:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:15:22 INFO - Running setup.py install for mozrunner 10:15:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:15:22 INFO - Running setup.py install for mozscreenshot 10:15:22 INFO - Running setup.py install for moztest 10:15:23 INFO - Running setup.py install for mozversion 10:15:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:15:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:15:23 INFO - Cleaning up... 10:15:23 INFO - Return code: 0 10:15:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:15:23 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')]} 10:15:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:23 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')]} 10:15:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:23 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 0x7f8c943baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2580410>, '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 0x2581310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25817a0>, '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': '33d5923976266a1c518c4bf7000001ab-1464628494.941087-1800182361', '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 10:15:23 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 10:15:23 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 10:15:23 INFO - Using env: {'DISPLAY': ':0', 10:15:23 INFO - 'HOME': '/home/cltbld', 10:15:23 INFO - 'LANG': 'en_US.UTF-8', 10:15:23 INFO - 'LANGUAGE': 'en_US:en', 10:15:23 INFO - 'LOGNAME': 'cltbld', 10:15:23 INFO - 'MAIL': '/var/mail/cltbld', 10:15:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:23 INFO - 'MOZ_NO_REMOTE': '1', 10:15:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:23 INFO - 'NO_EM_RESTART': '1', 10:15:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:23 INFO - 'PWD': '/builds/slave/test', 10:15:23 INFO - 'SHELL': '/bin/bash', 10:15:23 INFO - 'SHLVL': '1', 10:15:23 INFO - 'TERM': 'linux', 10:15:23 INFO - 'TMOUT': '86400', 10:15:23 INFO - 'USER': 'cltbld', 10:15:23 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464628494.941087-1800182361', 10:15:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:23 INFO - '_': '/tools/buildbot/bin/python'} 10:15:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:15:23 INFO - Running setup.py (path:/tmp/pip-Zk6bP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:15:23 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)) 10:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:15:23 INFO - Running setup.py (path:/tmp/pip-UrOxwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:15:23 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)) 10:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:15:23 INFO - Running setup.py (path:/tmp/pip-ix7_e6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:15:23 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)) 10:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:15:23 INFO - Running setup.py (path:/tmp/pip-oaBrgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:15:23 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)) 10:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:15:23 INFO - Running setup.py (path:/tmp/pip-mFAqwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:15:23 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)) 10:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:15:23 INFO - Running setup.py (path:/tmp/pip-gednKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:15:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:15:23 INFO - Running setup.py (path:/tmp/pip-1_aUPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:15:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:15:23 INFO - Running setup.py (path:/tmp/pip-Ne0VxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:15:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:15:23 INFO - Running setup.py (path:/tmp/pip-tXGVqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:15:24 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)) 10:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:15:24 INFO - Running setup.py (path:/tmp/pip-v6uuVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:15:24 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)) 10:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:15:24 INFO - Running setup.py (path:/tmp/pip-ADghx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:15:24 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)) 10:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:15:24 INFO - Running setup.py (path:/tmp/pip-9A4Cu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:15:24 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)) 10:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:15:24 INFO - Running setup.py (path:/tmp/pip-1HTcDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:15:24 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)) 10:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:15:24 INFO - Running setup.py (path:/tmp/pip-3LS0gX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:15:24 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)) 10:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:15:24 INFO - Running setup.py (path:/tmp/pip-4Y3Kc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:15:24 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)) 10:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:15:24 INFO - Running setup.py (path:/tmp/pip-D13HFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:15:24 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)) 10:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:15:24 INFO - Running setup.py (path:/tmp/pip-0exkUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:15:24 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)) 10:15:24 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)) 10:15:24 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)) 10:15:24 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)) 10:15:24 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)) 10:15:24 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)) 10:15:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:15:24 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 10:15:24 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 10:15:24 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 10:15:24 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 10:15:24 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 10:15:24 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 10:15:26 INFO - Downloading blessings-1.6.tar.gz 10:15:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:15:26 INFO - Installing collected packages: blessings 10:15:26 INFO - Running setup.py install for blessings 10:15:26 INFO - Successfully installed blessings 10:15:26 INFO - Cleaning up... 10:15:26 INFO - Return code: 0 10:15:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:15:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:15:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:15:26 INFO - Reading from file tmpfile_stdout 10:15:26 INFO - Current package versions: 10:15:26 INFO - argparse == 1.2.1 10:15:26 INFO - blessings == 1.6 10:15:26 INFO - blobuploader == 1.2.4 10:15:26 INFO - docopt == 0.6.1 10:15:26 INFO - manifestparser == 1.1 10:15:26 INFO - mozInstall == 1.12 10:15:26 INFO - mozcrash == 0.17 10:15:26 INFO - mozdebug == 0.1 10:15:26 INFO - mozdevice == 0.48 10:15:26 INFO - mozfile == 1.2 10:15:26 INFO - mozhttpd == 0.7 10:15:26 INFO - mozinfo == 0.9 10:15:26 INFO - mozleak == 0.1 10:15:26 INFO - mozlog == 3.1 10:15:26 INFO - moznetwork == 0.27 10:15:26 INFO - mozprocess == 0.22 10:15:26 INFO - mozprofile == 0.28 10:15:26 INFO - mozrunner == 6.11 10:15:26 INFO - mozscreenshot == 0.1 10:15:26 INFO - mozsystemmonitor == 0.0 10:15:26 INFO - moztest == 0.7 10:15:26 INFO - mozversion == 1.4 10:15:26 INFO - psutil == 3.1.1 10:15:26 INFO - requests == 1.2.3 10:15:26 INFO - wsgiref == 0.1.2 10:15:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:15:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c943baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2580410>, '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 0x2581310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25817a0>, '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': '33d5923976266a1c518c4bf7000001ab-1464628494.941087-1800182361', '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 10:15:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:15:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:15:26 INFO - Using env: {'DISPLAY': ':0', 10:15:26 INFO - 'HOME': '/home/cltbld', 10:15:26 INFO - 'LANG': 'en_US.UTF-8', 10:15:26 INFO - 'LANGUAGE': 'en_US:en', 10:15:26 INFO - 'LOGNAME': 'cltbld', 10:15:26 INFO - 'MAIL': '/var/mail/cltbld', 10:15:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:26 INFO - 'MOZ_NO_REMOTE': '1', 10:15:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:26 INFO - 'NO_EM_RESTART': '1', 10:15:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:26 INFO - 'PWD': '/builds/slave/test', 10:15:26 INFO - 'SHELL': '/bin/bash', 10:15:26 INFO - 'SHLVL': '1', 10:15:26 INFO - 'TERM': 'linux', 10:15:26 INFO - 'TMOUT': '86400', 10:15:26 INFO - 'USER': 'cltbld', 10:15:26 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464628494.941087-1800182361', 10:15:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:26 INFO - '_': '/tools/buildbot/bin/python'} 10:15:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:27 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)) 10:15:27 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)) 10:15:27 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)) 10:15:27 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)) 10:15:27 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)) 10:15:27 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)) 10:15:27 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)) 10:15:27 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)) 10:15:27 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)) 10:15:27 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)) 10:15:27 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)) 10:15:27 INFO - Cleaning up... 10:15:27 INFO - Return code: 0 10:15:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:15: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')]} 10:15:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15: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')]} 10:15:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c943baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2580410>, '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 0x2581310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25817a0>, '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': '33d5923976266a1c518c4bf7000001ab-1464628494.941087-1800182361', '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 10:15: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', 'jsonschema'] in /builds/slave/test/build 10:15: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 jsonschema 10:15:27 INFO - Using env: {'DISPLAY': ':0', 10:15:27 INFO - 'HOME': '/home/cltbld', 10:15:27 INFO - 'LANG': 'en_US.UTF-8', 10:15:27 INFO - 'LANGUAGE': 'en_US:en', 10:15:27 INFO - 'LOGNAME': 'cltbld', 10:15:27 INFO - 'MAIL': '/var/mail/cltbld', 10:15:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:27 INFO - 'MOZ_NO_REMOTE': '1', 10:15:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:27 INFO - 'NO_EM_RESTART': '1', 10:15:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:27 INFO - 'PWD': '/builds/slave/test', 10:15:27 INFO - 'SHELL': '/bin/bash', 10:15:27 INFO - 'SHLVL': '1', 10:15:27 INFO - 'TERM': 'linux', 10:15:27 INFO - 'TMOUT': '86400', 10:15:27 INFO - 'USER': 'cltbld', 10:15:27 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464628494.941087-1800182361', 10:15:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:27 INFO - '_': '/tools/buildbot/bin/python'} 10:15:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:27 INFO - Downloading/unpacking jsonschema 10:15: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 10:15: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 10:15: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 10:15: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 10:15: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 10:15: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 10:15:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:15:29 INFO - Downloading/unpacking functools32 (from jsonschema) 10:15:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:29 INFO - Downloading functools32-3.2.3-2.tar.gz 10:15:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:15:29 INFO - warning: no files found matching '*.txt' 10:15:29 INFO - no previously-included directories found matching 'build' 10:15:29 INFO - no previously-included directories found matching 'dist' 10:15:29 INFO - no previously-included directories found matching '.git*' 10:15:29 INFO - Installing collected packages: jsonschema, functools32 10:15:29 INFO - Running setup.py install for functools32 10:15:29 INFO - warning: no files found matching '*.txt' 10:15:29 INFO - no previously-included directories found matching 'build' 10:15:29 INFO - no previously-included directories found matching 'dist' 10:15:29 INFO - no previously-included directories found matching '.git*' 10:15:29 INFO - Successfully installed jsonschema functools32 10:15:29 INFO - Cleaning up... 10:15:29 INFO - Return code: 0 10:15:29 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:15:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c943baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2580410>, '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 0x2581310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25817a0>, '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': '33d5923976266a1c518c4bf7000001ab-1464628494.941087-1800182361', '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 10:15:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:15:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:15:29 INFO - Using env: {'DISPLAY': ':0', 10:15:29 INFO - 'HOME': '/home/cltbld', 10:15:29 INFO - 'LANG': 'en_US.UTF-8', 10:15:29 INFO - 'LANGUAGE': 'en_US:en', 10:15:29 INFO - 'LOGNAME': 'cltbld', 10:15:29 INFO - 'MAIL': '/var/mail/cltbld', 10:15:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:29 INFO - 'MOZ_NO_REMOTE': '1', 10:15:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:29 INFO - 'NO_EM_RESTART': '1', 10:15:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:29 INFO - 'PWD': '/builds/slave/test', 10:15:29 INFO - 'SHELL': '/bin/bash', 10:15:29 INFO - 'SHLVL': '1', 10:15:29 INFO - 'TERM': 'linux', 10:15:29 INFO - 'TMOUT': '86400', 10:15:29 INFO - 'USER': 'cltbld', 10:15:29 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464628494.941087-1800182361', 10:15:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:29 INFO - '_': '/tools/buildbot/bin/python'} 10:15:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:29 INFO - Downloading/unpacking flake8 10:15:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:15:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:15:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:15:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:15:32 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 10:15:32 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 10:15:32 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 10:15:32 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 10:15:32 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 10:15:32 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 10:15:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:15:32 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 10:15:32 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 10:15:32 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 10:15:32 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 10:15:32 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 10:15:32 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 10:15:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:15:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:15:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:15:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:15:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:15:32 INFO - no previously-included directories found matching 'docs/_build' 10:15:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:15:32 INFO - Running setup.py install for pep8 10:15:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:15:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:15:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:15:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:15:32 INFO - no previously-included directories found matching 'docs/_build' 10:15:32 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:15:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:15:32 INFO - Cleaning up... 10:15:32 INFO - Return code: 0 10:15:32 INFO - Running post-action listener: _resource_record_post_action 10:15:32 INFO - Running post-action listener: _start_resource_monitoring 10:15:32 INFO - Starting resource monitoring. 10:15:32 INFO - ##### 10:15:32 INFO - ##### Running install step. 10:15:32 INFO - ##### 10:15:32 INFO - Running pre-action listener: _resource_record_pre_action 10:15:32 INFO - Running main action method: install 10:15:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:15:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:15:33 INFO - Reading from file tmpfile_stdout 10:15:33 INFO - Detecting whether we're running mozinstall >=1.0... 10:15:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:15:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:15:33 INFO - Reading from file tmpfile_stdout 10:15:33 INFO - Output received: 10:15:33 INFO - Usage: mozinstall [options] installer 10:15:33 INFO - Options: 10:15:33 INFO - -h, --help show this help message and exit 10:15:33 INFO - -d DEST, --destination=DEST 10:15:33 INFO - Directory to install application into. [default: 10:15:33 INFO - "/builds/slave/test"] 10:15:33 INFO - --app=APP Application being installed. [default: firefox] 10:15:33 INFO - mkdir: /builds/slave/test/build/application 10:15:33 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'] 10:15:33 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 10:15:48 INFO - Reading from file tmpfile_stdout 10:15:48 INFO - Output received: 10:15:48 INFO - /builds/slave/test/build/application/firefox/firefox 10:15:48 INFO - Running post-action listener: _resource_record_post_action 10:15:48 INFO - ##### 10:15:48 INFO - ##### Running run-tests step. 10:15:48 INFO - ##### 10:15:48 INFO - Running pre-action listener: _resource_record_pre_action 10:15:48 INFO - Running main action method: run_tests 10:15:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:15:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:15:48 INFO - Python 2.7.3 10:15:48 INFO - Return code: 0 10:15:48 INFO - grabbing minidump binary from tooltool 10:15: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')]} 10:15:48 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2580410>, '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 0x2581310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25817a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:15:48 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:15:48 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:15:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:15:48 INFO - Return code: 0 10:15:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:15:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:15:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:15:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:15:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:15:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:15:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:15:49 INFO - Return code: 0 10:15:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/boa9F7RPQdGTqlMknlJH_w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 10:15:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/boa9F7RPQdGTqlMknlJH_w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --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 10:15:49 INFO - Using env: {'DISPLAY': ':0', 10:15:49 INFO - 'HOME': '/home/cltbld', 10:15:49 INFO - 'LANG': 'en_US.UTF-8', 10:15:49 INFO - 'LANGUAGE': 'en_US:en', 10:15:49 INFO - 'LOGNAME': 'cltbld', 10:15:49 INFO - 'MAIL': '/var/mail/cltbld', 10:15:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:15:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:15:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:49 INFO - 'MOZ_NO_REMOTE': '1', 10:15:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:15:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:49 INFO - 'NO_EM_RESTART': '1', 10:15:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:49 INFO - 'PWD': '/builds/slave/test', 10:15:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:15:49 INFO - 'SHELL': '/bin/bash', 10:15:49 INFO - 'SHLVL': '1', 10:15:49 INFO - 'TERM': 'linux', 10:15:49 INFO - 'TMOUT': '86400', 10:15:49 INFO - 'USER': 'cltbld', 10:15:49 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464628494.941087-1800182361', 10:15:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:49 INFO - '_': '/tools/buildbot/bin/python'} 10:15:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/boa9F7RPQdGTqlMknlJH_w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 10:15:50 INFO - mozversion application_buildid: 20160530073151 10:15:50 INFO - mozversion application_changeset: ed1c3aae460813241ce2c3480df30fae2268ab1f 10:15:50 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:15:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:15:50 INFO - mozversion application_name: Firefox 10:15:50 INFO - mozversion application_remotingname: firefox-dev 10:15:50 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:15:50 INFO - mozversion application_vendor: Mozilla 10:15:50 INFO - mozversion application_version: 48.0a2 10:15:50 INFO - mozversion platform_buildid: 20160530073151 10:15:50 INFO - mozversion platform_changeset: ed1c3aae460813241ce2c3480df30fae2268ab1f 10:15:50 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:15:50 INFO - mozversion platform_version: 48.0a2 10:15:50 INFO - using testdate: 1464628550 10:15:50 INFO - actual date: 1464628550 10:15:50 INFO - starting webserver on 'localhost:51305' 10:15:50 INFO - SUITE-START | Running 2 tests 10:15:50 INFO - TEST-START | dromaeo_css 10:15:50 INFO - operating with platform_type : linux_ 10:15:50 INFO - Initialising browser for dromaeo_css test... 10:15:50 INFO - TEST-INFO | started process 1017 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4S4IFz/profile http://localhost:51305/getInfo.html) 10:16:04 INFO - PROCESS | 1017 | __metrics Screen width/height:1600/1200 10:16:04 INFO - PROCESS | 1017 | colorDepth:24 10:16:04 INFO - PROCESS | 1017 | Browser inner width/height: 1024/697 10:16:04 INFO - PROCESS | 1017 | __metrics 10:16:06 ERROR - PROCESS | 1017 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:16:07 INFO - TEST-INFO | 1017: exit 0 10:16:07 INFO - Browser initialized. 10:16:07 INFO - Running cycle 1/1 for dromaeo_css test... 10:16:07 INFO - TEST-INFO | started process 1119 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4S4IFz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:16:19 INFO - PROCESS | 1119 | RSS: Main: 141893632 10:16:19 INFO - PROCESS | 1119 | 10:17:10 INFO - PROCESS | 1119 | 1464628630553 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] 10:19:19 INFO - PROCESS | 1119 | Cycle 1(1): loaded http://localhost:51305/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51305/tests/dromaeo/cssquery-ext.html) 10:19:20 INFO - PROCESS | 1119 | RSS: Main: 251502592 10:19:20 INFO - PROCESS | 1119 | 10:22:22 INFO - PROCESS | 1119 | Cycle 1(1): loaded http://localhost:51305/tests/dromaeo/cssquery-ext.html (next: http://localhost:51305/tests/dromaeo/cssquery-jquery.html) 10:22:23 INFO - PROCESS | 1119 | RSS: Main: 227328000 10:22:23 INFO - PROCESS | 1119 | 10:25:24 INFO - PROCESS | 1119 | Cycle 1(1): loaded http://localhost:51305/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51305/tests/dromaeo/cssquery-mootools.html) 10:25:25 INFO - PROCESS | 1119 | RSS: Main: 209514496 10:25:25 INFO - PROCESS | 1119 | 10:28:27 INFO - PROCESS | 1119 | Cycle 1(1): loaded http://localhost:51305/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51305/tests/dromaeo/cssquery-prototype.html) 10:28:27 INFO - PROCESS | 1119 | RSS: Main: 219496448 10:28:27 INFO - PROCESS | 1119 | 10:31:30 INFO - PROCESS | 1119 | Cycle 1(1): loaded http://localhost:51305/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51305/tests/dromaeo/cssquery-yui.html) 10:31:31 INFO - PROCESS | 1119 | RSS: Main: 210599936 10:31:31 INFO - PROCESS | 1119 | 10:34:33 INFO - PROCESS | 1119 | Cycle 1(1): loaded http://localhost:51305/tests/dromaeo/cssquery-yui.html (next: http://localhost:51305/tests/dromaeo/cssquery-dojo.html) 10:34:33 INFO - PROCESS | 1119 | RSS: Main: 255012864 10:34:33 INFO - PROCESS | 1119 | 10:34:33 INFO - PROCESS | 1119 | __start_tp_report 10:34:33 INFO - PROCESS | 1119 | _x_x_mozilla_page_load 10:34:33 INFO - PROCESS | 1119 | _x_x_mozilla_page_load_details 10:34:33 INFO - PROCESS | 1119 | |i|pagename|runs| 10:34:33 INFO - PROCESS | 1119 | |0;dojo.html;3323.6344002159767;3394.304167645633;3409.539712138862;3421.110511267073;3460.2041530447996;5556.111022236438;5561.277033985586;5573.303337082864;5573.888522229553;5576.414476479972;5556.9444305556935;5566.693831839248;5576.386597474275;5585.1063829787245;5627.380988091307;4965.60661947962;5006.949930500694;5139.0749665060275;5184.585233181355;5220.634555581111;5123.436421993596;5187.144121220013;5192.792288308482;5194.013137503862;5198.792048318062;5082.1360368737405;5141.640085194038;5149.433562308143;5162.793488260465;5180.559652429548;5127.717975511346;5148.459411761786;5148.6910785353;5149.9485005149845;5174.4825517448335;4951.3810773653295;5007.349044624176;5042.218456139304;5077.898442031175;5099.566536844372;5546.389897111315;5604.971975140139;5609.046462101453;5615.522680572156;5627.184058311563;5964.284285885678;5966.761329546813;5969.820905372846;5970.432808883149;5972.343042265347;6024.036154215304;6122.142899994004;6179.443850053472;6179.752809887599;6212.254529456494;5711.857203569903;5717.8570535736935;5722.799702010409;5725.341585717612;5733.254676892019;6074.36219196978;6243.906341404882;6245.156903818017;6256.624602523863;6262.843428914222;5898.8820223595285;5956.642601443928;5961;5978.103284507359;5996.760129594854;6062.120992456069;6071.058985857199;6077.058056001327;6086.482648974887;6089.725962331706;5812.534997200214;6008.789692360747;6043.184170137063;6045.425684559959;6048.243969503812;6074.058520929263;6076.513878889678;6094.8171554853425;6100.72546735398;6129.1419201311855;4615.076984603093;4622.907541849211;4630.629549636021;4630.675852690347;4637.513061128533;4017.4777278953547;4037.9192416151513;4113.773742444135;4130.235906357333;4156.521999969982;5779.739911703983;5800.59395842287;5808.448197421239;5810.477057064884;5819.4762471376935;6082.57421980466;6100.877982440326;6124.35694252106;6126.724297406628;6132.110843927606;5629.887402251932;5724.4561766632105;5727.713614319267;5739.483446489836;5845.357010728816;5229.450907654717;5250.081235783722;5251.947480525222;5258.07983602868;5258.6581872178185;6244.406781355764;6316.62100273985;6322.778702745381;6327.050942358683;6331.303556608769;5942;6051.394860513913;6118.710550942667;6120.9652521188555;6143.354947730424;6292.716827742855;6293.339199383999;6306.432421082125;6346.238451385863;6348.492120630246;5755.223044888887;5963.314218864886;5986.07215881539;5991.281046274475;5992.9700351499705;6070.332263450929;6116.761878222105;6122.154209354628;6123.099607468126;6130.9791012021615;5941.37615550361;5952.821415357546;5956.076808094752;5960.433758792908;5970.850728731816;5654.802081927113;5799.8550036249435;5866.208061911588;5929.703514824328;5937.168796368598;5760.539156867524;5807.796727114531;5813.157092221689;5827.970860145672;5857.8535536610225;5883.588148829541;5928.436798504135;5935.2877654681715;5944.524438045032;5945.851353716192;5693.202951586698;5810.564207684356;5813.970930145322;5852.882942341044;5902.822915312548 10:34:33 INFO - PROCESS | 1119 | |1;ext.html;663.3532306001649;678.7285085965614;684.2678334182425;742.2021327073394;756.0889128600038;33706.325873482514;34366.48450273248;34427.65572344279;41002.38496422556;41511;43918.56081439184;44242.33636495447;44269.77865110678;44463.88752787306;44528.33207501882;8104.5542495162745;8777.912220877804;8955.552222388887;8962.283017358595;8965.641374345018;10396.220283478731;10577.947110264477;10582.100521455686;10584.364938103738;10588.523516441779;10702.839457408145;10788.838167427495;10789.244752867302;10798.082163016114;10799.784004319908;8185.79535511611;10424.843627345595;10559.630412935549;10656.467176641214;10663.520141593646;10503.422311772849;10587.84118238227;10636.255462117655;10636.946815265874;10641.946790266;41270.58729412698;41649.1670166598;41744.37383439251;41778;41834.163316733495;3761.360568703327;3840.788756618385;3864.652181303696;4050.7772072536;4417.690761646686;32075.358492830244;34612.134696632536;34659;34701.4794778076;34951.9514414568;4559.817607295738;4628.143793398199;4635.559621835921;4675.25461656419;4716.716996980158;322915;326706.3664681685;327077;327155;327956;68353.31646683569;68436.315636844;68521.65739171272;68868.6556567224;69002;72977.6351118241;74621;75926;76450.23549764432;76533;18082.63834723298;18222.453326400228;18234;18237.54406139857;18258.45224643263;13767.518136865161;13867.237301948287;14039.719205615831;14184.503542375967;14423.278836058365;21201.575968480545;21284.36146915595;21381.57236855254;21412.143514259566;21493.495455317978;7965.761027169194;8078.192180781874;8232.670693172326;8278.379121565908;8357.707480238163;1117.6423544465692;1121.1759356872692;1129.1249281806665;1139.5897476908306;1199.5141967503175;33638.663613363555;34044.14889627729;34217.48673769896;34605.78879739197;34688.13279667978;1213.2477863724548;1226.938653067343;1235.7528494301175;1282.435728279554;1313.5796545105666;17709.55726106832;18266.26934922588;18728.81271187298;19487.22051117968;19612.509687257934;520385;523803;524406;526097;530555;63992.36007639957;64713.35286647167;64737.35262647313;64876.675616621615;64892.67553662202;1365.2422905287463;1500.9549713508393;1552.5031989763393;1569.9215039247993;1654.1646468533554;30281;31625.5256171153;33975.66024339725;34322.656773432944;34371.31257374889;51483.74258128835;51997.7400112997;52330.47669523256;52500.212496811815;52506.73746631242;380830;380879;382161;382193;383327;28044.57933130964;30991.69008309888;31276.843615781774;31285;31572.526412104296;45210;47782.76108619435;48348;48645.27032094451;48977.265341020626;40387.99030024273;40667.7966610165;40750.79624601858;41836.37245441382;41864.58135418607;40800.59199407968;40869.38695919504;40900.59099408968;40921;41882.37176442295;42121.578784211764;45588.31617525806;45800;46875.765621171675;47084.52915470801;33484.83257583697;34850.82574587111;35010.64989350074;35116;35574.288514229054;28420.715792841806;29190.854045729637;29215.707842922147;29341.85329073341;29443.558346625246 10:34:33 INFO - PROCESS | 1119 | |2;jquery.html;420.45700139497416;435.77775334579354;442.91806015887045;445.6167695781628;448.6875888027521;18918.14868330925;19470.805291947094;19676.704849427253;20529;21034.368968930918;19789.307374241904;20175;20496.590068198628;20510.89744551279;20522.48693782656;5537.1140617501305;5917.615355001933;5922.555808314372;5929.73316200772;5930.822075337746;4245.830166793325;5797.65214087154;5877.67672777997;6082.543809214305;6370.74517019321;6321.841953951142;6336.968315158418;6341.778037768679;6342.334054924236;6355.269144048448;6138.785142520012;6282.591631543935;6434.324395938406;6443.226812782473;6443.259025212114;3977.960220397817;5600.551955843523;5749.59752817303;5769.653820770767;5834.3873893241025;22858.657120143213;23091.307260782203;23185.53628927429;23191.88404057986;24088;2512.1960972488628;2564.192279431973;2569.9100531481495;2763.9309017274727;3110.3623757129963;7626.771196864103;14188.57434276963;14844.183569903651;14868.033577817516;15628.843711562966;2017.0923084611984;2084.062172022596;2092.7488701355783;2157.223399576151;2196.8681879087308;77987.61006194989;78294.60852695757;79417.99999999942;80645;80769.59615201886;11114.444277786079;11158.815444208421;11341.206115571997;11624;11866.110041746904;15629.765553516707;16111.516654500383;16195.676086478205;16234.188290585424;16238.269277882524;9056.637734490547;9110.954445227731;9137.451752894847;9156.6795162169;9285.72142835716;9015.729528114167;9118.133777291147;9129;9176.908230917605;9197;6973.372396484341;7025.297470252934;7085.50401471892;7099.615574962832;7171.462140339391;1841.8894866308065;1987.9701804472945;2002.819746222847;2058.938231853047;2107.905144268512;1037.4345981440133;1070.5610699613121;1085.9674209773718;1134.8524691790014;1152.6657269391783;18675.066246687613;19201.423957281302;19525.414237572895;20233.595328093357;20473.89763051175;1115.9107271418268;1117.212365282474;1123.25864929148;1166.3759888459633;1272.739088486858;11727.120465964916;11748.70628234301;11791.469383877746;11829.408529573488;11880.940595296968;380821;386184;388940;390472;530853;95783.52108239415;97545.51227243818;99390.50304748575;99800;100233;1147.2772153543215;1166.026367982744;1175.8059920113258;1178.7112157521462;1188.1564089496383;17544.21051052731;17944.551386215448;18024.81975180284;18130.093495325444;18371.63256734831;40057.599424006556;40183;41680.58319416767;42066;42247.155056899304;55307.44692553023;56961.71519142378;58880;61174.38825611865;61643.69178154081;8575.656973720981;8702.956485217534;8737.563121843756;8794.076621954602;8838.425502342327;9870;10593.89406105929;12936.611901642966;13051;13714.51999180024;11222.270552414067;11395.373254471084;11690.70773230676;11721.355325457182;11752.647420577396;5575.581831362583;9387.483688397204;11277.71805704864;11558.479868405773;11933.582324618597;12362.196457230251;12533.749325013267;12563.434645440795;12712.936435317764;12741.745165096461;8685.826283474422;8744.431611945203;8747.65009399617;8839.46963182211;8883.777905552413;9033.141851524095;11323.716907077389;12158;12221.816672749737;12319.815202772144 10:34:33 INFO - PROCESS | 1119 | |3;mootools.html;1426.1585664457969;1546.814382274127;1583.897046691965;1756.9824301756978;1869.72888931105;7372.963135184324;8149.796255093625;8291.253787159154;8297.917020829798;8306.91693083069;8210.425270231071;8391.328693704505;8397.202265784756;8398.28614567761;8398.3281337493;2090.8118269355755;2368.549975504657;2409.8674572898526;2429.0526694589125;2440.9755902441016;2435.0503303711566;2444.523317953;2446.9755302447015;2449.375409270642;2449.5223431430877;2377.619580867062;2433.866137362453;2441.816863735227;2441.987790061056;2443.926682199537;2132.9040193191345;2438.8414753040997;2475.814313926454;2476.752324767509;2479.826412151132;2413.6862207913036;2425.5162315347084;2427.381017840457;2442.3894026493376;2476.578981573137;8370.581470926429;8460.196281353261;8470.364722645827;8477.915220847774;8480.575971201415;5325.068113080196;5382;5423.376311724123;5434.483724046209;5444;3518.313928783888;3593.4250519916686;3624.9275014499826;3629.27414517095;3655.5065066215984;1159.8144296912537;1186.8991135753472;1190.2560899437851;1198.7003249187703;1246.613549799556;11731.882681173165;11929.761404771856;11929.761404771943;11931.463084161234;11931.940340298243;4657.138429390574;4666.416697912761;4758.524147585283;4815.542523460265;4872.731999740048;10276.897231027744;10283.07452329294;10288.12550933179;10295.94852025735;10305.690829274983;4833.081714474239;5465.426130256265;5468.660178256353;5470.480304371078;5472.315960504937;4698.201305777958;4705.153072446992;4715.292706094114;4763.3807605011125;4774.689645173053;4150.1284730207;4166.729162604421;4258.297380932111;4267.4025636410925;4275.315949448135;1331.6471135149193;1363.6931690369786;1368.2269517722455;1402.6563491944335;1408.8520705325793;960.7454024683325;984.6455276100598;1022.1158697726413;1026.7227848480868;1117.458032854065;6100.908486372708;6152.2002139722445;6181.072839074175;6187.907181392283;6224.906626400608;1034.94307813071;1046.7173863056933;1067.43087661138;1067.572970811666;1071.5071067309125;4304.246756817544;4419.535948725337;4450.666200035011;4451.577100175478;4467.195904737178;10038.64864729731;10407.68776936693;10419.426931518688;10458.111060559786;10590.788184236271;9913.75215619601;10002.499875006366;10131.341462804894;10131.442770647538;10149.035841595036;7658.770236892902;7771.533707977539;7782.8054298641855;7787.44251149761;7832.177621349791;5994.850128746816;6118.326984031842;6155.72299246526;6191;6269.7178626962805;9112;9314.72055838326;9400.106989835955;9411.152996230097;9433.764155896157;9394.107559781809;9420.905790942003;9731.56207970629;9760.804783904425;9773;6759.493038022069;7395.8151046224275;7501.924980750341;7586.317231449196;7698.884516732365;8070.798230044061;8084.797880053045;8121.066077401175;8145.714899978472;8146.714864979697;7359.852802944019;7362.9631851840395;7490.213527579525;7608.087029556488;7676.462647614613;7337.633118344168;7405.44459165554;7416.666250018654;7466.514676546007;7508.211637778173;6720.1599800025;6724.092247546519;6760;6768.052472653931;6770.187577490733;5248.212768084818;5273.419923808455;5360.195970604284;5384.084705599979;5424.403315635356;5424.294841670558;5444.891102178013;5450.400455949763;5454.3454785426;5503.559715222853 10:34:33 INFO - PROCESS | 1119 | |4;prototype.html;346.6066015072892;346.89246333636567;355.4082452716228;357.2230398882432;364.2550983239277;6323.810285691425;6385.680715964207;6394.200724909387;6421.940379837333;6452.4192822645955;6268.153799237101;6273.717682704278;6288.842778930529;6295.15015472911;6315.147455093561;4596.747178905151;4684.297355396684;4743.600637811854;4746.145693775119;4761.262004389308;4745.311929770181;4747.691400059002;4764.975530260993;4792.424909010906;4802.991371811923;4566.6575006874455;4755.001449695568;4763.261694437368;4764.761761911908;4768.761561921908;4639.930401043987;4664.813407463697;4682.110399024192;4727.834525791615;4739.123262196505;4138.937915931264;4157.3140431829015;4157.605027522381;4167.166566686645;4176.373543968399;6012.128241405016;6020.518358531351;6047.7278522466595;6052.061930400795;6063.333033366371;5543.695096769676;5546.500814926636;5548.445155484419;5554.055810512223;5562.471565201299;6485.254195767453;6610.471162307004;6616.503762217853;6622.9668851655915;6634.46924246064;4603.677742558022;4614.2617181250835;4615.676902616819;4617.953820461786;4690.695104818176;6917.481188910851;6932.064171336855;6944.062551555526;6967.1291088613925;6976.860462790766;4685.953140468551;4686.81252749893;4697.389339385926;4698.88252793676;4700.435947686299;4865.172920603506;4873.220284754422;4873.853784386474;4875.7074575524875;4878.292647566083;5522.972385138049;5530.253415788817;5535.25274087993;5537.916931246034;5542.501174894279;6545.083688283644;6687.732490700415;6696.86606267872;6702.765403210962;6703.262641109474;1700.4388551777884;1713.0406972095666;1719.8624110071164;1721.3458885623384;1721.5696075981004;1078.8058149533003;1097.6103483263487;1098.6868742408376;1111.360967443723;1131.7114135895295;6474.1907261592305;6562.376574225441;6579.703913323912;6585.769498067544;6587.374199451045;6978.302169783083;6989.091418115612;7000;7000.47496437759;7000.649967501605;6579.967100164468;6610.8016759497295;6655.6339401332425;6661.3005634408655;6664.400203981568;3705.888823335304;3758.8872333830027;3764;3771;3776.2258736958856;7010.544314619533;7239.095113110861;7248.565086094745;7253.165885923187;7266.164391095092;7105.89341159883;7109.253528379549;7120.038794762744;7120.145582530026;7126.964365178244;7214.891776623354;7225.205227424979;7233.963830180921;7255.818604534928;7277.818054548678;6918.757843475454;6962.110724049463;6965.268646792014;6968.4076853465995;6973.96513017452;6603.306652801579;6915.239323674492;6919.411849992605;6920.342567456084;6929.757458488929;7261.455390845602;7278.927210728037;7295.781126566211;7299.708011679473;7302.306280903305;4693.882652933704;4726.1020406122725;4731.716097034189;4733.721895088376;4733.952660473489;6965.616891071039;6975.581465112109;6988.615626140611;6989.7553585624255;6990.021397004525;6573.3098024706715;6782.084418603426;6820.693068812015;6843.931560684528;6844.760433384808;6773.221079575715;6777;6790.93209067903;6791.796246112624;6794.184697836094;6659.467242620482;6667.599944003376;6678.933210667831;6678.933210668026;6683.064370987969;6836;6845.281245469353;6850.520463567503;6854.862902742017;6856.177258728984;6407.487401008001;6499.447546958561;6614.173228346457;6694;6744.865102698017 10:34:33 INFO - PROCESS | 1119 | |5;yui.html;820.3027426687313;854.3933806997031;860.11408249503;913.1507697841007;918.728974952389;15977.600559986005;16194;16214.351425942948;16227.432039878606;16247.268872900719;14520.128792272471;14787.186704731235;14795.556133316019;14839.035462694917;14939.103653780781;746.3991486853081;867.7396780965717;893.4907102951321;895.0288936503902;903.5662881816731;899.6176624934409;899.9775005624846;901.085398320705;902.1700035966926;902.2331018634175;945.2060269373725;947.1522986926697;948.3503799897059;948.6015873333182;948.8102379524088;806.3267171911461;924.3852837862813;941.4257303045136;944.6032666280179;945.9858102128474;689.8792711275557;691.408845437154;691.861627674462;694.4583225084442;696.3767428151775;15147.621309467351;15165.696686066327;15234.238288085662;15239.466618668404;15242.923785381003;14576.271186440636;14811.48159814412;14863.405463781435;14945.775813362809;15026.849731502654;12044.698882528008;12078.27530348182;12294.692632684166;12362.505499779998;12605.08352349622;4086.9182616347803;4110.157417729359;4126.66986641068;4151.97924010378;4160.895977600554;61490.69254653698;61884;62254;62298.99999999955;62386.68806655983;11972.58095966637;12010.939945300217;12155.756884862254;12228.266304021787;12334.259944403364;22265.888670556542;22295.777042229696;22304.10783568639;22320.10719571199;22338;8856.291496680251;9000.684976025808;9135.954320228357;9349.813003739888;9438.197753190918;5125.79496820123;5253.13323301651;5263.499967503081;5271.499207575274;5312.707801070978;3501.824908754552;3565.16218688608;3577.5885773136424;3578.4453409721536;3582;617.0990354083;623.23031056645;649.6037417175519;651.4950913042335;681.2676372899153;801.1747899663357;805.9153788852203;816.1797393619374;830.7009476588423;833.2875391540267;9820.263480239011;10079.949600251952;10142.442165680959;10413.219008574235;10442.164626829835;661.3381140907788;767.2136060537881;801.631249625179;809.4455298120688;832.995835020821;4633.513481084437;4694.812207511662;4911.009717529892;4920.163572192664;4953.678010929278;69373.30626693668;70875;71147;71171.28828711646;71483.2851671487;54763.72618136884;58201.12698309529;58633;59160.11259831106;59923;54028;54722.72638636861;54993.72503137459;56022.439775602536;56282.71858640681;10051.359863439617;10077.94989785195;10171.28800983924;10309.536070876979;10358.860525342358;40512.79743601381;40567;41500.58499414967;41702;41886.581134188265;48657;48744;53473.73263133659;54033.45966540284;54658.726706366215;12375.814362784746;12665.683357916127;12835.422405991567;12900.935495322463;12959.546415875398;14288.857111428753;14306.928465357607;14395.280235988368;14473;14475.638109047359;11689.941550292195;13202.603921882359;13669.38487768033;13813.309334533033;14125.929370353082;13414.798778018143;13764.449422023006;13780.586582402544;13895.30523473802;14194.645133871323;13554.59336219915;13691.124893494807;13793.724125517232;13902.582922512342;14408.639784005065;10673.092787113183;10944.343339399344;10998.890011099787;11029.503672334924;11058.944705276423;11197.216194866282;11559.884401156218;11845.822312665488;11953.940230298793;11956.521739130338 10:34:33 INFO - PROCESS | 1119 | __end_tp_report 10:34:33 INFO - PROCESS | 1119 | __start_cc_report 10:34:33 INFO - PROCESS | 1119 | _x_x_mozilla_cycle_collect,894 10:34:33 INFO - PROCESS | 1119 | __end_cc_report 10:34:33 INFO - PROCESS | 1119 | __startTimestamp1464629673874__endTimestamp 10:34:33 INFO - PROCESS | 1119 | 10:34:33 INFO - PROCESS | 1119 | ------- Summary: start ------- 10:34:33 INFO - PROCESS | 1119 | Number of tests: 6 10:34:33 INFO - PROCESS | 1119 | 10:34:33 INFO - PROCESS | 1119 | [#0] dojo.html Cycles:165 Average:5625.99 Median:5813.97 stddev:636.65 (11.0%) stddev-sans-first:612.45 10:34:33 INFO - PROCESS | 1119 | Values: 3323.6 3394.3 3409.5 3421.1 3460.2 5556.1 5561.3 5573.3 5573.9 5576.4 5556.9 5566.7 5576.4 5585.1 5627.4 4965.6 5006.9 5139.1 5184.6 5220.6 5123.4 5187.1 5192.8 5194.0 5198.8 5082.1 5141.6 5149.4 5162.8 5180.6 5127.7 5148.5 5148.7 5149.9 5174.5 4951.4 5007.3 5042.2 5077.9 5099.6 5546.4 5605.0 5609.0 5615.5 5627.2 5964.3 5966.8 5969.8 5970.4 5972.3 6024.0 6122.1 6179.4 6179.8 6212.3 5711.9 5717.9 5722.8 5725.3 5733.3 6074.4 6243.9 6245.2 6256.6 6262.8 5898.9 5956.6 5961.0 5978.1 5996.8 6062.1 6071.1 6077.1 6086.5 6089.7 5812.5 6008.8 6043.2 6045.4 6048.2 6074.1 6076.5 6094.8 6100.7 6129.1 4615.1 4622.9 4630.6 4630.7 4637.5 4017.5 4037.9 4113.8 4130.2 4156.5 5779.7 5800.6 5808.4 5810.5 5819.5 6082.6 6100.9 6124.4 6126.7 6132.1 5629.9 5724.5 5727.7 5739.5 5845.4 5229.5 5250.1 5251.9 5258.1 5258.7 6244.4 6316.6 6322.8 6327.1 6331.3 5942.0 6051.4 6118.7 6121.0 6143.4 6292.7 6293.3 6306.4 6346.2 6348.5 5755.2 5963.3 5986.1 5991.3 5993.0 6070.3 6116.8 6122.2 6123.1 6131.0 5941.4 5952.8 5956.1 5960.4 5970.9 5654.8 5799.9 5866.2 5929.7 5937.2 5760.5 5807.8 5813.2 5828.0 5857.9 5883.6 5928.4 5935.3 5944.5 5945.9 5693.2 5810.6 5814.0 5852.9 5902.8 10:34:33 INFO - PROCESS | 1119 | 10:34:33 INFO - PROCESS | 1119 | [#1] ext.html Cycles:180 Average:59248.67 Median:35345.14 stddev:110881.92 (313.7%) stddev-sans-first:111105.72 10:34:33 INFO - PROCESS | 1119 | Values: 663.4 678.7 684.3 742.2 756.1 33706.3 34366.5 34427.7 41002.4 41511.0 43918.6 44242.3 44269.8 44463.9 44528.3 8104.6 8777.9 8955.6 8962.3 8965.6 10396.2 10577.9 10582.1 10584.4 10588.5 10702.8 10788.8 10789.2 10798.1 10799.8 8185.8 10424.8 10559.6 10656.5 10663.5 10503.4 10587.8 10636.3 10636.9 10641.9 41270.6 41649.2 41744.4 41778.0 41834.2 3761.4 3840.8 3864.7 4050.8 4417.7 32075.4 34612.1 34659.0 34701.5 34952.0 4559.8 4628.1 4635.6 4675.3 4716.7 322915.0 326706.4 327077.0 327155.0 327956.0 68353.3 68436.3 68521.7 68868.7 69002.0 72977.6 74621.0 75926.0 76450.2 76533.0 18082.6 18222.5 18234.0 18237.5 18258.5 13767.5 13867.2 14039.7 14184.5 14423.3 21201.6 21284.4 21381.6 21412.1 21493.5 7965.8 8078.2 8232.7 8278.4 8357.7 1117.6 1121.2 1129.1 1139.6 1199.5 33638.7 34044.1 34217.5 34605.8 34688.1 1213.2 1226.9 1235.8 1282.4 1313.6 17709.6 18266.3 18728.8 19487.2 19612.5 520385.0 523803.0 524406.0 526097.0 530555.0 63992.4 64713.4 64737.4 64876.7 64892.7 1365.2 1501.0 1552.5 1569.9 1654.2 30281.0 31625.5 33975.7 34322.7 34371.3 51483.7 51997.7 52330.5 52500.2 52506.7 380830.0 380879.0 382161.0 382193.0 383327.0 28044.6 30991.7 31276.8 31285.0 31572.5 45210.0 47782.8 48348.0 48645.3 48977.3 40388.0 40667.8 40750.8 41836.4 41864.6 40800.6 40869.4 40900.6 40921.0 41882.4 42121.6 45588.3 45800.0 46875.8 47084.5 33484.8 34850.8 35010.6 35116.0 35574.3 28420.7 29190.9 29215.7 29341.9 29443.6 10:34:33 INFO - PROCESS | 1119 | 10:34:33 INFO - PROCESS | 1119 | [#2] jquery.html Cycles:180 Average:27444.28 Median:13300.10 stddev:69723.69 (524.2%) stddev-sans-first:69889.76 10:34:33 INFO - PROCESS | 1119 | Values: 420.5 435.8 442.9 445.6 448.7 18918.1 19470.8 19676.7 20529.0 21034.4 19789.3 20175.0 20496.6 20510.9 20522.5 5537.1 5917.6 5922.6 5929.7 5930.8 4245.8 5797.7 5877.7 6082.5 6370.7 6321.8 6337.0 6341.8 6342.3 6355.3 6138.8 6282.6 6434.3 6443.2 6443.3 3978.0 5600.6 5749.6 5769.7 5834.4 22858.7 23091.3 23185.5 23191.9 24088.0 2512.2 2564.2 2569.9 2763.9 3110.4 7626.8 14188.6 14844.2 14868.0 15628.8 2017.1 2084.1 2092.7 2157.2 2196.9 77987.6 78294.6 79418.0 80645.0 80769.6 11114.4 11158.8 11341.2 11624.0 11866.1 15629.8 16111.5 16195.7 16234.2 16238.3 9056.6 9111.0 9137.5 9156.7 9285.7 9015.7 9118.1 9129.0 9176.9 9197.0 6973.4 7025.3 7085.5 7099.6 7171.5 1841.9 1988.0 2002.8 2058.9 2107.9 1037.4 1070.6 1086.0 1134.9 1152.7 18675.1 19201.4 19525.4 20233.6 20473.9 1115.9 1117.2 1123.3 1166.4 1272.7 11727.1 11748.7 11791.5 11829.4 11880.9 380821.0 386184.0 388940.0 390472.0 530853.0 95783.5 97545.5 99390.5 99800.0 100233.0 1147.3 1166.0 1175.8 1178.7 1188.2 17544.2 17944.6 18024.8 18130.1 18371.6 40057.6 40183.0 41680.6 42066.0 42247.2 55307.4 56961.7 58880.0 61174.4 61643.7 8575.7 8703.0 8737.6 8794.1 8838.4 9870.0 10593.9 12936.6 13051.0 13714.5 11222.3 11395.4 11690.7 11721.4 11752.6 5575.6 9387.5 11277.7 11558.5 11933.6 12362.2 12533.7 12563.4 12712.9 12741.7 8685.8 8744.4 8747.7 8839.5 8883.8 9033.1 11323.7 12158.0 12221.8 12319.8 10:34:33 INFO - PROCESS | 1119 | 10:34:33 INFO - PROCESS | 1119 | [#3] mootools.html Cycles:180 Average:5704.16 Median:4824.31 stddev:3054.08 (63.3%) stddev-sans-first:3045.72 10:34:33 INFO - PROCESS | 1119 | Values: 1426.2 1546.8 1583.9 1757.0 1869.7 7373.0 8149.8 8291.3 8297.9 8306.9 8210.4 8391.3 8397.2 8398.3 8398.3 2090.8 2368.5 2409.9 2429.1 2441.0 2435.1 2444.5 2447.0 2449.4 2449.5 2377.6 2433.9 2441.8 2442.0 2443.9 2132.9 2438.8 2475.8 2476.8 2479.8 2413.7 2425.5 2427.4 2442.4 2476.6 8370.6 8460.2 8470.4 8477.9 8480.6 5325.1 5382.0 5423.4 5434.5 5444.0 3518.3 3593.4 3624.9 3629.3 3655.5 1159.8 1186.9 1190.3 1198.7 1246.6 11731.9 11929.8 11929.8 11931.5 11931.9 4657.1 4666.4 4758.5 4815.5 4872.7 10276.9 10283.1 10288.1 10295.9 10305.7 4833.1 5465.4 5468.7 5470.5 5472.3 4698.2 4705.2 4715.3 4763.4 4774.7 4150.1 4166.7 4258.3 4267.4 4275.3 1331.6 1363.7 1368.2 1402.7 1408.9 960.7 984.6 1022.1 1026.7 1117.5 6100.9 6152.2 6181.1 6187.9 6224.9 1034.9 1046.7 1067.4 1067.6 1071.5 4304.2 4419.5 4450.7 4451.6 4467.2 10038.6 10407.7 10419.4 10458.1 10590.8 9913.8 10002.5 10131.3 10131.4 10149.0 7658.8 7771.5 7782.8 7787.4 7832.2 5994.9 6118.3 6155.7 6191.0 6269.7 9112.0 9314.7 9400.1 9411.2 9433.8 9394.1 9420.9 9731.6 9760.8 9773.0 6759.5 7395.8 7501.9 7586.3 7698.9 8070.8 8084.8 8121.1 8145.7 8146.7 7359.9 7363.0 7490.2 7608.1 7676.5 7337.6 7405.4 7416.7 7466.5 7508.2 6720.2 6724.1 6760.0 6768.1 6770.2 5248.2 5273.4 5360.2 5384.1 5424.4 5424.3 5444.9 5450.4 5454.3 5503.6 10:34:33 INFO - PROCESS | 1119 | 10:34:33 INFO - PROCESS | 1119 | [#4] prototype.html Cycles:180 Average:5622.78 Median:6463.31 stddev:1720.02 (26.6%) stddev-sans-first:1678.64 10:34:33 INFO - PROCESS | 1119 | Values: 346.6 346.9 355.4 357.2 364.3 6323.8 6385.7 6394.2 6421.9 6452.4 6268.2 6273.7 6288.8 6295.2 6315.1 4596.7 4684.3 4743.6 4746.1 4761.3 4745.3 4747.7 4765.0 4792.4 4803.0 4566.7 4755.0 4763.3 4764.8 4768.8 4639.9 4664.8 4682.1 4727.8 4739.1 4138.9 4157.3 4157.6 4167.2 4176.4 6012.1 6020.5 6047.7 6052.1 6063.3 5543.7 5546.5 5548.4 5554.1 5562.5 6485.3 6610.5 6616.5 6623.0 6634.5 4603.7 4614.3 4615.7 4618.0 4690.7 6917.5 6932.1 6944.1 6967.1 6976.9 4686.0 4686.8 4697.4 4698.9 4700.4 4865.2 4873.2 4873.9 4875.7 4878.3 5523.0 5530.3 5535.3 5537.9 5542.5 6545.1 6687.7 6696.9 6702.8 6703.3 1700.4 1713.0 1719.9 1721.3 1721.6 1078.8 1097.6 1098.7 1111.4 1131.7 6474.2 6562.4 6579.7 6585.8 6587.4 6978.3 6989.1 7000.0 7000.5 7000.6 6580.0 6610.8 6655.6 6661.3 6664.4 3705.9 3758.9 3764.0 3771.0 3776.2 7010.5 7239.1 7248.6 7253.2 7266.2 7105.9 7109.3 7120.0 7120.1 7127.0 7214.9 7225.2 7234.0 7255.8 7277.8 6918.8 6962.1 6965.3 6968.4 6974.0 6603.3 6915.2 6919.4 6920.3 6929.8 7261.5 7278.9 7295.8 7299.7 7302.3 4693.9 4726.1 4731.7 4733.7 4734.0 6965.6 6975.6 6988.6 6989.8 6990.0 6573.3 6782.1 6820.7 6843.9 6844.8 6773.2 6777.0 6790.9 6791.8 6794.2 6659.5 6667.6 6678.9 6678.9 6683.1 6836.0 6845.3 6850.5 6854.9 6856.2 6407.5 6499.4 6614.2 6694.0 6744.9 10:34:33 INFO - PROCESS | 1119 | 10:34:33 INFO - PROCESS | 1119 | [#5] yui.html Cycles:180 Average:16459.94 Median:4156.44 stddev:19231.08 (462.7%) stddev-sans-first:19249.17 10:34:33 INFO - PROCESS | 1119 | Values: 820.3 854.4 860.1 913.2 918.7 15977.6 16194.0 16214.4 16227.4 16247.3 14520.1 14787.2 14795.6 14839.0 14939.1 746.4 867.7 893.5 895.0 903.6 899.6 900.0 901.1 902.2 902.2 945.2 947.2 948.4 948.6 948.8 806.3 924.4 941.4 944.6 946.0 689.9 691.4 691.9 694.5 696.4 15147.6 15165.7 15234.2 15239.5 15242.9 14576.3 14811.5 14863.4 14945.8 15026.8 12044.7 12078.3 12294.7 12362.5 12605.1 4086.9 4110.2 4126.7 4152.0 4160.9 61490.7 61884.0 62254.0 62299.0 62386.7 11972.6 12010.9 12155.8 12228.3 12334.3 22265.9 22295.8 22304.1 22320.1 22338.0 8856.3 9000.7 9136.0 9349.8 9438.2 5125.8 5253.1 5263.5 5271.5 5312.7 3501.8 3565.2 3577.6 3578.4 3582.0 617.1 623.2 649.6 651.5 681.3 801.2 805.9 816.2 830.7 833.3 9820.3 10079.9 10142.4 10413.2 10442.2 661.3 767.2 801.6 809.4 833.0 4633.5 4694.8 4911.0 4920.2 4953.7 69373.3 70875.0 71147.0 71171.3 71483.3 54763.7 58201.1 58633.0 59160.1 59923.0 54028.0 54722.7 54993.7 56022.4 56282.7 10051.4 10077.9 10171.3 10309.5 10358.9 40512.8 40567.0 41500.6 41702.0 41886.6 48657.0 48744.0 53473.7 54033.5 54658.7 12375.8 12665.7 12835.4 12900.9 12959.5 14288.9 14306.9 14395.3 14473.0 14475.6 11689.9 13202.6 13669.4 13813.3 14125.9 13414.8 13764.4 13780.6 13895.3 14194.6 13554.6 13691.1 13793.7 13902.6 14408.6 10673.1 10944.3 10998.9 11029.5 11058.9 11197.2 11559.9 11845.8 11953.9 11956.5 10:34:33 INFO - PROCESS | 1119 | -------- Summary: end -------- 10:34:33 INFO - PROCESS | 1119 | 10:34:34 INFO - TEST-INFO | 1119: exit 0 10:34:34 INFO - TEST-OK | dromaeo_css | took 1124618ms 10:34:34 INFO - TEST-START | kraken 10:34:34 INFO - operating with platform_type : linux_ 10:34:34 INFO - Initialising browser for kraken test... 10:34:34 INFO - TEST-INFO | started process 1377 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXcQsPA/profile http://localhost:51305/getInfo.html) 10:34:40 INFO - PROCESS | 1377 | __metrics Screen width/height:1600/1200 10:34:40 INFO - PROCESS | 1377 | colorDepth:24 10:34:40 INFO - PROCESS | 1377 | Browser inner width/height: 1024/697 10:34:40 INFO - PROCESS | 1377 | __metrics 10:34:42 ERROR - PROCESS | 1377 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:34:43 INFO - TEST-INFO | 1377: exit 0 10:34:43 INFO - Browser initialized. 10:34:43 INFO - Running cycle 1/1 for kraken test... 10:34:43 INFO - TEST-INFO | started process 1468 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXcQsPA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:34:55 INFO - PROCESS | 1468 | RSS: Main: 141864960 10:34:55 INFO - PROCESS | 1468 | 10:34:57 INFO - PROCESS | 1468 | Cycle 1(1): loaded http://localhost:51305/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51305/tests/kraken/driver.html?testName=audio-beat-detection) 10:34:58 INFO - PROCESS | 1468 | RSS: Main: 196886528 10:34:58 INFO - PROCESS | 1468 | 10:35:01 INFO - PROCESS | 1468 | Cycle 1(1): loaded http://localhost:51305/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51305/tests/kraken/driver.html?testName=audio-dft) 10:35:01 INFO - PROCESS | 1468 | RSS: Main: 183083008 10:35:01 INFO - PROCESS | 1468 | 10:35:04 INFO - PROCESS | 1468 | Cycle 1(1): loaded http://localhost:51305/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51305/tests/kraken/driver.html?testName=audio-fft) 10:35:05 INFO - PROCESS | 1468 | RSS: Main: 273502208 10:35:05 INFO - PROCESS | 1468 | 10:35:07 INFO - PROCESS | 1468 | Cycle 1(1): loaded http://localhost:51305/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51305/tests/kraken/driver.html?testName=audio-oscillator) 10:35:07 INFO - PROCESS | 1468 | RSS: Main: 179560448 10:35:07 INFO - PROCESS | 1468 | 10:35:09 INFO - PROCESS | 1468 | Cycle 1(1): loaded http://localhost:51305/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51305/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:35:10 INFO - PROCESS | 1468 | RSS: Main: 177778688 10:35:10 INFO - PROCESS | 1468 | 10:35:13 INFO - PROCESS | 1468 | Cycle 1(1): loaded http://localhost:51305/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51305/tests/kraken/driver.html?testName=imaging-darkroom) 10:35:14 INFO - PROCESS | 1468 | RSS: Main: 212140032 10:35:14 INFO - PROCESS | 1468 | 10:35:17 INFO - PROCESS | 1468 | Cycle 1(1): loaded http://localhost:51305/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51305/tests/kraken/driver.html?testName=imaging-desaturate) 10:35:18 INFO - PROCESS | 1468 | RSS: Main: 212086784 10:35:18 INFO - PROCESS | 1468 | 10:35:20 INFO - PROCESS | 1468 | Cycle 1(1): loaded http://localhost:51305/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51305/tests/kraken/driver.html?testName=json-parse-financial) 10:35:21 INFO - PROCESS | 1468 | RSS: Main: 212213760 10:35:21 INFO - PROCESS | 1468 | 10:35:22 INFO - PROCESS | 1468 | Cycle 1(1): loaded http://localhost:51305/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51305/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:35:23 INFO - PROCESS | 1468 | RSS: Main: 190672896 10:35:23 INFO - PROCESS | 1468 | 10:35:25 INFO - PROCESS | 1468 | Cycle 1(1): loaded http://localhost:51305/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51305/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:35:25 INFO - PROCESS | 1468 | RSS: Main: 194834432 10:35:25 INFO - PROCESS | 1468 | 10:35:27 INFO - PROCESS | 1468 | Cycle 1(1): loaded http://localhost:51305/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51305/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:35:28 INFO - PROCESS | 1468 | RSS: Main: 207441920 10:35:28 INFO - PROCESS | 1468 | 10:35:30 INFO - PROCESS | 1468 | Cycle 1(1): loaded http://localhost:51305/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51305/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:35:31 INFO - PROCESS | 1468 | RSS: Main: 212717568 10:35:31 INFO - PROCESS | 1468 | 10:35:34 INFO - PROCESS | 1468 | Cycle 1(1): loaded http://localhost:51305/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51305/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:35:34 INFO - PROCESS | 1468 | RSS: Main: 210378752 10:35:34 INFO - PROCESS | 1468 | 10:35:36 INFO - PROCESS | 1468 | Cycle 1(1): loaded http://localhost:51305/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51305/tests/kraken/driver.html?testName=ai-astar) 10:35:36 INFO - PROCESS | 1468 | RSS: Main: 274178048 10:35:36 INFO - PROCESS | 1468 | 10:35:36 INFO - PROCESS | 1468 | __start_tp_report 10:35:36 INFO - PROCESS | 1468 | _x_x_mozilla_page_load 10:35:36 INFO - PROCESS | 1468 | _x_x_mozilla_page_load_details 10:35:36 INFO - PROCESS | 1468 | |i|pagename|runs| 10:35:36 INFO - PROCESS | 1468 | |0;ai-astar;111;112;112;111;112;112;107;111;110;111 10:35:36 INFO - PROCESS | 1468 | |1;audio-beat-detection;156;129;156;175;143;158;160;129;183;127 10:35:36 INFO - PROCESS | 1468 | |2;audio-dft;163;161;160;160;161;160;163;160;162;160 10:35:36 INFO - PROCESS | 1468 | |3;audio-fft;77;76;76;172;76;74;74;73;162;72 10:35:36 INFO - PROCESS | 1468 | |4;audio-oscillator;92;94;146;92;92;92;155;92;93;142 10:35:36 INFO - PROCESS | 1468 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;117;117;116 10:35:36 INFO - PROCESS | 1468 | |6;imaging-darkroom;146;145;148;145;147;145;145;145;146;145 10:35:36 INFO - PROCESS | 1468 | |7;imaging-desaturate;95;95;94;94;95;95;95;94;94;95 10:35:36 INFO - PROCESS | 1468 | |8;json-parse-financial;52;54;53;54;56;54;57;75;53;51 10:35:36 INFO - PROCESS | 1468 | |9;json-stringify-tinderbox;58;59;59;59;59;58;59;59;58;59 10:35:36 INFO - PROCESS | 1468 | |10;stanford-crypto-aes;72;72;71;78;73;72;74;72;73;72 10:35:36 INFO - PROCESS | 1468 | |11;stanford-crypto-ccm;112;115;116;114;116;111;112;112;126;112 10:35:36 INFO - PROCESS | 1468 | |12;stanford-crypto-pbkdf2;160;156;158;154;157;162;156;158;158;157 10:35:36 INFO - PROCESS | 1468 | |13;stanford-crypto-sha256-iterative;67;68;71;65;67;67;66;65;67;61 10:35:36 INFO - PROCESS | 1468 | __end_tp_report 10:35:36 INFO - PROCESS | 1468 | __start_cc_report 10:35:36 INFO - PROCESS | 1468 | _x_x_mozilla_cycle_collect,1621 10:35:36 INFO - PROCESS | 1468 | __end_cc_report 10:35:36 INFO - PROCESS | 1468 | __startTimestamp1464629736579__endTimestamp 10:35:36 INFO - PROCESS | 1468 | 10:35:36 INFO - PROCESS | 1468 | ------- Summary: start ------- 10:35:36 INFO - PROCESS | 1468 | Number of tests: 14 10:35:36 INFO - PROCESS | 1468 | 10:35:36 INFO - PROCESS | 1468 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.50 stddev:1.52 (1.4%) stddev-sans-first:1.62 10:35:36 INFO - PROCESS | 1468 | Values: 111.0 112.0 112.0 111.0 112.0 112.0 107.0 111.0 110.0 111.0 10:35:36 INFO - PROCESS | 1468 | 10:35:36 INFO - PROCESS | 1468 | [#1] audio-beat-detection Cycles:10 Average:151.60 Median:157.00 stddev:19.39 (12.4%) stddev-sans-first:20.50 10:35:36 INFO - PROCESS | 1468 | Values: 156.0 129.0 156.0 175.0 143.0 158.0 160.0 129.0 183.0 127.0 10:35:36 INFO - PROCESS | 1468 | 10:35:36 INFO - PROCESS | 1468 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.25 (0.8%) stddev-sans-first:1.09 10:35:36 INFO - PROCESS | 1468 | Values: 163.0 161.0 160.0 160.0 161.0 160.0 163.0 160.0 162.0 160.0 10:35:36 INFO - PROCESS | 1468 | 10:35:36 INFO - PROCESS | 1468 | [#3] audio-fft Cycles:10 Average:93.20 Median:75.00 stddev:39.00 (52.0%) stddev-sans-first:40.92 10:35:36 INFO - PROCESS | 1468 | Values: 77.0 76.0 76.0 172.0 76.0 74.0 74.0 73.0 162.0 72.0 10:35:36 INFO - PROCESS | 1468 | 10:35:36 INFO - PROCESS | 1468 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:92.00 stddev:26.87 (29.2%) stddev-sans-first:27.79 10:35:36 INFO - PROCESS | 1468 | Values: 92.0 94.0 146.0 92.0 92.0 92.0 155.0 92.0 93.0 142.0 10:35:36 INFO - PROCESS | 1468 | 10:35:36 INFO - PROCESS | 1468 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:35:36 INFO - PROCESS | 1468 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 116.0 10:35:36 INFO - PROCESS | 1468 | 10:35:36 INFO - PROCESS | 1468 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:145.50 stddev:1.06 (0.7%) stddev-sans-first:1.12 10:35:36 INFO - PROCESS | 1468 | Values: 146.0 145.0 148.0 145.0 147.0 145.0 145.0 145.0 146.0 145.0 10:35:36 INFO - PROCESS | 1468 | 10:35:36 INFO - PROCESS | 1468 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 10:35:36 INFO - PROCESS | 1468 | Values: 95.0 95.0 94.0 94.0 95.0 95.0 95.0 94.0 94.0 95.0 10:35:36 INFO - PROCESS | 1468 | 10:35:36 INFO - PROCESS | 1468 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:54.00 stddev:6.94 (12.8%) stddev-sans-first:7.21 10:35:36 INFO - PROCESS | 1468 | Values: 52.0 54.0 53.0 54.0 56.0 54.0 57.0 75.0 53.0 51.0 10:35:36 INFO - PROCESS | 1468 | 10:35:36 INFO - PROCESS | 1468 | [#9] json-stringify-tinderbox Cycles:10 Average:58.70 Median:59.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 10:35:36 INFO - PROCESS | 1468 | Values: 58.0 59.0 59.0 59.0 59.0 58.0 59.0 59.0 58.0 59.0 10:35:36 INFO - PROCESS | 1468 | 10:35:36 INFO - PROCESS | 1468 | [#10] stanford-crypto-aes Cycles:10 Average:72.90 Median:72.50 stddev:1.97 (2.7%) stddev-sans-first:2.06 10:35:36 INFO - PROCESS | 1468 | Values: 72.0 72.0 71.0 78.0 73.0 72.0 74.0 72.0 73.0 72.0 10:35:36 INFO - PROCESS | 1468 | 10:35:36 INFO - PROCESS | 1468 | [#11] stanford-crypto-ccm Cycles:10 Average:114.60 Median:114.50 stddev:4.40 (3.8%) stddev-sans-first:4.57 10:35:36 INFO - PROCESS | 1468 | Values: 112.0 115.0 116.0 114.0 116.0 111.0 112.0 112.0 126.0 112.0 10:35:36 INFO - PROCESS | 1468 | 10:35:36 INFO - PROCESS | 1468 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.60 Median:158.00 stddev:2.22 (1.4%) stddev-sans-first:2.18 10:35:36 INFO - PROCESS | 1468 | Values: 160.0 156.0 158.0 154.0 157.0 162.0 156.0 158.0 158.0 157.0 10:35:36 INFO - PROCESS | 1468 | 10:35:36 INFO - PROCESS | 1468 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:67.00 stddev:2.55 (3.8%) stddev-sans-first:2.69 10:35:36 INFO - PROCESS | 1468 | Values: 67.0 68.0 71.0 65.0 67.0 67.0 66.0 65.0 67.0 61.0 10:35:36 INFO - PROCESS | 1468 | -------- Summary: end -------- 10:35:36 INFO - PROCESS | 1468 | 10:35:37 INFO - TEST-INFO | 1468: exit 0 10:35:37 INFO - TEST-OK | kraken | took 63001ms 10:35:37 INFO - SUITE-END | took 1187s 10:35:37 INFO - Completed test suite (00:19:47) 10:35:37 INFO - javascript benchmark 10:35:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3323.6344002159767, 3394.304167645633, 3409.539712138862, 3421.110511267073, 3460.2041530447996, 5556.111022236438, 5561.277033985586, 5573.303337082864, 5573.888522229553, 5576.414476479972, 5556.9444305556935, 5566.693831839248, 5576.386597474275, 5585.1063829787245, 5627.380988091307, 4965.60661947962, 5006.949930500694, 5139.0749665060275, 5184.585233181355, 5220.634555581111, 5123.436421993596, 5187.144121220013, 5192.792288308482, 5194.013137503862, 5198.792048318062, 5082.1360368737405, 5141.640085194038, 5149.433562308143, 5162.793488260465, 5180.559652429548, 5127.717975511346, 5148.459411761786, 5148.6910785353, 5149.9485005149845, 5174.4825517448335, 4951.3810773653295, 5007.349044624176, 5042.218456139304, 5077.898442031175, 5099.566536844372, 5546.389897111315, 5604.971975140139, 5609.046462101453, 5615.522680572156, 5627.184058311563, 5964.284285885678, 5966.761329546813, 5969.820905372846, 5970.432808883149, 5972.343042265347, 6024.036154215304, 6122.142899994004, 6179.443850053472, 6179.752809887599, 6212.254529456494, 5711.857203569903, 5717.8570535736935, 5722.799702010409, 5725.341585717612, 5733.254676892019, 6074.36219196978, 6243.906341404882, 6245.156903818017, 6256.624602523863, 6262.843428914222, 5898.8820223595285, 5956.642601443928, 5961.0, 5978.103284507359, 5996.760129594854, 6062.120992456069, 6071.058985857199, 6077.058056001327, 6086.482648974887, 6089.725962331706, 5812.534997200214, 6008.789692360747, 6043.184170137063, 6045.425684559959, 6048.243969503812, 6074.058520929263, 6076.513878889678, 6094.8171554853425, 6100.72546735398, 6129.1419201311855, 4615.076984603093, 4622.907541849211, 4630.629549636021, 4630.675852690347, 4637.513061128533, 4017.4777278953547, 4037.9192416151513, 4113.773742444135, 4130.235906357333, 4156.521999969982, 5779.739911703983, 5800.59395842287, 5808.448197421239, 5810.477057064884, 5819.4762471376935, 6082.57421980466, 6100.877982440326, 6124.35694252106, 6126.724297406628, 6132.110843927606, 5629.887402251932, 5724.4561766632105, 5727.713614319267, 5739.483446489836, 5845.357010728816, 5229.450907654717, 5250.081235783722, 5251.947480525222, 5258.07983602868, 5258.6581872178185, 6244.406781355764, 6316.62100273985, 6322.778702745381, 6327.050942358683, 6331.303556608769, 5942.0, 6051.394860513913, 6118.710550942667, 6120.9652521188555, 6143.354947730424, 6292.716827742855, 6293.339199383999, 6306.432421082125, 6346.238451385863, 6348.492120630246, 5755.223044888887, 5963.314218864886, 5986.07215881539, 5991.281046274475, 5992.9700351499705, 6070.332263450929, 6116.761878222105, 6122.154209354628, 6123.099607468126, 6130.9791012021615, 5941.37615550361, 5952.821415357546, 5956.076808094752, 5960.433758792908, 5970.850728731816, 5654.802081927113, 5799.8550036249435, 5866.208061911588, 5929.703514824328, 5937.168796368598, 5760.539156867524, 5807.796727114531, 5813.157092221689, 5827.970860145672, 5857.8535536610225, 5883.588148829541, 5928.436798504135, 5935.2877654681715, 5944.524438045032, 5945.851353716192, 5693.202951586698, 5810.564207684356, 5813.970930145322, 5852.882942341044, 5902.822915312548], "value": 5583.974006152809, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [663.3532306001649, 678.7285085965614, 684.2678334182425, 742.2021327073394, 756.0889128600038, 33706.325873482514, 34366.48450273248, 34427.65572344279, 41002.38496422556, 41511.0, 43918.56081439184, 44242.33636495447, 44269.77865110678, 44463.88752787306, 44528.33207501882, 8104.5542495162745, 8777.912220877804, 8955.552222388887, 8962.283017358595, 8965.641374345018, 10396.220283478731, 10577.947110264477, 10582.100521455686, 10584.364938103738, 10588.523516441779, 10702.839457408145, 10788.838167427495, 10789.244752867302, 10798.082163016114, 10799.784004319908, 8185.79535511611, 10424.843627345595, 10559.630412935549, 10656.467176641214, 10663.520141593646, 10503.422311772849, 10587.84118238227, 10636.255462117655, 10636.946815265874, 10641.946790266, 41270.58729412698, 41649.1670166598, 41744.37383439251, 41778.0, 41834.163316733495, 3761.360568703327, 3840.788756618385, 3864.652181303696, 4050.7772072536, 4417.690761646686, 32075.358492830244, 34612.134696632536, 34659.0, 34701.4794778076, 34951.9514414568, 4559.817607295738, 4628.143793398199, 4635.559621835921, 4675.25461656419, 4716.716996980158, 322915.0, 326706.3664681685, 327077.0, 327155.0, 327956.0, 68353.31646683569, 68436.315636844, 68521.65739171272, 68868.6556567224, 69002.0, 72977.6351118241, 74621.0, 75926.0, 76450.23549764432, 76533.0, 18082.63834723298, 18222.453326400228, 18234.0, 18237.54406139857, 18258.45224643263, 13767.518136865161, 13867.237301948287, 14039.719205615831, 14184.503542375967, 14423.278836058365, 21201.575968480545, 21284.36146915595, 21381.57236855254, 21412.143514259566, 21493.495455317978, 7965.761027169194, 8078.192180781874, 8232.670693172326, 8278.379121565908, 8357.707480238163, 1117.6423544465692, 1121.1759356872692, 1129.1249281806665, 1139.5897476908306, 1199.5141967503175, 33638.663613363555, 34044.14889627729, 34217.48673769896, 34605.78879739197, 34688.13279667978, 1213.2477863724548, 1226.938653067343, 1235.7528494301175, 1282.435728279554, 1313.5796545105666, 17709.55726106832, 18266.26934922588, 18728.81271187298, 19487.22051117968, 19612.509687257934, 520385.0, 523803.0, 524406.0, 526097.0, 530555.0, 63992.36007639957, 64713.35286647167, 64737.35262647313, 64876.675616621615, 64892.67553662202, 1365.2422905287463, 1500.9549713508393, 1552.5031989763393, 1569.9215039247993, 1654.1646468533554, 30281.0, 31625.5256171153, 33975.66024339725, 34322.656773432944, 34371.31257374889, 51483.74258128835, 51997.7400112997, 52330.47669523256, 52500.212496811815, 52506.73746631242, 380830.0, 380879.0, 382161.0, 382193.0, 383327.0, 28044.57933130964, 30991.69008309888, 31276.843615781774, 31285.0, 31572.526412104296, 45210.0, 47782.76108619435, 48348.0, 48645.27032094451, 48977.265341020626, 40387.99030024273, 40667.7966610165, 40750.79624601858, 41836.37245441382, 41864.58135418607, 40800.59199407968, 40869.38695919504, 40900.59099408968, 40921.0, 41882.37176442295, 42121.578784211764, 45588.31617525806, 45800.0, 46875.765621171675, 47084.52915470801, 33484.83257583697, 34850.82574587111, 35010.64989350074, 35116.0, 35574.288514229054, 28420.715792841806, 29190.854045729637, 29215.707842922147, 29341.85329073341, 29443.558346625246], "value": 21465.217819629328, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [420.45700139497416, 435.77775334579354, 442.91806015887045, 445.6167695781628, 448.6875888027521, 18918.14868330925, 19470.805291947094, 19676.704849427253, 20529.0, 21034.368968930918, 19789.307374241904, 20175.0, 20496.590068198628, 20510.89744551279, 20522.48693782656, 5537.1140617501305, 5917.615355001933, 5922.555808314372, 5929.73316200772, 5930.822075337746, 4245.830166793325, 5797.65214087154, 5877.67672777997, 6082.543809214305, 6370.74517019321, 6321.841953951142, 6336.968315158418, 6341.778037768679, 6342.334054924236, 6355.269144048448, 6138.785142520012, 6282.591631543935, 6434.324395938406, 6443.226812782473, 6443.259025212114, 3977.960220397817, 5600.551955843523, 5749.59752817303, 5769.653820770767, 5834.3873893241025, 22858.657120143213, 23091.307260782203, 23185.53628927429, 23191.88404057986, 24088.0, 2512.1960972488628, 2564.192279431973, 2569.9100531481495, 2763.9309017274727, 3110.3623757129963, 7626.771196864103, 14188.57434276963, 14844.183569903651, 14868.033577817516, 15628.843711562966, 2017.0923084611984, 2084.062172022596, 2092.7488701355783, 2157.223399576151, 2196.8681879087308, 77987.61006194989, 78294.60852695757, 79417.99999999942, 80645.0, 80769.59615201886, 11114.444277786079, 11158.815444208421, 11341.206115571997, 11624.0, 11866.110041746904, 15629.765553516707, 16111.516654500383, 16195.676086478205, 16234.188290585424, 16238.269277882524, 9056.637734490547, 9110.954445227731, 9137.451752894847, 9156.6795162169, 9285.72142835716, 9015.729528114167, 9118.133777291147, 9129.0, 9176.908230917605, 9197.0, 6973.372396484341, 7025.297470252934, 7085.50401471892, 7099.615574962832, 7171.462140339391, 1841.8894866308065, 1987.9701804472945, 2002.819746222847, 2058.938231853047, 2107.905144268512, 1037.4345981440133, 1070.5610699613121, 1085.9674209773718, 1134.8524691790014, 1152.6657269391783, 18675.066246687613, 19201.423957281302, 19525.414237572895, 20233.595328093357, 20473.89763051175, 1115.9107271418268, 1117.212365282474, 1123.25864929148, 1166.3759888459633, 1272.739088486858, 11727.120465964916, 11748.70628234301, 11791.469383877746, 11829.408529573488, 11880.940595296968, 380821.0, 386184.0, 388940.0, 390472.0, 530853.0, 95783.52108239415, 97545.51227243818, 99390.50304748575, 99800.0, 100233.0, 1147.2772153543215, 1166.026367982744, 1175.8059920113258, 1178.7112157521462, 1188.1564089496383, 17544.21051052731, 17944.551386215448, 18024.81975180284, 18130.093495325444, 18371.63256734831, 40057.599424006556, 40183.0, 41680.58319416767, 42066.0, 42247.155056899304, 55307.44692553023, 56961.71519142378, 58880.0, 61174.38825611865, 61643.69178154081, 8575.656973720981, 8702.956485217534, 8737.563121843756, 8794.076621954602, 8838.425502342327, 9870.0, 10593.89406105929, 12936.611901642966, 13051.0, 13714.51999180024, 11222.270552414067, 11395.373254471084, 11690.70773230676, 11721.355325457182, 11752.647420577396, 5575.581831362583, 9387.483688397204, 11277.71805704864, 11558.479868405773, 11933.582324618597, 12362.196457230251, 12533.749325013267, 12563.434645440795, 12712.936435317764, 12741.745165096461, 8685.826283474422, 8744.431611945203, 8747.65009399617, 8839.46963182211, 8883.777905552413, 9033.141851524095, 11323.716907077389, 12158.0, 12221.816672749737, 12319.815202772144], "value": 9727.278712599682, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1426.1585664457969, 1546.814382274127, 1583.897046691965, 1756.9824301756978, 1869.72888931105, 7372.963135184324, 8149.796255093625, 8291.253787159154, 8297.917020829798, 8306.91693083069, 8210.425270231071, 8391.328693704505, 8397.202265784756, 8398.28614567761, 8398.3281337493, 2090.8118269355755, 2368.549975504657, 2409.8674572898526, 2429.0526694589125, 2440.9755902441016, 2435.0503303711566, 2444.523317953, 2446.9755302447015, 2449.375409270642, 2449.5223431430877, 2377.619580867062, 2433.866137362453, 2441.816863735227, 2441.987790061056, 2443.926682199537, 2132.9040193191345, 2438.8414753040997, 2475.814313926454, 2476.752324767509, 2479.826412151132, 2413.6862207913036, 2425.5162315347084, 2427.381017840457, 2442.3894026493376, 2476.578981573137, 8370.581470926429, 8460.196281353261, 8470.364722645827, 8477.915220847774, 8480.575971201415, 5325.068113080196, 5382.0, 5423.376311724123, 5434.483724046209, 5444.0, 3518.313928783888, 3593.4250519916686, 3624.9275014499826, 3629.27414517095, 3655.5065066215984, 1159.8144296912537, 1186.8991135753472, 1190.2560899437851, 1198.7003249187703, 1246.613549799556, 11731.882681173165, 11929.761404771856, 11929.761404771943, 11931.463084161234, 11931.940340298243, 4657.138429390574, 4666.416697912761, 4758.524147585283, 4815.542523460265, 4872.731999740048, 10276.897231027744, 10283.07452329294, 10288.12550933179, 10295.94852025735, 10305.690829274983, 4833.081714474239, 5465.426130256265, 5468.660178256353, 5470.480304371078, 5472.315960504937, 4698.201305777958, 4705.153072446992, 4715.292706094114, 4763.3807605011125, 4774.689645173053, 4150.1284730207, 4166.729162604421, 4258.297380932111, 4267.4025636410925, 4275.315949448135, 1331.6471135149193, 1363.6931690369786, 1368.2269517722455, 1402.6563491944335, 1408.8520705325793, 960.7454024683325, 984.6455276100598, 1022.1158697726413, 1026.7227848480868, 1117.458032854065, 6100.908486372708, 6152.2002139722445, 6181.072839074175, 6187.907181392283, 6224.906626400608, 1034.94307813071, 1046.7173863056933, 1067.43087661138, 1067.572970811666, 1071.5071067309125, 4304.246756817544, 4419.535948725337, 4450.666200035011, 4451.577100175478, 4467.195904737178, 10038.64864729731, 10407.68776936693, 10419.426931518688, 10458.111060559786, 10590.788184236271, 9913.75215619601, 10002.499875006366, 10131.341462804894, 10131.442770647538, 10149.035841595036, 7658.770236892902, 7771.533707977539, 7782.8054298641855, 7787.44251149761, 7832.177621349791, 5994.850128746816, 6118.326984031842, 6155.72299246526, 6191.0, 6269.7178626962805, 9112.0, 9314.72055838326, 9400.106989835955, 9411.152996230097, 9433.764155896157, 9394.107559781809, 9420.905790942003, 9731.56207970629, 9760.804783904425, 9773.0, 6759.493038022069, 7395.8151046224275, 7501.924980750341, 7586.317231449196, 7698.884516732365, 8070.798230044061, 8084.797880053045, 8121.066077401175, 8145.714899978472, 8146.714864979697, 7359.852802944019, 7362.9631851840395, 7490.213527579525, 7608.087029556488, 7676.462647614613, 7337.633118344168, 7405.44459165554, 7416.666250018654, 7466.514676546007, 7508.211637778173, 6720.1599800025, 6724.092247546519, 6760.0, 6768.052472653931, 6770.187577490733, 5248.212768084818, 5273.419923808455, 5360.195970604284, 5384.084705599979, 5424.403315635356, 5424.294841670558, 5444.891102178013, 5450.400455949763, 5454.3454785426, 5503.559715222853], "value": 4677.166807275967, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.6066015072892, 346.89246333636567, 355.4082452716228, 357.2230398882432, 364.2550983239277, 6323.810285691425, 6385.680715964207, 6394.200724909387, 6421.940379837333, 6452.4192822645955, 6268.153799237101, 6273.717682704278, 6288.842778930529, 6295.15015472911, 6315.147455093561, 4596.747178905151, 4684.297355396684, 4743.600637811854, 4746.145693775119, 4761.262004389308, 4745.311929770181, 4747.691400059002, 4764.975530260993, 4792.424909010906, 4802.991371811923, 4566.6575006874455, 4755.001449695568, 4763.261694437368, 4764.761761911908, 4768.761561921908, 4639.930401043987, 4664.813407463697, 4682.110399024192, 4727.834525791615, 4739.123262196505, 4138.937915931264, 4157.3140431829015, 4157.605027522381, 4167.166566686645, 4176.373543968399, 6012.128241405016, 6020.518358531351, 6047.7278522466595, 6052.061930400795, 6063.333033366371, 5543.695096769676, 5546.500814926636, 5548.445155484419, 5554.055810512223, 5562.471565201299, 6485.254195767453, 6610.471162307004, 6616.503762217853, 6622.9668851655915, 6634.46924246064, 4603.677742558022, 4614.2617181250835, 4615.676902616819, 4617.953820461786, 4690.695104818176, 6917.481188910851, 6932.064171336855, 6944.062551555526, 6967.1291088613925, 6976.860462790766, 4685.953140468551, 4686.81252749893, 4697.389339385926, 4698.88252793676, 4700.435947686299, 4865.172920603506, 4873.220284754422, 4873.853784386474, 4875.7074575524875, 4878.292647566083, 5522.972385138049, 5530.253415788817, 5535.25274087993, 5537.916931246034, 5542.501174894279, 6545.083688283644, 6687.732490700415, 6696.86606267872, 6702.765403210962, 6703.262641109474, 1700.4388551777884, 1713.0406972095666, 1719.8624110071164, 1721.3458885623384, 1721.5696075981004, 1078.8058149533003, 1097.6103483263487, 1098.6868742408376, 1111.360967443723, 1131.7114135895295, 6474.1907261592305, 6562.376574225441, 6579.703913323912, 6585.769498067544, 6587.374199451045, 6978.302169783083, 6989.091418115612, 7000.0, 7000.47496437759, 7000.649967501605, 6579.967100164468, 6610.8016759497295, 6655.6339401332425, 6661.3005634408655, 6664.400203981568, 3705.888823335304, 3758.8872333830027, 3764.0, 3771.0, 3776.2258736958856, 7010.544314619533, 7239.095113110861, 7248.565086094745, 7253.165885923187, 7266.164391095092, 7105.89341159883, 7109.253528379549, 7120.038794762744, 7120.145582530026, 7126.964365178244, 7214.891776623354, 7225.205227424979, 7233.963830180921, 7255.818604534928, 7277.818054548678, 6918.757843475454, 6962.110724049463, 6965.268646792014, 6968.4076853465995, 6973.96513017452, 6603.306652801579, 6915.239323674492, 6919.411849992605, 6920.342567456084, 6929.757458488929, 7261.455390845602, 7278.927210728037, 7295.781126566211, 7299.708011679473, 7302.306280903305, 4693.882652933704, 4726.1020406122725, 4731.716097034189, 4733.721895088376, 4733.952660473489, 6965.616891071039, 6975.581465112109, 6988.615626140611, 6989.7553585624255, 6990.021397004525, 6573.3098024706715, 6782.084418603426, 6820.693068812015, 6843.931560684528, 6844.760433384808, 6773.221079575715, 6777.0, 6790.93209067903, 6791.796246112624, 6794.184697836094, 6659.467242620482, 6667.599944003376, 6678.933210667831, 6678.933210668026, 6683.064370987969, 6836.0, 6845.281245469353, 6850.520463567503, 6854.862902742017, 6856.177258728984, 6407.487401008001, 6499.447546958561, 6614.173228346457, 6694.0, 6744.865102698017], "value": 5061.5430214605885, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [820.3027426687313, 854.3933806997031, 860.11408249503, 913.1507697841007, 918.728974952389, 15977.600559986005, 16194.0, 16214.351425942948, 16227.432039878606, 16247.268872900719, 14520.128792272471, 14787.186704731235, 14795.556133316019, 14839.035462694917, 14939.103653780781, 746.3991486853081, 867.7396780965717, 893.4907102951321, 895.0288936503902, 903.5662881816731, 899.6176624934409, 899.9775005624846, 901.085398320705, 902.1700035966926, 902.2331018634175, 945.2060269373725, 947.1522986926697, 948.3503799897059, 948.6015873333182, 948.8102379524088, 806.3267171911461, 924.3852837862813, 941.4257303045136, 944.6032666280179, 945.9858102128474, 689.8792711275557, 691.408845437154, 691.861627674462, 694.4583225084442, 696.3767428151775, 15147.621309467351, 15165.696686066327, 15234.238288085662, 15239.466618668404, 15242.923785381003, 14576.271186440636, 14811.48159814412, 14863.405463781435, 14945.775813362809, 15026.849731502654, 12044.698882528008, 12078.27530348182, 12294.692632684166, 12362.505499779998, 12605.08352349622, 4086.9182616347803, 4110.157417729359, 4126.66986641068, 4151.97924010378, 4160.895977600554, 61490.69254653698, 61884.0, 62254.0, 62298.99999999955, 62386.68806655983, 11972.58095966637, 12010.939945300217, 12155.756884862254, 12228.266304021787, 12334.259944403364, 22265.888670556542, 22295.777042229696, 22304.10783568639, 22320.10719571199, 22338.0, 8856.291496680251, 9000.684976025808, 9135.954320228357, 9349.813003739888, 9438.197753190918, 5125.79496820123, 5253.13323301651, 5263.499967503081, 5271.499207575274, 5312.707801070978, 3501.824908754552, 3565.16218688608, 3577.5885773136424, 3578.4453409721536, 3582.0, 617.0990354083, 623.23031056645, 649.6037417175519, 651.4950913042335, 681.2676372899153, 801.1747899663357, 805.9153788852203, 816.1797393619374, 830.7009476588423, 833.2875391540267, 9820.263480239011, 10079.949600251952, 10142.442165680959, 10413.219008574235, 10442.164626829835, 661.3381140907788, 767.2136060537881, 801.631249625179, 809.4455298120688, 832.995835020821, 4633.513481084437, 4694.812207511662, 4911.009717529892, 4920.163572192664, 4953.678010929278, 69373.30626693668, 70875.0, 71147.0, 71171.28828711646, 71483.2851671487, 54763.72618136884, 58201.12698309529, 58633.0, 59160.11259831106, 59923.0, 54028.0, 54722.72638636861, 54993.72503137459, 56022.439775602536, 56282.71858640681, 10051.359863439617, 10077.94989785195, 10171.28800983924, 10309.536070876979, 10358.860525342358, 40512.79743601381, 40567.0, 41500.58499414967, 41702.0, 41886.581134188265, 48657.0, 48744.0, 53473.73263133659, 54033.45966540284, 54658.726706366215, 12375.814362784746, 12665.683357916127, 12835.422405991567, 12900.935495322463, 12959.546415875398, 14288.857111428753, 14306.928465357607, 14395.280235988368, 14473.0, 14475.638109047359, 11689.941550292195, 13202.603921882359, 13669.38487768033, 13813.309334533033, 14125.929370353082, 13414.798778018143, 13764.449422023006, 13780.586582402544, 13895.30523473802, 14194.645133871323, 13554.59336219915, 13691.124893494807, 13793.724125517232, 13902.582922512342, 14408.639784005065, 10673.092787113183, 10944.343339399344, 10998.890011099787, 11029.503672334924, 11058.944705276423, 11197.216194866282, 11559.884401156218, 11845.822312665488, 11953.940230298793, 11956.521739130338], "value": 7394.888798914331, "unit": "score"}], "name": "dromaeo_css", "value": 7673.34376686239, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 112.0, 111.0, 112.0, 112.0, 107.0, 111.0, 110.0, 111.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 129.0, 156.0, 175.0, 143.0, 158.0, 160.0, 129.0, 183.0, 127.0], "value": 151.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 160.0, 160.0, 161.0, 160.0, 163.0, 160.0, 162.0, 160.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 172.0, 76.0, 74.0, 74.0, 73.0, 162.0, 72.0], "value": 93.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 146.0, 92.0, 92.0, 92.0, 155.0, 92.0, 93.0, 142.0], "value": 109.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 148.0, 145.0, 147.0, 145.0, 145.0, 145.0, 146.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 54.0, 53.0, 54.0, 56.0, 54.0, 57.0, 75.0, 53.0, 51.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 59.0, 59.0, 58.0, 59.0, 59.0, 58.0, 59.0], "value": 58.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 71.0, 78.0, 73.0, 72.0, 74.0, 72.0, 73.0, 72.0], "value": 72.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 115.0, 116.0, 114.0, 116.0, 111.0, 112.0, 112.0, 126.0, 112.0], "value": 114.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 156.0, 158.0, 154.0, 157.0, 162.0, 156.0, 158.0, 158.0, 157.0], "value": 157.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 71.0, 65.0, 67.0, 67.0, 66.0, 65.0, 67.0, 61.0], "value": 66.4, "unit": "score"}], "name": "kraken", "value": 1508.9, "alertThreshold": 2.0}]} 10:35:37 INFO - Return code: 0 10:35:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:35:37 ERROR - # TBPL SUCCESS # 10:35:37 INFO - Running post-action listener: _resource_record_post_action 10:35:37 INFO - Running post-run listener: _resource_record_post_run 10:35:38 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 12288; Write bytes: 493555712; Read time: 5056; Write time: 3356192 10:35:38 INFO - install - Wall time: 16s; CPU: 26.0%; Read bytes: 0; Write bytes: 170020864; Read time: 0; Write time: 1458120 10:35:39 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 12288; Write bytes: 320626688; Read time: 5056; Write time: 1855016 10:35:39 INFO - Running post-run listener: _upload_blobber_files 10:35:39 INFO - Blob upload gear active. 10:35:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:35:39 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:35:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:35:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:35:39 INFO - (blobuploader) - INFO - Open directory for files ... 10:35:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:35:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:35:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:35:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:35:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:35:40 INFO - (blobuploader) - INFO - Done attempting. 10:35:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:35:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:35:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:35:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:35:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:35:40 INFO - (blobuploader) - INFO - Done attempting. 10:35:40 INFO - (blobuploader) - INFO - Iteration through files over. 10:35:40 INFO - Return code: 0 10:35:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:35:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:35:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/70d0b8616879b202a5b1eba0a3e8173416efcf55842fb2ddae7c4024e7e55a40420f1a339907c2f25931c15b64c86a907bd09ae37b990bfa72722cb1f8c22b8e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/135970695449962e8ad87ce39214f9918e63805f471a287c3a315be0fb9ce8ca5a2ff04d84d39b68fdbc01e5c73da278e43fd3a4c8e9b3fe1c6b288fcae263d3"} 10:35:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:35:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:35:40 INFO - Contents: 10:35:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/70d0b8616879b202a5b1eba0a3e8173416efcf55842fb2ddae7c4024e7e55a40420f1a339907c2f25931c15b64c86a907bd09ae37b990bfa72722cb1f8c22b8e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/135970695449962e8ad87ce39214f9918e63805f471a287c3a315be0fb9ce8ca5a2ff04d84d39b68fdbc01e5c73da278e43fd3a4c8e9b3fe1c6b288fcae263d3"} 10:35:40 INFO - Running post-run listener: copy_logs_to_upload_dir 10:35:40 INFO - Copying logs to upload dir... 10:35:40 INFO - mkdir: /builds/slave/test/build/upload/logs 10:35:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.849547 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-05-30 10:35:40.786530) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 10:35:40.789920) ========= 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=33d5923976266a1c518c4bf7000001ab-1464628494.941087-1800182361 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/70d0b8616879b202a5b1eba0a3e8173416efcf55842fb2ddae7c4024e7e55a40420f1a339907c2f25931c15b64c86a907bd09ae37b990bfa72722cb1f8c22b8e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/135970695449962e8ad87ce39214f9918e63805f471a287c3a315be0fb9ce8ca5a2ff04d84d39b68fdbc01e5c73da278e43fd3a4c8e9b3fe1c6b288fcae263d3"} build_url:https://queue.taskcluster.net/v1/task/boa9F7RPQdGTqlMknlJH_w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011354 build_url: 'https://queue.taskcluster.net/v1/task/boa9F7RPQdGTqlMknlJH_w/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/70d0b8616879b202a5b1eba0a3e8173416efcf55842fb2ddae7c4024e7e55a40420f1a339907c2f25931c15b64c86a907bd09ae37b990bfa72722cb1f8c22b8e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/135970695449962e8ad87ce39214f9918e63805f471a287c3a315be0fb9ce8ca5a2ff04d84d39b68fdbc01e5c73da278e43fd3a4c8e9b3fe1c6b288fcae263d3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 10:35:40.815368) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 10:35:40.815708) ========= 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=33d5923976266a1c518c4bf7000001ab-1464628494.941087-1800182361 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004571 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 10:35:40.901391) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 10:35:40.901716) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 10:35:40.902000) ========= ========= Total master_lag: 0.16 =========