builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-011 starttime: 1463174948.56 results: success (0) buildid: 20160513114547 builduid: 844298ff049b42b29dca75dc9f9d8466 revision: 805051b9a46259319d5c56424cb5249efc811363 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 14:29:08.561797) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 14:29:08.562608) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 14:29:08.563161) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 14:29:08.582043) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 14:29:08.582592) ========= 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=5cf47e208febbcd81da23b2e0000026f-1463174943.258325-510991029 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-13 14:29:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 101M=0s 2016-05-13 14:29:08 (101 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115474 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 14:29:08.714917) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 14:29:08.715518) ========= 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=5cf47e208febbcd81da23b2e0000026f-1463174943.258325-510991029 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019293 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 14:29:08.768740) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 14:29:08.769372) ========= 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=5cf47e208febbcd81da23b2e0000026f-1463174943.258325-510991029 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-13 14:29:08,898 truncating revision to first 12 chars 2016-05-13 14:29:08,898 Setting DEBUG logging. 2016-05-13 14:29:08,898 attempt 1/10 2016-05-13 14:29:08,898 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:29:09,158 unpacking tar archive at: mozilla-aurora-805051b9a462/testing/mozharness/ program finished with exit code 0 elapsedTime=0.532782 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 14:29:09.318467) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 14:29:09.319098) ========= script_repo_revision: 805051b9a46259319d5c56424cb5249efc811363 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 14:29:09.319866) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 14:29:09.320360) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 14:29:09.332538) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-05-13 14:29:09.333139) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1463174943.258325-510991029 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:29:09 INFO - MultiFileLogger online at 20160513 14:29:09 in /builds/slave/test 14:29:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 14:29:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:29:09 INFO - {'append_to_log': False, 14:29:09 INFO - 'base_work_dir': '/builds/slave/test', 14:29:09 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:29:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:29:09 INFO - 'branch': 'Mozilla-Aurora', 14:29:09 INFO - 'buildbot_json_path': 'buildprops.json', 14:29:09 INFO - 'config_files': ('talos/linux_config.py',), 14:29:09 INFO - 'default_actions': ('clobber', 14:29:09 INFO - 'read-buildbot-config', 14:29:09 INFO - 'download-and-extract', 14:29:09 INFO - 'populate-webroot', 14:29:09 INFO - 'create-virtualenv', 14:29:09 INFO - 'install', 14:29:09 INFO - 'run-tests'), 14:29:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:29:09 INFO - 'download_minidump_stackwalk': True, 14:29:09 INFO - 'download_symbols': 'ondemand', 14:29:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:29:09 INFO - 'tooltool.py': '/tools/tooltool.py', 14:29:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:29:09 INFO - '/tools/misc-python/virtualenv.py')}, 14:29:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:29:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:29:09 INFO - 'installer_path': 'installer.exe', 14:29:09 INFO - 'log_level': 'info', 14:29:09 INFO - 'log_name': 'talos', 14:29:09 INFO - 'log_to_console': True, 14:29:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:29:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:29:09 INFO - 'opt_config_files': (), 14:29:09 INFO - 'pip_index': False, 14:29:09 INFO - 'sps_profile': False, 14:29:09 INFO - 'sps_profile_interval': 0, 14:29:09 INFO - 'suite': 'dromaeojs', 14:29:09 INFO - 'system_bits': '32', 14:29:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:29:09 INFO - 'title': 'talos-linux64-ix-011', 14:29:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:29:09 INFO - 'use_talos_json': True, 14:29:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:29:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:29:09 INFO - 'work_dir': 'build'} 14:29:09 INFO - ##### 14:29:09 INFO - ##### Running clobber step. 14:29:09 INFO - ##### 14:29:09 INFO - Running pre-action listener: _resource_record_pre_action 14:29:09 INFO - Running main action method: clobber 14:29:09 INFO - rmtree: /builds/slave/test/build 14:29:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:29:10 INFO - Running post-action listener: _resource_record_post_action 14:29:10 INFO - ##### 14:29:10 INFO - ##### Running read-buildbot-config step. 14:29:10 INFO - ##### 14:29:10 INFO - Running pre-action listener: _resource_record_pre_action 14:29:10 INFO - Running main action method: read_buildbot_config 14:29:10 INFO - Using buildbot properties: 14:29:10 INFO - { 14:29:10 INFO - "project": "", 14:29:10 INFO - "product": "firefox", 14:29:10 INFO - "script_repo_revision": "production", 14:29:10 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 14:29:10 INFO - "repository": "", 14:29:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 14:29:10 INFO - "buildid": "20160513114547", 14:29:10 INFO - "pgo_build": "True", 14:29:10 INFO - "basedir": "/builds/slave/test", 14:29:10 INFO - "buildnumber": 500, 14:29:10 INFO - "slavename": "talos-linux64-ix-011", 14:29:10 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:29:10 INFO - "platform": "ubuntu64_hw", 14:29:10 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 14:29:10 INFO - "branch": "mozilla-aurora", 14:29:10 INFO - "repo_path": "releases/mozilla-aurora", 14:29:10 INFO - "revision": "805051b9a46259319d5c56424cb5249efc811363", 14:29:10 INFO - "stage_platform": "linux64-pgo", 14:29:10 INFO - "builduid": "844298ff049b42b29dca75dc9f9d8466", 14:29:10 INFO - "slavebuilddir": "test" 14:29:10 INFO - } 14:29:10 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:29:10 INFO - Running post-action listener: _resource_record_post_action 14:29:10 INFO - ##### 14:29:10 INFO - ##### Running download-and-extract step. 14:29:10 INFO - ##### 14:29:10 INFO - Running pre-action listener: _resource_record_pre_action 14:29:10 INFO - Running main action method: download_and_extract 14:29:10 INFO - mkdir: /builds/slave/test/build/tests 14:29: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:29:10 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:29:10 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:29:10 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:29:10 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:29:10 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:29:11 INFO - Downloaded 1361 bytes. 14:29:11 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 14:29:11 INFO - Using the following test package requirements: 14:29:11 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 14:29:11 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:29:11 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 14:29:11 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:29:11 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 14:29:11 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:29:11 INFO - u'jsshell-linux-x86_64.zip'], 14:29:11 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:29:11 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 14:29:11 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 14:29:11 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:29:11 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 14:29:11 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:29:11 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 14:29:11 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:29:11 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 14:29:11 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:29:11 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 14:29:11 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:29:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:29:11 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:29:11 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:29:11 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:29:11 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:29:11 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:29:12 INFO - Downloaded 23800103 bytes. 14:29:12 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:29:12 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:29:14 INFO - Return code: 0 14:29:14 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:29:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:29:14 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:29:14 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:29:14 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:29:14 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:29:14 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:29:15 INFO - Downloaded 23800103 bytes. 14:29:15 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:29:15 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:29:16 INFO - Return code: 0 14:29:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:29:16 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:29:16 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:29:16 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:29:16 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:29:16 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:29:18 INFO - Downloaded 10840145 bytes. 14:29:18 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:29:18 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:29:18 INFO - Return code: 0 14:29:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:29:18 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:29:18 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:29:18 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:29:18 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:29:18 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:29:19 INFO - Downloaded 62696567 bytes. 14:29:19 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:29:19 INFO - mkdir: /builds/slave/test/properties 14:29:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:29:19 INFO - Writing to file /builds/slave/test/properties/build_url 14:29:19 INFO - Contents: 14:29:19 INFO - build_url:https://queue.taskcluster.net/v1/task/JwMZ7IgpTKysdzjwdycVlA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 14:29:20 INFO - Running post-action listener: _resource_record_post_action 14:29:20 INFO - Running post-action listener: set_extra_try_arguments 14:29:20 INFO - ##### 14:29:20 INFO - ##### Running populate-webroot step. 14:29:20 INFO - ##### 14:29:20 INFO - Running pre-action listener: _resource_record_pre_action 14:29:20 INFO - Running main action method: populate_webroot 14:29:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:29:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:29:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:29:20 INFO - '--tppagecycles', 14:29:20 INFO - '7'], 14:29:20 INFO - 'tests': ['tsvgm']}}, 14:29:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:29:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:29:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:29:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:29:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:29:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:29:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:29:20 INFO - 'talos_options': ['--disable-e10s'], 14:29:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:29:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:29:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:29:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:29:20 INFO - 'talos_options': ['--disable-e10s'], 14:29:20 INFO - 'tests': ['damp', 'tps']}, 14:29:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:29:20 INFO - 'tests': ['damp', 'tps']}, 14:29:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:29:20 INFO - 'tests': ['dromaeo_dom']}, 14:29:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:29:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:29:20 INFO - 'tests': ['a11yr', 14:29:20 INFO - 'ts_paint', 14:29:20 INFO - 'tpaint', 14:29:20 INFO - 'sessionrestore', 14:29:20 INFO - 'sessionrestore_no_auto_restore', 14:29:20 INFO - 'tabpaint']}, 14:29:20 INFO - 'other-e10s': {'tests': ['a11yr', 14:29:20 INFO - 'ts_paint', 14:29:20 INFO - 'tpaint', 14:29:20 INFO - 'sessionrestore', 14:29:20 INFO - 'sessionrestore_no_auto_restore', 14:29:20 INFO - 'tabpaint']}, 14:29:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:29:20 INFO - 'ts_paint', 14:29:20 INFO - 'tpaint', 14:29:20 INFO - 'sessionrestore', 14:29:20 INFO - 'sessionrestore_no_auto_restore', 14:29:20 INFO - 'tabpaint']}, 14:29:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:29:20 INFO - 'ts_paint', 14:29:20 INFO - 'tpaint', 14:29:20 INFO - 'sessionrestore', 14:29:20 INFO - 'sessionrestore_no_auto_restore', 14:29:20 INFO - 'tabpaint']}, 14:29:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:29:20 INFO - 'tests': ['a11yr', 14:29:20 INFO - 'ts_paint', 14:29:20 INFO - 'tpaint', 14:29:20 INFO - 'sessionrestore', 14:29:20 INFO - 'sessionrestore_no_auto_restore', 14:29:20 INFO - 'tabpaint']}, 14:29:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:29:20 INFO - 'tests': ['a11yr', 14:29:20 INFO - 'ts_paint', 14:29:20 INFO - 'tpaint', 14:29:20 INFO - 'sessionrestore', 14:29:20 INFO - 'sessionrestore_no_auto_restore', 14:29:20 INFO - 'tabpaint']}, 14:29:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:29:20 INFO - 'tests': ['tsvgx', 14:29:20 INFO - 'tsvgr_opacity', 14:29:20 INFO - 'tart', 14:29:20 INFO - 'tscrollx', 14:29:20 INFO - 'cart']}, 14:29:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:29:20 INFO - 'tsvgr_opacity', 14:29:20 INFO - 'tart', 14:29:20 INFO - 'tscrollx', 14:29:20 INFO - 'cart']}, 14:29:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:29:20 INFO - 'talos_options': ['--disable-e10s'], 14:29:20 INFO - 'tests': ['tp5o']}, 14:29:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:29:20 INFO - 'tests': ['tp5o']}, 14:29:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:29:20 INFO - 'talos_options': ['--disable-e10s', 14:29:20 INFO - '--xperf_path', 14:29:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:29:20 INFO - 'tests': ['tp5n']}, 14:29:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:29:20 INFO - 'talos_options': ['--xperf_path', 14:29:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:29:20 INFO - 'tests': ['tp5n']}}, 14:29:20 INFO - 'talos.zip': {'path': '', 14:29:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:29:20 INFO - Running post-action listener: _resource_record_post_action 14:29:20 INFO - ##### 14:29:20 INFO - ##### Running create-virtualenv step. 14:29:20 INFO - ##### 14:29:20 INFO - Running pre-action listener: _resource_record_pre_action 14:29:20 INFO - Running main action method: create_virtualenv 14:29:20 INFO - Creating virtualenv /builds/slave/test/build/venv 14:29:20 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:29:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:29:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:29:20 INFO - Using real prefix '/usr' 14:29:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:29:21 INFO - Installing distribute.............................................................................................................................................................................................done. 14:29:23 INFO - Installing pip.................done. 14:29:23 INFO - Return code: 0 14:29:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:29:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:29:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:29:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:29:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:29:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:23 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 0x7f0449a53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abe410>, '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 0x1abf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abf7a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1463174943.258325-510991029', '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:29:23 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:29:23 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:29:23 INFO - Using env: {'DISPLAY': ':0', 14:29:23 INFO - 'HOME': '/home/cltbld', 14:29:23 INFO - 'LANG': 'en_US.UTF-8', 14:29:23 INFO - 'LANGUAGE': 'en_US:en', 14:29:23 INFO - 'LOGNAME': 'cltbld', 14:29:23 INFO - 'MAIL': '/var/mail/cltbld', 14:29:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:29:23 INFO - 'MOZ_NO_REMOTE': '1', 14:29:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:29:23 INFO - 'NO_EM_RESTART': '1', 14:29:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:29:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:29:23 INFO - 'PWD': '/builds/slave/test', 14:29:23 INFO - 'SHELL': '/bin/bash', 14:29:23 INFO - 'SHLVL': '1', 14:29:23 INFO - 'TERM': 'linux', 14:29:23 INFO - 'TMOUT': '86400', 14:29:23 INFO - 'USER': 'cltbld', 14:29:23 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1463174943.258325-510991029', 14:29:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:29:23 INFO - '_': '/tools/buildbot/bin/python'} 14:29:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:29:23 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:29:23 INFO - Cleaning up... 14:29:23 INFO - Return code: 0 14:29:23 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:29:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:29:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:29:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:29:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:29:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:23 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 0x7f0449a53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abe410>, '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 0x1abf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abf7a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1463174943.258325-510991029', '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:29:23 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:29:23 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:29:23 INFO - Using env: {'DISPLAY': ':0', 14:29:23 INFO - 'HOME': '/home/cltbld', 14:29:23 INFO - 'LANG': 'en_US.UTF-8', 14:29:23 INFO - 'LANGUAGE': 'en_US:en', 14:29:23 INFO - 'LOGNAME': 'cltbld', 14:29:23 INFO - 'MAIL': '/var/mail/cltbld', 14:29:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:29:23 INFO - 'MOZ_NO_REMOTE': '1', 14:29:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:29:23 INFO - 'NO_EM_RESTART': '1', 14:29:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:29:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:29:23 INFO - 'PWD': '/builds/slave/test', 14:29:23 INFO - 'SHELL': '/bin/bash', 14:29:23 INFO - 'SHLVL': '1', 14:29:23 INFO - 'TERM': 'linux', 14:29:23 INFO - 'TMOUT': '86400', 14:29:23 INFO - 'USER': 'cltbld', 14:29:23 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1463174943.258325-510991029', 14:29:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:29:23 INFO - '_': '/tools/buildbot/bin/python'} 14:29:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:29:23 INFO - Downloading/unpacking psutil>=0.7.1 14:29:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:29:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:29:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:29:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:29:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:29:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:29:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:29:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:29:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:29:25 INFO - Installing collected packages: psutil 14:29:25 INFO - Running setup.py install for psutil 14:29:25 INFO - building 'psutil._psutil_linux' extension 14:29:25 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:29:25 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:29:25 INFO - building 'psutil._psutil_posix' extension 14:29:25 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:29:26 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:29:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:29:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:29:26 INFO - Successfully installed psutil 14:29:26 INFO - Cleaning up... 14:29:26 INFO - Return code: 0 14:29:26 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:29:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:29:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:29:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:29:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:29:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0449a53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abe410>, '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 0x1abf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abf7a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1463174943.258325-510991029', '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:29:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:29:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:29:26 INFO - Using env: {'DISPLAY': ':0', 14:29:26 INFO - 'HOME': '/home/cltbld', 14:29:26 INFO - 'LANG': 'en_US.UTF-8', 14:29:26 INFO - 'LANGUAGE': 'en_US:en', 14:29:26 INFO - 'LOGNAME': 'cltbld', 14:29:26 INFO - 'MAIL': '/var/mail/cltbld', 14:29:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:29:26 INFO - 'MOZ_NO_REMOTE': '1', 14:29:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:29:26 INFO - 'NO_EM_RESTART': '1', 14:29:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:29:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:29:26 INFO - 'PWD': '/builds/slave/test', 14:29:26 INFO - 'SHELL': '/bin/bash', 14:29:26 INFO - 'SHLVL': '1', 14:29:26 INFO - 'TERM': 'linux', 14:29:26 INFO - 'TMOUT': '86400', 14:29:26 INFO - 'USER': 'cltbld', 14:29:26 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1463174943.258325-510991029', 14:29:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:29:26 INFO - '_': '/tools/buildbot/bin/python'} 14:29:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:29:26 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:29:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:29:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:29:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:29:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:29:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:29:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:29:28 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:29:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:29:28 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:29:28 INFO - Installing collected packages: mozsystemmonitor 14:29:28 INFO - Running setup.py install for mozsystemmonitor 14:29:28 INFO - Successfully installed mozsystemmonitor 14:29:28 INFO - Cleaning up... 14:29:28 INFO - Return code: 0 14:29:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:29:28 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:29:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:29:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:28 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:29:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:29:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:28 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 0x7f0449a53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abe410>, '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 0x1abf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abf7a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1463174943.258325-510991029', '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:29:28 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:29:28 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:29:28 INFO - Using env: {'DISPLAY': ':0', 14:29:28 INFO - 'HOME': '/home/cltbld', 14:29:28 INFO - 'LANG': 'en_US.UTF-8', 14:29:28 INFO - 'LANGUAGE': 'en_US:en', 14:29:28 INFO - 'LOGNAME': 'cltbld', 14:29:28 INFO - 'MAIL': '/var/mail/cltbld', 14:29:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:29:28 INFO - 'MOZ_NO_REMOTE': '1', 14:29:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:29:28 INFO - 'NO_EM_RESTART': '1', 14:29:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:29:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:29:28 INFO - 'PWD': '/builds/slave/test', 14:29:28 INFO - 'SHELL': '/bin/bash', 14:29:28 INFO - 'SHLVL': '1', 14:29:28 INFO - 'TERM': 'linux', 14:29:28 INFO - 'TMOUT': '86400', 14:29:28 INFO - 'USER': 'cltbld', 14:29:28 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1463174943.258325-510991029', 14:29:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:29:28 INFO - '_': '/tools/buildbot/bin/python'} 14:29:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:29:28 INFO - Downloading/unpacking blobuploader==1.2.4 14:29:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:29:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:29:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:29:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:29:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:29:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:29:30 INFO - Downloading blobuploader-1.2.4.tar.gz 14:29:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:29:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:29:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:29:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:29:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:29:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:29:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:29:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:29:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:29:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:29:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:29:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:29:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:29:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:29:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:29:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:29:31 INFO - Downloading docopt-0.6.1.tar.gz 14:29:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:29:31 INFO - Installing collected packages: blobuploader, requests, docopt 14:29:31 INFO - Running setup.py install for blobuploader 14:29:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:29:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:29:31 INFO - Running setup.py install for requests 14:29:31 INFO - Running setup.py install for docopt 14:29:31 INFO - Successfully installed blobuploader requests docopt 14:29:31 INFO - Cleaning up... 14:29:32 INFO - Return code: 0 14:29:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:29:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:29:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:29:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:29:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:29:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:32 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 0x7f0449a53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abe410>, '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 0x1abf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abf7a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1463174943.258325-510991029', '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:29:32 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:29:32 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:29:32 INFO - Using env: {'DISPLAY': ':0', 14:29:32 INFO - 'HOME': '/home/cltbld', 14:29:32 INFO - 'LANG': 'en_US.UTF-8', 14:29:32 INFO - 'LANGUAGE': 'en_US:en', 14:29:32 INFO - 'LOGNAME': 'cltbld', 14:29:32 INFO - 'MAIL': '/var/mail/cltbld', 14:29:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:29:32 INFO - 'MOZ_NO_REMOTE': '1', 14:29:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:29:32 INFO - 'NO_EM_RESTART': '1', 14:29:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:29:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:29:32 INFO - 'PWD': '/builds/slave/test', 14:29:32 INFO - 'SHELL': '/bin/bash', 14:29:32 INFO - 'SHLVL': '1', 14:29:32 INFO - 'TERM': 'linux', 14:29:32 INFO - 'TMOUT': '86400', 14:29:32 INFO - 'USER': 'cltbld', 14:29:32 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1463174943.258325-510991029', 14:29:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:29:32 INFO - '_': '/tools/buildbot/bin/python'} 14:29:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:29:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:29:32 INFO - Running setup.py (path:/tmp/pip-WrVX3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:29:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:29:32 INFO - Running setup.py (path:/tmp/pip-r5FrGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:29:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:29:32 INFO - Running setup.py (path:/tmp/pip-vYf3rk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:29:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:29:32 INFO - Running setup.py (path:/tmp/pip-FIpHcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:29:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:29:32 INFO - Running setup.py (path:/tmp/pip-l65yTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:29:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:29:32 INFO - Running setup.py (path:/tmp/pip-F1hD6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:29:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:29:32 INFO - Running setup.py (path:/tmp/pip-2B4PJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:29:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:29:32 INFO - Running setup.py (path:/tmp/pip-O233Hv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:29:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:29:32 INFO - Running setup.py (path:/tmp/pip-Wj3SFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:29:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:29:32 INFO - Running setup.py (path:/tmp/pip-9IBJ2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:29:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:29:32 INFO - Running setup.py (path:/tmp/pip-DIC2Pn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:29:33 INFO - Running setup.py (path:/tmp/pip-N63dC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:29:33 INFO - Running setup.py (path:/tmp/pip-AAjVwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:29:33 INFO - Running setup.py (path:/tmp/pip-c2IOU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:29:33 INFO - Running setup.py (path:/tmp/pip-J0dP6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:29:33 INFO - Running setup.py (path:/tmp/pip-WpeRD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:29:33 INFO - Running setup.py (path:/tmp/pip-CWWTWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:29:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:29:33 INFO - Running setup.py install for manifestparser 14:29:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:29:33 INFO - Running setup.py install for mozcrash 14:29:33 INFO - Running setup.py install for mozdebug 14:29:33 INFO - Running setup.py install for mozdevice 14:29:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:29:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:29:33 INFO - Running setup.py install for mozfile 14:29:33 INFO - Running setup.py install for mozhttpd 14:29:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:29:34 INFO - Running setup.py install for mozinfo 14:29:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:29:34 INFO - Running setup.py install for mozInstall 14:29:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:29:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:29:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:29:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:29:34 INFO - Running setup.py install for mozleak 14:29:34 INFO - Running setup.py install for mozlog 14:29:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:29:34 INFO - Running setup.py install for moznetwork 14:29:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:29:34 INFO - Running setup.py install for mozprocess 14:29:34 INFO - Running setup.py install for mozprofile 14:29:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:29:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:29:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:29:34 INFO - Running setup.py install for mozrunner 14:29:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:29:34 INFO - Running setup.py install for mozscreenshot 14:29:35 INFO - Running setup.py install for moztest 14:29:35 INFO - Running setup.py install for mozversion 14:29:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:29:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:29:35 INFO - Cleaning up... 14:29:35 INFO - Return code: 0 14:29:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:29:35 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:29:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:29:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:35 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:29:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:29:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:35 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 0x7f0449a53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abe410>, '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 0x1abf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abf7a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1463174943.258325-510991029', '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:29:35 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:29:35 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:29:35 INFO - Using env: {'DISPLAY': ':0', 14:29:35 INFO - 'HOME': '/home/cltbld', 14:29:35 INFO - 'LANG': 'en_US.UTF-8', 14:29:35 INFO - 'LANGUAGE': 'en_US:en', 14:29:35 INFO - 'LOGNAME': 'cltbld', 14:29:35 INFO - 'MAIL': '/var/mail/cltbld', 14:29:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:29:35 INFO - 'MOZ_NO_REMOTE': '1', 14:29:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:29:35 INFO - 'NO_EM_RESTART': '1', 14:29:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:29:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:29:35 INFO - 'PWD': '/builds/slave/test', 14:29:35 INFO - 'SHELL': '/bin/bash', 14:29:35 INFO - 'SHLVL': '1', 14:29:35 INFO - 'TERM': 'linux', 14:29:35 INFO - 'TMOUT': '86400', 14:29:35 INFO - 'USER': 'cltbld', 14:29:35 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1463174943.258325-510991029', 14:29:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:29:35 INFO - '_': '/tools/buildbot/bin/python'} 14:29:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:29:35 INFO - Running setup.py (path:/tmp/pip-aUJ9IW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:29:35 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:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:29:35 INFO - Running setup.py (path:/tmp/pip-Bbbn_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:29:35 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:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:29:35 INFO - Running setup.py (path:/tmp/pip-fPjS9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:29:35 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:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:29:35 INFO - Running setup.py (path:/tmp/pip-hfwASw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:29:35 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:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:29:35 INFO - Running setup.py (path:/tmp/pip-lzbyup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:29:35 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:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:29:35 INFO - Running setup.py (path:/tmp/pip-RbhtYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:29:35 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:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:29:35 INFO - Running setup.py (path:/tmp/pip-15u7vB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:29:35 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:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:29:35 INFO - Running setup.py (path:/tmp/pip-TuBO5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:29:36 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:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:29:36 INFO - Running setup.py (path:/tmp/pip-DXiZrh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:29:36 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:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:29:36 INFO - Running setup.py (path:/tmp/pip-pFrXuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:29:36 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:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:29:36 INFO - Running setup.py (path:/tmp/pip-Z6jafO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:29:36 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:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:29:36 INFO - Running setup.py (path:/tmp/pip-En8ILy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:29:36 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:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:29:36 INFO - Running setup.py (path:/tmp/pip-6KsiqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:29:36 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:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:29:36 INFO - Running setup.py (path:/tmp/pip-G1J4zO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:29:36 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:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:29:36 INFO - Running setup.py (path:/tmp/pip-CgD5DN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:29:36 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:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:29:36 INFO - Running setup.py (path:/tmp/pip-s7BYOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:29:36 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:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:29:36 INFO - Running setup.py (path:/tmp/pip-t9A3CK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:29:36 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:29:36 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:29:36 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:29:36 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:29:36 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:29:36 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:29:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:29:36 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:29:36 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:29:36 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:29:36 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:29:36 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:29:36 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:29:38 INFO - Downloading blessings-1.6.tar.gz 14:29:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:29:38 INFO - Installing collected packages: blessings 14:29:38 INFO - Running setup.py install for blessings 14:29:38 INFO - Successfully installed blessings 14:29:38 INFO - Cleaning up... 14:29:38 INFO - Return code: 0 14:29:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:29:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:29:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:29:38 INFO - Reading from file tmpfile_stdout 14:29:38 INFO - Current package versions: 14:29:38 INFO - argparse == 1.2.1 14:29:38 INFO - blessings == 1.6 14:29:38 INFO - blobuploader == 1.2.4 14:29:38 INFO - docopt == 0.6.1 14:29:38 INFO - manifestparser == 1.1 14:29:38 INFO - mozInstall == 1.12 14:29:38 INFO - mozcrash == 0.17 14:29:38 INFO - mozdebug == 0.1 14:29:38 INFO - mozdevice == 0.48 14:29:38 INFO - mozfile == 1.2 14:29:38 INFO - mozhttpd == 0.7 14:29:38 INFO - mozinfo == 0.9 14:29:38 INFO - mozleak == 0.1 14:29:38 INFO - mozlog == 3.1 14:29:38 INFO - moznetwork == 0.27 14:29:38 INFO - mozprocess == 0.22 14:29:38 INFO - mozprofile == 0.28 14:29:38 INFO - mozrunner == 6.11 14:29:38 INFO - mozscreenshot == 0.1 14:29:38 INFO - mozsystemmonitor == 0.0 14:29:38 INFO - moztest == 0.7 14:29:39 INFO - mozversion == 1.4 14:29:39 INFO - psutil == 3.1.1 14:29:39 INFO - requests == 1.2.3 14:29:39 INFO - wsgiref == 0.1.2 14:29:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:29:39 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:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:29:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:39 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:29:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:29:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:39 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 0x7f0449a53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abe410>, '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 0x1abf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abf7a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1463174943.258325-510991029', '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:29:39 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:29:39 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:29:39 INFO - Using env: {'DISPLAY': ':0', 14:29:39 INFO - 'HOME': '/home/cltbld', 14:29:39 INFO - 'LANG': 'en_US.UTF-8', 14:29:39 INFO - 'LANGUAGE': 'en_US:en', 14:29:39 INFO - 'LOGNAME': 'cltbld', 14:29:39 INFO - 'MAIL': '/var/mail/cltbld', 14:29:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:29:39 INFO - 'MOZ_NO_REMOTE': '1', 14:29:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:29:39 INFO - 'NO_EM_RESTART': '1', 14:29:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:29:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:29:39 INFO - 'PWD': '/builds/slave/test', 14:29:39 INFO - 'SHELL': '/bin/bash', 14:29:39 INFO - 'SHLVL': '1', 14:29:39 INFO - 'TERM': 'linux', 14:29:39 INFO - 'TMOUT': '86400', 14:29:39 INFO - 'USER': 'cltbld', 14:29:39 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1463174943.258325-510991029', 14:29:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:29:39 INFO - '_': '/tools/buildbot/bin/python'} 14:29:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:29:39 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:29:39 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:29:39 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:29:39 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:29:39 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:29:39 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:29:39 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:29:39 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:29:39 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:29:39 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:29:39 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:29:39 INFO - Cleaning up... 14:29:39 INFO - Return code: 0 14:29:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:29:39 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:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:29:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:39 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:29:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:29:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:39 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 0x7f0449a53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abe410>, '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 0x1abf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abf7a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1463174943.258325-510991029', '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:29:39 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:29:39 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:29:39 INFO - Using env: {'DISPLAY': ':0', 14:29:39 INFO - 'HOME': '/home/cltbld', 14:29:39 INFO - 'LANG': 'en_US.UTF-8', 14:29:39 INFO - 'LANGUAGE': 'en_US:en', 14:29:39 INFO - 'LOGNAME': 'cltbld', 14:29:39 INFO - 'MAIL': '/var/mail/cltbld', 14:29:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:29:39 INFO - 'MOZ_NO_REMOTE': '1', 14:29:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:29:39 INFO - 'NO_EM_RESTART': '1', 14:29:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:29:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:29:39 INFO - 'PWD': '/builds/slave/test', 14:29:39 INFO - 'SHELL': '/bin/bash', 14:29:39 INFO - 'SHLVL': '1', 14:29:39 INFO - 'TERM': 'linux', 14:29:39 INFO - 'TMOUT': '86400', 14:29:39 INFO - 'USER': 'cltbld', 14:29:39 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1463174943.258325-510991029', 14:29:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:29:39 INFO - '_': '/tools/buildbot/bin/python'} 14:29:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:29:39 INFO - Downloading/unpacking jsonschema 14:29:39 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:29:39 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:29:39 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:29:39 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:29:39 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:29:39 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:29:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:29:41 INFO - Downloading/unpacking functools32 (from jsonschema) 14:29:41 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:29:41 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:29:41 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:29:41 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:29:41 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:29:41 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:29:41 INFO - Downloading functools32-3.2.3-2.tar.gz 14:29:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:29:41 INFO - warning: no files found matching '*.txt' 14:29:41 INFO - no previously-included directories found matching 'build' 14:29:41 INFO - no previously-included directories found matching 'dist' 14:29:41 INFO - no previously-included directories found matching '.git*' 14:29:41 INFO - Installing collected packages: jsonschema, functools32 14:29:41 INFO - Running setup.py install for functools32 14:29:41 INFO - warning: no files found matching '*.txt' 14:29:41 INFO - no previously-included directories found matching 'build' 14:29:41 INFO - no previously-included directories found matching 'dist' 14:29:41 INFO - no previously-included directories found matching '.git*' 14:29:41 INFO - Successfully installed jsonschema functools32 14:29:41 INFO - Cleaning up... 14:29:41 INFO - Return code: 0 14:29:41 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:29:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:29:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:29:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:29:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:29:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0449a53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abe410>, '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 0x1abf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abf7a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1463174943.258325-510991029', '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:29:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:29:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:29:41 INFO - Using env: {'DISPLAY': ':0', 14:29:41 INFO - 'HOME': '/home/cltbld', 14:29:41 INFO - 'LANG': 'en_US.UTF-8', 14:29:41 INFO - 'LANGUAGE': 'en_US:en', 14:29:41 INFO - 'LOGNAME': 'cltbld', 14:29:41 INFO - 'MAIL': '/var/mail/cltbld', 14:29:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:29:41 INFO - 'MOZ_NO_REMOTE': '1', 14:29:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:29:41 INFO - 'NO_EM_RESTART': '1', 14:29:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:29:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:29:41 INFO - 'PWD': '/builds/slave/test', 14:29:41 INFO - 'SHELL': '/bin/bash', 14:29:41 INFO - 'SHLVL': '1', 14:29:41 INFO - 'TERM': 'linux', 14:29:41 INFO - 'TMOUT': '86400', 14:29:41 INFO - 'USER': 'cltbld', 14:29:41 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1463174943.258325-510991029', 14:29:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:29:41 INFO - '_': '/tools/buildbot/bin/python'} 14:29:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:29:41 INFO - Downloading/unpacking flake8 14:29:41 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:29:41 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:29:41 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:29:41 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:29:41 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:29:41 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:29:43 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:29:43 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:29:43 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:29:43 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:29:43 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:29:43 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:29:43 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:29:43 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:29:44 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:29:44 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:29:44 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:29:44 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:29:44 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:29:44 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:29:44 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:29:44 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:29:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:29:44 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:29:44 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:29:44 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:29:44 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:29:44 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:29:44 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:29:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:29:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:29:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:29:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:29:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:29:44 INFO - no previously-included directories found matching 'docs/_build' 14:29:44 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:29:44 INFO - Running setup.py install for pep8 14:29:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:29:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:29:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:29:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:29:44 INFO - no previously-included directories found matching 'docs/_build' 14:29:44 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:29:44 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:29:44 INFO - Cleaning up... 14:29:44 INFO - Return code: 0 14:29:44 INFO - Running post-action listener: _resource_record_post_action 14:29:44 INFO - Running post-action listener: _start_resource_monitoring 14:29:44 INFO - Starting resource monitoring. 14:29:44 INFO - ##### 14:29:44 INFO - ##### Running install step. 14:29:44 INFO - ##### 14:29:44 INFO - Running pre-action listener: _resource_record_pre_action 14:29:44 INFO - Running main action method: install 14:29:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:29:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:29:45 INFO - Reading from file tmpfile_stdout 14:29:45 INFO - Detecting whether we're running mozinstall >=1.0... 14:29:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:29:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:29:45 INFO - Reading from file tmpfile_stdout 14:29:45 INFO - Output received: 14:29:45 INFO - Usage: mozinstall [options] installer 14:29:45 INFO - Options: 14:29:45 INFO - -h, --help show this help message and exit 14:29:45 INFO - -d DEST, --destination=DEST 14:29:45 INFO - Directory to install application into. [default: 14:29:45 INFO - "/builds/slave/test"] 14:29:45 INFO - --app=APP Application being installed. [default: firefox] 14:29:45 INFO - mkdir: /builds/slave/test/build/application 14:29:45 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:29:45 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:30:00 INFO - Reading from file tmpfile_stdout 14:30:00 INFO - Output received: 14:30:00 INFO - /builds/slave/test/build/application/firefox/firefox 14:30:00 INFO - Running post-action listener: _resource_record_post_action 14:30:00 INFO - ##### 14:30:00 INFO - ##### Running run-tests step. 14:30:00 INFO - ##### 14:30:00 INFO - Running pre-action listener: _resource_record_pre_action 14:30:00 INFO - Running main action method: run_tests 14:30:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:30:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:30:00 INFO - Python 2.7.3 14:30:00 INFO - Return code: 0 14:30:00 INFO - grabbing minidump binary from tooltool 14:30:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:00 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 0x1abe410>, '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 0x1abf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abf7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:30:00 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:30:00 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:30:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:30:00 INFO - Return code: 0 14:30:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:30:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:30:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:30:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:30:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:30:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:30:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:30:01 INFO - Return code: 0 14:30:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JwMZ7IgpTKysdzjwdycVlA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:30:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JwMZ7IgpTKysdzjwdycVlA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:30:01 INFO - Using env: {'DISPLAY': ':0', 14:30:01 INFO - 'HOME': '/home/cltbld', 14:30:01 INFO - 'LANG': 'en_US.UTF-8', 14:30:01 INFO - 'LANGUAGE': 'en_US:en', 14:30:01 INFO - 'LOGNAME': 'cltbld', 14:30:01 INFO - 'MAIL': '/var/mail/cltbld', 14:30:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:30:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:30:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:01 INFO - 'MOZ_NO_REMOTE': '1', 14:30:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:30:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:01 INFO - 'NO_EM_RESTART': '1', 14:30:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:01 INFO - 'PWD': '/builds/slave/test', 14:30:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:30:01 INFO - 'SHELL': '/bin/bash', 14:30:01 INFO - 'SHLVL': '1', 14:30:01 INFO - 'TERM': 'linux', 14:30:01 INFO - 'TMOUT': '86400', 14:30:01 INFO - 'USER': 'cltbld', 14:30:01 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1463174943.258325-510991029', 14:30:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:01 INFO - '_': '/tools/buildbot/bin/python'} 14:30:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JwMZ7IgpTKysdzjwdycVlA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:30:02 INFO - mozversion application_buildid: 20160513114547 14:30:02 INFO - mozversion application_changeset: 805051b9a46259319d5c56424cb5249efc811363 14:30:02 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:30:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:30:02 INFO - mozversion application_name: Firefox 14:30:02 INFO - mozversion application_remotingname: firefox-dev 14:30:02 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:30:02 INFO - mozversion application_vendor: Mozilla 14:30:02 INFO - mozversion application_version: 48.0a2 14:30:02 INFO - mozversion platform_buildid: 20160513114547 14:30:02 INFO - mozversion platform_changeset: 805051b9a46259319d5c56424cb5249efc811363 14:30:02 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:30:02 INFO - mozversion platform_version: 48.0a2 14:30:02 INFO - using testdate: 1463175002 14:30:02 INFO - actual date: 1463175002 14:30:02 INFO - starting webserver on 'localhost:39161' 14:30:02 INFO - SUITE-START | Running 2 tests 14:30:02 INFO - TEST-START | dromaeo_css 14:30:02 INFO - operating with platform_type : linux_ 14:30:02 INFO - Initialising browser for dromaeo_css test... 14:30:02 INFO - TEST-INFO | started process 28102 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdFFAw6/profile http://localhost:39161/getInfo.html) 14:30:06 INFO - PROCESS | 28102 | __metrics Screen width/height:1600/1200 14:30:06 INFO - PROCESS | 28102 | colorDepth:24 14:30:06 INFO - PROCESS | 28102 | Browser inner width/height: 1024/697 14:30:06 INFO - PROCESS | 28102 | __metrics 14:30:07 ERROR - PROCESS | 28102 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:30:08 INFO - TEST-INFO | 28102: exit 0 14:30:08 INFO - Browser initialized. 14:30:08 INFO - Running cycle 1/1 for dromaeo_css test... 14:30:08 INFO - TEST-INFO | started process 28194 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdFFAw6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:30:20 INFO - PROCESS | 28194 | RSS: Main: 142487552 14:30:20 INFO - PROCESS | 28194 | 14:31:11 INFO - PROCESS | 28194 | 1463175071591 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:33:19 INFO - PROCESS | 28194 | Cycle 1(1): loaded http://localhost:39161/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39161/tests/dromaeo/cssquery-ext.html) 14:33:20 INFO - PROCESS | 28194 | RSS: Main: 247713792 14:33:20 INFO - PROCESS | 28194 | 14:36:22 INFO - PROCESS | 28194 | Cycle 1(1): loaded http://localhost:39161/tests/dromaeo/cssquery-ext.html (next: http://localhost:39161/tests/dromaeo/cssquery-jquery.html) 14:36:23 INFO - PROCESS | 28194 | RSS: Main: 221917184 14:36:23 INFO - PROCESS | 28194 | 14:39:25 INFO - PROCESS | 28194 | Cycle 1(1): loaded http://localhost:39161/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39161/tests/dromaeo/cssquery-mootools.html) 14:39:25 INFO - PROCESS | 28194 | RSS: Main: 223895552 14:39:25 INFO - PROCESS | 28194 | 14:42:27 INFO - PROCESS | 28194 | Cycle 1(1): loaded http://localhost:39161/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39161/tests/dromaeo/cssquery-prototype.html) 14:42:28 INFO - PROCESS | 28194 | RSS: Main: 216522752 14:42:28 INFO - PROCESS | 28194 | 14:45:30 INFO - PROCESS | 28194 | Cycle 1(1): loaded http://localhost:39161/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39161/tests/dromaeo/cssquery-yui.html) 14:45:31 INFO - PROCESS | 28194 | RSS: Main: 212488192 14:45:31 INFO - PROCESS | 28194 | 14:48:33 INFO - PROCESS | 28194 | Cycle 1(1): loaded http://localhost:39161/tests/dromaeo/cssquery-yui.html (next: http://localhost:39161/tests/dromaeo/cssquery-dojo.html) 14:48:34 INFO - PROCESS | 28194 | RSS: Main: 256131072 14:48:34 INFO - PROCESS | 28194 | 14:48:34 INFO - PROCESS | 28194 | __start_tp_report 14:48:34 INFO - PROCESS | 28194 | _x_x_mozilla_page_load 14:48:34 INFO - PROCESS | 28194 | _x_x_mozilla_page_load_details 14:48:34 INFO - PROCESS | 28194 | |i|pagename|runs| 14:48:34 INFO - PROCESS | 28194 | |0;dojo.html;3314.436545787216;3341.431956567382;3349.3971085204666;3392.3893699134146;3400.727941764659;5485.286912701348;5532.834014979552;5535.474129957647;5538.390777014531;5542.8337149885565;5572.554195664347;5573.442655734424;5593.300837395325;5598.1602759586085;5631.971840140804;5032.949670503293;5054.595632349403;5130.050940575987;5182.119039763249;5201.55786758126;5030.874228144307;5098.694078355292;5119.846404607868;5121.385433747955;5126.461721519243;5071.797128114871;5133.332666753336;5159.38087429509;5161.638685292031;5205.817796377128;5201.973990130044;5202.401723801773;5226.163813789775;5226.660267082628;5256.868578285555;5023.547880690755;5069.923951140736;5099.617528685327;5123.385193776733;5132.769025393866;5528.640638358494;5546.833594992157;5557.221988921554;5573.944260557383;5589.413111623262;6097.664628445434;6144.446999769997;6146.108814221958;6147.969260153671;6149.754009839601;5988.161657367972;5999.700014999233;6020.6688632125215;6036.698165091728;6150.077488376734;5609.046462101453;5624.55003599711;5653.830385088454;5656.971715141439;5657.066584013592;5778.422157784272;6148.296553136854;6178.135061091451;6183.938160618426;6189.04069869171;5949.0481522956115;5994.790182343684;6000.489958353589;6009.759609615654;6040.426159514839;6049.879002419927;6071.180390647294;6072.848178795565;6077;6100.206973093469;5930.318013428425;6016.669083200466;6045.3652366501765;6065.4541091302;6065.848353791102;6033.215681961405;6041.033434650435;6051.485623721945;6058.697065146725;6082.300535438393;4568.680192386501;4574.016586433866;4578.748168850745;4582.610478109398;4600.217962946307;4066.3900414938;4080.591940805896;4110.753354798721;4117.444145040441;4126.133511962522;5660.150977353348;5666.263385759825;5676.772929082873;5711.257536520226;5714.285714285715;5976.85057873548;6030.939690603038;6063.363346848606;6063.878722425527;6064.9090263646085;5547.833564993057;5615.466530679579;5633.436656334334;5668;5697.886042279131;5196.948030519647;5198.610104242121;5199.350081239845;5202.635815492955;5224.9738751306;6227;6228.252609686776;6228.47058000066;6231.532635052389;6236.03341482071;5973.1338955852025;6005.819825405245;6024.367441418675;6068.939310606837;6096.512279017579;6175.116126074035;6180.134781130555;6215.9378406215355;6221.3156552780065;6228.688565571794;5896.056630939029;5896.64620122794;5898.1152827076285;5908.881822363614;5939.16851640762;5928.555358348055;6128.601640893327;6155.630662160284;6157.876842463215;6179.412955769375;5931.911021334769;5935;5939.049752039826;5954.3152537458745;5959.28488581373;5843.766249349978;5892.381299963614;5893.086571581412;5894;5906.320773111147;5690.089585666274;5699.629524080921;5743.966086104541;5761.510271626791;5789.073748200268;5908.261467316585;5967.164596956516;5971.3132989705;5977.432143946318;5991.221141251609;5652.7173641318595;5847.678377689268;5859.267591551056;5859.326177489644;5880.852978675567 14:48:34 INFO - PROCESS | 28194 | |1;ext.html;589.7110415896212;656.8357910522369;673.4915139070001;680.1701923653143;689.1729924091089;33330.16674583137;33970.830145849264;34020.82989585049;39232.80383598078;40270.19459610814;42989.570104298946;43540.564594354044;43544.782276088576;43799.3430098548;43976;8143.877841832377;8800.779980500474;8976.8653470198;8985.64057437705;8989.775255618597;8234.876476852822;10664.413457259847;10954.34273943562;10960;10961.56153753849;10679.946600267027;10758.193135514868;10771;10771.892281077207;10777.245592808507;8317.126701696296;10619.946900265526;10626.574937002511;10665.413402262873;10727.195460340467;10427.94786026065;10525.84211236832;10536.841947370796;10542.631007914686;10544.420056896945;40507;40918;41075.589244107476;41082.58917410817;41114;4066.9389959150635;4084.0402505411203;4145.937810932838;4332.241857674894;4686.179918514281;34092.82953585241;34542;34740.65259347399;34931.30137397263;34965.30069398623;4577.748223847687;4696.671233013691;4719.905601887943;4739.668223224376;4753.3582966299455;316382;316791;319355.9999999977;320699;321484;41515;68135;69496.30503695;69567;69592.3040769596;38937.80531097383;39108;39175;39212.2157556853;39233.80383098123;18027.098645067694;18312.450626481226;18321.63356732858;18323.816761832477;18325.54186145357;13544.86455135436;14815.481458149128;15086.924565377103;15116.54650360491;15172.241387930559;9560.665376711782;9601.087896649808;9606.423614583147;9618.230541556659;9660.37207581519;3736.252749450121;3810.2189051244427;3823.8470461181796;3853.451030516048;3874.1089549403796;1183.8461000069935;1192.8568571771443;1203.7231436769591;1206.9577564785366;1297.6885547468728;33752.49371259433;34054.82972585121;34182.48726269108;34631.134221644155;34839.65160348415;1237.8390809194748;1248;1265.8480982282001;1307.1895424836662;1307.9673008174873;18010.549736256697;18019.909900450413;18237.54406139857;18372.35696750607;18498.907505462386;489860;495493;497333;497858;498610;62256.68871655613;62947.6852615734;63052;63125.684371577845;63242;1521.634807646179;1524.3902439024257;1542.9845701543065;1565.1000674612144;1638.9344426222817;30268.84865575746;30823.2294192647;31588.684113158575;31672.208194795316;32094.197645058128;45013;45137;45259.99999999868;45273.77363113163;45279.54720452753;314330;317345;317822;317958;318734;27013.459730805665;29342;29397.265068372606;29417.705822942353;32136.83931580327;43981;44060;44380.33429498625;44381.33427998518;44830;36634.816825916765;37416.438753419265;37443;37725.62274377331;38064;37170.25659486741;37346;37386.252274953804;39365.80317098396;41318.38022429726;41919.37120943127;42413.78793106015;42673;42875.142497150504;43289.13421731611;34970.65029349674;36180.819095905405;36474.08814779545;36610.26779464343;36659;27796.166115016582;28559.857200713865;28736.568951465328;28904.42191156123;28930.98741544036 14:48:34 INFO - PROCESS | 28194 | |2;jquery.html;429.4074177634864;429.7217650131577;436.2474731088874;439.66925781056585;449.1645539296907;19021.144048517814;19220.807791922078;19588;20978;21442.24952126676;19780.70328945067;20064.197432102734;20451.386458406272;20481.180752769873;20511.589768204627;5414.566834653228;5765.308163020422;5770.307563092435;5778.046622307335;5782.392848750884;4366.8253269869165;5666.348369937468;5736.741846616891;5982.192404025466;6297.748090076391;6270.780522681707;6277.5291853110975;6278.183836101301;6281.340459251781;6289.465395441393;6232.345603711613;6258.342873998233;6277.121203031579;6311.968440157792;6447.54867159299;3998.5001874765653;4171.499420069611;5506.339239291311;5768.019436695772;5777.335606405275;23601;23776.048958041658;23808.523829523314;23849.403764906016;24053.759462405327;2654.349684327333;2762.240383894445;3061.556074369204;3067.662557118715;3276.950845737316;14659.926700366537;14690.779638305434;14724.263786810723;14829.925850370679;15030;2040.8673436226597;2070.430631576329;2072.8030837070605;2109.5148115933266;2147.892605369725;76382;76680;76708;78111.609441953;80729.59635201845;10961.397123158144;11093.611723589636;11183.776324473465;11288.887111128948;12015.399230038463;16019.519414417586;16097.275622597012;16105.838941610667;16145.67708645844;16148.111853848151;9037.728868133967;9084.545772711337;9108.271338292921;9205.585748641328;9339.159475647224;9185.127412895765;9189.216027009556;9196.540172991457;9275.21160701348;9453.669121580711;7090.503664743418;7168.132746901177;7185.209626941032;7226.0606121204955;7228.602426866468;1815.1074916318723;1971.7732460766908;1977.179470519747;1977.6341376845041;2093.9476513087293;1028.7016765138176;1120.1822669451346;1135.5344308833503;1160.2284480820329;1186.1581710078003;19558.608827823366;19870.30453934134;19917.800821991594;19962.600747984958;20095;1109.4286442482128;1114.5931734916696;1119.9104071674246;1131.7849608574345;1145.7422080032093;11478.784985379265;11486.0811135109;11571.479283432265;11608.76782464346;11628.360440175702;473501;476055;480068;482226;483810;77872.99999999886;78701.60649196718;79119;79159;79533.20466795373;1089.536946797608;1106.8505751723576;1112.9276597021167;1113.5768408004906;1118.4266269269606;17274.481765547054;17666;17792.288308467516;17871;18294.817051829312;36070.8196459016;36604.81697591495;37281.62718372782;38559.42160867533;38825.417618736305;51407;51565.742171288905;51802;51966.48033519617;52065.219021715464;9247.537623118951;9250.398724083183;9345.532723363669;9383.906160938302;9540.141387275178;13516.729665406834;13779.931100344435;13783.310834458438;13801.171929684251;14038.929805350908;11895.762084758084;12048.216865903689;12169.756604868031;12179.330136842558;12361.196522226026;11662.533498660297;11757.235779674294;11870.584529541424;11893.76212475763;12242.081843861568;12234.571789987307;12259.32573708419;12318.938405307916;12462.127651064338;12575.49698012106;8767.561621919007;8865.822683546421;8930.598123084346;9001.864972025294;9015.864762028443;12215.144939854124;12288.201266917622;12391.876081239432;12421.503139874303;12601.87398126007 14:48:34 INFO - PROCESS | 28194 | |3;mootools.html;1437.223899094489;1575.0313557162344;1588.0471716969819;1737.140115642757;1842.5577861313288;7508.511946723466;8033.317168040716;8255.133211012848;8276.462029968056;8288.17118288171;8165.632546535406;8302.377321700882;8323.16768323169;8331.16688331168;8336.874946875801;2140.935771926837;2184.5194057307444;2346.249200255919;2424.2000139953775;2446.7308596054418;2419.68544089269;2422.733499315074;2425.260295609838;2425.5391475619576;2425.9514809703796;2256.6615007748887;2293.048384920256;2297.6783250344965;2297.781710737477;2308.8383813133087;2100.537881666031;2325.360525855386;2339.532093581282;2373.8694371809543;2374.050379848057;2322.8025617822336;2329.720433547985;2365.9171928982405;2369.7274813396507;2371.1108334374608;8334.541600211985;8375.45559538628;8408.453450525758;8411.915880841236;8414.495130292202;5171.482851714836;5271.314729085233;5282.339707536558;5282.735863206863;5285.814996475144;3557.5375201223933;3575.535180426554;3620.7284453665816;3698.260347930425;3735.346314394997;1158.461315488302;1163.906887449002;1173.6948393417688;1190.4523918997186;1197.9341136237504;11818.468168932419;11854.170208085437;11865.940670296679;11888.465019074163;11911.642650720492;4563.931541026887;4683.695559788671;4689.577937985529;4742.881427964328;4752.025834703946;10202.795944081077;10225.233107516966;10233.846492302622;10236.744081397876;10242.641507547349;5166.638335316492;5177.508136727005;5184;5184.8963020739375;5185;4325.2214601371425;4650.279206722963;4663.160631086369;4725.810967561328;4737.692050016738;3936.252112098692;3966.186931678999;3995.5405128410603;4027.154297597479;4032.6773858091283;1263.9747205055846;1282.0320657903223;1284.312892602472;1290.2645492069619;1295.5854126679371;916.5234078279258;990.9504524773877;1065.8667666541683;1080.227637239362;1082.2640604389092;5826.563007774434;5826.737796799154;5842.415758424124;5924.7926322578505;6019.277686677627;934.2852717670987;935.251798561162;954.1126752120456;959.6804393958307;966.1256562810668;3971.126352202511;3998.8800335989968;4010.3583426651594;4017.9196416071513;4042.717009809344;10440;10641.201909856793;10700.678979630624;10716;10741.570337186426;10493.475326233658;10499.160067194605;10524.579016839241;10547.736306592396;10550;8157.347412207009;8185.140560241208;8191.590420478952;8259.174082591693;8279.875801862976;5863.94136058651;5875.853103672443;5878.412158784087;5906.616069955439;6062.120992456157;8967.461952282883;9105.453672779655;9164.587593558439;9177.54112294396;9192.448453092837;8893.377463577488;8910;8953.641854325753;9062;9407.24742020623;6823.658817059028;7128.180259270251;7241.348278654947;7309.086364204474;7334.046573945353;7844.568548729874;8055.154208808225;8070.798230044061;8073.394495412985;8095.150009248944;7100.715971361295;7355.66899489535;7426.220246874001;7483.363914067365;7552.6223688816435;7005.894911576433;7020.368166865007;7056.7530136444975;7088.858222835412;7154.821129471805;6413.77551785704;6418.903716444351;6453.903191452226;6467.062275969864;6470.352964703492;4771.06964141989;4780.187368147493;4837.588804951619;4839.733814640229;4937.333459982857;5178.171492561172;5196.896062078662;5201;5219.295395121761;5270.367555893164 14:48:34 INFO - PROCESS | 28194 | |4;prototype.html;360.4269211952994;360.7853327270274;366.1377456090906;371.4001886952572;373.34105304138217;6411.903821442676;6424.64664443456;6433.5174861885425;6433.646149461783;6495.805125846232;6402.711877965491;6408.711607977641;6410.1666783318105;6426.325235850239;6441.838954026151;4666.78999445025;4775.880602984936;4855.126077306083;4862.051899879525;4876.926846097312;4881.316615673809;4898.853034408973;4918.114739346916;4925.802967881281;4927.7536123193695;4721.598664113537;4894.388201474816;4897.094037603055;4897.436794768611;4897.7795999180125;4756.881077973044;4836.15367310721;4859.562639362474;4872.731999740013;4900.191468407708;4306.849260275875;4312.1160162167;4320.805563749639;4321.82712691492;4323.762193079379;6118.684482836212;6128.479079278267;6136.693165341715;6138.0792881067755;6138.447539721402;5701.771929122871;5706.572007099484;5708.143778433268;5712.485876271156;5721.713914304268;6571.112899758567;6725.966370168167;6728.495362847757;6730.0577919091365;6733.09103271057;4648.907021859543;4658.440987081572;4674.532546745332;4677.391939047902;4686.812527498896;7020.087388639444;7083.0437890885105;7092.751753688648;7093.858122837514;7095.858082838366;4774.522547745198;4774.785134668949;4779.139754844092;4780;4783.521647835259;4833.637477189225;4839.927401088987;4840.636952228597;4843.564079232886;4845.709257444564;5614.6350487219015;5618.578606604521;5626.071698169756;5630.296212973379;5639.492445679908;6665.533412661164;6802.693878775467;6853.211880633791;6855.07456493377;6862.897056544156;1736.5224563244956;1768.32803534656;1769.7699299091037;1772.0430967277525;1773.0248363400335;1110.0564520157802;1174.107678164584;1183.7514122034297;1189.7917864373874;1209.1173443386376;6419.903701444482;6456.51576131792;6467.741290348427;6478.481721462272;6482.124913136666;6960.512764106464;6961.512694111364;6981.232064472904;6992.1259842519685;7028.789136325919;6483.09236706852;6485.254195767548;6491.837704057342;6496.870062598721;6498.252700939358;3666.5966743658178;3740.9064773380337;3775.0562359410146;3778.6410291022307;3781.621837816251;7195.172555156119;7202.171750248684;7208.387287080552;7217.8917316240295;7237.312455316736;7031.6484175791;7047.753328633473;7062.15254169503;7080.575165489984;7081.822954426078;7196.424286057103;7210.062691850131;7218.59237448703;7222.422206223385;7227;6761.121054262914;6950.339717726808;6953.826154346182;6959.095317608679;6959.130108736408;6810.8637827244165;6846.178458584803;6856.834338162624;6865.41643960269;6870.244273130052;7198.20819709821;7203.387712044535;7205.207427182901;7205.567665940061;7217.386522145676;4919.409670839522;4926.48271931442;4927.187014142626;4928.654994150518;4929.151568161939;6913.2049814272;6914.5159838812815;6918.896216556856;6926.341997510229;6929.688164032731;6607.405333520006;6722.361375669304;6743.629100399525;6754.763583274562;6764.425023873026;6677;6699;6699.9665001674675;6709.094272273181;6723.7646682365885;6606.339366063356;6611.07444957716;6612.173478315211;6618.768343107968;6623.205215374186;6621.768238111643;6756.729730810909;6757.662116894234;6770.796876093725;6776.322367763381;6491.545591808528;6588.703508342041;6644.767433139817;6722.831929201809;6744.325567443217 14:48:34 INFO - PROCESS | 28194 | |5;yui.html;924.2605915267784;929.7180951242113;929.9770252722006;948.3409030723641;956.9425834449934;15117.395304187832;15481.84518154818;15540.456084037061;15553.222338883053;15553.922230388833;13900.930495347535;14208.644783880382;14219.644508887282;14239.3592288347;14264.928675356608;738.4314078159828;878.4290211362634;894.5661354243186;899.6716198587501;900.6172376739892;887.3256325192835;892.9151730585584;894.5393122541897;896.2874514760748;896.4262871762045;944.3814301632442;944.9102335278137;946.7349142240183;946.8863736351648;948.1324588002004;770.2836362183167;913.4519288426957;924.2375040591539;925.8472352061901;927.6938610258633;686.7836631461074;686.8248596607883;688.7899190746821;689.3175756001523;689.48633268215;14477.638059048502;14517.419303227858;14533.418663253457;14539.927300363537;14541.200233987127;14539.491117810825;14893.925530372388;14923.403063877431;15206.923965380101;15419.460318888785;12133.21134126279;12493.75012499754;12918.772716592002;13250.536231231861;13433;4772.904541909143;4785.234362502018;4792.0895029944195;4809.639277054235;4900.142475066885;54449.45550544523;54575;54703;54840;54959;11514.94242528782;11746.941265293619;11912.523499060115;11941;12032.759344813056;20965.895170524356;21884.234051808427;21900.561988760455;21960.231391901525;21962.121515139217;8639.13608639131;8710.52092134926;9254.074592540692;9271.76820579491;9296.581653825595;4999;5001.074801161724;5013;5083.415407228142;5099.388073431212;3536.3634545781492;3576.2847430514003;3583.4445660922597;3591.6049234584175;3593.065802891215;606.9605475644069;649.4285029174297;673.7978606418153;677.9627120508321;692.1832237959156;781.9296263336327;787.5432249295395;800.4676889868289;810.4367464612155;814.539785021461;10199.18406527476;10234.48827558619;10261.640842570474;10291.125254353314;10462.68611941643;833.966641334352;835.1231207232381;836.4019725896013;848.253536887535;856.8372009318209;4896.216605343128;4932.901341973212;4951.876203094951;4957.578605818474;5056;63742;66818;66925.66537167283;67001.66499167473;67388.32611673919;56256.43743562512;56679;57187.428125719045;57561.42438575644;58480.12279815806;50739.23891141636;50753.49246507488;50854.745726271874;50953;51580.74209629003;9401.20089792348;9500.95249523748;9512.2865785065;9546.856797148188;9582.904170958202;39362.606373935894;40062.599374005884;40747;41081.79459102685;41178.58821411747;45691.31463028124;50132.74933625309;50351.49648503468;50553.49446505488;51702.22446663379;12016.819747703617;12072;12154.392280385768;12286.754264914473;12288.078394120656;12239;12516.687082823002;13384.19694818314;13628.86371136276;13635.181889086687;12559.748805024032;12669.8099528509;12781.29702866314;13170.934145329213;13887.583372498437;13777.862221377658;14018.929905350407;14098.929505352407;14353.569392918229;14667.48663796762;13492.730145397234;13701.862981370059;13714.143797342605;13772.931135344259;13856.792148117585;11459.828102578302;11733.237339572901;11888.821667674818;11950.581729639422;12027.338496382783;10569.682909512727;11256.380899050631;11524;11586.246893951866;11828.52685892589 14:48:34 INFO - PROCESS | 28194 | __end_tp_report 14:48:34 INFO - PROCESS | 28194 | __start_cc_report 14:48:34 INFO - PROCESS | 28194 | _x_x_mozilla_cycle_collect,838 14:48:34 INFO - PROCESS | 28194 | __end_cc_report 14:48:34 INFO - PROCESS | 28194 | __startTimestamp1463176114023__endTimestamp 14:48:34 INFO - PROCESS | 28194 | 14:48:34 INFO - PROCESS | 28194 | ------- Summary: start ------- 14:48:34 INFO - PROCESS | 28194 | Number of tests: 6 14:48:34 INFO - PROCESS | 28194 | 14:48:34 INFO - PROCESS | 28194 | [#0] dojo.html Cycles:165 Average:5601.86 Median:5843.77 stddev:630.42 (10.8%) stddev-sans-first:606.28 14:48:34 INFO - PROCESS | 28194 | Values: 3314.4 3341.4 3349.4 3392.4 3400.7 5485.3 5532.8 5535.5 5538.4 5542.8 5572.6 5573.4 5593.3 5598.2 5632.0 5032.9 5054.6 5130.1 5182.1 5201.6 5030.9 5098.7 5119.8 5121.4 5126.5 5071.8 5133.3 5159.4 5161.6 5205.8 5202.0 5202.4 5226.2 5226.7 5256.9 5023.5 5069.9 5099.6 5123.4 5132.8 5528.6 5546.8 5557.2 5573.9 5589.4 6097.7 6144.4 6146.1 6148.0 6149.8 5988.2 5999.7 6020.7 6036.7 6150.1 5609.0 5624.6 5653.8 5657.0 5657.1 5778.4 6148.3 6178.1 6183.9 6189.0 5949.0 5994.8 6000.5 6009.8 6040.4 6049.9 6071.2 6072.8 6077.0 6100.2 5930.3 6016.7 6045.4 6065.5 6065.8 6033.2 6041.0 6051.5 6058.7 6082.3 4568.7 4574.0 4578.7 4582.6 4600.2 4066.4 4080.6 4110.8 4117.4 4126.1 5660.2 5666.3 5676.8 5711.3 5714.3 5976.9 6030.9 6063.4 6063.9 6064.9 5547.8 5615.5 5633.4 5668.0 5697.9 5196.9 5198.6 5199.4 5202.6 5225.0 6227.0 6228.3 6228.5 6231.5 6236.0 5973.1 6005.8 6024.4 6068.9 6096.5 6175.1 6180.1 6215.9 6221.3 6228.7 5896.1 5896.6 5898.1 5908.9 5939.2 5928.6 6128.6 6155.6 6157.9 6179.4 5931.9 5935.0 5939.0 5954.3 5959.3 5843.8 5892.4 5893.1 5894.0 5906.3 5690.1 5699.6 5744.0 5761.5 5789.1 5908.3 5967.2 5971.3 5977.4 5991.2 5652.7 5847.7 5859.3 5859.3 5880.9 14:48:34 INFO - PROCESS | 28194 | 14:48:34 INFO - PROCESS | 28194 | [#1] ext.html Cycles:180 Average:54164.46 Median:36646.91 stddev:102181.79 (278.8%) stddev-sans-first:102389.26 14:48:34 INFO - PROCESS | 28194 | Values: 589.7 656.8 673.5 680.2 689.2 33330.2 33970.8 34020.8 39232.8 40270.2 42989.6 43540.6 43544.8 43799.3 43976.0 8143.9 8800.8 8976.9 8985.6 8989.8 8234.9 10664.4 10954.3 10960.0 10961.6 10679.9 10758.2 10771.0 10771.9 10777.2 8317.1 10619.9 10626.6 10665.4 10727.2 10427.9 10525.8 10536.8 10542.6 10544.4 40507.0 40918.0 41075.6 41082.6 41114.0 4066.9 4084.0 4145.9 4332.2 4686.2 34092.8 34542.0 34740.7 34931.3 34965.3 4577.7 4696.7 4719.9 4739.7 4753.4 316382.0 316791.0 319356.0 320699.0 321484.0 41515.0 68135.0 69496.3 69567.0 69592.3 38937.8 39108.0 39175.0 39212.2 39233.8 18027.1 18312.5 18321.6 18323.8 18325.5 13544.9 14815.5 15086.9 15116.5 15172.2 9560.7 9601.1 9606.4 9618.2 9660.4 3736.3 3810.2 3823.8 3853.5 3874.1 1183.8 1192.9 1203.7 1207.0 1297.7 33752.5 34054.8 34182.5 34631.1 34839.7 1237.8 1248.0 1265.8 1307.2 1308.0 18010.5 18019.9 18237.5 18372.4 18498.9 489860.0 495493.0 497333.0 497858.0 498610.0 62256.7 62947.7 63052.0 63125.7 63242.0 1521.6 1524.4 1543.0 1565.1 1638.9 30268.8 30823.2 31588.7 31672.2 32094.2 45013.0 45137.0 45260.0 45273.8 45279.5 314330.0 317345.0 317822.0 317958.0 318734.0 27013.5 29342.0 29397.3 29417.7 32136.8 43981.0 44060.0 44380.3 44381.3 44830.0 36634.8 37416.4 37443.0 37725.6 38064.0 37170.3 37346.0 37386.3 39365.8 41318.4 41919.4 42413.8 42673.0 42875.1 43289.1 34970.7 36180.8 36474.1 36610.3 36659.0 27796.2 28559.9 28736.6 28904.4 28931.0 14:48:34 INFO - PROCESS | 28194 | 14:48:34 INFO - PROCESS | 28194 | [#2] jquery.html Cycles:180 Average:28518.78 Median:23688.52 stddev:78542.56 (331.6%) stddev-sans-first:78734.57 14:48:34 INFO - PROCESS | 28194 | Values: 429.4 429.7 436.2 439.7 449.2 19021.1 19220.8 19588.0 20978.0 21442.2 19780.7 20064.2 20451.4 20481.2 20511.6 5414.6 5765.3 5770.3 5778.0 5782.4 4366.8 5666.3 5736.7 5982.2 6297.7 6270.8 6277.5 6278.2 6281.3 6289.5 6232.3 6258.3 6277.1 6312.0 6447.5 3998.5 4171.5 5506.3 5768.0 5777.3 23601.0 23776.0 23808.5 23849.4 24053.8 2654.3 2762.2 3061.6 3067.7 3277.0 14659.9 14690.8 14724.3 14829.9 15030.0 2040.9 2070.4 2072.8 2109.5 2147.9 76382.0 76680.0 76708.0 78111.6 80729.6 10961.4 11093.6 11183.8 11288.9 12015.4 16019.5 16097.3 16105.8 16145.7 16148.1 9037.7 9084.5 9108.3 9205.6 9339.2 9185.1 9189.2 9196.5 9275.2 9453.7 7090.5 7168.1 7185.2 7226.1 7228.6 1815.1 1971.8 1977.2 1977.6 2093.9 1028.7 1120.2 1135.5 1160.2 1186.2 19558.6 19870.3 19917.8 19962.6 20095.0 1109.4 1114.6 1119.9 1131.8 1145.7 11478.8 11486.1 11571.5 11608.8 11628.4 473501.0 476055.0 480068.0 482226.0 483810.0 77873.0 78701.6 79119.0 79159.0 79533.2 1089.5 1106.9 1112.9 1113.6 1118.4 17274.5 17666.0 17792.3 17871.0 18294.8 36070.8 36604.8 37281.6 38559.4 38825.4 51407.0 51565.7 51802.0 51966.5 52065.2 9247.5 9250.4 9345.5 9383.9 9540.1 13516.7 13779.9 13783.3 13801.2 14038.9 11895.8 12048.2 12169.8 12179.3 12361.2 11662.5 11757.2 11870.6 11893.8 12242.1 12234.6 12259.3 12318.9 12462.1 12575.5 8767.6 8865.8 8930.6 9001.9 9015.9 12215.1 12288.2 12391.9 12421.5 12601.9 14:48:34 INFO - PROCESS | 28194 | 14:48:34 INFO - PROCESS | 28194 | [#3] mootools.html Cycles:180 Average:5596.54 Median:4838.66 stddev:3077.70 (63.6%) stddev-sans-first:3070.46 14:48:34 INFO - PROCESS | 28194 | Values: 1437.2 1575.0 1588.0 1737.1 1842.6 7508.5 8033.3 8255.1 8276.5 8288.2 8165.6 8302.4 8323.2 8331.2 8336.9 2140.9 2184.5 2346.2 2424.2 2446.7 2419.7 2422.7 2425.3 2425.5 2426.0 2256.7 2293.0 2297.7 2297.8 2308.8 2100.5 2325.4 2339.5 2373.9 2374.1 2322.8 2329.7 2365.9 2369.7 2371.1 8334.5 8375.5 8408.5 8411.9 8414.5 5171.5 5271.3 5282.3 5282.7 5285.8 3557.5 3575.5 3620.7 3698.3 3735.3 1158.5 1163.9 1173.7 1190.5 1197.9 11818.5 11854.2 11865.9 11888.5 11911.6 4563.9 4683.7 4689.6 4742.9 4752.0 10202.8 10225.2 10233.8 10236.7 10242.6 5166.6 5177.5 5184.0 5184.9 5185.0 4325.2 4650.3 4663.2 4725.8 4737.7 3936.3 3966.2 3995.5 4027.2 4032.7 1264.0 1282.0 1284.3 1290.3 1295.6 916.5 991.0 1065.9 1080.2 1082.3 5826.6 5826.7 5842.4 5924.8 6019.3 934.3 935.3 954.1 959.7 966.1 3971.1 3998.9 4010.4 4017.9 4042.7 10440.0 10641.2 10700.7 10716.0 10741.6 10493.5 10499.2 10524.6 10547.7 10550.0 8157.3 8185.1 8191.6 8259.2 8279.9 5863.9 5875.9 5878.4 5906.6 6062.1 8967.5 9105.5 9164.6 9177.5 9192.4 8893.4 8910.0 8953.6 9062.0 9407.2 6823.7 7128.2 7241.3 7309.1 7334.0 7844.6 8055.2 8070.8 8073.4 8095.2 7100.7 7355.7 7426.2 7483.4 7552.6 7005.9 7020.4 7056.8 7088.9 7154.8 6413.8 6418.9 6453.9 6467.1 6470.4 4771.1 4780.2 4837.6 4839.7 4937.3 5178.2 5196.9 5201.0 5219.3 5270.4 14:48:34 INFO - PROCESS | 28194 | 14:48:34 INFO - PROCESS | 28194 | [#4] prototype.html Cycles:180 Average:5656.79 Median:6462.13 stddev:1690.39 (26.2%) stddev-sans-first:1647.72 14:48:34 INFO - PROCESS | 28194 | Values: 360.4 360.8 366.1 371.4 373.3 6411.9 6424.6 6433.5 6433.6 6495.8 6402.7 6408.7 6410.2 6426.3 6441.8 4666.8 4775.9 4855.1 4862.1 4876.9 4881.3 4898.9 4918.1 4925.8 4927.8 4721.6 4894.4 4897.1 4897.4 4897.8 4756.9 4836.2 4859.6 4872.7 4900.2 4306.8 4312.1 4320.8 4321.8 4323.8 6118.7 6128.5 6136.7 6138.1 6138.4 5701.8 5706.6 5708.1 5712.5 5721.7 6571.1 6726.0 6728.5 6730.1 6733.1 4648.9 4658.4 4674.5 4677.4 4686.8 7020.1 7083.0 7092.8 7093.9 7095.9 4774.5 4774.8 4779.1 4780.0 4783.5 4833.6 4839.9 4840.6 4843.6 4845.7 5614.6 5618.6 5626.1 5630.3 5639.5 6665.5 6802.7 6853.2 6855.1 6862.9 1736.5 1768.3 1769.8 1772.0 1773.0 1110.1 1174.1 1183.8 1189.8 1209.1 6419.9 6456.5 6467.7 6478.5 6482.1 6960.5 6961.5 6981.2 6992.1 7028.8 6483.1 6485.3 6491.8 6496.9 6498.3 3666.6 3740.9 3775.1 3778.6 3781.6 7195.2 7202.2 7208.4 7217.9 7237.3 7031.6 7047.8 7062.2 7080.6 7081.8 7196.4 7210.1 7218.6 7222.4 7227.0 6761.1 6950.3 6953.8 6959.1 6959.1 6810.9 6846.2 6856.8 6865.4 6870.2 7198.2 7203.4 7205.2 7205.6 7217.4 4919.4 4926.5 4927.2 4928.7 4929.2 6913.2 6914.5 6918.9 6926.3 6929.7 6607.4 6722.4 6743.6 6754.8 6764.4 6677.0 6699.0 6700.0 6709.1 6723.8 6606.3 6611.1 6612.2 6618.8 6623.2 6621.8 6756.7 6757.7 6770.8 6776.3 6491.5 6588.7 6644.8 6722.8 6744.3 14:48:34 INFO - PROCESS | 28194 | 14:48:34 INFO - PROCESS | 28194 | [#5] yui.html Cycles:180 Average:15807.28 Median:4898.18 stddev:17971.52 (366.9%) stddev-sans-first:17987.18 14:48:34 INFO - PROCESS | 28194 | Values: 924.3 929.7 930.0 948.3 956.9 15117.4 15481.8 15540.5 15553.2 15553.9 13900.9 14208.6 14219.6 14239.4 14264.9 738.4 878.4 894.6 899.7 900.6 887.3 892.9 894.5 896.3 896.4 944.4 944.9 946.7 946.9 948.1 770.3 913.5 924.2 925.8 927.7 686.8 686.8 688.8 689.3 689.5 14477.6 14517.4 14533.4 14539.9 14541.2 14539.5 14893.9 14923.4 15206.9 15419.5 12133.2 12493.8 12918.8 13250.5 13433.0 4772.9 4785.2 4792.1 4809.6 4900.1 54449.5 54575.0 54703.0 54840.0 54959.0 11514.9 11746.9 11912.5 11941.0 12032.8 20965.9 21884.2 21900.6 21960.2 21962.1 8639.1 8710.5 9254.1 9271.8 9296.6 4999.0 5001.1 5013.0 5083.4 5099.4 3536.4 3576.3 3583.4 3591.6 3593.1 607.0 649.4 673.8 678.0 692.2 781.9 787.5 800.5 810.4 814.5 10199.2 10234.5 10261.6 10291.1 10462.7 834.0 835.1 836.4 848.3 856.8 4896.2 4932.9 4951.9 4957.6 5056.0 63742.0 66818.0 66925.7 67001.7 67388.3 56256.4 56679.0 57187.4 57561.4 58480.1 50739.2 50753.5 50854.7 50953.0 51580.7 9401.2 9501.0 9512.3 9546.9 9582.9 39362.6 40062.6 40747.0 41081.8 41178.6 45691.3 50132.7 50351.5 50553.5 51702.2 12016.8 12072.0 12154.4 12286.8 12288.1 12239.0 12516.7 13384.2 13628.9 13635.2 12559.7 12669.8 12781.3 13170.9 13887.6 13777.9 14018.9 14098.9 14353.6 14667.5 13492.7 13701.9 13714.1 13772.9 13856.8 11459.8 11733.2 11888.8 11950.6 12027.3 10569.7 11256.4 11524.0 11586.2 11828.5 14:48:34 INFO - PROCESS | 28194 | -------- Summary: end -------- 14:48:34 INFO - PROCESS | 28194 | 14:48:34 INFO - TEST-INFO | 28194: exit 0 14:48:34 INFO - TEST-OK | dromaeo_css | took 1112668ms 14:48:34 INFO - TEST-START | kraken 14:48:34 INFO - operating with platform_type : linux_ 14:48:34 INFO - Initialising browser for kraken test... 14:48:34 INFO - TEST-INFO | started process 28381 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQNBKTH/profile http://localhost:39161/getInfo.html) 14:48:39 INFO - PROCESS | 28381 | __metrics Screen width/height:1600/1200 14:48:39 INFO - PROCESS | 28381 | colorDepth:24 14:48:39 INFO - PROCESS | 28381 | Browser inner width/height: 1024/697 14:48:39 INFO - PROCESS | 28381 | __metrics 14:48:40 ERROR - PROCESS | 28381 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:48:41 INFO - TEST-INFO | 28381: exit 0 14:48:41 INFO - Browser initialized. 14:48:41 INFO - Running cycle 1/1 for kraken test... 14:48:41 INFO - TEST-INFO | started process 28471 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQNBKTH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:48:53 INFO - PROCESS | 28471 | RSS: Main: 141737984 14:48:53 INFO - PROCESS | 28471 | 14:48:56 INFO - PROCESS | 28471 | Cycle 1(1): loaded http://localhost:39161/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39161/tests/kraken/driver.html?testName=audio-beat-detection) 14:48:56 INFO - PROCESS | 28471 | RSS: Main: 197349376 14:48:56 INFO - PROCESS | 28471 | 14:48:59 INFO - PROCESS | 28471 | Cycle 1(1): loaded http://localhost:39161/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39161/tests/kraken/driver.html?testName=audio-dft) 14:49:00 INFO - PROCESS | 28471 | RSS: Main: 182140928 14:49:00 INFO - PROCESS | 28471 | 14:49:02 INFO - PROCESS | 28471 | Cycle 1(1): loaded http://localhost:39161/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39161/tests/kraken/driver.html?testName=audio-fft) 14:49:03 INFO - PROCESS | 28471 | RSS: Main: 272838656 14:49:03 INFO - PROCESS | 28471 | 14:49:05 INFO - PROCESS | 28471 | Cycle 1(1): loaded http://localhost:39161/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39161/tests/kraken/driver.html?testName=audio-oscillator) 14:49:06 INFO - PROCESS | 28471 | RSS: Main: 178372608 14:49:06 INFO - PROCESS | 28471 | 14:49:08 INFO - PROCESS | 28471 | Cycle 1(1): loaded http://localhost:39161/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39161/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:49:08 INFO - PROCESS | 28471 | RSS: Main: 177410048 14:49:08 INFO - PROCESS | 28471 | 14:49:11 INFO - PROCESS | 28471 | Cycle 1(1): loaded http://localhost:39161/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39161/tests/kraken/driver.html?testName=imaging-darkroom) 14:49:12 INFO - PROCESS | 28471 | RSS: Main: 212316160 14:49:12 INFO - PROCESS | 28471 | 14:49:15 INFO - PROCESS | 28471 | Cycle 1(1): loaded http://localhost:39161/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39161/tests/kraken/driver.html?testName=imaging-desaturate) 14:49:16 INFO - PROCESS | 28471 | RSS: Main: 212226048 14:49:16 INFO - PROCESS | 28471 | 14:49:19 INFO - PROCESS | 28471 | Cycle 1(1): loaded http://localhost:39161/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39161/tests/kraken/driver.html?testName=json-parse-financial) 14:49:19 INFO - PROCESS | 28471 | RSS: Main: 212402176 14:49:19 INFO - PROCESS | 28471 | 14:49:21 INFO - PROCESS | 28471 | Cycle 1(1): loaded http://localhost:39161/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39161/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:49:21 INFO - PROCESS | 28471 | RSS: Main: 190750720 14:49:21 INFO - PROCESS | 28471 | 14:49:23 INFO - PROCESS | 28471 | Cycle 1(1): loaded http://localhost:39161/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39161/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:49:24 INFO - PROCESS | 28471 | RSS: Main: 192630784 14:49:24 INFO - PROCESS | 28471 | 14:49:26 INFO - PROCESS | 28471 | Cycle 1(1): loaded http://localhost:39161/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39161/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:49:26 INFO - PROCESS | 28471 | RSS: Main: 209661952 14:49:26 INFO - PROCESS | 28471 | 14:49:29 INFO - PROCESS | 28471 | Cycle 1(1): loaded http://localhost:39161/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39161/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:49:29 INFO - PROCESS | 28471 | RSS: Main: 215420928 14:49:29 INFO - PROCESS | 28471 | 14:49:32 INFO - PROCESS | 28471 | Cycle 1(1): loaded http://localhost:39161/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39161/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:49:33 INFO - PROCESS | 28471 | RSS: Main: 211394560 14:49:33 INFO - PROCESS | 28471 | 14:49:34 INFO - PROCESS | 28471 | Cycle 1(1): loaded http://localhost:39161/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39161/tests/kraken/driver.html?testName=ai-astar) 14:49:35 INFO - PROCESS | 28471 | RSS: Main: 275120128 14:49:35 INFO - PROCESS | 28471 | 14:49:35 INFO - PROCESS | 28471 | __start_tp_report 14:49:35 INFO - PROCESS | 28471 | _x_x_mozilla_page_load 14:49:35 INFO - PROCESS | 28471 | _x_x_mozilla_page_load_details 14:49:35 INFO - PROCESS | 28471 | |i|pagename|runs| 14:49:35 INFO - PROCESS | 28471 | |0;ai-astar;109;109;111;110;110;112;108;110;110;110 14:49:35 INFO - PROCESS | 28471 | |1;audio-beat-detection;154;126;154;182;127;157;160;128;171;127 14:49:35 INFO - PROCESS | 28471 | |2;audio-dft;163;164;159;160;162;161;161;162;161;160 14:49:35 INFO - PROCESS | 28471 | |3;audio-fft;76;78;78;180;78;75;73;75;167;73 14:49:35 INFO - PROCESS | 28471 | |4;audio-oscillator;91;91;150;92;93;92;150;92;92;149 14:49:35 INFO - PROCESS | 28471 | |5;imaging-gaussian-blur;117;117;117;118;117;116;116;116;117;116 14:49:35 INFO - PROCESS | 28471 | |6;imaging-darkroom;145;146;145;146;146;145;145;145;145;145 14:49:35 INFO - PROCESS | 28471 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;94 14:49:35 INFO - PROCESS | 28471 | |8;json-parse-financial;54;54;54;55;54;55;54;73;54;53 14:49:35 INFO - PROCESS | 28471 | |9;json-stringify-tinderbox;61;57;58;58;58;58;58;60;58;57 14:49:35 INFO - PROCESS | 28471 | |10;stanford-crypto-aes;74;72;71;73;74;74;73;75;74;73 14:49:35 INFO - PROCESS | 28471 | |11;stanford-crypto-ccm;113;114;111;111;113;111;112;112;132;127 14:49:35 INFO - PROCESS | 28471 | |12;stanford-crypto-pbkdf2;162;160;157;156;165;157;159;156;159;153 14:49:35 INFO - PROCESS | 28471 | |13;stanford-crypto-sha256-iterative;68;67;67;67;66;66;65;66;65;64 14:49:35 INFO - PROCESS | 28471 | __end_tp_report 14:49:35 INFO - PROCESS | 28471 | __start_cc_report 14:49:35 INFO - PROCESS | 28471 | _x_x_mozilla_cycle_collect,1616 14:49:35 INFO - PROCESS | 28471 | __end_cc_report 14:49:35 INFO - PROCESS | 28471 | __startTimestamp1463176175017__endTimestamp 14:49:35 INFO - PROCESS | 28471 | 14:49:35 INFO - PROCESS | 28471 | ------- Summary: start ------- 14:49:35 INFO - PROCESS | 28471 | Number of tests: 14 14:49:35 INFO - PROCESS | 28471 | 14:49:35 INFO - PROCESS | 28471 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.00 stddev:1.10 (1.0%) stddev-sans-first:1.12 14:49:35 INFO - PROCESS | 28471 | Values: 109.0 109.0 111.0 110.0 110.0 112.0 108.0 110.0 110.0 110.0 14:49:35 INFO - PROCESS | 28471 | 14:49:35 INFO - PROCESS | 28471 | [#1] audio-beat-detection Cycles:10 Average:148.60 Median:155.50 stddev:20.40 (13.1%) stddev-sans-first:21.54 14:49:35 INFO - PROCESS | 28471 | Values: 154.0 126.0 154.0 182.0 127.0 157.0 160.0 128.0 171.0 127.0 14:49:35 INFO - PROCESS | 28471 | 14:49:35 INFO - PROCESS | 28471 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:1.49 (0.9%) stddev-sans-first:1.45 14:49:35 INFO - PROCESS | 28471 | Values: 163.0 164.0 159.0 160.0 162.0 161.0 161.0 162.0 161.0 160.0 14:49:35 INFO - PROCESS | 28471 | 14:49:35 INFO - PROCESS | 28471 | [#3] audio-fft Cycles:10 Average:95.30 Median:75.50 stddev:41.37 (54.8%) stddev-sans-first:43.29 14:49:35 INFO - PROCESS | 28471 | Values: 76.0 78.0 78.0 180.0 78.0 75.0 73.0 75.0 167.0 73.0 14:49:35 INFO - PROCESS | 28471 | 14:49:35 INFO - PROCESS | 28471 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:92.00 stddev:27.93 (30.4%) stddev-sans-first:28.84 14:49:35 INFO - PROCESS | 28471 | Values: 91.0 91.0 150.0 92.0 93.0 92.0 150.0 92.0 92.0 149.0 14:49:35 INFO - PROCESS | 28471 | 14:49:35 INFO - PROCESS | 28471 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 14:49:35 INFO - PROCESS | 28471 | Values: 117.0 117.0 117.0 118.0 117.0 116.0 116.0 116.0 117.0 116.0 14:49:35 INFO - PROCESS | 28471 | 14:49:35 INFO - PROCESS | 28471 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 14:49:35 INFO - PROCESS | 28471 | Values: 145.0 146.0 145.0 146.0 146.0 145.0 145.0 145.0 145.0 145.0 14:49:35 INFO - PROCESS | 28471 | 14:49:35 INFO - PROCESS | 28471 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 14:49:35 INFO - PROCESS | 28471 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 14:49:35 INFO - PROCESS | 28471 | 14:49:35 INFO - PROCESS | 28471 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:54.00 stddev:6.00 (11.1%) stddev-sans-first:6.32 14:49:35 INFO - PROCESS | 28471 | Values: 54.0 54.0 54.0 55.0 54.0 55.0 54.0 73.0 54.0 53.0 14:49:35 INFO - PROCESS | 28471 | 14:49:35 INFO - PROCESS | 28471 | [#9] json-stringify-tinderbox Cycles:10 Average:58.30 Median:58.00 stddev:1.25 (2.2%) stddev-sans-first:0.87 14:49:35 INFO - PROCESS | 28471 | Values: 61.0 57.0 58.0 58.0 58.0 58.0 58.0 60.0 58.0 57.0 14:49:35 INFO - PROCESS | 28471 | 14:49:35 INFO - PROCESS | 28471 | [#10] stanford-crypto-aes Cycles:10 Average:73.30 Median:74.00 stddev:1.16 (1.6%) stddev-sans-first:1.20 14:49:35 INFO - PROCESS | 28471 | Values: 74.0 72.0 71.0 73.0 74.0 74.0 73.0 75.0 74.0 73.0 14:49:35 INFO - PROCESS | 28471 | 14:49:35 INFO - PROCESS | 28471 | [#11] stanford-crypto-ccm Cycles:10 Average:115.60 Median:113.00 stddev:7.49 (6.6%) stddev-sans-first:7.88 14:49:35 INFO - PROCESS | 28471 | Values: 113.0 114.0 111.0 111.0 113.0 111.0 112.0 112.0 132.0 127.0 14:49:35 INFO - PROCESS | 28471 | 14:49:35 INFO - PROCESS | 28471 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.40 Median:159.00 stddev:3.41 (2.1%) stddev-sans-first:3.35 14:49:35 INFO - PROCESS | 28471 | Values: 162.0 160.0 157.0 156.0 165.0 157.0 159.0 156.0 159.0 153.0 14:49:35 INFO - PROCESS | 28471 | 14:49:35 INFO - PROCESS | 28471 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.50 stddev:1.20 (1.8%) stddev-sans-first:1.05 14:49:35 INFO - PROCESS | 28471 | Values: 68.0 67.0 67.0 67.0 66.0 66.0 65.0 66.0 65.0 64.0 14:49:35 INFO - PROCESS | 28471 | -------- Summary: end -------- 14:49:35 INFO - PROCESS | 28471 | 14:49:35 INFO - TEST-INFO | 28471: exit 0 14:49:35 INFO - TEST-OK | kraken | took 61201ms 14:49:35 INFO - SUITE-END | took 1173s 14:49:36 INFO - Completed test suite (00:19:34) 14:49:36 INFO - javascript benchmark 14:49:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3314.436545787216, 3341.431956567382, 3349.3971085204666, 3392.3893699134146, 3400.727941764659, 5485.286912701348, 5532.834014979552, 5535.474129957647, 5538.390777014531, 5542.8337149885565, 5572.554195664347, 5573.442655734424, 5593.300837395325, 5598.1602759586085, 5631.971840140804, 5032.949670503293, 5054.595632349403, 5130.050940575987, 5182.119039763249, 5201.55786758126, 5030.874228144307, 5098.694078355292, 5119.846404607868, 5121.385433747955, 5126.461721519243, 5071.797128114871, 5133.332666753336, 5159.38087429509, 5161.638685292031, 5205.817796377128, 5201.973990130044, 5202.401723801773, 5226.163813789775, 5226.660267082628, 5256.868578285555, 5023.547880690755, 5069.923951140736, 5099.617528685327, 5123.385193776733, 5132.769025393866, 5528.640638358494, 5546.833594992157, 5557.221988921554, 5573.944260557383, 5589.413111623262, 6097.664628445434, 6144.446999769997, 6146.108814221958, 6147.969260153671, 6149.754009839601, 5988.161657367972, 5999.700014999233, 6020.6688632125215, 6036.698165091728, 6150.077488376734, 5609.046462101453, 5624.55003599711, 5653.830385088454, 5656.971715141439, 5657.066584013592, 5778.422157784272, 6148.296553136854, 6178.135061091451, 6183.938160618426, 6189.04069869171, 5949.0481522956115, 5994.790182343684, 6000.489958353589, 6009.759609615654, 6040.426159514839, 6049.879002419927, 6071.180390647294, 6072.848178795565, 6077.0, 6100.206973093469, 5930.318013428425, 6016.669083200466, 6045.3652366501765, 6065.4541091302, 6065.848353791102, 6033.215681961405, 6041.033434650435, 6051.485623721945, 6058.697065146725, 6082.300535438393, 4568.680192386501, 4574.016586433866, 4578.748168850745, 4582.610478109398, 4600.217962946307, 4066.3900414938, 4080.591940805896, 4110.753354798721, 4117.444145040441, 4126.133511962522, 5660.150977353348, 5666.263385759825, 5676.772929082873, 5711.257536520226, 5714.285714285715, 5976.85057873548, 6030.939690603038, 6063.363346848606, 6063.878722425527, 6064.9090263646085, 5547.833564993057, 5615.466530679579, 5633.436656334334, 5668.0, 5697.886042279131, 5196.948030519647, 5198.610104242121, 5199.350081239845, 5202.635815492955, 5224.9738751306, 6227.0, 6228.252609686776, 6228.47058000066, 6231.532635052389, 6236.03341482071, 5973.1338955852025, 6005.819825405245, 6024.367441418675, 6068.939310606837, 6096.512279017579, 6175.116126074035, 6180.134781130555, 6215.9378406215355, 6221.3156552780065, 6228.688565571794, 5896.056630939029, 5896.64620122794, 5898.1152827076285, 5908.881822363614, 5939.16851640762, 5928.555358348055, 6128.601640893327, 6155.630662160284, 6157.876842463215, 6179.412955769375, 5931.911021334769, 5935.0, 5939.049752039826, 5954.3152537458745, 5959.28488581373, 5843.766249349978, 5892.381299963614, 5893.086571581412, 5894.0, 5906.320773111147, 5690.089585666274, 5699.629524080921, 5743.966086104541, 5761.510271626791, 5789.073748200268, 5908.261467316585, 5967.164596956516, 5971.3132989705, 5977.432143946318, 5991.221141251609, 5652.7173641318595, 5847.678377689268, 5859.267591551056, 5859.326177489644, 5880.852978675567], "value": 5560.23568287406, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.7110415896212, 656.8357910522369, 673.4915139070001, 680.1701923653143, 689.1729924091089, 33330.16674583137, 33970.830145849264, 34020.82989585049, 39232.80383598078, 40270.19459610814, 42989.570104298946, 43540.564594354044, 43544.782276088576, 43799.3430098548, 43976.0, 8143.877841832377, 8800.779980500474, 8976.8653470198, 8985.64057437705, 8989.775255618597, 8234.876476852822, 10664.413457259847, 10954.34273943562, 10960.0, 10961.56153753849, 10679.946600267027, 10758.193135514868, 10771.0, 10771.892281077207, 10777.245592808507, 8317.126701696296, 10619.946900265526, 10626.574937002511, 10665.413402262873, 10727.195460340467, 10427.94786026065, 10525.84211236832, 10536.841947370796, 10542.631007914686, 10544.420056896945, 40507.0, 40918.0, 41075.589244107476, 41082.58917410817, 41114.0, 4066.9389959150635, 4084.0402505411203, 4145.937810932838, 4332.241857674894, 4686.179918514281, 34092.82953585241, 34542.0, 34740.65259347399, 34931.30137397263, 34965.30069398623, 4577.748223847687, 4696.671233013691, 4719.905601887943, 4739.668223224376, 4753.3582966299455, 316382.0, 316791.0, 319355.9999999977, 320699.0, 321484.0, 41515.0, 68135.0, 69496.30503695, 69567.0, 69592.3040769596, 38937.80531097383, 39108.0, 39175.0, 39212.2157556853, 39233.80383098123, 18027.098645067694, 18312.450626481226, 18321.63356732858, 18323.816761832477, 18325.54186145357, 13544.86455135436, 14815.481458149128, 15086.924565377103, 15116.54650360491, 15172.241387930559, 9560.665376711782, 9601.087896649808, 9606.423614583147, 9618.230541556659, 9660.37207581519, 3736.252749450121, 3810.2189051244427, 3823.8470461181796, 3853.451030516048, 3874.1089549403796, 1183.8461000069935, 1192.8568571771443, 1203.7231436769591, 1206.9577564785366, 1297.6885547468728, 33752.49371259433, 34054.82972585121, 34182.48726269108, 34631.134221644155, 34839.65160348415, 1237.8390809194748, 1248.0, 1265.8480982282001, 1307.1895424836662, 1307.9673008174873, 18010.549736256697, 18019.909900450413, 18237.54406139857, 18372.35696750607, 18498.907505462386, 489860.0, 495493.0, 497333.0, 497858.0, 498610.0, 62256.68871655613, 62947.6852615734, 63052.0, 63125.684371577845, 63242.0, 1521.634807646179, 1524.3902439024257, 1542.9845701543065, 1565.1000674612144, 1638.9344426222817, 30268.84865575746, 30823.2294192647, 31588.684113158575, 31672.208194795316, 32094.197645058128, 45013.0, 45137.0, 45259.99999999868, 45273.77363113163, 45279.54720452753, 314330.0, 317345.0, 317822.0, 317958.0, 318734.0, 27013.459730805665, 29342.0, 29397.265068372606, 29417.705822942353, 32136.83931580327, 43981.0, 44060.0, 44380.33429498625, 44381.33427998518, 44830.0, 36634.816825916765, 37416.438753419265, 37443.0, 37725.62274377331, 38064.0, 37170.25659486741, 37346.0, 37386.252274953804, 39365.80317098396, 41318.38022429726, 41919.37120943127, 42413.78793106015, 42673.0, 42875.142497150504, 43289.13421731611, 34970.65029349674, 36180.819095905405, 36474.08814779545, 36610.26779464343, 36659.0, 27796.166115016582, 28559.857200713865, 28736.568951465328, 28904.42191156123, 28930.98741544036], "value": 19737.39435405135, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.4074177634864, 429.7217650131577, 436.2474731088874, 439.66925781056585, 449.1645539296907, 19021.144048517814, 19220.807791922078, 19588.0, 20978.0, 21442.24952126676, 19780.70328945067, 20064.197432102734, 20451.386458406272, 20481.180752769873, 20511.589768204627, 5414.566834653228, 5765.308163020422, 5770.307563092435, 5778.046622307335, 5782.392848750884, 4366.8253269869165, 5666.348369937468, 5736.741846616891, 5982.192404025466, 6297.748090076391, 6270.780522681707, 6277.5291853110975, 6278.183836101301, 6281.340459251781, 6289.465395441393, 6232.345603711613, 6258.342873998233, 6277.121203031579, 6311.968440157792, 6447.54867159299, 3998.5001874765653, 4171.499420069611, 5506.339239291311, 5768.019436695772, 5777.335606405275, 23601.0, 23776.048958041658, 23808.523829523314, 23849.403764906016, 24053.759462405327, 2654.349684327333, 2762.240383894445, 3061.556074369204, 3067.662557118715, 3276.950845737316, 14659.926700366537, 14690.779638305434, 14724.263786810723, 14829.925850370679, 15030.0, 2040.8673436226597, 2070.430631576329, 2072.8030837070605, 2109.5148115933266, 2147.892605369725, 76382.0, 76680.0, 76708.0, 78111.609441953, 80729.59635201845, 10961.397123158144, 11093.611723589636, 11183.776324473465, 11288.887111128948, 12015.399230038463, 16019.519414417586, 16097.275622597012, 16105.838941610667, 16145.67708645844, 16148.111853848151, 9037.728868133967, 9084.545772711337, 9108.271338292921, 9205.585748641328, 9339.159475647224, 9185.127412895765, 9189.216027009556, 9196.540172991457, 9275.21160701348, 9453.669121580711, 7090.503664743418, 7168.132746901177, 7185.209626941032, 7226.0606121204955, 7228.602426866468, 1815.1074916318723, 1971.7732460766908, 1977.179470519747, 1977.6341376845041, 2093.9476513087293, 1028.7016765138176, 1120.1822669451346, 1135.5344308833503, 1160.2284480820329, 1186.1581710078003, 19558.608827823366, 19870.30453934134, 19917.800821991594, 19962.600747984958, 20095.0, 1109.4286442482128, 1114.5931734916696, 1119.9104071674246, 1131.7849608574345, 1145.7422080032093, 11478.784985379265, 11486.0811135109, 11571.479283432265, 11608.76782464346, 11628.360440175702, 473501.0, 476055.0, 480068.0, 482226.0, 483810.0, 77872.99999999886, 78701.60649196718, 79119.0, 79159.0, 79533.20466795373, 1089.536946797608, 1106.8505751723576, 1112.9276597021167, 1113.5768408004906, 1118.4266269269606, 17274.481765547054, 17666.0, 17792.288308467516, 17871.0, 18294.817051829312, 36070.8196459016, 36604.81697591495, 37281.62718372782, 38559.42160867533, 38825.417618736305, 51407.0, 51565.742171288905, 51802.0, 51966.48033519617, 52065.219021715464, 9247.537623118951, 9250.398724083183, 9345.532723363669, 9383.906160938302, 9540.141387275178, 13516.729665406834, 13779.931100344435, 13783.310834458438, 13801.171929684251, 14038.929805350908, 11895.762084758084, 12048.216865903689, 12169.756604868031, 12179.330136842558, 12361.196522226026, 11662.533498660297, 11757.235779674294, 11870.584529541424, 11893.76212475763, 12242.081843861568, 12234.571789987307, 12259.32573708419, 12318.938405307916, 12462.127651064338, 12575.49698012106, 8767.561621919007, 8865.822683546421, 8930.598123084346, 9001.864972025294, 9015.864762028443, 12215.144939854124, 12288.201266917622, 12391.876081239432, 12421.503139874303, 12601.87398126007], "value": 9780.043647167593, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1437.223899094489, 1575.0313557162344, 1588.0471716969819, 1737.140115642757, 1842.5577861313288, 7508.511946723466, 8033.317168040716, 8255.133211012848, 8276.462029968056, 8288.17118288171, 8165.632546535406, 8302.377321700882, 8323.16768323169, 8331.16688331168, 8336.874946875801, 2140.935771926837, 2184.5194057307444, 2346.249200255919, 2424.2000139953775, 2446.7308596054418, 2419.68544089269, 2422.733499315074, 2425.260295609838, 2425.5391475619576, 2425.9514809703796, 2256.6615007748887, 2293.048384920256, 2297.6783250344965, 2297.781710737477, 2308.8383813133087, 2100.537881666031, 2325.360525855386, 2339.532093581282, 2373.8694371809543, 2374.050379848057, 2322.8025617822336, 2329.720433547985, 2365.9171928982405, 2369.7274813396507, 2371.1108334374608, 8334.541600211985, 8375.45559538628, 8408.453450525758, 8411.915880841236, 8414.495130292202, 5171.482851714836, 5271.314729085233, 5282.339707536558, 5282.735863206863, 5285.814996475144, 3557.5375201223933, 3575.535180426554, 3620.7284453665816, 3698.260347930425, 3735.346314394997, 1158.461315488302, 1163.906887449002, 1173.6948393417688, 1190.4523918997186, 1197.9341136237504, 11818.468168932419, 11854.170208085437, 11865.940670296679, 11888.465019074163, 11911.642650720492, 4563.931541026887, 4683.695559788671, 4689.577937985529, 4742.881427964328, 4752.025834703946, 10202.795944081077, 10225.233107516966, 10233.846492302622, 10236.744081397876, 10242.641507547349, 5166.638335316492, 5177.508136727005, 5184.0, 5184.8963020739375, 5185.0, 4325.2214601371425, 4650.279206722963, 4663.160631086369, 4725.810967561328, 4737.692050016738, 3936.252112098692, 3966.186931678999, 3995.5405128410603, 4027.154297597479, 4032.6773858091283, 1263.9747205055846, 1282.0320657903223, 1284.312892602472, 1290.2645492069619, 1295.5854126679371, 916.5234078279258, 990.9504524773877, 1065.8667666541683, 1080.227637239362, 1082.2640604389092, 5826.563007774434, 5826.737796799154, 5842.415758424124, 5924.7926322578505, 6019.277686677627, 934.2852717670987, 935.251798561162, 954.1126752120456, 959.6804393958307, 966.1256562810668, 3971.126352202511, 3998.8800335989968, 4010.3583426651594, 4017.9196416071513, 4042.717009809344, 10440.0, 10641.201909856793, 10700.678979630624, 10716.0, 10741.570337186426, 10493.475326233658, 10499.160067194605, 10524.579016839241, 10547.736306592396, 10550.0, 8157.347412207009, 8185.140560241208, 8191.590420478952, 8259.174082591693, 8279.875801862976, 5863.94136058651, 5875.853103672443, 5878.412158784087, 5906.616069955439, 6062.120992456157, 8967.461952282883, 9105.453672779655, 9164.587593558439, 9177.54112294396, 9192.448453092837, 8893.377463577488, 8910.0, 8953.641854325753, 9062.0, 9407.24742020623, 6823.658817059028, 7128.180259270251, 7241.348278654947, 7309.086364204474, 7334.046573945353, 7844.568548729874, 8055.154208808225, 8070.798230044061, 8073.394495412985, 8095.150009248944, 7100.715971361295, 7355.66899489535, 7426.220246874001, 7483.363914067365, 7552.6223688816435, 7005.894911576433, 7020.368166865007, 7056.7530136444975, 7088.858222835412, 7154.821129471805, 6413.77551785704, 6418.903716444351, 6453.903191452226, 6467.062275969864, 6470.352964703492, 4771.06964141989, 4780.187368147493, 4837.588804951619, 4839.733814640229, 4937.333459982857, 5178.171492561172, 5196.896062078662, 5201.0, 5219.295395121761, 5270.367555893164], "value": 4554.63638045016, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.4269211952994, 360.7853327270274, 366.1377456090906, 371.4001886952572, 373.34105304138217, 6411.903821442676, 6424.64664443456, 6433.5174861885425, 6433.646149461783, 6495.805125846232, 6402.711877965491, 6408.711607977641, 6410.1666783318105, 6426.325235850239, 6441.838954026151, 4666.78999445025, 4775.880602984936, 4855.126077306083, 4862.051899879525, 4876.926846097312, 4881.316615673809, 4898.853034408973, 4918.114739346916, 4925.802967881281, 4927.7536123193695, 4721.598664113537, 4894.388201474816, 4897.094037603055, 4897.436794768611, 4897.7795999180125, 4756.881077973044, 4836.15367310721, 4859.562639362474, 4872.731999740013, 4900.191468407708, 4306.849260275875, 4312.1160162167, 4320.805563749639, 4321.82712691492, 4323.762193079379, 6118.684482836212, 6128.479079278267, 6136.693165341715, 6138.0792881067755, 6138.447539721402, 5701.771929122871, 5706.572007099484, 5708.143778433268, 5712.485876271156, 5721.713914304268, 6571.112899758567, 6725.966370168167, 6728.495362847757, 6730.0577919091365, 6733.09103271057, 4648.907021859543, 4658.440987081572, 4674.532546745332, 4677.391939047902, 4686.812527498896, 7020.087388639444, 7083.0437890885105, 7092.751753688648, 7093.858122837514, 7095.858082838366, 4774.522547745198, 4774.785134668949, 4779.139754844092, 4780.0, 4783.521647835259, 4833.637477189225, 4839.927401088987, 4840.636952228597, 4843.564079232886, 4845.709257444564, 5614.6350487219015, 5618.578606604521, 5626.071698169756, 5630.296212973379, 5639.492445679908, 6665.533412661164, 6802.693878775467, 6853.211880633791, 6855.07456493377, 6862.897056544156, 1736.5224563244956, 1768.32803534656, 1769.7699299091037, 1772.0430967277525, 1773.0248363400335, 1110.0564520157802, 1174.107678164584, 1183.7514122034297, 1189.7917864373874, 1209.1173443386376, 6419.903701444482, 6456.51576131792, 6467.741290348427, 6478.481721462272, 6482.124913136666, 6960.512764106464, 6961.512694111364, 6981.232064472904, 6992.1259842519685, 7028.789136325919, 6483.09236706852, 6485.254195767548, 6491.837704057342, 6496.870062598721, 6498.252700939358, 3666.5966743658178, 3740.9064773380337, 3775.0562359410146, 3778.6410291022307, 3781.621837816251, 7195.172555156119, 7202.171750248684, 7208.387287080552, 7217.8917316240295, 7237.312455316736, 7031.6484175791, 7047.753328633473, 7062.15254169503, 7080.575165489984, 7081.822954426078, 7196.424286057103, 7210.062691850131, 7218.59237448703, 7222.422206223385, 7227.0, 6761.121054262914, 6950.339717726808, 6953.826154346182, 6959.095317608679, 6959.130108736408, 6810.8637827244165, 6846.178458584803, 6856.834338162624, 6865.41643960269, 6870.244273130052, 7198.20819709821, 7203.387712044535, 7205.207427182901, 7205.567665940061, 7217.386522145676, 4919.409670839522, 4926.48271931442, 4927.187014142626, 4928.654994150518, 4929.151568161939, 6913.2049814272, 6914.5159838812815, 6918.896216556856, 6926.341997510229, 6929.688164032731, 6607.405333520006, 6722.361375669304, 6743.629100399525, 6754.763583274562, 6764.425023873026, 6677.0, 6699.0, 6699.9665001674675, 6709.094272273181, 6723.7646682365885, 6606.339366063356, 6611.07444957716, 6612.173478315211, 6618.768343107968, 6623.205215374186, 6621.768238111643, 6756.729730810909, 6757.662116894234, 6770.796876093725, 6776.322367763381, 6491.545591808528, 6588.703508342041, 6644.767433139817, 6722.831929201809, 6744.325567443217], "value": 5112.396175678021, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [924.2605915267784, 929.7180951242113, 929.9770252722006, 948.3409030723641, 956.9425834449934, 15117.395304187832, 15481.84518154818, 15540.456084037061, 15553.222338883053, 15553.922230388833, 13900.930495347535, 14208.644783880382, 14219.644508887282, 14239.3592288347, 14264.928675356608, 738.4314078159828, 878.4290211362634, 894.5661354243186, 899.6716198587501, 900.6172376739892, 887.3256325192835, 892.9151730585584, 894.5393122541897, 896.2874514760748, 896.4262871762045, 944.3814301632442, 944.9102335278137, 946.7349142240183, 946.8863736351648, 948.1324588002004, 770.2836362183167, 913.4519288426957, 924.2375040591539, 925.8472352061901, 927.6938610258633, 686.7836631461074, 686.8248596607883, 688.7899190746821, 689.3175756001523, 689.48633268215, 14477.638059048502, 14517.419303227858, 14533.418663253457, 14539.927300363537, 14541.200233987127, 14539.491117810825, 14893.925530372388, 14923.403063877431, 15206.923965380101, 15419.460318888785, 12133.21134126279, 12493.75012499754, 12918.772716592002, 13250.536231231861, 13433.0, 4772.904541909143, 4785.234362502018, 4792.0895029944195, 4809.639277054235, 4900.142475066885, 54449.45550544523, 54575.0, 54703.0, 54840.0, 54959.0, 11514.94242528782, 11746.941265293619, 11912.523499060115, 11941.0, 12032.759344813056, 20965.895170524356, 21884.234051808427, 21900.561988760455, 21960.231391901525, 21962.121515139217, 8639.13608639131, 8710.52092134926, 9254.074592540692, 9271.76820579491, 9296.581653825595, 4999.0, 5001.074801161724, 5013.0, 5083.415407228142, 5099.388073431212, 3536.3634545781492, 3576.2847430514003, 3583.4445660922597, 3591.6049234584175, 3593.065802891215, 606.9605475644069, 649.4285029174297, 673.7978606418153, 677.9627120508321, 692.1832237959156, 781.9296263336327, 787.5432249295395, 800.4676889868289, 810.4367464612155, 814.539785021461, 10199.18406527476, 10234.48827558619, 10261.640842570474, 10291.125254353314, 10462.68611941643, 833.966641334352, 835.1231207232381, 836.4019725896013, 848.253536887535, 856.8372009318209, 4896.216605343128, 4932.901341973212, 4951.876203094951, 4957.578605818474, 5056.0, 63742.0, 66818.0, 66925.66537167283, 67001.66499167473, 67388.32611673919, 56256.43743562512, 56679.0, 57187.428125719045, 57561.42438575644, 58480.12279815806, 50739.23891141636, 50753.49246507488, 50854.745726271874, 50953.0, 51580.74209629003, 9401.20089792348, 9500.95249523748, 9512.2865785065, 9546.856797148188, 9582.904170958202, 39362.606373935894, 40062.599374005884, 40747.0, 41081.79459102685, 41178.58821411747, 45691.31463028124, 50132.74933625309, 50351.49648503468, 50553.49446505488, 51702.22446663379, 12016.819747703617, 12072.0, 12154.392280385768, 12286.754264914473, 12288.078394120656, 12239.0, 12516.687082823002, 13384.19694818314, 13628.86371136276, 13635.181889086687, 12559.748805024032, 12669.8099528509, 12781.29702866314, 13170.934145329213, 13887.583372498437, 13777.862221377658, 14018.929905350407, 14098.929505352407, 14353.569392918229, 14667.48663796762, 13492.730145397234, 13701.862981370059, 13714.143797342605, 13772.931135344259, 13856.792148117585, 11459.828102578302, 11733.237339572901, 11888.821667674818, 11950.581729639422, 12027.338496382783, 10569.682909512727, 11256.380899050631, 11524.0, 11586.246893951866, 11828.52685892589], "value": 7315.202745525215, "unit": "score"}], "name": "dromaeo_css", "value": 7533.748447049439, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 109.0, 111.0, 110.0, 110.0, 112.0, 108.0, 110.0, 110.0, 110.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 126.0, 154.0, 182.0, 127.0, 157.0, 160.0, 128.0, 171.0, 127.0], "value": 148.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 159.0, 160.0, 162.0, 161.0, 161.0, 162.0, 161.0, 160.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 78.0, 180.0, 78.0, 75.0, 73.0, 75.0, 167.0, 73.0], "value": 95.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 150.0, 92.0, 93.0, 92.0, 150.0, 92.0, 92.0, 149.0], "value": 109.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 116.0, 116.0, 116.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 55.0, 54.0, 55.0, 54.0, 73.0, 54.0, 53.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 57.0, 58.0, 58.0, 58.0, 58.0, 58.0, 60.0, 58.0, 57.0], "value": 58.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 71.0, 73.0, 74.0, 74.0, 73.0, 75.0, 74.0, 73.0], "value": 73.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 111.0, 111.0, 113.0, 111.0, 112.0, 112.0, 132.0, 127.0], "value": 115.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 157.0, 156.0, 165.0, 157.0, 159.0, 156.0, 159.0, 153.0], "value": 158.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 67.0, 66.0, 66.0, 65.0, 66.0, 65.0, 64.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1508.9, "alertThreshold": 2.0}]} 14:49:36 INFO - Return code: 0 14:49:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:49:36 ERROR - # TBPL SUCCESS # 14:49:36 INFO - Running post-action listener: _resource_record_post_action 14:49:36 INFO - Running post-run listener: _resource_record_post_run 14:49:37 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 262144; Write bytes: 496521216; Read time: 28; Write time: 784204 14:49:37 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 254955520; Read time: 0; Write time: 466944 14:49:37 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 262144; Write bytes: 241565696; Read time: 28; Write time: 317260 14:49:37 INFO - Running post-run listener: _upload_blobber_files 14:49:37 INFO - Blob upload gear active. 14:49:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:49:37 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:49:37 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:49:37 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:49:38 INFO - (blobuploader) - INFO - Open directory for files ... 14:49:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:49:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:49:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:49:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:49:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:49:39 INFO - (blobuploader) - INFO - Done attempting. 14:49:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:49:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:49:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:49:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:49:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:49:39 INFO - (blobuploader) - INFO - Done attempting. 14:49:39 INFO - (blobuploader) - INFO - Iteration through files over. 14:49:39 INFO - Return code: 0 14:49:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:49:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:49:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d967efbdee5372e0a3521706c911eb417dd154879cb2c01a0e4d664b4b53f201e74bd266ff1764f6b7d477cb100fd1f332658b289980300d8c74d1a55c59c711", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a0fdfc176800618042201d753f963f391c8c9105d13d7d3a2c79870172ce02e85d9bb555e8cd3feeb03d146bf1b3077c086a5eed73e8d317ab92ba4de082abf6"} 14:49:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:49:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:49:39 INFO - Contents: 14:49:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d967efbdee5372e0a3521706c911eb417dd154879cb2c01a0e4d664b4b53f201e74bd266ff1764f6b7d477cb100fd1f332658b289980300d8c74d1a55c59c711", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a0fdfc176800618042201d753f963f391c8c9105d13d7d3a2c79870172ce02e85d9bb555e8cd3feeb03d146bf1b3077c086a5eed73e8d317ab92ba4de082abf6"} 14:49:39 INFO - Running post-run listener: copy_logs_to_upload_dir 14:49:39 INFO - Copying logs to upload dir... 14:49:39 INFO - mkdir: /builds/slave/test/build/upload/logs 14:49:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.357052 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-05-13 14:49:39.713020) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-13 14:49:39.716241) ========= 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=5cf47e208febbcd81da23b2e0000026f-1463174943.258325-510991029 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d967efbdee5372e0a3521706c911eb417dd154879cb2c01a0e4d664b4b53f201e74bd266ff1764f6b7d477cb100fd1f332658b289980300d8c74d1a55c59c711", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a0fdfc176800618042201d753f963f391c8c9105d13d7d3a2c79870172ce02e85d9bb555e8cd3feeb03d146bf1b3077c086a5eed73e8d317ab92ba4de082abf6"} 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.011459 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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d967efbdee5372e0a3521706c911eb417dd154879cb2c01a0e4d664b4b53f201e74bd266ff1764f6b7d477cb100fd1f332658b289980300d8c74d1a55c59c711", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a0fdfc176800618042201d753f963f391c8c9105d13d7d3a2c79870172ce02e85d9bb555e8cd3feeb03d146bf1b3077c086a5eed73e8d317ab92ba4de082abf6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-13 14:49:39.745227) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 14:49:39.745594) ========= 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=5cf47e208febbcd81da23b2e0000026f-1463174943.258325-510991029 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004513 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 14:49:39.830032) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 14:49:39.830370) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 14:49:39.830721) ========= ========= Total master_lag: 0.19 =========