builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-051 starttime: 1463175164.24 results: success (0) buildid: 20160513114547 builduid: 844298ff049b42b29dca75dc9f9d8466 revision: 805051b9a46259319d5c56424cb5249efc811363 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 14:32:44.236657) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 14:32:44.237395) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 14:32:44.239323) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 14:32:44.251787) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 14:32:44.252354) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1463175154.968173-340417346 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-13 14:32:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-05-13 14:32:44 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.130882 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 14:32:44.398482) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 14:32:44.398963) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1463175154.968173-340417346 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016084 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 14:32:44.453199) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 14:32:44.453699) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 805051b9a46259319d5c56424cb5249efc811363 --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 805051b9a46259319d5c56424cb5249efc811363 --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=5ac5dba3e01a12f1ff77ab15000001b1-1463175154.968173-340417346 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-13 14:32:44,664 truncating revision to first 12 chars 2016-05-13 14:32:44,664 Setting DEBUG logging. 2016-05-13 14:32:44,664 attempt 1/10 2016-05-13 14:32:44,664 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/805051b9a462?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-13 14:32:45,027 unpacking tar archive at: mozilla-aurora-805051b9a462/testing/mozharness/ program finished with exit code 0 elapsedTime=0.672037 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 14:32:45.143613) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 14:32:45.144182) ========= script_repo_revision: 805051b9a46259319d5c56424cb5249efc811363 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 14:32:45.147891) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 14:32:45.148365) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 14:32:45.164639) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-05-13 14:32:45.165062) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=5ac5dba3e01a12f1ff77ab15000001b1-1463175154.968173-340417346 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:32:45 INFO - MultiFileLogger online at 20160513 14:32:45 in /builds/slave/test 14:32:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 14:32:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:32:45 INFO - {'append_to_log': False, 14:32:45 INFO - 'base_work_dir': '/builds/slave/test', 14:32:45 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:32:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:32:45 INFO - 'branch': 'Mozilla-Aurora', 14:32:45 INFO - 'buildbot_json_path': 'buildprops.json', 14:32:45 INFO - 'config_files': ('talos/linux_config.py',), 14:32:45 INFO - 'default_actions': ('clobber', 14:32:45 INFO - 'read-buildbot-config', 14:32:45 INFO - 'download-and-extract', 14:32:45 INFO - 'populate-webroot', 14:32:45 INFO - 'create-virtualenv', 14:32:45 INFO - 'install', 14:32:45 INFO - 'run-tests'), 14:32:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:32:45 INFO - 'download_minidump_stackwalk': True, 14:32:45 INFO - 'download_symbols': 'ondemand', 14:32:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:32:45 INFO - 'tooltool.py': '/tools/tooltool.py', 14:32:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:32:45 INFO - '/tools/misc-python/virtualenv.py')}, 14:32:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:32:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:32:45 INFO - 'installer_path': 'installer.exe', 14:32:45 INFO - 'log_level': 'info', 14:32:45 INFO - 'log_name': 'talos', 14:32:45 INFO - 'log_to_console': True, 14:32:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:32:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:32:45 INFO - 'opt_config_files': (), 14:32:45 INFO - 'pip_index': False, 14:32:45 INFO - 'sps_profile': False, 14:32:45 INFO - 'sps_profile_interval': 0, 14:32:45 INFO - 'suite': 'dromaeojs-e10s', 14:32:45 INFO - 'system_bits': '32', 14:32:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:32:45 INFO - 'title': 'talos-linux64-ix-051', 14:32:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:32:45 INFO - 'use_talos_json': True, 14:32:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:32:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:32:45 INFO - 'work_dir': 'build'} 14:32:45 INFO - ##### 14:32:45 INFO - ##### Running clobber step. 14:32:45 INFO - ##### 14:32:45 INFO - Running pre-action listener: _resource_record_pre_action 14:32:45 INFO - Running main action method: clobber 14:32:45 INFO - rmtree: /builds/slave/test/build 14:32:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:32:46 INFO - Running post-action listener: _resource_record_post_action 14:32:46 INFO - ##### 14:32:46 INFO - ##### Running read-buildbot-config step. 14:32:46 INFO - ##### 14:32:46 INFO - Running pre-action listener: _resource_record_pre_action 14:32:46 INFO - Running main action method: read_buildbot_config 14:32:46 INFO - Using buildbot properties: 14:32:46 INFO - { 14:32:46 INFO - "project": "", 14:32:46 INFO - "product": "firefox", 14:32:46 INFO - "script_repo_revision": "production", 14:32:46 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 14:32:46 INFO - "repository": "", 14:32:46 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 14:32:46 INFO - "buildid": "20160513114547", 14:32:46 INFO - "pgo_build": "True", 14:32:46 INFO - "basedir": "/builds/slave/test", 14:32:46 INFO - "buildnumber": 267, 14:32:46 INFO - "slavename": "talos-linux64-ix-051", 14:32:46 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:32:46 INFO - "platform": "ubuntu64_hw", 14:32:46 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 14:32:46 INFO - "branch": "mozilla-aurora", 14:32:46 INFO - "repo_path": "releases/mozilla-aurora", 14:32:46 INFO - "revision": "805051b9a46259319d5c56424cb5249efc811363", 14:32:46 INFO - "stage_platform": "linux64-pgo", 14:32:46 INFO - "builduid": "844298ff049b42b29dca75dc9f9d8466", 14:32:46 INFO - "slavebuilddir": "test" 14:32:46 INFO - } 14:32:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/JwMZ7IgpTKysdzjwdycVlA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 14:32:46 INFO - Running post-action listener: _resource_record_post_action 14:32:46 INFO - ##### 14:32:46 INFO - ##### Running download-and-extract step. 14:32:46 INFO - ##### 14:32:46 INFO - Running pre-action listener: _resource_record_pre_action 14:32:46 INFO - Running main action method: download_and_extract 14:32:46 INFO - mkdir: /builds/slave/test/build/tests 14:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:46 INFO - https://queue.taskcluster.net/v1/task/JwMZ7IgpTKysdzjwdycVlA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:32:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JwMZ7IgpTKysdzjwdycVlA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 14:32:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JwMZ7IgpTKysdzjwdycVlA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 14:32:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JwMZ7IgpTKysdzjwdycVlA/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 14:32:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JwMZ7IgpTKysdzjwdycVlA/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 14:32:48 INFO - Downloaded 1361 bytes. 14:32:48 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 14:32:48 INFO - Using the following test package requirements: 14:32:48 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 14:32:48 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:32:48 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 14:32:48 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:32:48 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 14:32:48 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:32:48 INFO - u'jsshell-linux-x86_64.zip'], 14:32:48 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:32:48 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 14:32:48 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 14:32:48 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:32:48 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 14:32:48 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:32:48 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 14:32:48 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:32:48 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 14:32:48 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:32:48 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 14:32:48 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:32: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')]} 14:32:48 INFO - https://queue.taskcluster.net/v1/task/JwMZ7IgpTKysdzjwdycVlA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:32:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JwMZ7IgpTKysdzjwdycVlA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 14:32:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JwMZ7IgpTKysdzjwdycVlA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 14:32:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JwMZ7IgpTKysdzjwdycVlA/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 14:32:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JwMZ7IgpTKysdzjwdycVlA/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 14:32:49 INFO - Downloaded 23800103 bytes. 14:32:49 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'] 14:32:49 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 14:32:50 INFO - Return code: 0 14:32:50 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 14:32:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:50 INFO - https://queue.taskcluster.net/v1/task/JwMZ7IgpTKysdzjwdycVlA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:32:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JwMZ7IgpTKysdzjwdycVlA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 14:32:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JwMZ7IgpTKysdzjwdycVlA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 14:32:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JwMZ7IgpTKysdzjwdycVlA/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 14:32:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JwMZ7IgpTKysdzjwdycVlA/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 14:32:53 INFO - Downloaded 23800103 bytes. 14:32:53 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'] 14:32:53 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 14:32:54 INFO - Return code: 0 14:32:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:54 INFO - https://queue.taskcluster.net/v1/task/JwMZ7IgpTKysdzjwdycVlA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:32:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JwMZ7IgpTKysdzjwdycVlA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 14:32:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JwMZ7IgpTKysdzjwdycVlA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 14:32:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JwMZ7IgpTKysdzjwdycVlA/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 14:32:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JwMZ7IgpTKysdzjwdycVlA/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 14:32:55 INFO - Downloaded 10840145 bytes. 14:32:55 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'] 14:32:55 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 14:32:56 INFO - Return code: 0 14:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:56 INFO - https://queue.taskcluster.net/v1/task/JwMZ7IgpTKysdzjwdycVlA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:32:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JwMZ7IgpTKysdzjwdycVlA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 14:32:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JwMZ7IgpTKysdzjwdycVlA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 14:32:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JwMZ7IgpTKysdzjwdycVlA/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 14:32:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JwMZ7IgpTKysdzjwdycVlA/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 14:32:58 INFO - Downloaded 62696567 bytes. 14:32:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JwMZ7IgpTKysdzjwdycVlA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 14:32:58 INFO - mkdir: /builds/slave/test/properties 14:32:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:32:58 INFO - Writing to file /builds/slave/test/properties/build_url 14:32:58 INFO - Contents: 14:32:58 INFO - build_url:https://queue.taskcluster.net/v1/task/JwMZ7IgpTKysdzjwdycVlA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 14:32:58 INFO - Running post-action listener: _resource_record_post_action 14:32:58 INFO - Running post-action listener: set_extra_try_arguments 14:32:58 INFO - ##### 14:32:58 INFO - ##### Running populate-webroot step. 14:32:58 INFO - ##### 14:32:58 INFO - Running pre-action listener: _resource_record_pre_action 14:32:58 INFO - Running main action method: populate_webroot 14:32:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:32:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:32:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:32:58 INFO - '--tppagecycles', 14:32:58 INFO - '7'], 14:32:58 INFO - 'tests': ['tsvgm']}}, 14:32:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:32:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:32:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:32:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:32:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:32:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:32:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:58 INFO - 'talos_options': ['--disable-e10s'], 14:32:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:32:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:32:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:58 INFO - 'talos_options': ['--disable-e10s'], 14:32:58 INFO - 'tests': ['damp', 'tps']}, 14:32:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:58 INFO - 'tests': ['damp', 'tps']}, 14:32:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:32:58 INFO - 'tests': ['dromaeo_dom']}, 14:32:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:32:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:32:58 INFO - 'tests': ['a11yr', 14:32:58 INFO - 'ts_paint', 14:32:58 INFO - 'tpaint', 14:32:58 INFO - 'sessionrestore', 14:32:58 INFO - 'sessionrestore_no_auto_restore', 14:32:58 INFO - 'tabpaint']}, 14:32:58 INFO - 'other-e10s': {'tests': ['a11yr', 14:32:58 INFO - 'ts_paint', 14:32:58 INFO - 'tpaint', 14:32:58 INFO - 'sessionrestore', 14:32:58 INFO - 'sessionrestore_no_auto_restore', 14:32:58 INFO - 'tabpaint']}, 14:32:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:32:58 INFO - 'ts_paint', 14:32:58 INFO - 'tpaint', 14:32:58 INFO - 'sessionrestore', 14:32:58 INFO - 'sessionrestore_no_auto_restore', 14:32:58 INFO - 'tabpaint']}, 14:32:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:32:58 INFO - 'ts_paint', 14:32:58 INFO - 'tpaint', 14:32:58 INFO - 'sessionrestore', 14:32:58 INFO - 'sessionrestore_no_auto_restore', 14:32:58 INFO - 'tabpaint']}, 14:32:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:32:58 INFO - 'tests': ['a11yr', 14:32:58 INFO - 'ts_paint', 14:32:58 INFO - 'tpaint', 14:32:58 INFO - 'sessionrestore', 14:32:58 INFO - 'sessionrestore_no_auto_restore', 14:32:58 INFO - 'tabpaint']}, 14:32:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:32:58 INFO - 'tests': ['a11yr', 14:32:58 INFO - 'ts_paint', 14:32:58 INFO - 'tpaint', 14:32:58 INFO - 'sessionrestore', 14:32:58 INFO - 'sessionrestore_no_auto_restore', 14:32:58 INFO - 'tabpaint']}, 14:32:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:32:58 INFO - 'tests': ['tsvgx', 14:32:58 INFO - 'tsvgr_opacity', 14:32:58 INFO - 'tart', 14:32:58 INFO - 'tscrollx', 14:32:58 INFO - 'cart']}, 14:32:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:32:58 INFO - 'tsvgr_opacity', 14:32:58 INFO - 'tart', 14:32:58 INFO - 'tscrollx', 14:32:58 INFO - 'cart']}, 14:32:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:58 INFO - 'talos_options': ['--disable-e10s'], 14:32:58 INFO - 'tests': ['tp5o']}, 14:32:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:58 INFO - 'tests': ['tp5o']}, 14:32:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:58 INFO - 'talos_options': ['--disable-e10s', 14:32:58 INFO - '--xperf_path', 14:32:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:32:58 INFO - 'tests': ['tp5n']}, 14:32:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:58 INFO - 'talos_options': ['--xperf_path', 14:32:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:32:58 INFO - 'tests': ['tp5n']}}, 14:32:58 INFO - 'talos.zip': {'path': '', 14:32:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:32:58 INFO - Running post-action listener: _resource_record_post_action 14:32:58 INFO - ##### 14:32:58 INFO - ##### Running create-virtualenv step. 14:32:58 INFO - ##### 14:32:58 INFO - Running pre-action listener: _resource_record_pre_action 14:32:58 INFO - Running main action method: create_virtualenv 14:32:58 INFO - Creating virtualenv /builds/slave/test/build/venv 14:32:58 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:32:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:32:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:32:59 INFO - Using real prefix '/usr' 14:32:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:32:59 INFO - Installing distribute.............................................................................................................................................................................................done. 14:33:01 INFO - Installing pip.................done. 14:33:01 INFO - Return code: 0 14:33:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:33:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:01 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 0x7fef4b17ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19685a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f7410>, '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 0x19f8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f87a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1463175154.968173-340417346', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:33:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:33:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:33:01 INFO - Using env: {'DISPLAY': ':0', 14:33:01 INFO - 'HOME': '/home/cltbld', 14:33:01 INFO - 'LANG': 'en_US.UTF-8', 14:33:01 INFO - 'LANGUAGE': 'en_US:en', 14:33:01 INFO - 'LOGNAME': 'cltbld', 14:33:01 INFO - 'MAIL': '/var/mail/cltbld', 14:33:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:01 INFO - 'MOZ_NO_REMOTE': '1', 14:33:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:33:01 INFO - 'NO_EM_RESTART': '1', 14:33:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:33:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:01 INFO - 'PWD': '/builds/slave/test', 14:33:01 INFO - 'SHELL': '/bin/bash', 14:33:01 INFO - 'SHLVL': '1', 14:33:01 INFO - 'TERM': 'linux', 14:33:01 INFO - 'TMOUT': '86400', 14:33:01 INFO - 'USER': 'cltbld', 14:33:01 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1463175154.968173-340417346', 14:33:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:01 INFO - '_': '/tools/buildbot/bin/python'} 14:33:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:01 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:33:01 INFO - Cleaning up... 14:33:01 INFO - Return code: 0 14:33:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:33:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:01 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 0x7fef4b17ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19685a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f7410>, '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 0x19f8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f87a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1463175154.968173-340417346', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:33:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 14:33:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:33:01 INFO - Using env: {'DISPLAY': ':0', 14:33:01 INFO - 'HOME': '/home/cltbld', 14:33:01 INFO - 'LANG': 'en_US.UTF-8', 14:33:01 INFO - 'LANGUAGE': 'en_US:en', 14:33:01 INFO - 'LOGNAME': 'cltbld', 14:33:01 INFO - 'MAIL': '/var/mail/cltbld', 14:33:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:01 INFO - 'MOZ_NO_REMOTE': '1', 14:33:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:33:01 INFO - 'NO_EM_RESTART': '1', 14:33:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:33:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:01 INFO - 'PWD': '/builds/slave/test', 14:33:01 INFO - 'SHELL': '/bin/bash', 14:33:01 INFO - 'SHLVL': '1', 14:33:01 INFO - 'TERM': 'linux', 14:33:01 INFO - 'TMOUT': '86400', 14:33:01 INFO - 'USER': 'cltbld', 14:33:01 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1463175154.968173-340417346', 14:33:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:01 INFO - '_': '/tools/buildbot/bin/python'} 14:33:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:01 INFO - Downloading/unpacking psutil>=0.7.1 14:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:33:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:33:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:33:03 INFO - Installing collected packages: psutil 14:33:03 INFO - Running setup.py install for psutil 14:33:03 INFO - building 'psutil._psutil_linux' extension 14:33:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:33:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:33:04 INFO - building 'psutil._psutil_posix' extension 14:33:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:33:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:33:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:33:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:33:04 INFO - Successfully installed psutil 14:33:04 INFO - Cleaning up... 14:33:04 INFO - Return code: 0 14:33:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:33: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')]} 14:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33: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')]} 14:33:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:04 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 0x7fef4b17ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19685a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f7410>, '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 0x19f8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f87a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1463175154.968173-340417346', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:33:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:33:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:33:04 INFO - Using env: {'DISPLAY': ':0', 14:33:04 INFO - 'HOME': '/home/cltbld', 14:33:04 INFO - 'LANG': 'en_US.UTF-8', 14:33:04 INFO - 'LANGUAGE': 'en_US:en', 14:33:04 INFO - 'LOGNAME': 'cltbld', 14:33:04 INFO - 'MAIL': '/var/mail/cltbld', 14:33:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:04 INFO - 'MOZ_NO_REMOTE': '1', 14:33:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:33:04 INFO - 'NO_EM_RESTART': '1', 14:33:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:33:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:04 INFO - 'PWD': '/builds/slave/test', 14:33:04 INFO - 'SHELL': '/bin/bash', 14:33:04 INFO - 'SHLVL': '1', 14:33:04 INFO - 'TERM': 'linux', 14:33:04 INFO - 'TMOUT': '86400', 14:33:04 INFO - 'USER': 'cltbld', 14:33:04 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1463175154.968173-340417346', 14:33:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:04 INFO - '_': '/tools/buildbot/bin/python'} 14:33:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:33:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:33:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:33:06 INFO - Installing collected packages: mozsystemmonitor 14:33:06 INFO - Running setup.py install for mozsystemmonitor 14:33:06 INFO - Successfully installed mozsystemmonitor 14:33:06 INFO - Cleaning up... 14:33:06 INFO - Return code: 0 14:33:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:33:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:33:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:06 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 0x7fef4b17ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19685a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f7410>, '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 0x19f8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f87a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1463175154.968173-340417346', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:33:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:33:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:33:06 INFO - Using env: {'DISPLAY': ':0', 14:33:06 INFO - 'HOME': '/home/cltbld', 14:33:06 INFO - 'LANG': 'en_US.UTF-8', 14:33:06 INFO - 'LANGUAGE': 'en_US:en', 14:33:06 INFO - 'LOGNAME': 'cltbld', 14:33:06 INFO - 'MAIL': '/var/mail/cltbld', 14:33:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:06 INFO - 'MOZ_NO_REMOTE': '1', 14:33:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:33:06 INFO - 'NO_EM_RESTART': '1', 14:33:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:33:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:06 INFO - 'PWD': '/builds/slave/test', 14:33:06 INFO - 'SHELL': '/bin/bash', 14:33:06 INFO - 'SHLVL': '1', 14:33:06 INFO - 'TERM': 'linux', 14:33:06 INFO - 'TMOUT': '86400', 14:33:06 INFO - 'USER': 'cltbld', 14:33:06 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1463175154.968173-340417346', 14:33:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:06 INFO - '_': '/tools/buildbot/bin/python'} 14:33:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:06 INFO - Downloading/unpacking blobuploader==1.2.4 14:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:08 INFO - Downloading blobuploader-1.2.4.tar.gz 14:33:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:33:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:33:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:09 INFO - Downloading docopt-0.6.1.tar.gz 14:33:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:33:09 INFO - Installing collected packages: blobuploader, requests, docopt 14:33:09 INFO - Running setup.py install for blobuploader 14:33:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:33:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:33:09 INFO - Running setup.py install for requests 14:33:10 INFO - Running setup.py install for docopt 14:33:10 INFO - Successfully installed blobuploader requests docopt 14:33:10 INFO - Cleaning up... 14:33:10 INFO - Return code: 0 14:33:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:33:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:10 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 0x7fef4b17ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19685a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f7410>, '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 0x19f8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f87a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1463175154.968173-340417346', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:33:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:33:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:33:10 INFO - Using env: {'DISPLAY': ':0', 14:33:10 INFO - 'HOME': '/home/cltbld', 14:33:10 INFO - 'LANG': 'en_US.UTF-8', 14:33:10 INFO - 'LANGUAGE': 'en_US:en', 14:33:10 INFO - 'LOGNAME': 'cltbld', 14:33:10 INFO - 'MAIL': '/var/mail/cltbld', 14:33:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:10 INFO - 'MOZ_NO_REMOTE': '1', 14:33:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:33:10 INFO - 'NO_EM_RESTART': '1', 14:33:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:33:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:10 INFO - 'PWD': '/builds/slave/test', 14:33:10 INFO - 'SHELL': '/bin/bash', 14:33:10 INFO - 'SHLVL': '1', 14:33:10 INFO - 'TERM': 'linux', 14:33:10 INFO - 'TMOUT': '86400', 14:33:10 INFO - 'USER': 'cltbld', 14:33:10 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1463175154.968173-340417346', 14:33:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:10 INFO - '_': '/tools/buildbot/bin/python'} 14:33:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:33:10 INFO - Running setup.py (path:/tmp/pip-Bu0Lx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:33:10 INFO - Running setup.py (path:/tmp/pip-GkkFZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:33:10 INFO - Running setup.py (path:/tmp/pip-5Rwcvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:33:10 INFO - Running setup.py (path:/tmp/pip-1xbxES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:33:10 INFO - Running setup.py (path:/tmp/pip-ED_FxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:33:10 INFO - Running setup.py (path:/tmp/pip-1Qkw7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:33:10 INFO - Running setup.py (path:/tmp/pip-cc8tBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:33:10 INFO - Running setup.py (path:/tmp/pip-VkRhoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:33:10 INFO - Running setup.py (path:/tmp/pip-inlUsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:33:11 INFO - Running setup.py (path:/tmp/pip-p_ErEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:33:11 INFO - Running setup.py (path:/tmp/pip-LkpdU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:33:11 INFO - Running setup.py (path:/tmp/pip-xAFkmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:33:11 INFO - Running setup.py (path:/tmp/pip-38QnRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:33:11 INFO - Running setup.py (path:/tmp/pip-3F0B9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:33:11 INFO - Running setup.py (path:/tmp/pip-hBpXQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:33:11 INFO - Running setup.py (path:/tmp/pip-W7eE0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:33:11 INFO - Running setup.py (path:/tmp/pip-OpJ5bv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:33:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:33:11 INFO - Running setup.py install for manifestparser 14:33:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:33:11 INFO - Running setup.py install for mozcrash 14:33:11 INFO - Running setup.py install for mozdebug 14:33:11 INFO - Running setup.py install for mozdevice 14:33:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:33:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:33:12 INFO - Running setup.py install for mozfile 14:33:12 INFO - Running setup.py install for mozhttpd 14:33:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:33:12 INFO - Running setup.py install for mozinfo 14:33:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:33:12 INFO - Running setup.py install for mozInstall 14:33:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:33:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:33:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:33:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:33:12 INFO - Running setup.py install for mozleak 14:33:12 INFO - Running setup.py install for mozlog 14:33:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:33:12 INFO - Running setup.py install for moznetwork 14:33:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:33:12 INFO - Running setup.py install for mozprocess 14:33:12 INFO - Running setup.py install for mozprofile 14:33:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:33:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:33:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:33:13 INFO - Running setup.py install for mozrunner 14:33:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:33:13 INFO - Running setup.py install for mozscreenshot 14:33:13 INFO - Running setup.py install for moztest 14:33:13 INFO - Running setup.py install for mozversion 14:33:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:33:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:33:13 INFO - Cleaning up... 14:33:13 INFO - Return code: 0 14:33:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:33:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:33:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:13 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 0x7fef4b17ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19685a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f7410>, '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 0x19f8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f87a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1463175154.968173-340417346', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:33:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:33:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:33:13 INFO - Using env: {'DISPLAY': ':0', 14:33:13 INFO - 'HOME': '/home/cltbld', 14:33:13 INFO - 'LANG': 'en_US.UTF-8', 14:33:13 INFO - 'LANGUAGE': 'en_US:en', 14:33:13 INFO - 'LOGNAME': 'cltbld', 14:33:13 INFO - 'MAIL': '/var/mail/cltbld', 14:33:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:13 INFO - 'MOZ_NO_REMOTE': '1', 14:33:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:33:13 INFO - 'NO_EM_RESTART': '1', 14:33:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:33:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:13 INFO - 'PWD': '/builds/slave/test', 14:33:13 INFO - 'SHELL': '/bin/bash', 14:33:13 INFO - 'SHLVL': '1', 14:33:13 INFO - 'TERM': 'linux', 14:33:13 INFO - 'TMOUT': '86400', 14:33:13 INFO - 'USER': 'cltbld', 14:33:13 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1463175154.968173-340417346', 14:33:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:13 INFO - '_': '/tools/buildbot/bin/python'} 14:33:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:33:13 INFO - Running setup.py (path:/tmp/pip-ugQmbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:33:13 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:33:13 INFO - Running setup.py (path:/tmp/pip-BVY5SX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:33:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:33:13 INFO - Running setup.py (path:/tmp/pip-dT9u4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:33:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:33:13 INFO - Running setup.py (path:/tmp/pip-WcUVex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:33:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:33:13 INFO - Running setup.py (path:/tmp/pip-XxwVr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:33:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:33:14 INFO - Running setup.py (path:/tmp/pip-_8zPJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:33:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:33:14 INFO - Running setup.py (path:/tmp/pip-p54WA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:33:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:33:14 INFO - Running setup.py (path:/tmp/pip-Oc70oV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:33:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:33:14 INFO - Running setup.py (path:/tmp/pip-rp9Tqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:33:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:33:14 INFO - Running setup.py (path:/tmp/pip-gPyEae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:33:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:33:14 INFO - Running setup.py (path:/tmp/pip-0wJP6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:33:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:33:14 INFO - Running setup.py (path:/tmp/pip-gbGgnj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:33:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:33:14 INFO - Running setup.py (path:/tmp/pip-jVhnPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:33:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:33:14 INFO - Running setup.py (path:/tmp/pip-hcdfSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:33:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:33:14 INFO - Running setup.py (path:/tmp/pip-XkA7ka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:33:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:33:14 INFO - Running setup.py (path:/tmp/pip-4y39SH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:33:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:33:14 INFO - Running setup.py (path:/tmp/pip-QPDy4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:33:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:33:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:33:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:33:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:33:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:33:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:33:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:33: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 14:33: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 14:33: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 14:33: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 14:33: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 14:33: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 14:33:16 INFO - Downloading blessings-1.6.tar.gz 14:33:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:33:16 INFO - Installing collected packages: blessings 14:33:16 INFO - Running setup.py install for blessings 14:33:16 INFO - Successfully installed blessings 14:33:16 INFO - Cleaning up... 14:33:17 INFO - Return code: 0 14:33:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:33:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:33:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:33:17 INFO - Reading from file tmpfile_stdout 14:33:17 INFO - Current package versions: 14:33:17 INFO - argparse == 1.2.1 14:33:17 INFO - blessings == 1.6 14:33:17 INFO - blobuploader == 1.2.4 14:33:17 INFO - docopt == 0.6.1 14:33:17 INFO - manifestparser == 1.1 14:33:17 INFO - mozInstall == 1.12 14:33:17 INFO - mozcrash == 0.17 14:33:17 INFO - mozdebug == 0.1 14:33:17 INFO - mozdevice == 0.48 14:33:17 INFO - mozfile == 1.2 14:33:17 INFO - mozhttpd == 0.7 14:33:17 INFO - mozinfo == 0.9 14:33:17 INFO - mozleak == 0.1 14:33:17 INFO - mozlog == 3.1 14:33:17 INFO - moznetwork == 0.27 14:33:17 INFO - mozprocess == 0.22 14:33:17 INFO - mozprofile == 0.28 14:33:17 INFO - mozrunner == 6.11 14:33:17 INFO - mozscreenshot == 0.1 14:33:17 INFO - mozsystemmonitor == 0.0 14:33:17 INFO - moztest == 0.7 14:33:17 INFO - mozversion == 1.4 14:33:17 INFO - psutil == 3.1.1 14:33:17 INFO - requests == 1.2.3 14:33:17 INFO - wsgiref == 0.1.2 14:33:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:33:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:33:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:17 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 0x7fef4b17ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19685a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f7410>, '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 0x19f8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f87a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1463175154.968173-340417346', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:33:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:33:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:33:17 INFO - Using env: {'DISPLAY': ':0', 14:33:17 INFO - 'HOME': '/home/cltbld', 14:33:17 INFO - 'LANG': 'en_US.UTF-8', 14:33:17 INFO - 'LANGUAGE': 'en_US:en', 14:33:17 INFO - 'LOGNAME': 'cltbld', 14:33:17 INFO - 'MAIL': '/var/mail/cltbld', 14:33:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:17 INFO - 'MOZ_NO_REMOTE': '1', 14:33:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:33:17 INFO - 'NO_EM_RESTART': '1', 14:33:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:33:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:17 INFO - 'PWD': '/builds/slave/test', 14:33:17 INFO - 'SHELL': '/bin/bash', 14:33:17 INFO - 'SHLVL': '1', 14:33:17 INFO - 'TERM': 'linux', 14:33:17 INFO - 'TMOUT': '86400', 14:33:17 INFO - 'USER': 'cltbld', 14:33:17 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1463175154.968173-340417346', 14:33:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:17 INFO - '_': '/tools/buildbot/bin/python'} 14:33:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:33:17 INFO - Cleaning up... 14:33:17 INFO - Return code: 0 14:33:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:33:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:33:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:17 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 0x7fef4b17ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19685a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f7410>, '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 0x19f8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f87a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1463175154.968173-340417346', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:33:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:33:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:33:17 INFO - Using env: {'DISPLAY': ':0', 14:33:17 INFO - 'HOME': '/home/cltbld', 14:33:17 INFO - 'LANG': 'en_US.UTF-8', 14:33:17 INFO - 'LANGUAGE': 'en_US:en', 14:33:17 INFO - 'LOGNAME': 'cltbld', 14:33:17 INFO - 'MAIL': '/var/mail/cltbld', 14:33:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:17 INFO - 'MOZ_NO_REMOTE': '1', 14:33:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:33:17 INFO - 'NO_EM_RESTART': '1', 14:33:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:33:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:17 INFO - 'PWD': '/builds/slave/test', 14:33:17 INFO - 'SHELL': '/bin/bash', 14:33:17 INFO - 'SHLVL': '1', 14:33:17 INFO - 'TERM': 'linux', 14:33:17 INFO - 'TMOUT': '86400', 14:33:17 INFO - 'USER': 'cltbld', 14:33:17 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1463175154.968173-340417346', 14:33:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:17 INFO - '_': '/tools/buildbot/bin/python'} 14:33:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:17 INFO - Downloading/unpacking jsonschema 14:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:33:19 INFO - Downloading/unpacking functools32 (from jsonschema) 14:33: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 14:33: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 14:33: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 14:33: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 14:33: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 14:33: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 14:33:19 INFO - Downloading functools32-3.2.3-2.tar.gz 14:33:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:33:19 INFO - warning: no files found matching '*.txt' 14:33:19 INFO - no previously-included directories found matching 'build' 14:33:19 INFO - no previously-included directories found matching 'dist' 14:33:19 INFO - no previously-included directories found matching '.git*' 14:33:19 INFO - Installing collected packages: jsonschema, functools32 14:33:19 INFO - Running setup.py install for functools32 14:33:19 INFO - warning: no files found matching '*.txt' 14:33:19 INFO - no previously-included directories found matching 'build' 14:33:19 INFO - no previously-included directories found matching 'dist' 14:33:19 INFO - no previously-included directories found matching '.git*' 14:33:19 INFO - Successfully installed jsonschema functools32 14:33:19 INFO - Cleaning up... 14:33:19 INFO - Return code: 0 14:33:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:33:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:33:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:33:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:19 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 0x7fef4b17ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19685a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f7410>, '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 0x19f8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f87a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1463175154.968173-340417346', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:33:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:33:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:33:19 INFO - Using env: {'DISPLAY': ':0', 14:33:19 INFO - 'HOME': '/home/cltbld', 14:33:19 INFO - 'LANG': 'en_US.UTF-8', 14:33:19 INFO - 'LANGUAGE': 'en_US:en', 14:33:19 INFO - 'LOGNAME': 'cltbld', 14:33:19 INFO - 'MAIL': '/var/mail/cltbld', 14:33:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:19 INFO - 'MOZ_NO_REMOTE': '1', 14:33:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:33:19 INFO - 'NO_EM_RESTART': '1', 14:33:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:33:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:19 INFO - 'PWD': '/builds/slave/test', 14:33:19 INFO - 'SHELL': '/bin/bash', 14:33:19 INFO - 'SHLVL': '1', 14:33:19 INFO - 'TERM': 'linux', 14:33:19 INFO - 'TMOUT': '86400', 14:33:19 INFO - 'USER': 'cltbld', 14:33:19 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1463175154.968173-340417346', 14:33:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:19 INFO - '_': '/tools/buildbot/bin/python'} 14:33:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:20 INFO - Downloading/unpacking flake8 14:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:33:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:33:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:33:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:33:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:33:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:33:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:33:22 INFO - no previously-included directories found matching 'docs/_build' 14:33:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:33:22 INFO - Running setup.py install for pep8 14:33:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:33:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:33:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:33:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:33:22 INFO - no previously-included directories found matching 'docs/_build' 14:33:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:33:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:33:22 INFO - Cleaning up... 14:33:23 INFO - Return code: 0 14:33:23 INFO - Running post-action listener: _resource_record_post_action 14:33:23 INFO - Running post-action listener: _start_resource_monitoring 14:33:23 INFO - Starting resource monitoring. 14:33:23 INFO - ##### 14:33:23 INFO - ##### Running install step. 14:33:23 INFO - ##### 14:33:23 INFO - Running pre-action listener: _resource_record_pre_action 14:33:23 INFO - Running main action method: install 14:33:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:33:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:33:23 INFO - Reading from file tmpfile_stdout 14:33:23 INFO - Detecting whether we're running mozinstall >=1.0... 14:33:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:33:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:33:23 INFO - Reading from file tmpfile_stdout 14:33:23 INFO - Output received: 14:33:23 INFO - Usage: mozinstall [options] installer 14:33:23 INFO - Options: 14:33:23 INFO - -h, --help show this help message and exit 14:33:23 INFO - -d DEST, --destination=DEST 14:33:23 INFO - Directory to install application into. [default: 14:33:23 INFO - "/builds/slave/test"] 14:33:23 INFO - --app=APP Application being installed. [default: firefox] 14:33:23 INFO - mkdir: /builds/slave/test/build/application 14:33:23 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'] 14:33:23 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 14:33:38 INFO - Reading from file tmpfile_stdout 14:33:38 INFO - Output received: 14:33:38 INFO - /builds/slave/test/build/application/firefox/firefox 14:33:38 INFO - Running post-action listener: _resource_record_post_action 14:33:38 INFO - ##### 14:33:38 INFO - ##### Running run-tests step. 14:33:38 INFO - ##### 14:33:38 INFO - Running pre-action listener: _resource_record_pre_action 14:33:38 INFO - Running main action method: run_tests 14:33:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:33:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:33:38 INFO - Python 2.7.3 14:33:38 INFO - Return code: 0 14:33:38 INFO - grabbing minidump binary from tooltool 14:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:33:38 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 0x19f7410>, '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 0x19f8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f87a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:33:38 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:33:38 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:33:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:33:39 INFO - Return code: 0 14:33:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:33:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:33:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:33:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:33:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:33:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:33:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:33:39 INFO - Return code: 0 14:33:39 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JwMZ7IgpTKysdzjwdycVlA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:33:39 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JwMZ7IgpTKysdzjwdycVlA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:33:39 INFO - Using env: {'DISPLAY': ':0', 14:33:39 INFO - 'HOME': '/home/cltbld', 14:33:39 INFO - 'LANG': 'en_US.UTF-8', 14:33:39 INFO - 'LANGUAGE': 'en_US:en', 14:33:39 INFO - 'LOGNAME': 'cltbld', 14:33:39 INFO - 'MAIL': '/var/mail/cltbld', 14:33:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:33:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:33:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:39 INFO - 'MOZ_NO_REMOTE': '1', 14:33:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:33:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:33:39 INFO - 'NO_EM_RESTART': '1', 14:33:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:33:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:39 INFO - 'PWD': '/builds/slave/test', 14:33:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:33:39 INFO - 'SHELL': '/bin/bash', 14:33:39 INFO - 'SHLVL': '1', 14:33:39 INFO - 'TERM': 'linux', 14:33:39 INFO - 'TMOUT': '86400', 14:33:39 INFO - 'USER': 'cltbld', 14:33:39 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1463175154.968173-340417346', 14:33:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:39 INFO - '_': '/tools/buildbot/bin/python'} 14:33:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JwMZ7IgpTKysdzjwdycVlA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:33:40 INFO - mozversion application_buildid: 20160513114547 14:33:40 INFO - mozversion application_changeset: 805051b9a46259319d5c56424cb5249efc811363 14:33:40 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:33:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:33:40 INFO - mozversion application_name: Firefox 14:33:40 INFO - mozversion application_remotingname: firefox-dev 14:33:40 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:33:40 INFO - mozversion application_vendor: Mozilla 14:33:40 INFO - mozversion application_version: 48.0a2 14:33:40 INFO - mozversion platform_buildid: 20160513114547 14:33:40 INFO - mozversion platform_changeset: 805051b9a46259319d5c56424cb5249efc811363 14:33:40 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:33:40 INFO - mozversion platform_version: 48.0a2 14:33:40 INFO - using testdate: 1463175220 14:33:40 INFO - actual date: 1463175220 14:33:40 INFO - starting webserver on 'localhost:55945' 14:33:40 INFO - SUITE-START | Running 2 tests 14:33:40 INFO - TEST-START | dromaeo_css 14:33:40 INFO - operating with platform_type : linux_ 14:33:40 INFO - Initialising browser for dromaeo_css test... 14:33:40 INFO - TEST-INFO | started process 26718 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFADFTp/profile http://localhost:55945/getInfo.html) 14:33:43 INFO - PROCESS | 26718 | 14:33:43 INFO - PROCESS | 26718 | (process:26797): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:33:44 INFO - PROCESS | 26718 | __metrics Screen width/height:1600/1200 14:33:44 INFO - PROCESS | 26718 | colorDepth:24 14:33:44 INFO - PROCESS | 26718 | Browser inner width/height: 1024/697 14:33:44 INFO - PROCESS | 26718 | __metrics 14:33:45 ERROR - PROCESS | 26718 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 14:33:45 INFO - TEST-INFO | 26718: exit 0 14:33:45 INFO - Browser initialized. 14:33:45 INFO - Running cycle 1/1 for dromaeo_css test... 14:33:45 INFO - TEST-INFO | started process 26848 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFADFTp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:33:47 INFO - PROCESS | 26848 | 14:33:47 INFO - PROCESS | 26848 | (process:26917): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:33:57 INFO - PROCESS | 26848 | RSS: Main: 152199168 14:33:57 INFO - PROCESS | 26848 | 14:34:47 INFO - PROCESS | 26848 | 1463175287332 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:36:54 INFO - PROCESS | 26848 | Cycle 1(1): loaded http://localhost:55945/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55945/tests/dromaeo/cssquery-ext.html) 14:36:55 INFO - PROCESS | 26848 | RSS: Main: 155942912 14:36:55 INFO - PROCESS | 26848 | 14:39:57 INFO - PROCESS | 26848 | Cycle 1(1): loaded http://localhost:55945/tests/dromaeo/cssquery-ext.html (next: http://localhost:55945/tests/dromaeo/cssquery-jquery.html) 14:39:58 INFO - PROCESS | 26848 | RSS: Main: 153706496 14:39:58 INFO - PROCESS | 26848 | 14:42:59 INFO - PROCESS | 26848 | Cycle 1(1): loaded http://localhost:55945/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55945/tests/dromaeo/cssquery-mootools.html) 14:43:00 INFO - PROCESS | 26848 | RSS: Main: 153276416 14:43:00 INFO - PROCESS | 26848 | 14:46:02 INFO - PROCESS | 26848 | Cycle 1(1): loaded http://localhost:55945/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55945/tests/dromaeo/cssquery-prototype.html) 14:46:02 INFO - PROCESS | 26848 | RSS: Main: 153305088 14:46:02 INFO - PROCESS | 26848 | 14:49:05 INFO - PROCESS | 26848 | Cycle 1(1): loaded http://localhost:55945/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55945/tests/dromaeo/cssquery-yui.html) 14:49:05 INFO - PROCESS | 26848 | RSS: Main: 154472448 14:49:05 INFO - PROCESS | 26848 | 14:52:07 INFO - PROCESS | 26848 | Cycle 1(1): loaded http://localhost:55945/tests/dromaeo/cssquery-yui.html (next: http://localhost:55945/tests/dromaeo/cssquery-dojo.html) 14:52:08 INFO - PROCESS | 26848 | RSS: Main: 156069888 14:52:08 INFO - PROCESS | 26848 | 14:52:08 INFO - PROCESS | 26848 | __start_tp_report 14:52:08 INFO - PROCESS | 26848 | _x_x_mozilla_page_load 14:52:08 INFO - PROCESS | 26848 | _x_x_mozilla_page_load_details 14:52:08 INFO - PROCESS | 26848 | |i|pagename|runs| 14:52:08 INFO - PROCESS | 26848 | |0;dojo.html;3387.8644854205827;3429.6741809528085;3436.518887355772;3460.4290292101805;3477.1133360992944;5546.944530554693;5553.583481238913;5557.3886872444045;5561.47166019228;5573.191887176362;5585.245991791107;5588.21764952907;5591.8042868499615;5596.720163991805;5647.152927060943;5072.771725272362;5090.592752579803;5094.592432605383;5100.438951715309;5143.305653736754;5061.898762024757;5168.793248270064;5196.350456192976;5222.321098257221;5242.7640756166065;5151.304573882516;5239.161734122541;5245.816396426126;5289.206619007141;5305.204219367087;5134.05020071288;5153.974230128825;5162.561182299509;5166.896662066738;5189.896202075937;5001.9499805002215;5027.522385373383;5085.084684756743;5140.691558506464;5145.974270128663;5509.669419834822;5547.306586676666;5568.109102543614;5579.079451890433;5605.467480589378;5953.28560572734;6000.159977603139;6004.489618382443;6011.48902343297;6015.608985415934;5905.527557795366;6017.428344307284;6070.180525629028;6080.969595151996;6117.480014198798;5647.040003199466;5658.43415658435;5670.177824215466;5737.741801618937;5753.568482363839;6219.813405597839;6220.222472190976;6248.28144763349;6248.656323902138;6251.74993000284;5953.702314884238;5987.550933679991;5993.160957465958;6003.21958145447;6008.399160084044;6114.11489084418;6134.846628834315;6145.692715364214;6159.876802463926;6167.321594624587;6055.969720151459;6066.272047354346;6071.817845464643;6084.361142080106;6097.878042439126;6048.6673232971725;6060.2424696912885;6064.02975523914;6101.664408457489;6136.846578835565;4631.698939568917;4634.559716826963;4644.767761611906;4646.744429056367;4670.299455081765;4139.441175441277;4142.855000074983;4143.254214241466;4191.97904010478;4202.117555313357;5725.227094342211;5804;5846.56150788684;5872.5301975842685;5888.587798854039;6031.849203769853;6073.210482637229;6093.634381937098;6097.054956481752;6097.69511524422;5809.7095145242565;5833.679147646835;5840.211571437886;5845.269341332333;5867.647941123546;5119.257707632372;5174.508421700008;5234.26720259164;5237.685738855681;5242.9213561796605;6286.874262514724;6293.370662933761;6304.747810087637;6315.621062736159;6317.305096439388;6068.666223357758;6118.388161183846;6119.602225855305;6122.632642041492;6128.32588415265;6070.848228794315;6264;6298.905516417349;6360.141380913517;6361.554691171574;6023.45788879003;6024.90962635552;6026;6038.547108966757;6056.697165141637;5931.258592675916;6149.077638354103;6154.9384506154365;6155.446009859134;6159.938400615936;5988.730507127103;5999.520038397005;6012.849678758066;6050.515958723379;6060.2424696912885;5947.078202878561;5949.7620095197435;5969.164316995711;5973.611715238496;5983.311919129356;5725.8568535786935;5730.054541000855;5859.589828711949;5863.706814659336;5881.794137205177;5989.490893274121;6042.093685947143;6069.848253793691;6078.179445774764;6099.573029887865;5848.970755146197;5854.648721076749;5885.676287804212;5889.911651325147;5954.583179177416 14:52:08 INFO - PROCESS | 26848 | |1;ext.html;613.3069631316614;624.3070192086785;657.447743895128;668.6255696809787;683.9418649414796;39667.80166099165;39698;40283.59716402835;40420.797896010554;40518.39222411662;41280.793596032054;41889;41924.161516769724;41995.580044199545;42006.15987680245;8715.694950676727;8833.823323533525;8892.199702026815;8898.243649289818;8953.194212520872;8729.694460693878;8856.070112638177;8886.155815197546;9036.186743193111;9093.045230250827;9090.000099988996;9125.543722813833;9187.081291870827;9196.310276729238;9212.677556285531;9076.59155338008;9109.863352049724;9130.77173070672;9145.862812057825;9148.268138548934;8989.910100898973;9017.774555636162;9066.048064953151;9068.954655226747;9120.361574689774;42282;42743.57256427427;42775.35836962448;42834.78582607098;42854.35718464226;3939.8818035458694;3954.703397245218;3989.740666856674;4158.293090174678;4509.346144808985;31254.687453125403;31531.36937261242;31929.680703193135;33861.322773544634;35672;4369.956300436987;4377.474703035656;4402.779861006937;4417.160739459492;4420.31485119807;216373;217554.99999999843;217949;219426;219679;38753.22493550113;39664;56285;56715.43284567184;56879;37239.627603724155;37370.43944340837;37523.81238093792;37553;37633.24733505314;16774.99350038977;16818.831811681972;16865;16936.322547098225;16947.152642367833;14290.499832505813;14405.639859003399;14477.78283325751;14512.274386280644;14545.636359090895;9412.71761847132;9591.616335346647;9649.131578158;9651;9723.319367644197;3620.4931309616672;3652.6164752701116;3761.780549475822;3765.3222419964122;3782.6028267032116;1125.2839419884579;1177.4936777185892;1182.1429463638965;1215.7629262293945;1216.9473405504175;32449.513257301158;33151.3369732604;33227.16932076718;33549.66450335514;33966.83016584901;1234.1977714485656;1238.6036468330049;1266.3984607311454;1338.9129706569236;1363.372848489686;17052.2326495308;17386.391476298522;17390.304387824344;17487.35152599318;17641.206145723474;521464;567561;576429;886653;944028;57669.4233057664;58606.706966464895;58658;58870;58891;1527.3508758777475;1530.8163020437619;1539.984600153984;1541.6300087978805;1552.2937063636018;31088.68911310858;31526.842365788023;34157.14607134742;34556.30887382288;35413.82293088518;52420.47579524156;53091.46908530865;53569.73215133899;53664;53673.46326536841;426391;427613;427732;429623;431696;46052.7697361511;46118;46857;47282.763586183224;47459.76270118627;49348.75325623349;49889.50110498994;50060.49939500559;50639;51176.74411627918;41388;41532.169356612096;41786.58213417827;42477;43401.782991084845;41152.38271425991;41240.58759412367;42166;42341.78829105835;42643.57356426396;44176;44901.10197796091;44913.32630010487;44992.32511512395;45193.32210016787;36333.0916727084;37157.81421092986;37585.2482950334;37887.62112378951;37899.62100378961;28960.855195723885;29474.263143421587;29512.409751804415;29650.55524167096;30270.243243919078 14:52:08 INFO - PROCESS | 26848 | |2;jquery.html;403.83644623927313;415.2401105976064;426.8698047095635;433.92840181370076;437.29158762804263;15602.531924042269;18315;18765.906170469163;18980.810191898094;19007.144678489465;19567.217311307566;19882.20471181151;20035.899820500912;20573.177072917064;20645.070971806268;5137.332146820908;5584.636998595099;5652.236948012007;6099.085137229406;6128.417800308964;6037.547183961198;6060.606060606046;6079.331273559905;6106.786262480814;6133.080037994292;6021.157038014681;6079.088136779496;7306.525075870051;7740.148583655793;7752.186020467854;7257.637118144072;7405.629718514053;7428.739994100208;7434.665440055211;7509.324160825525;7213.927860721431;7255.600941948191;7321.048263725682;7321.194668586451;7333.120025596909;24670.753292467027;25871.74128258712;26246.08138715155;27374;27464.450710985668;2616.6205900144564;2733.043434797825;2738.548139556971;2942.529195328737;3303.7357011439026;15282.923585382114;15584.688306233811;16083.11542865142;16307.918460407622;16404.589885252844;2230.531588366429;2239.0931672672596;2313.2944451942153;2429.125514814665;2470.407102295454;92037;94488.52755736247;95563;97085;97344;18444.170012349477;18633.254669813057;18663.147581628604;18719.438416847515;18861;15802;16484.587885302724;34292.48561271583;34492.65507344894;34537;8222.62998165084;8453;8644.438111522732;8903.06517815633;9104.81790364189;8551.187637174582;8560.101189375151;8565.657373705106;8622.956885215533;8907.866382004275;5061.139606266944;5099.184130539096;5145.922811157836;5183.688978661293;5208.73956302191;2118.1661193240284;2152.763196048433;2181.4110190248543;2202.25123458025;2243.573720993006;1085.2674444749762;1087.3149915553151;1103.508938522366;1107.1917500224881;1222.7371115210271;19168.71246931297;19332.130054147598;19444.70832937507;19453.80546194548;20033.098510566768;1040.635777477892;1091.4542728635681;1104.8066588347008;1137.7155711072232;1154.2439701995206;10936.671899843017;11210.27133236337;11233.943830280796;11255.831162532568;11374.488148033359;448886;461063;461396;469705;472932;79833;84492.57753711192;90744.5462772682;91438.54280728554;91691.0830891696;1108.5177947592822;1110.1396417776289;1118.9440527973732;1141.3209140561353;1148.7472755993667;17170.22733976949;17181.398651047653;17493.650126997643;17496.737548936522;17597.824021759618;38537.614623854526;38947.41578876263;39501.802490987364;40341;40606.39090413705;56413.71793141008;56484.15273770979;57880.4211957875;58472.70763646154;58499;9129.360944733804;9186.127317904788;9251.953740231256;9254.4910029949;9490.525473726148;10074.798504029732;13643.65890852697;13744.381502832597;13874.583762487142;14044.297785110908;11543.249688770204;11803.940980295043;12019.21875078117;12113.636590902288;12206.206596571194;11581.420928953687;11656.358900260228;11690;11736.88263117358;11962.342071186169;11969.581064662694;12165.148439609497;12273.447694853574;12346.197497162655;12364.62906112818;8550.871736923827;9010.459372437675;9055.456672599665;9160.404573702688;9291.442513449214;8439.704610338855;8548.10244924274;8682.479051256692;8802.91197088021;9193.678221262224 14:52:08 INFO - PROCESS | 26848 | |3;mootools.html;1534.2635534943229;1562.9452969146078;1762.938297159599;1847.0395394394907;1877.943661690149;7358.521696089751;7969.123396426396;7997.960010199941;8131.10557838638;8137.511749295039;7913.4856234344725;7937.285644292013;7939.325157361617;8018.639161237744;8099.716509922154;2378.4172877645;2389.5937690592555;2401.0395841663385;2407.711074671042;2413.9034438622434;2308.122913292946;2338.754430784769;2367.8816059197056;2383.285014495653;2384.2251268337773;2343.086196383412;2378.916737914173;2394.425337918896;2404.4710163763943;2404.9759502405013;2371.4782747795457;2377.679013333195;2380.6786083878715;2384.606539920911;2399.604065329236;2376.310869847742;2402.7356990731005;2404.6152615581423;2405.2663937499055;2405.927822165338;8125.918740812575;8138.674453021931;8187.631556579968;8244.752657420288;8260.752177434626;5188.11801993662;5254.369475662907;5281.15501519755;5291.656042357235;5304.389995150568;3421.3841508528453;3427.4344733119005;3475.965240347615;3506.754527183098;3518.1556426457723;1107.9778404431947;1114.4984756859446;1114.7826173896094;1124.7244425115816;1145.2670291013758;11272.210945233837;11483.196176267664;11504.194706370557;11532.192746507748;11533.826992595117;4510.864674059783;4539.31910213464;4597.908041839144;4642.79107440166;4696.342512048316;9844.458554779556;9852.704418867446;9853.901460985442;9855.90144098564;9858.260630452745;5201.6358854880555;5206.271122042917;5238.554722848525;5261.289725887033;5268.262443257947;4235.97882010588;4610.354550362952;4792.113459010095;4795.520447955177;4815.686980346266;3959.1685745993086;3985.5217373915316;4058.431819545266;4062.1469491406547;4121.237571049365;1276.846778386581;1277.6358737759879;1279.6864768131868;1284.2872205925614;1290.677330667333;861.2722249698994;916.6608354908726;994.4132961552718;1094.7700982793704;1100.533922397985;5856.385079566669;5959.28488581373;5992.640441573432;5995.310539288038;6056.939430605637;469.0806020200377;471.91033703596895;475.3369050174987;1117.458032854065;1118.4799068433217;4242.151569686075;4245.724027938236;4257.169851878916;4268.103698223408;4281.743095414286;9487.288453365887;9760.902390976;9831.950840245752;9866.062724041205;9876.851847222297;9736.977617350218;9773.12041916231;9799.069088436587;9846.310758246855;9853.655122070837;7419.443541734284;7573.242675732383;7777.805554861174;8067;8113.553754543556;5819.912701309399;5838;5838.737256823538;5907.793227237198;5924.437178468039;8875.556222188994;8920;9085.000649928636;9093.77265568366;9143.542822858963;8455.32357411418;8706.738797836075;8762.649494020168;8812.779680508038;9056.637734490547;6636.13730215069;7026.297370262932;7046.401055910305;7145.285471453021;7172.964135179291;7920.762377128695;7941.642626081724;7947.483413578099;7968.521888686697;7977.162397948132;6888.965555172192;7213.71145154188;7268.600226987355;7300.707971681073;7421.925780742339;7070.505064645631;7084.681189346388;7102.218755936739;7170.139583250043;7186.209516953236;6798.626075565891;7009.439244860297;7010.894836577558;7014.929850701427;7023.297670232936;5031.471695471922;5284.727567146164;5301.761420735999;5332.173513105475;5440.700761458158;5377.650452720717;5437.972810135924;5467.890642187213;5589;5666.923284575917 14:52:08 INFO - PROCESS | 26848 | |4;prototype.html;354.5497218532464;358.9461580762886;363.57824923089214;366.9046048027512;369.09203359735034;6597.109390232317;6887.655617219144;6905.68924398402;6921.723131074764;6927.930720692798;6613;6721.966390168054;6726.3609957054005;6736.7978960631135;6745.966270168655;4871.756412179377;4995.350604421438;4996.850094497171;4998.875028124307;5001.374828146481;4899.069176856386;4983.07813054586;4991.301217829488;4995.125852975733;4998.525140111684;4910.140725373046;4910.312556242129;4919.065377578267;4934.4325402578625;4936.210206366982;4922.876928076791;4927.556519913207;4944.159492886218;4949.208126699728;4969.378827646544;4299.828006879721;4303;4305.483341998949;4308.138372325548;4312.417823593806;6356.586821856565;6361.713722882481;6369.172007639024;6377.17096777416;6403.263624683128;5610.69141197234;5657.575681823839;5727.284089488814;5728.799492017801;5743.4543718346695;6874.65626718662;6926.549774264707;6963.09479767627;6973.965130174317;6985.091938048021;4671.065786842645;4688.390509233778;4692.389989301369;4699.7415142167165;4731.621470282404;7316.122065352191;7340.706371745124;7355.521891077063;7405.814854628624;7413.036305280333;4772.188727916263;4842.903141937141;4842.951570484321;4846.660733748674;4860.441049279378;4958.677685950402;4966.850994470172;4971.130052240844;4977.477364876709;4982.451930287665;5733.512651424592;5756.251687280626;5768.480836724715;5775.249217601685;5785.27684039495;7085.89371159433;7088.681009354591;7095.396891264197;7106.076210092655;7110.92889071113;1721.277063633277;1729.7145970914657;1732.5668582854287;1734.4016314371522;1735.1757914990278;1106.7399161197113;1137.3346592243465;1147.5811328864904;1147.770445910821;1150.7813515432042;6753.35843094915;6811.897821532681;6823.931760682429;6836.93163068363;6842.110525631636;7270.236625154388;7275.963620181865;7290.963545182346;7303.817404564822;7320.341169294683;6597.9670101650145;6714.496412769062;6718.93281067183;6719.496037797185;6853.280405557444;3964.266610677034;3981.343078392091;3997.360422332471;4002.419649150857;4008.8797336079965;7687.884681729778;7694;7694.422918281151;7700.961495192488;7703.34521565662;7487.438442116863;7538.246175382527;7546.886796698054;7556.508826926232;7556.697732090654;7430.96284518574;7603.923960760432;7613.885791713129;7630.580318082559;7680.231976802275;7306.890396644161;7326.6702998364135;7384.224656411215;7391.482596218429;7395.778126656209;7240.855182896207;7262.128544574685;7295.161056478573;7296.7446139384865;7298.4526160539235;7622.045055152414;7646.158922518407;7705.383569314329;7711.421643376657;7750.844983100419;4714.127886341038;4764.166270902648;4776.259679749644;4796.736179510161;4805;7356.264373562601;7368.4842061055215;7373.33639972405;7381.704731810667;7398.075240594926;7136.357727804522;7148.213696493278;7201.855962880818;7211.134663840373;7224.096987876515;6991.440684745106;7118.857622847618;7140.6786694599905;7149.499535032498;7155.606441645759;7024.473164512784;7034.577925324497;7037.472189585699;7039.894401583878;7044.964775176091;7127.572345659277;7180.5691658500655;7181.928180718126;7214.74748383804;7218.819529511804;7003.7548685795755;7011.894821577578;7019.2629773873;7023.964880175567;7037.472189585699 14:52:08 INFO - PROCESS | 26848 | |5;yui.html;881.6958149438442;892.9553522323882;899.7840518275616;904.9728508144756;907.1336873286011;14548;14784.112953222813;14813.25933703316;14829.258537073158;14944.701105977874;14103;14265;14350.569482915504;14358.784618230735;14406.927965360159;871.2811930157613;875.7241468937265;888.524639317965;899.2266650680409;901.923336516397;899.3389858454063;906.4425378392307;906.9773255668628;907.6414816147618;907.773056735816;931.7717159295981;932.4545141092435;932.6782260120248;933.0343094896783;936.1013427109982;921.7050543825978;923.9122283383068;925.1118925831211;928.0533855467453;930.1907340613676;673.8989151627246;680.3876511139964;681.3152781454606;681.9488538359643;682.2324884504932;14306.427742890271;14380.352884120135;14404.135751854817;14424.567262982127;14431.49489767853;14633.487827926077;14775.187364694937;14799.926000370036;14814.185219812905;14816.259187040605;12052.758944821055;12135.211211271328;12144.817827732591;12204.877951220464;12217.144799864012;3996.860109896169;4022.597740225983;4061.5532291447917;4063.817128229237;4071.2671719090554;55907.161392579146;56138.71930640362;56519.71740141273;56565.43434565643;57027.42972570263;11256.573236077567;11352.318860868374;11620.128490363257;11789.351585662871;11874;19883.701744473845;20008.89995550042;20029.399118026482;20045.398638040882;20058.39824805258;9132.680356187502;9171.90828091724;9256;9333.346665733468;9536.141747242642;5031.371078615173;5066.290719299301;5082.186850103965;5122.795088196505;5257.395399529027;3646.2342907989087;3670.082479380155;3691.5570131583845;3692.040069581928;3704.7777133371546;679.9592024478548;684.8801459744525;690.1752405874931;696.6377483708544;699.1679900917892;760.9657565409569;802.4864086984335;824.8061705499202;829.1004260377558;853.7097386888488;9295.814083718287;9930.556941312685;9969.451680157516;10059.497025148714;10220.846687299696;673.2089794491453;701.8841891087914;763.7861398808343;799.4403917257943;823.8558252305822;4308.547602501692;4404.933925991113;4598.517155698671;4715.174844402216;4782.879804454587;66669.99995000078;66865.66567167231;67219;67802;67925.66037169882;58386.708066459396;59766.70116649476;60003.69998149981;60569.39430605726;61121;52658.473415266126;52984.470155298724;54121;54205.1869221962;54336.72831635817;9078.682246121354;9169.54152292396;9211.815763684823;9365.157135857806;9456.952715236379;39800.60199397969;39920.40119398153;39963.60036399715;40311.79844100761;41407.792961035004;50149.498505015945;51918.221226682384;52593.21110183274;53015.4698453026;53747.19379209237;11332.490037948148;11405.486753096297;11774;11950;12018.218815776947;12217.144799863925;12331.075169362513;12409.751804964031;12511.311877846805;12547.43536540876;12115.515379384726;12315.19951203169;12399.75200496003;12432.316222607844;13110.475580977036;13660.316984150553;13674.111182773087;13841.454603437225;13995.790063149265;14072.718545628826;13630;13847.930760346133;14061.507847225297;14117.43530258778;14153.292335383396;11838.28970261787;11956.940215298868;12059.138846643178;12206.32865192423;12315.384230788604;11659.53361865516;11735.178537502294;11805.173637845268;12035.75928481443;12146.878531214576 14:52:08 INFO - PROCESS | 26848 | __end_tp_report 14:52:08 INFO - PROCESS | 26848 | __start_cc_report 14:52:08 INFO - PROCESS | 26848 | _x_x_mozilla_cycle_collect,333 14:52:08 INFO - PROCESS | 26848 | __end_cc_report 14:52:08 INFO - PROCESS | 26848 | __startTimestamp1463176328071__endTimestamp 14:52:08 INFO - PROCESS | 26848 | 14:52:08 INFO - PROCESS | 26848 | ------- Summary: start ------- 14:52:08 INFO - PROCESS | 26848 | Number of tests: 6 14:52:08 INFO - PROCESS | 26848 | 14:52:08 INFO - PROCESS | 26848 | [#0] dojo.html Cycles:165 Average:5651.92 Median:5888.59 stddev:632.11 (10.7%) stddev-sans-first:608.58 14:52:08 INFO - PROCESS | 26848 | Values: 3387.9 3429.7 3436.5 3460.4 3477.1 5546.9 5553.6 5557.4 5561.5 5573.2 5585.2 5588.2 5591.8 5596.7 5647.2 5072.8 5090.6 5094.6 5100.4 5143.3 5061.9 5168.8 5196.4 5222.3 5242.8 5151.3 5239.2 5245.8 5289.2 5305.2 5134.1 5154.0 5162.6 5166.9 5189.9 5001.9 5027.5 5085.1 5140.7 5146.0 5509.7 5547.3 5568.1 5579.1 5605.5 5953.3 6000.2 6004.5 6011.5 6015.6 5905.5 6017.4 6070.2 6081.0 6117.5 5647.0 5658.4 5670.2 5737.7 5753.6 6219.8 6220.2 6248.3 6248.7 6251.7 5953.7 5987.6 5993.2 6003.2 6008.4 6114.1 6134.8 6145.7 6159.9 6167.3 6056.0 6066.3 6071.8 6084.4 6097.9 6048.7 6060.2 6064.0 6101.7 6136.8 4631.7 4634.6 4644.8 4646.7 4670.3 4139.4 4142.9 4143.3 4192.0 4202.1 5725.2 5804.0 5846.6 5872.5 5888.6 6031.8 6073.2 6093.6 6097.1 6097.7 5809.7 5833.7 5840.2 5845.3 5867.6 5119.3 5174.5 5234.3 5237.7 5242.9 6286.9 6293.4 6304.7 6315.6 6317.3 6068.7 6118.4 6119.6 6122.6 6128.3 6070.8 6264.0 6298.9 6360.1 6361.6 6023.5 6024.9 6026.0 6038.5 6056.7 5931.3 6149.1 6154.9 6155.4 6159.9 5988.7 5999.5 6012.8 6050.5 6060.2 5947.1 5949.8 5969.2 5973.6 5983.3 5725.9 5730.1 5859.6 5863.7 5881.8 5989.5 6042.1 6069.8 6078.2 6099.6 5849.0 5854.6 5885.7 5889.9 5954.6 14:52:08 INFO - PROCESS | 26848 | 14:52:08 INFO - PROCESS | 26848 | [#1] ext.html Cycles:180 Average:60616.10 Median:42086.08 stddev:134988.89 (320.7%) stddev-sans-first:135292.39 14:52:08 INFO - PROCESS | 26848 | Values: 613.3 624.3 657.4 668.6 683.9 39667.8 39698.0 40283.6 40420.8 40518.4 41280.8 41889.0 41924.2 41995.6 42006.2 8715.7 8833.8 8892.2 8898.2 8953.2 8729.7 8856.1 8886.2 9036.2 9093.0 9090.0 9125.5 9187.1 9196.3 9212.7 9076.6 9109.9 9130.8 9145.9 9148.3 8989.9 9017.8 9066.0 9069.0 9120.4 42282.0 42743.6 42775.4 42834.8 42854.4 3939.9 3954.7 3989.7 4158.3 4509.3 31254.7 31531.4 31929.7 33861.3 35672.0 4370.0 4377.5 4402.8 4417.2 4420.3 216373.0 217555.0 217949.0 219426.0 219679.0 38753.2 39664.0 56285.0 56715.4 56879.0 37239.6 37370.4 37523.8 37553.0 37633.2 16775.0 16818.8 16865.0 16936.3 16947.2 14290.5 14405.6 14477.8 14512.3 14545.6 9412.7 9591.6 9649.1 9651.0 9723.3 3620.5 3652.6 3761.8 3765.3 3782.6 1125.3 1177.5 1182.1 1215.8 1216.9 32449.5 33151.3 33227.2 33549.7 33966.8 1234.2 1238.6 1266.4 1338.9 1363.4 17052.2 17386.4 17390.3 17487.4 17641.2 521464.0 567561.0 576429.0 886653.0 944028.0 57669.4 58606.7 58658.0 58870.0 58891.0 1527.4 1530.8 1540.0 1541.6 1552.3 31088.7 31526.8 34157.1 34556.3 35413.8 52420.5 53091.5 53569.7 53664.0 53673.5 426391.0 427613.0 427732.0 429623.0 431696.0 46052.8 46118.0 46857.0 47282.8 47459.8 49348.8 49889.5 50060.5 50639.0 51176.7 41388.0 41532.2 41786.6 42477.0 43401.8 41152.4 41240.6 42166.0 42341.8 42643.6 44176.0 44901.1 44913.3 44992.3 45193.3 36333.1 37157.8 37585.2 37887.6 37899.6 28960.9 29474.3 29512.4 29650.6 30270.2 14:52:08 INFO - PROCESS | 26848 | 14:52:08 INFO - PROCESS | 26848 | [#2] jquery.html Cycles:180 Average:29453.62 Median:3123.13 stddev:76519.71 (2450.1%) stddev-sans-first:76703.28 14:52:08 INFO - PROCESS | 26848 | Values: 403.8 415.2 426.9 433.9 437.3 15602.5 18315.0 18765.9 18980.8 19007.1 19567.2 19882.2 20035.9 20573.2 20645.1 5137.3 5584.6 5652.2 6099.1 6128.4 6037.5 6060.6 6079.3 6106.8 6133.1 6021.2 6079.1 7306.5 7740.1 7752.2 7257.6 7405.6 7428.7 7434.7 7509.3 7213.9 7255.6 7321.0 7321.2 7333.1 24670.8 25871.7 26246.1 27374.0 27464.5 2616.6 2733.0 2738.5 2942.5 3303.7 15282.9 15584.7 16083.1 16307.9 16404.6 2230.5 2239.1 2313.3 2429.1 2470.4 92037.0 94488.5 95563.0 97085.0 97344.0 18444.2 18633.3 18663.1 18719.4 18861.0 15802.0 16484.6 34292.5 34492.7 34537.0 8222.6 8453.0 8644.4 8903.1 9104.8 8551.2 8560.1 8565.7 8623.0 8907.9 5061.1 5099.2 5145.9 5183.7 5208.7 2118.2 2152.8 2181.4 2202.3 2243.6 1085.3 1087.3 1103.5 1107.2 1222.7 19168.7 19332.1 19444.7 19453.8 20033.1 1040.6 1091.5 1104.8 1137.7 1154.2 10936.7 11210.3 11233.9 11255.8 11374.5 448886.0 461063.0 461396.0 469705.0 472932.0 79833.0 84492.6 90744.5 91438.5 91691.1 1108.5 1110.1 1118.9 1141.3 1148.7 17170.2 17181.4 17493.7 17496.7 17597.8 38537.6 38947.4 39501.8 40341.0 40606.4 56413.7 56484.2 57880.4 58472.7 58499.0 9129.4 9186.1 9252.0 9254.5 9490.5 10074.8 13643.7 13744.4 13874.6 14044.3 11543.2 11803.9 12019.2 12113.6 12206.2 11581.4 11656.4 11690.0 11736.9 11962.3 11969.6 12165.1 12273.4 12346.2 12364.6 8550.9 9010.5 9055.5 9160.4 9291.4 8439.7 8548.1 8682.5 8802.9 9193.7 14:52:08 INFO - PROCESS | 26848 | 14:52:08 INFO - PROCESS | 26848 | [#3] mootools.html Cycles:180 Average:5520.04 Median:5354.91 stddev:2933.45 (54.8%) stddev-sans-first:2926.39 14:52:08 INFO - PROCESS | 26848 | Values: 1534.3 1562.9 1762.9 1847.0 1877.9 7358.5 7969.1 7998.0 8131.1 8137.5 7913.5 7937.3 7939.3 8018.6 8099.7 2378.4 2389.6 2401.0 2407.7 2413.9 2308.1 2338.8 2367.9 2383.3 2384.2 2343.1 2378.9 2394.4 2404.5 2405.0 2371.5 2377.7 2380.7 2384.6 2399.6 2376.3 2402.7 2404.6 2405.3 2405.9 8125.9 8138.7 8187.6 8244.8 8260.8 5188.1 5254.4 5281.2 5291.7 5304.4 3421.4 3427.4 3476.0 3506.8 3518.2 1108.0 1114.5 1114.8 1124.7 1145.3 11272.2 11483.2 11504.2 11532.2 11533.8 4510.9 4539.3 4597.9 4642.8 4696.3 9844.5 9852.7 9853.9 9855.9 9858.3 5201.6 5206.3 5238.6 5261.3 5268.3 4236.0 4610.4 4792.1 4795.5 4815.7 3959.2 3985.5 4058.4 4062.1 4121.2 1276.8 1277.6 1279.7 1284.3 1290.7 861.3 916.7 994.4 1094.8 1100.5 5856.4 5959.3 5992.6 5995.3 6056.9 469.1 471.9 475.3 1117.5 1118.5 4242.2 4245.7 4257.2 4268.1 4281.7 9487.3 9760.9 9832.0 9866.1 9876.9 9737.0 9773.1 9799.1 9846.3 9853.7 7419.4 7573.2 7777.8 8067.0 8113.6 5819.9 5838.0 5838.7 5907.8 5924.4 8875.6 8920.0 9085.0 9093.8 9143.5 8455.3 8706.7 8762.6 8812.8 9056.6 6636.1 7026.3 7046.4 7145.3 7173.0 7920.8 7941.6 7947.5 7968.5 7977.2 6889.0 7213.7 7268.6 7300.7 7421.9 7070.5 7084.7 7102.2 7170.1 7186.2 6798.6 7009.4 7010.9 7014.9 7023.3 5031.5 5284.7 5301.8 5332.2 5440.7 5377.7 5438.0 5467.9 5589.0 5666.9 14:52:08 INFO - PROCESS | 26848 | 14:52:08 INFO - PROCESS | 26848 | [#4] prototype.html Cycles:180 Average:5897.15 Median:6782.63 stddev:1836.38 (27.1%) stddev-sans-first:1793.79 14:52:08 INFO - PROCESS | 26848 | Values: 354.5 358.9 363.6 366.9 369.1 6597.1 6887.7 6905.7 6921.7 6927.9 6613.0 6722.0 6726.4 6736.8 6746.0 4871.8 4995.4 4996.9 4998.9 5001.4 4899.1 4983.1 4991.3 4995.1 4998.5 4910.1 4910.3 4919.1 4934.4 4936.2 4922.9 4927.6 4944.2 4949.2 4969.4 4299.8 4303.0 4305.5 4308.1 4312.4 6356.6 6361.7 6369.2 6377.2 6403.3 5610.7 5657.6 5727.3 5728.8 5743.5 6874.7 6926.5 6963.1 6974.0 6985.1 4671.1 4688.4 4692.4 4699.7 4731.6 7316.1 7340.7 7355.5 7405.8 7413.0 4772.2 4842.9 4843.0 4846.7 4860.4 4958.7 4966.9 4971.1 4977.5 4982.5 5733.5 5756.3 5768.5 5775.2 5785.3 7085.9 7088.7 7095.4 7106.1 7110.9 1721.3 1729.7 1732.6 1734.4 1735.2 1106.7 1137.3 1147.6 1147.8 1150.8 6753.4 6811.9 6823.9 6836.9 6842.1 7270.2 7276.0 7291.0 7303.8 7320.3 6598.0 6714.5 6718.9 6719.5 6853.3 3964.3 3981.3 3997.4 4002.4 4008.9 7687.9 7694.0 7694.4 7701.0 7703.3 7487.4 7538.2 7546.9 7556.5 7556.7 7431.0 7603.9 7613.9 7630.6 7680.2 7306.9 7326.7 7384.2 7391.5 7395.8 7240.9 7262.1 7295.2 7296.7 7298.5 7622.0 7646.2 7705.4 7711.4 7750.8 4714.1 4764.2 4776.3 4796.7 4805.0 7356.3 7368.5 7373.3 7381.7 7398.1 7136.4 7148.2 7201.9 7211.1 7224.1 6991.4 7118.9 7140.7 7149.5 7155.6 7024.5 7034.6 7037.5 7039.9 7045.0 7127.6 7180.6 7181.9 7214.7 7218.8 7003.8 7011.9 7019.3 7024.0 7037.5 14:52:08 INFO - PROCESS | 26848 | 14:52:08 INFO - PROCESS | 26848 | [#5] yui.html Cycles:180 Average:15932.10 Median:4749.03 stddev:18621.89 (392.1%) stddev-sans-first:18639.83 14:52:08 INFO - PROCESS | 26848 | Values: 881.7 893.0 899.8 905.0 907.1 14548.0 14784.1 14813.3 14829.3 14944.7 14103.0 14265.0 14350.6 14358.8 14406.9 871.3 875.7 888.5 899.2 901.9 899.3 906.4 907.0 907.6 907.8 931.8 932.5 932.7 933.0 936.1 921.7 923.9 925.1 928.1 930.2 673.9 680.4 681.3 681.9 682.2 14306.4 14380.4 14404.1 14424.6 14431.5 14633.5 14775.2 14799.9 14814.2 14816.3 12052.8 12135.2 12144.8 12204.9 12217.1 3996.9 4022.6 4061.6 4063.8 4071.3 55907.2 56138.7 56519.7 56565.4 57027.4 11256.6 11352.3 11620.1 11789.4 11874.0 19883.7 20008.9 20029.4 20045.4 20058.4 9132.7 9171.9 9256.0 9333.3 9536.1 5031.4 5066.3 5082.2 5122.8 5257.4 3646.2 3670.1 3691.6 3692.0 3704.8 680.0 684.9 690.2 696.6 699.2 761.0 802.5 824.8 829.1 853.7 9295.8 9930.6 9969.5 10059.5 10220.8 673.2 701.9 763.8 799.4 823.9 4308.5 4404.9 4598.5 4715.2 4782.9 66670.0 66865.7 67219.0 67802.0 67925.7 58386.7 59766.7 60003.7 60569.4 61121.0 52658.5 52984.5 54121.0 54205.2 54336.7 9078.7 9169.5 9211.8 9365.2 9457.0 39800.6 39920.4 39963.6 40311.8 41407.8 50149.5 51918.2 52593.2 53015.5 53747.2 11332.5 11405.5 11774.0 11950.0 12018.2 12217.1 12331.1 12409.8 12511.3 12547.4 12115.5 12315.2 12399.8 12432.3 13110.5 13660.3 13674.1 13841.5 13995.8 14072.7 13630.0 13847.9 14061.5 14117.4 14153.3 11838.3 11956.9 12059.1 12206.3 12315.4 11659.5 11735.2 11805.2 12035.8 12146.9 14:52:08 INFO - PROCESS | 26848 | -------- Summary: end -------- 14:52:08 INFO - PROCESS | 26848 | 14:52:08 INFO - TEST-INFO | 26848: exit 0 14:52:08 INFO - TEST-OK | dromaeo_css | took 1108573ms 14:52:08 INFO - TEST-START | kraken 14:52:08 INFO - operating with platform_type : linux_ 14:52:08 INFO - Initialising browser for kraken test... 14:52:08 INFO - TEST-INFO | started process 27091 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcjsUfW/profile http://localhost:55945/getInfo.html) 14:52:12 INFO - PROCESS | 27091 | 14:52:12 INFO - PROCESS | 27091 | (process:27170): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:52:12 INFO - PROCESS | 27091 | __metrics Screen width/height:1600/1200 14:52:12 INFO - PROCESS | 27091 | colorDepth:24 14:52:12 INFO - PROCESS | 27091 | Browser inner width/height: 1024/697 14:52:12 INFO - PROCESS | 27091 | __metrics 14:52:13 ERROR - PROCESS | 27091 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 14:52:14 INFO - TEST-INFO | 27091: exit 0 14:52:14 INFO - Browser initialized. 14:52:14 INFO - Running cycle 1/1 for kraken test... 14:52:14 INFO - TEST-INFO | started process 27221 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcjsUfW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:52:16 INFO - PROCESS | 27221 | 14:52:16 INFO - PROCESS | 27221 | (process:27293): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:52:26 INFO - PROCESS | 27221 | RSS: Main: 151998464 14:52:26 INFO - PROCESS | 27221 | 14:52:28 INFO - PROCESS | 27221 | Cycle 1(1): loaded http://localhost:55945/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55945/tests/kraken/driver.html?testName=audio-beat-detection) 14:52:29 INFO - PROCESS | 27221 | RSS: Main: 156835840 14:52:29 INFO - PROCESS | 27221 | 14:52:32 INFO - PROCESS | 27221 | Cycle 1(1): loaded http://localhost:55945/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55945/tests/kraken/driver.html?testName=audio-dft) 14:52:32 INFO - PROCESS | 27221 | RSS: Main: 156684288 14:52:32 INFO - PROCESS | 27221 | 14:52:35 INFO - PROCESS | 27221 | Cycle 1(1): loaded http://localhost:55945/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55945/tests/kraken/driver.html?testName=audio-fft) 14:52:36 INFO - PROCESS | 27221 | RSS: Main: 156852224 14:52:36 INFO - PROCESS | 27221 | 14:52:38 INFO - PROCESS | 27221 | Cycle 1(1): loaded http://localhost:55945/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55945/tests/kraken/driver.html?testName=audio-oscillator) 14:52:38 INFO - PROCESS | 27221 | RSS: Main: 157069312 14:52:38 INFO - PROCESS | 27221 | 14:52:41 INFO - PROCESS | 27221 | Cycle 1(1): loaded http://localhost:55945/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55945/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:52:41 INFO - PROCESS | 27221 | RSS: Main: 157102080 14:52:41 INFO - PROCESS | 27221 | 14:52:44 INFO - PROCESS | 27221 | Cycle 1(1): loaded http://localhost:55945/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55945/tests/kraken/driver.html?testName=imaging-darkroom) 14:52:45 INFO - PROCESS | 27221 | RSS: Main: 157659136 14:52:45 INFO - PROCESS | 27221 | 14:52:48 INFO - PROCESS | 27221 | Cycle 1(1): loaded http://localhost:55945/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55945/tests/kraken/driver.html?testName=imaging-desaturate) 14:52:49 INFO - PROCESS | 27221 | RSS: Main: 157663232 14:52:49 INFO - PROCESS | 27221 | 14:52:52 INFO - PROCESS | 27221 | Cycle 1(1): loaded http://localhost:55945/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55945/tests/kraken/driver.html?testName=json-parse-financial) 14:52:52 INFO - PROCESS | 27221 | RSS: Main: 157339648 14:52:52 INFO - PROCESS | 27221 | 14:52:54 INFO - PROCESS | 27221 | Cycle 1(1): loaded http://localhost:55945/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55945/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:52:54 INFO - PROCESS | 27221 | RSS: Main: 157126656 14:52:54 INFO - PROCESS | 27221 | 14:52:56 INFO - PROCESS | 27221 | Cycle 1(1): loaded http://localhost:55945/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55945/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:52:57 INFO - PROCESS | 27221 | RSS: Main: 157036544 14:52:57 INFO - PROCESS | 27221 | 14:52:59 INFO - PROCESS | 27221 | Cycle 1(1): loaded http://localhost:55945/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55945/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:52:59 INFO - PROCESS | 27221 | RSS: Main: 157601792 14:52:59 INFO - PROCESS | 27221 | 14:53:02 INFO - PROCESS | 27221 | Cycle 1(1): loaded http://localhost:55945/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55945/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:53:03 INFO - PROCESS | 27221 | RSS: Main: 157736960 14:53:03 INFO - PROCESS | 27221 | 14:53:05 INFO - PROCESS | 27221 | Cycle 1(1): loaded http://localhost:55945/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55945/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:53:06 INFO - PROCESS | 27221 | RSS: Main: 157773824 14:53:06 INFO - PROCESS | 27221 | 14:53:08 INFO - PROCESS | 27221 | Cycle 1(1): loaded http://localhost:55945/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55945/tests/kraken/driver.html?testName=ai-astar) 14:53:08 INFO - PROCESS | 27221 | RSS: Main: 159293440 14:53:08 INFO - PROCESS | 27221 | 14:53:08 INFO - PROCESS | 27221 | __start_tp_report 14:53:08 INFO - PROCESS | 27221 | _x_x_mozilla_page_load 14:53:08 INFO - PROCESS | 27221 | _x_x_mozilla_page_load_details 14:53:08 INFO - PROCESS | 27221 | |i|pagename|runs| 14:53:08 INFO - PROCESS | 27221 | |0;ai-astar;108;112;105;113;111;110;101;113;111;111 14:53:08 INFO - PROCESS | 27221 | |1;audio-beat-detection;152;127;161;173;135;159;163;136;176;129 14:53:08 INFO - PROCESS | 27221 | |2;audio-dft;163;162;161;162;161;161;162;163;161;164 14:53:08 INFO - PROCESS | 27221 | |3;audio-fft;76;76;77;169;74;78;73;76;154;77 14:53:08 INFO - PROCESS | 27221 | |4;audio-oscillator;94;92;163;93;92;92;145;93;91;159 14:53:08 INFO - PROCESS | 27221 | |5;imaging-gaussian-blur;120;118;117;120;117;117;117;118;118;117 14:53:08 INFO - PROCESS | 27221 | |6;imaging-darkroom;147;146;147;148;146;147;148;147;146;147 14:53:08 INFO - PROCESS | 27221 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;94;95 14:53:08 INFO - PROCESS | 27221 | |8;json-parse-financial;56;59;58;57;58;58;57;68;57;57 14:53:08 INFO - PROCESS | 27221 | |9;json-stringify-tinderbox;58;58;58;57;59;58;58;59;58;58 14:53:08 INFO - PROCESS | 27221 | |10;stanford-crypto-aes;76;73;74;82;82;73;83;74;76;74 14:53:08 INFO - PROCESS | 27221 | |11;stanford-crypto-ccm;116;116;113;117;113;111;120;113;133;125 14:53:08 INFO - PROCESS | 27221 | |12;stanford-crypto-pbkdf2;159;160;157;157;171;160;159;160;170;159 14:53:08 INFO - PROCESS | 27221 | |13;stanford-crypto-sha256-iterative;68;68;70;70;67;69;68;75;68;67 14:53:08 INFO - PROCESS | 27221 | __end_tp_report 14:53:08 INFO - PROCESS | 27221 | __start_cc_report 14:53:08 INFO - PROCESS | 27221 | _x_x_mozilla_cycle_collect,849 14:53:08 INFO - PROCESS | 27221 | __end_cc_report 14:53:08 INFO - PROCESS | 27221 | __startTimestamp1463176388300__endTimestamp 14:53:08 INFO - PROCESS | 27221 | 14:53:08 INFO - PROCESS | 27221 | ------- Summary: start ------- 14:53:08 INFO - PROCESS | 27221 | Number of tests: 14 14:53:08 INFO - PROCESS | 27221 | 14:53:08 INFO - PROCESS | 27221 | [#0] ai-astar Cycles:10 Average:109.50 Median:111.00 stddev:3.84 (3.5%) stddev-sans-first:4.03 14:53:08 INFO - PROCESS | 27221 | Values: 108.0 112.0 105.0 113.0 111.0 110.0 101.0 113.0 111.0 111.0 14:53:08 INFO - PROCESS | 27221 | 14:53:08 INFO - PROCESS | 27221 | [#1] audio-beat-detection Cycles:10 Average:151.10 Median:160.00 stddev:18.13 (11.3%) stddev-sans-first:19.23 14:53:08 INFO - PROCESS | 27221 | Values: 152.0 127.0 161.0 173.0 135.0 159.0 163.0 136.0 176.0 129.0 14:53:08 INFO - PROCESS | 27221 | 14:53:08 INFO - PROCESS | 27221 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.05 (0.7%) stddev-sans-first:1.05 14:53:08 INFO - PROCESS | 27221 | Values: 163.0 162.0 161.0 162.0 161.0 161.0 162.0 163.0 161.0 164.0 14:53:08 INFO - PROCESS | 27221 | 14:53:08 INFO - PROCESS | 27221 | [#3] audio-fft Cycles:10 Average:93.00 Median:76.00 stddev:36.30 (47.8%) stddev-sans-first:37.98 14:53:08 INFO - PROCESS | 27221 | Values: 76.0 76.0 77.0 169.0 74.0 78.0 73.0 76.0 154.0 77.0 14:53:08 INFO - PROCESS | 27221 | 14:53:08 INFO - PROCESS | 27221 | [#4] audio-oscillator Cycles:10 Average:111.40 Median:92.00 stddev:30.88 (33.6%) stddev-sans-first:32.11 14:53:08 INFO - PROCESS | 27221 | Values: 94.0 92.0 163.0 93.0 92.0 92.0 145.0 93.0 91.0 159.0 14:53:08 INFO - PROCESS | 27221 | 14:53:08 INFO - PROCESS | 27221 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:1.20 (1.0%) stddev-sans-first:1.00 14:53:08 INFO - PROCESS | 27221 | Values: 120.0 118.0 117.0 120.0 117.0 117.0 117.0 118.0 118.0 117.0 14:53:08 INFO - PROCESS | 27221 | 14:53:08 INFO - PROCESS | 27221 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 14:53:08 INFO - PROCESS | 27221 | Values: 147.0 146.0 147.0 148.0 146.0 147.0 148.0 147.0 146.0 147.0 14:53:08 INFO - PROCESS | 27221 | 14:53:08 INFO - PROCESS | 27221 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 14:53:08 INFO - PROCESS | 27221 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 14:53:08 INFO - PROCESS | 27221 | 14:53:08 INFO - PROCESS | 27221 | [#8] json-parse-financial Cycles:10 Average:58.50 Median:58.00 stddev:3.44 (5.9%) stddev-sans-first:3.53 14:53:08 INFO - PROCESS | 27221 | Values: 56.0 59.0 58.0 57.0 58.0 58.0 57.0 68.0 57.0 57.0 14:53:08 INFO - PROCESS | 27221 | 14:53:08 INFO - PROCESS | 27221 | [#9] json-stringify-tinderbox Cycles:10 Average:58.10 Median:58.00 stddev:0.57 (1.0%) stddev-sans-first:0.60 14:53:08 INFO - PROCESS | 27221 | Values: 58.0 58.0 58.0 57.0 59.0 58.0 58.0 59.0 58.0 58.0 14:53:08 INFO - PROCESS | 27221 | 14:53:08 INFO - PROCESS | 27221 | [#10] stanford-crypto-aes Cycles:10 Average:76.70 Median:76.00 stddev:4.03 (5.3%) stddev-sans-first:4.27 14:53:08 INFO - PROCESS | 27221 | Values: 76.0 73.0 74.0 82.0 82.0 73.0 83.0 74.0 76.0 74.0 14:53:08 INFO - PROCESS | 27221 | 14:53:08 INFO - PROCESS | 27221 | [#11] stanford-crypto-ccm Cycles:10 Average:117.70 Median:116.50 stddev:6.75 (5.8%) stddev-sans-first:7.13 14:53:08 INFO - PROCESS | 27221 | Values: 116.0 116.0 113.0 117.0 113.0 111.0 120.0 113.0 133.0 125.0 14:53:08 INFO - PROCESS | 27221 | 14:53:08 INFO - PROCESS | 27221 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.20 Median:160.00 stddev:5.03 (3.1%) stddev-sans-first:5.27 14:53:08 INFO - PROCESS | 27221 | Values: 159.0 160.0 157.0 157.0 171.0 160.0 159.0 160.0 170.0 159.0 14:53:08 INFO - PROCESS | 27221 | 14:53:08 INFO - PROCESS | 27221 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:68.50 stddev:2.36 (3.4%) stddev-sans-first:2.47 14:53:08 INFO - PROCESS | 27221 | Values: 68.0 68.0 70.0 70.0 67.0 69.0 68.0 75.0 68.0 67.0 14:53:08 INFO - PROCESS | 27221 | -------- Summary: end -------- 14:53:08 INFO - PROCESS | 27221 | 14:53:09 INFO - TEST-INFO | 27221: exit 0 14:53:09 INFO - TEST-OK | kraken | took 60548ms 14:53:09 INFO - SUITE-END | took 1169s 14:53:09 INFO - Completed test suite (00:19:29) 14:53:09 INFO - javascript benchmark 14:53:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3387.8644854205827, 3429.6741809528085, 3436.518887355772, 3460.4290292101805, 3477.1133360992944, 5546.944530554693, 5553.583481238913, 5557.3886872444045, 5561.47166019228, 5573.191887176362, 5585.245991791107, 5588.21764952907, 5591.8042868499615, 5596.720163991805, 5647.152927060943, 5072.771725272362, 5090.592752579803, 5094.592432605383, 5100.438951715309, 5143.305653736754, 5061.898762024757, 5168.793248270064, 5196.350456192976, 5222.321098257221, 5242.7640756166065, 5151.304573882516, 5239.161734122541, 5245.816396426126, 5289.206619007141, 5305.204219367087, 5134.05020071288, 5153.974230128825, 5162.561182299509, 5166.896662066738, 5189.896202075937, 5001.9499805002215, 5027.522385373383, 5085.084684756743, 5140.691558506464, 5145.974270128663, 5509.669419834822, 5547.306586676666, 5568.109102543614, 5579.079451890433, 5605.467480589378, 5953.28560572734, 6000.159977603139, 6004.489618382443, 6011.48902343297, 6015.608985415934, 5905.527557795366, 6017.428344307284, 6070.180525629028, 6080.969595151996, 6117.480014198798, 5647.040003199466, 5658.43415658435, 5670.177824215466, 5737.741801618937, 5753.568482363839, 6219.813405597839, 6220.222472190976, 6248.28144763349, 6248.656323902138, 6251.74993000284, 5953.702314884238, 5987.550933679991, 5993.160957465958, 6003.21958145447, 6008.399160084044, 6114.11489084418, 6134.846628834315, 6145.692715364214, 6159.876802463926, 6167.321594624587, 6055.969720151459, 6066.272047354346, 6071.817845464643, 6084.361142080106, 6097.878042439126, 6048.6673232971725, 6060.2424696912885, 6064.02975523914, 6101.664408457489, 6136.846578835565, 4631.698939568917, 4634.559716826963, 4644.767761611906, 4646.744429056367, 4670.299455081765, 4139.441175441277, 4142.855000074983, 4143.254214241466, 4191.97904010478, 4202.117555313357, 5725.227094342211, 5804.0, 5846.56150788684, 5872.5301975842685, 5888.587798854039, 6031.849203769853, 6073.210482637229, 6093.634381937098, 6097.054956481752, 6097.69511524422, 5809.7095145242565, 5833.679147646835, 5840.211571437886, 5845.269341332333, 5867.647941123546, 5119.257707632372, 5174.508421700008, 5234.26720259164, 5237.685738855681, 5242.9213561796605, 6286.874262514724, 6293.370662933761, 6304.747810087637, 6315.621062736159, 6317.305096439388, 6068.666223357758, 6118.388161183846, 6119.602225855305, 6122.632642041492, 6128.32588415265, 6070.848228794315, 6264.0, 6298.905516417349, 6360.141380913517, 6361.554691171574, 6023.45788879003, 6024.90962635552, 6026.0, 6038.547108966757, 6056.697165141637, 5931.258592675916, 6149.077638354103, 6154.9384506154365, 6155.446009859134, 6159.938400615936, 5988.730507127103, 5999.520038397005, 6012.849678758066, 6050.515958723379, 6060.2424696912885, 5947.078202878561, 5949.7620095197435, 5969.164316995711, 5973.611715238496, 5983.311919129356, 5725.8568535786935, 5730.054541000855, 5859.589828711949, 5863.706814659336, 5881.794137205177, 5989.490893274121, 6042.093685947143, 6069.848253793691, 6078.179445774764, 6099.573029887865, 5848.970755146197, 5854.648721076749, 5885.676287804212, 5889.911651325147, 5954.583179177416], "value": 5610.759011670311, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [613.3069631316614, 624.3070192086785, 657.447743895128, 668.6255696809787, 683.9418649414796, 39667.80166099165, 39698.0, 40283.59716402835, 40420.797896010554, 40518.39222411662, 41280.793596032054, 41889.0, 41924.161516769724, 41995.580044199545, 42006.15987680245, 8715.694950676727, 8833.823323533525, 8892.199702026815, 8898.243649289818, 8953.194212520872, 8729.694460693878, 8856.070112638177, 8886.155815197546, 9036.186743193111, 9093.045230250827, 9090.000099988996, 9125.543722813833, 9187.081291870827, 9196.310276729238, 9212.677556285531, 9076.59155338008, 9109.863352049724, 9130.77173070672, 9145.862812057825, 9148.268138548934, 8989.910100898973, 9017.774555636162, 9066.048064953151, 9068.954655226747, 9120.361574689774, 42282.0, 42743.57256427427, 42775.35836962448, 42834.78582607098, 42854.35718464226, 3939.8818035458694, 3954.703397245218, 3989.740666856674, 4158.293090174678, 4509.346144808985, 31254.687453125403, 31531.36937261242, 31929.680703193135, 33861.322773544634, 35672.0, 4369.956300436987, 4377.474703035656, 4402.779861006937, 4417.160739459492, 4420.31485119807, 216373.0, 217554.99999999843, 217949.0, 219426.0, 219679.0, 38753.22493550113, 39664.0, 56285.0, 56715.43284567184, 56879.0, 37239.627603724155, 37370.43944340837, 37523.81238093792, 37553.0, 37633.24733505314, 16774.99350038977, 16818.831811681972, 16865.0, 16936.322547098225, 16947.152642367833, 14290.499832505813, 14405.639859003399, 14477.78283325751, 14512.274386280644, 14545.636359090895, 9412.71761847132, 9591.616335346647, 9649.131578158, 9651.0, 9723.319367644197, 3620.4931309616672, 3652.6164752701116, 3761.780549475822, 3765.3222419964122, 3782.6028267032116, 1125.2839419884579, 1177.4936777185892, 1182.1429463638965, 1215.7629262293945, 1216.9473405504175, 32449.513257301158, 33151.3369732604, 33227.16932076718, 33549.66450335514, 33966.83016584901, 1234.1977714485656, 1238.6036468330049, 1266.3984607311454, 1338.9129706569236, 1363.372848489686, 17052.2326495308, 17386.391476298522, 17390.304387824344, 17487.35152599318, 17641.206145723474, 521464.0, 567561.0, 576429.0, 886653.0, 944028.0, 57669.4233057664, 58606.706966464895, 58658.0, 58870.0, 58891.0, 1527.3508758777475, 1530.8163020437619, 1539.984600153984, 1541.6300087978805, 1552.2937063636018, 31088.68911310858, 31526.842365788023, 34157.14607134742, 34556.30887382288, 35413.82293088518, 52420.47579524156, 53091.46908530865, 53569.73215133899, 53664.0, 53673.46326536841, 426391.0, 427613.0, 427732.0, 429623.0, 431696.0, 46052.7697361511, 46118.0, 46857.0, 47282.763586183224, 47459.76270118627, 49348.75325623349, 49889.50110498994, 50060.49939500559, 50639.0, 51176.74411627918, 41388.0, 41532.169356612096, 41786.58213417827, 42477.0, 43401.782991084845, 41152.38271425991, 41240.58759412367, 42166.0, 42341.78829105835, 42643.57356426396, 44176.0, 44901.10197796091, 44913.32630010487, 44992.32511512395, 45193.32210016787, 36333.0916727084, 37157.81421092986, 37585.2482950334, 37887.62112378951, 37899.62100378961, 28960.855195723885, 29474.263143421587, 29512.409751804415, 29650.55524167096, 30270.243243919078], "value": 19833.874808667104, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.83644623927313, 415.2401105976064, 426.8698047095635, 433.92840181370076, 437.29158762804263, 15602.531924042269, 18315.0, 18765.906170469163, 18980.810191898094, 19007.144678489465, 19567.217311307566, 19882.20471181151, 20035.899820500912, 20573.177072917064, 20645.070971806268, 5137.332146820908, 5584.636998595099, 5652.236948012007, 6099.085137229406, 6128.417800308964, 6037.547183961198, 6060.606060606046, 6079.331273559905, 6106.786262480814, 6133.080037994292, 6021.157038014681, 6079.088136779496, 7306.525075870051, 7740.148583655793, 7752.186020467854, 7257.637118144072, 7405.629718514053, 7428.739994100208, 7434.665440055211, 7509.324160825525, 7213.927860721431, 7255.600941948191, 7321.048263725682, 7321.194668586451, 7333.120025596909, 24670.753292467027, 25871.74128258712, 26246.08138715155, 27374.0, 27464.450710985668, 2616.6205900144564, 2733.043434797825, 2738.548139556971, 2942.529195328737, 3303.7357011439026, 15282.923585382114, 15584.688306233811, 16083.11542865142, 16307.918460407622, 16404.589885252844, 2230.531588366429, 2239.0931672672596, 2313.2944451942153, 2429.125514814665, 2470.407102295454, 92037.0, 94488.52755736247, 95563.0, 97085.0, 97344.0, 18444.170012349477, 18633.254669813057, 18663.147581628604, 18719.438416847515, 18861.0, 15802.0, 16484.587885302724, 34292.48561271583, 34492.65507344894, 34537.0, 8222.62998165084, 8453.0, 8644.438111522732, 8903.06517815633, 9104.81790364189, 8551.187637174582, 8560.101189375151, 8565.657373705106, 8622.956885215533, 8907.866382004275, 5061.139606266944, 5099.184130539096, 5145.922811157836, 5183.688978661293, 5208.73956302191, 2118.1661193240284, 2152.763196048433, 2181.4110190248543, 2202.25123458025, 2243.573720993006, 1085.2674444749762, 1087.3149915553151, 1103.508938522366, 1107.1917500224881, 1222.7371115210271, 19168.71246931297, 19332.130054147598, 19444.70832937507, 19453.80546194548, 20033.098510566768, 1040.635777477892, 1091.4542728635681, 1104.8066588347008, 1137.7155711072232, 1154.2439701995206, 10936.671899843017, 11210.27133236337, 11233.943830280796, 11255.831162532568, 11374.488148033359, 448886.0, 461063.0, 461396.0, 469705.0, 472932.0, 79833.0, 84492.57753711192, 90744.5462772682, 91438.54280728554, 91691.0830891696, 1108.5177947592822, 1110.1396417776289, 1118.9440527973732, 1141.3209140561353, 1148.7472755993667, 17170.22733976949, 17181.398651047653, 17493.650126997643, 17496.737548936522, 17597.824021759618, 38537.614623854526, 38947.41578876263, 39501.802490987364, 40341.0, 40606.39090413705, 56413.71793141008, 56484.15273770979, 57880.4211957875, 58472.70763646154, 58499.0, 9129.360944733804, 9186.127317904788, 9251.953740231256, 9254.4910029949, 9490.525473726148, 10074.798504029732, 13643.65890852697, 13744.381502832597, 13874.583762487142, 14044.297785110908, 11543.249688770204, 11803.940980295043, 12019.21875078117, 12113.636590902288, 12206.206596571194, 11581.420928953687, 11656.358900260228, 11690.0, 11736.88263117358, 11962.342071186169, 11969.581064662694, 12165.148439609497, 12273.447694853574, 12346.197497162655, 12364.62906112818, 8550.871736923827, 9010.459372437675, 9055.456672599665, 9160.404573702688, 9291.442513449214, 8439.704610338855, 8548.10244924274, 8682.479051256692, 8802.91197088021, 9193.678221262224], "value": 10172.464848734553, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1534.2635534943229, 1562.9452969146078, 1762.938297159599, 1847.0395394394907, 1877.943661690149, 7358.521696089751, 7969.123396426396, 7997.960010199941, 8131.10557838638, 8137.511749295039, 7913.4856234344725, 7937.285644292013, 7939.325157361617, 8018.639161237744, 8099.716509922154, 2378.4172877645, 2389.5937690592555, 2401.0395841663385, 2407.711074671042, 2413.9034438622434, 2308.122913292946, 2338.754430784769, 2367.8816059197056, 2383.285014495653, 2384.2251268337773, 2343.086196383412, 2378.916737914173, 2394.425337918896, 2404.4710163763943, 2404.9759502405013, 2371.4782747795457, 2377.679013333195, 2380.6786083878715, 2384.606539920911, 2399.604065329236, 2376.310869847742, 2402.7356990731005, 2404.6152615581423, 2405.2663937499055, 2405.927822165338, 8125.918740812575, 8138.674453021931, 8187.631556579968, 8244.752657420288, 8260.752177434626, 5188.11801993662, 5254.369475662907, 5281.15501519755, 5291.656042357235, 5304.389995150568, 3421.3841508528453, 3427.4344733119005, 3475.965240347615, 3506.754527183098, 3518.1556426457723, 1107.9778404431947, 1114.4984756859446, 1114.7826173896094, 1124.7244425115816, 1145.2670291013758, 11272.210945233837, 11483.196176267664, 11504.194706370557, 11532.192746507748, 11533.826992595117, 4510.864674059783, 4539.31910213464, 4597.908041839144, 4642.79107440166, 4696.342512048316, 9844.458554779556, 9852.704418867446, 9853.901460985442, 9855.90144098564, 9858.260630452745, 5201.6358854880555, 5206.271122042917, 5238.554722848525, 5261.289725887033, 5268.262443257947, 4235.97882010588, 4610.354550362952, 4792.113459010095, 4795.520447955177, 4815.686980346266, 3959.1685745993086, 3985.5217373915316, 4058.431819545266, 4062.1469491406547, 4121.237571049365, 1276.846778386581, 1277.6358737759879, 1279.6864768131868, 1284.2872205925614, 1290.677330667333, 861.2722249698994, 916.6608354908726, 994.4132961552718, 1094.7700982793704, 1100.533922397985, 5856.385079566669, 5959.28488581373, 5992.640441573432, 5995.310539288038, 6056.939430605637, 469.0806020200377, 471.91033703596895, 475.3369050174987, 1117.458032854065, 1118.4799068433217, 4242.151569686075, 4245.724027938236, 4257.169851878916, 4268.103698223408, 4281.743095414286, 9487.288453365887, 9760.902390976, 9831.950840245752, 9866.062724041205, 9876.851847222297, 9736.977617350218, 9773.12041916231, 9799.069088436587, 9846.310758246855, 9853.655122070837, 7419.443541734284, 7573.242675732383, 7777.805554861174, 8067.0, 8113.553754543556, 5819.912701309399, 5838.0, 5838.737256823538, 5907.793227237198, 5924.437178468039, 8875.556222188994, 8920.0, 9085.000649928636, 9093.77265568366, 9143.542822858963, 8455.32357411418, 8706.738797836075, 8762.649494020168, 8812.779680508038, 9056.637734490547, 6636.13730215069, 7026.297370262932, 7046.401055910305, 7145.285471453021, 7172.964135179291, 7920.762377128695, 7941.642626081724, 7947.483413578099, 7968.521888686697, 7977.162397948132, 6888.965555172192, 7213.71145154188, 7268.600226987355, 7300.707971681073, 7421.925780742339, 7070.505064645631, 7084.681189346388, 7102.218755936739, 7170.139583250043, 7186.209516953236, 6798.626075565891, 7009.439244860297, 7010.894836577558, 7014.929850701427, 7023.297670232936, 5031.471695471922, 5284.727567146164, 5301.761420735999, 5332.173513105475, 5440.700761458158, 5377.650452720717, 5437.972810135924, 5467.890642187213, 5589.0, 5666.923284575917], "value": 4504.91264212789, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.5497218532464, 358.9461580762886, 363.57824923089214, 366.9046048027512, 369.09203359735034, 6597.109390232317, 6887.655617219144, 6905.68924398402, 6921.723131074764, 6927.930720692798, 6613.0, 6721.966390168054, 6726.3609957054005, 6736.7978960631135, 6745.966270168655, 4871.756412179377, 4995.350604421438, 4996.850094497171, 4998.875028124307, 5001.374828146481, 4899.069176856386, 4983.07813054586, 4991.301217829488, 4995.125852975733, 4998.525140111684, 4910.140725373046, 4910.312556242129, 4919.065377578267, 4934.4325402578625, 4936.210206366982, 4922.876928076791, 4927.556519913207, 4944.159492886218, 4949.208126699728, 4969.378827646544, 4299.828006879721, 4303.0, 4305.483341998949, 4308.138372325548, 4312.417823593806, 6356.586821856565, 6361.713722882481, 6369.172007639024, 6377.17096777416, 6403.263624683128, 5610.69141197234, 5657.575681823839, 5727.284089488814, 5728.799492017801, 5743.4543718346695, 6874.65626718662, 6926.549774264707, 6963.09479767627, 6973.965130174317, 6985.091938048021, 4671.065786842645, 4688.390509233778, 4692.389989301369, 4699.7415142167165, 4731.621470282404, 7316.122065352191, 7340.706371745124, 7355.521891077063, 7405.814854628624, 7413.036305280333, 4772.188727916263, 4842.903141937141, 4842.951570484321, 4846.660733748674, 4860.441049279378, 4958.677685950402, 4966.850994470172, 4971.130052240844, 4977.477364876709, 4982.451930287665, 5733.512651424592, 5756.251687280626, 5768.480836724715, 5775.249217601685, 5785.27684039495, 7085.89371159433, 7088.681009354591, 7095.396891264197, 7106.076210092655, 7110.92889071113, 1721.277063633277, 1729.7145970914657, 1732.5668582854287, 1734.4016314371522, 1735.1757914990278, 1106.7399161197113, 1137.3346592243465, 1147.5811328864904, 1147.770445910821, 1150.7813515432042, 6753.35843094915, 6811.897821532681, 6823.931760682429, 6836.93163068363, 6842.110525631636, 7270.236625154388, 7275.963620181865, 7290.963545182346, 7303.817404564822, 7320.341169294683, 6597.9670101650145, 6714.496412769062, 6718.93281067183, 6719.496037797185, 6853.280405557444, 3964.266610677034, 3981.343078392091, 3997.360422332471, 4002.419649150857, 4008.8797336079965, 7687.884681729778, 7694.0, 7694.422918281151, 7700.961495192488, 7703.34521565662, 7487.438442116863, 7538.246175382527, 7546.886796698054, 7556.508826926232, 7556.697732090654, 7430.96284518574, 7603.923960760432, 7613.885791713129, 7630.580318082559, 7680.231976802275, 7306.890396644161, 7326.6702998364135, 7384.224656411215, 7391.482596218429, 7395.778126656209, 7240.855182896207, 7262.128544574685, 7295.161056478573, 7296.7446139384865, 7298.4526160539235, 7622.045055152414, 7646.158922518407, 7705.383569314329, 7711.421643376657, 7750.844983100419, 4714.127886341038, 4764.166270902648, 4776.259679749644, 4796.736179510161, 4805.0, 7356.264373562601, 7368.4842061055215, 7373.33639972405, 7381.704731810667, 7398.075240594926, 7136.357727804522, 7148.213696493278, 7201.855962880818, 7211.134663840373, 7224.096987876515, 6991.440684745106, 7118.857622847618, 7140.6786694599905, 7149.499535032498, 7155.606441645759, 7024.473164512784, 7034.577925324497, 7037.472189585699, 7039.894401583878, 7044.964775176091, 7127.572345659277, 7180.5691658500655, 7181.928180718126, 7214.74748383804, 7218.819529511804, 7003.7548685795755, 7011.894821577578, 7019.2629773873, 7023.964880175567, 7037.472189585699], "value": 5292.47798023641, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [881.6958149438442, 892.9553522323882, 899.7840518275616, 904.9728508144756, 907.1336873286011, 14548.0, 14784.112953222813, 14813.25933703316, 14829.258537073158, 14944.701105977874, 14103.0, 14265.0, 14350.569482915504, 14358.784618230735, 14406.927965360159, 871.2811930157613, 875.7241468937265, 888.524639317965, 899.2266650680409, 901.923336516397, 899.3389858454063, 906.4425378392307, 906.9773255668628, 907.6414816147618, 907.773056735816, 931.7717159295981, 932.4545141092435, 932.6782260120248, 933.0343094896783, 936.1013427109982, 921.7050543825978, 923.9122283383068, 925.1118925831211, 928.0533855467453, 930.1907340613676, 673.8989151627246, 680.3876511139964, 681.3152781454606, 681.9488538359643, 682.2324884504932, 14306.427742890271, 14380.352884120135, 14404.135751854817, 14424.567262982127, 14431.49489767853, 14633.487827926077, 14775.187364694937, 14799.926000370036, 14814.185219812905, 14816.259187040605, 12052.758944821055, 12135.211211271328, 12144.817827732591, 12204.877951220464, 12217.144799864012, 3996.860109896169, 4022.597740225983, 4061.5532291447917, 4063.817128229237, 4071.2671719090554, 55907.161392579146, 56138.71930640362, 56519.71740141273, 56565.43434565643, 57027.42972570263, 11256.573236077567, 11352.318860868374, 11620.128490363257, 11789.351585662871, 11874.0, 19883.701744473845, 20008.89995550042, 20029.399118026482, 20045.398638040882, 20058.39824805258, 9132.680356187502, 9171.90828091724, 9256.0, 9333.346665733468, 9536.141747242642, 5031.371078615173, 5066.290719299301, 5082.186850103965, 5122.795088196505, 5257.395399529027, 3646.2342907989087, 3670.082479380155, 3691.5570131583845, 3692.040069581928, 3704.7777133371546, 679.9592024478548, 684.8801459744525, 690.1752405874931, 696.6377483708544, 699.1679900917892, 760.9657565409569, 802.4864086984335, 824.8061705499202, 829.1004260377558, 853.7097386888488, 9295.814083718287, 9930.556941312685, 9969.451680157516, 10059.497025148714, 10220.846687299696, 673.2089794491453, 701.8841891087914, 763.7861398808343, 799.4403917257943, 823.8558252305822, 4308.547602501692, 4404.933925991113, 4598.517155698671, 4715.174844402216, 4782.879804454587, 66669.99995000078, 66865.66567167231, 67219.0, 67802.0, 67925.66037169882, 58386.708066459396, 59766.70116649476, 60003.69998149981, 60569.39430605726, 61121.0, 52658.473415266126, 52984.470155298724, 54121.0, 54205.1869221962, 54336.72831635817, 9078.682246121354, 9169.54152292396, 9211.815763684823, 9365.157135857806, 9456.952715236379, 39800.60199397969, 39920.40119398153, 39963.60036399715, 40311.79844100761, 41407.792961035004, 50149.498505015945, 51918.221226682384, 52593.21110183274, 53015.4698453026, 53747.19379209237, 11332.490037948148, 11405.486753096297, 11774.0, 11950.0, 12018.218815776947, 12217.144799863925, 12331.075169362513, 12409.751804964031, 12511.311877846805, 12547.43536540876, 12115.515379384726, 12315.19951203169, 12399.75200496003, 12432.316222607844, 13110.475580977036, 13660.316984150553, 13674.111182773087, 13841.454603437225, 13995.790063149265, 14072.718545628826, 13630.0, 13847.930760346133, 14061.507847225297, 14117.43530258778, 14153.292335383396, 11838.28970261787, 11956.940215298868, 12059.138846643178, 12206.32865192423, 12315.384230788604, 11659.53361865516, 11735.178537502294, 11805.173637845268, 12035.75928481443, 12146.878531214576], "value": 7235.016534595824, "unit": "score"}], "name": "dromaeo_css", "value": 7616.926866549336, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 112.0, 105.0, 113.0, 111.0, 110.0, 101.0, 113.0, 111.0, 111.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 127.0, 161.0, 173.0, 135.0, 159.0, 163.0, 136.0, 176.0, 129.0], "value": 151.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 161.0, 162.0, 161.0, 161.0, 162.0, 163.0, 161.0, 164.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 169.0, 74.0, 78.0, 73.0, 76.0, 154.0, 77.0], "value": 93.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 92.0, 163.0, 93.0, 92.0, 92.0, 145.0, 93.0, 91.0, 159.0], "value": 111.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 118.0, 117.0, 120.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 148.0, 146.0, 147.0, 148.0, 147.0, 146.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 59.0, 58.0, 57.0, 58.0, 58.0, 57.0, 68.0, 57.0, 57.0], "value": 58.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 57.0, 59.0, 58.0, 58.0, 59.0, 58.0, 58.0], "value": 58.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 74.0, 82.0, 82.0, 73.0, 83.0, 74.0, 76.0, 74.0], "value": 76.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 113.0, 117.0, 113.0, 111.0, 120.0, 113.0, 133.0, 125.0], "value": 117.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 157.0, 157.0, 171.0, 160.0, 159.0, 160.0, 170.0, 159.0], "value": 161.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 70.0, 70.0, 67.0, 69.0, 68.0, 75.0, 68.0, 67.0], "value": 69.0, "unit": "score"}], "name": "kraken", "value": 1527.8999999999999, "alertThreshold": 2.0}]} 14:53:09 INFO - Return code: 0 14:53:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:53:09 ERROR - # TBPL SUCCESS # 14:53:09 INFO - Running post-action listener: _resource_record_post_action 14:53:09 INFO - Running post-run listener: _resource_record_post_run 14:53:10 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 266240; Write bytes: 500727808; Read time: 28; Write time: 382108 14:53:10 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 248614912; Read time: 0; Write time: 223576 14:53:10 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 266240; Write bytes: 252112896; Read time: 28; Write time: 158532 14:53:10 INFO - Running post-run listener: _upload_blobber_files 14:53:10 INFO - Blob upload gear active. 14:53:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:53:10 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:53:10 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'] 14:53:10 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 14:53:11 INFO - (blobuploader) - INFO - Open directory for files ... 14:53:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:53:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:53:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:53:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:53:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:53:11 INFO - (blobuploader) - INFO - Done attempting. 14:53:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:53:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:53:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:53:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:53:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:53:12 INFO - (blobuploader) - INFO - Done attempting. 14:53:12 INFO - (blobuploader) - INFO - Iteration through files over. 14:53:12 INFO - Return code: 0 14:53:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:53:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:53:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/22ebca800dfcf80a8e167deb91599a98c8f77b0d756c8050ad6c46ef7b9b8fd8ff4165b106dab56a9c0844400dab6aa7cd920f18ea9c55e2e2bb250702445d62", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1036bf08acb08e692c27d4bdd2139e2c93492cc3afc193c0d6cab219f1bba6f844eb2dc14c017886c416b9b474a5a58fcc262deed90a84079f0b8aaf8e7c0dad"} 14:53:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:53:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:53:12 INFO - Contents: 14:53:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/22ebca800dfcf80a8e167deb91599a98c8f77b0d756c8050ad6c46ef7b9b8fd8ff4165b106dab56a9c0844400dab6aa7cd920f18ea9c55e2e2bb250702445d62", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1036bf08acb08e692c27d4bdd2139e2c93492cc3afc193c0d6cab219f1bba6f844eb2dc14c017886c416b9b474a5a58fcc262deed90a84079f0b8aaf8e7c0dad"} 14:53:12 INFO - Running post-run listener: copy_logs_to_upload_dir 14:53:12 INFO - Copying logs to upload dir... 14:53:12 INFO - mkdir: /builds/slave/test/build/upload/logs 14:53:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1227.423235 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-05-13 14:53:12.595859) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-13 14:53:12.598858) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1463175154.968173-340417346 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/22ebca800dfcf80a8e167deb91599a98c8f77b0d756c8050ad6c46ef7b9b8fd8ff4165b106dab56a9c0844400dab6aa7cd920f18ea9c55e2e2bb250702445d62", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1036bf08acb08e692c27d4bdd2139e2c93492cc3afc193c0d6cab219f1bba6f844eb2dc14c017886c416b9b474a5a58fcc262deed90a84079f0b8aaf8e7c0dad"} build_url:https://queue.taskcluster.net/v1/task/JwMZ7IgpTKysdzjwdycVlA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011281 build_url: 'https://queue.taskcluster.net/v1/task/JwMZ7IgpTKysdzjwdycVlA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/22ebca800dfcf80a8e167deb91599a98c8f77b0d756c8050ad6c46ef7b9b8fd8ff4165b106dab56a9c0844400dab6aa7cd920f18ea9c55e2e2bb250702445d62", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1036bf08acb08e692c27d4bdd2139e2c93492cc3afc193c0d6cab219f1bba6f844eb2dc14c017886c416b9b474a5a58fcc262deed90a84079f0b8aaf8e7c0dad"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-13 14:53:12.622792) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 14:53:12.623074) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1463175154.968173-340417346 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004433 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 14:53:12.706395) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 14:53:12.706718) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 14:53:12.707002) ========= ========= Total master_lag: 0.17 =========