builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1461703021.12 results: success (0) buildid: 20160426062558 builduid: 18458ff6a626441ea2f2e0a4fd3bd5e1 revision: cbeae0c4410bef3864b3d3f4ad939321c61cb15b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 13:37:01.121822) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 13:37:01.122369) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 13:37:01.122688) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 13:37:01.142499) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 13:37:01.143006) ========= 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=337fe3f4b1febe37b85fccc40000019e-1461703020.690475-831024322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-26 13:37:01-- 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% 46.3M=0s 2016-04-26 13:37:01 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115075 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 13:37:01.279510) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 13:37:01.279851) ========= 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=337fe3f4b1febe37b85fccc40000019e-1461703020.690475-831024322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019470 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 13:37:01.333483) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-26 13:37:01.334243) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev cbeae0c4410bef3864b3d3f4ad939321c61cb15b --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 cbeae0c4410bef3864b3d3f4ad939321c61cb15b --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=337fe3f4b1febe37b85fccc40000019e-1461703020.690475-831024322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-26 13:37:01,853 truncating revision to first 12 chars 2016-04-26 13:37:01,853 Setting DEBUG logging. 2016-04-26 13:37:01,853 attempt 1/10 2016-04-26 13:37:01,853 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/cbeae0c4410b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-26 13:37:02,813 unpacking tar archive at: mozilla-aurora-cbeae0c4410b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.248356 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-26 13:37:02.601283) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 13:37:02.601844) ========= script_repo_revision: cbeae0c4410bef3864b3d3f4ad939321c61cb15b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 13:37:02.602473) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 13:37:02.602962) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 13:37:02.614580) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-04-26 13:37:02.615272) ========= /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=337fe3f4b1febe37b85fccc40000019e-1461703020.690475-831024322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:37:03 INFO - MultiFileLogger online at 20160426 13:37:03 in /builds/slave/test 13:37:03 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 13:37:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:37:03 INFO - {'append_to_log': False, 13:37:03 INFO - 'base_work_dir': '/builds/slave/test', 13:37:03 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:37:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:37:03 INFO - 'branch': 'Mozilla-Aurora', 13:37:03 INFO - 'buildbot_json_path': 'buildprops.json', 13:37:03 INFO - 'config_files': ('talos/linux_config.py',), 13:37:03 INFO - 'default_actions': ('clobber', 13:37:03 INFO - 'read-buildbot-config', 13:37:03 INFO - 'download-and-extract', 13:37:03 INFO - 'populate-webroot', 13:37:03 INFO - 'create-virtualenv', 13:37:03 INFO - 'install', 13:37:03 INFO - 'run-tests'), 13:37:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:37:03 INFO - 'download_minidump_stackwalk': True, 13:37:03 INFO - 'download_symbols': 'ondemand', 13:37:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:37:03 INFO - 'tooltool.py': '/tools/tooltool.py', 13:37:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:37:03 INFO - '/tools/misc-python/virtualenv.py')}, 13:37:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:37:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:37:03 INFO - 'installer_path': 'installer.exe', 13:37:03 INFO - 'log_level': 'info', 13:37:03 INFO - 'log_name': 'talos', 13:37:03 INFO - 'log_to_console': True, 13:37:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:37:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:37:03 INFO - 'opt_config_files': (), 13:37:03 INFO - 'pip_index': False, 13:37:03 INFO - 'sps_profile': False, 13:37:03 INFO - 'sps_profile_interval': 0, 13:37:03 INFO - 'suite': 'dromaeojs', 13:37:03 INFO - 'system_bits': '32', 13:37:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:37:03 INFO - 'title': 'talos-linux64-ix-060', 13:37:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:37:03 INFO - 'use_talos_json': True, 13:37:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:37:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:37:03 INFO - 'work_dir': 'build'} 13:37:03 INFO - ##### 13:37:03 INFO - ##### Running clobber step. 13:37:03 INFO - ##### 13:37:03 INFO - Running pre-action listener: _resource_record_pre_action 13:37:03 INFO - Running main action method: clobber 13:37:03 INFO - rmtree: /builds/slave/test/build 13:37:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:37:04 INFO - Running post-action listener: _resource_record_post_action 13:37:04 INFO - ##### 13:37:04 INFO - ##### Running read-buildbot-config step. 13:37:04 INFO - ##### 13:37:04 INFO - Running pre-action listener: _resource_record_pre_action 13:37:04 INFO - Running main action method: read_buildbot_config 13:37:04 INFO - Using buildbot properties: 13:37:04 INFO - { 13:37:04 INFO - "project": "", 13:37:04 INFO - "product": "firefox", 13:37:04 INFO - "script_repo_revision": "production", 13:37:04 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 13:37:04 INFO - "repository": "", 13:37:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 13:37:04 INFO - "buildid": "20160426062558", 13:37:04 INFO - "pgo_build": "True", 13:37:04 INFO - "basedir": "/builds/slave/test", 13:37:04 INFO - "buildnumber": 194, 13:37:04 INFO - "slavename": "talos-linux64-ix-060", 13:37:04 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:37:04 INFO - "platform": "ubuntu64_hw", 13:37:04 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 13:37:04 INFO - "branch": "mozilla-aurora", 13:37:04 INFO - "repo_path": "releases/mozilla-aurora", 13:37:04 INFO - "revision": "cbeae0c4410bef3864b3d3f4ad939321c61cb15b", 13:37:04 INFO - "stage_platform": "linux64-pgo", 13:37:04 INFO - "builduid": "18458ff6a626441ea2f2e0a4fd3bd5e1", 13:37:04 INFO - "slavebuilddir": "test" 13:37:04 INFO - } 13:37:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 13:37:04 INFO - Running post-action listener: _resource_record_post_action 13:37:04 INFO - ##### 13:37:04 INFO - ##### Running download-and-extract step. 13:37:04 INFO - ##### 13:37:04 INFO - Running pre-action listener: _resource_record_pre_action 13:37:04 INFO - Running main action method: download_and_extract 13:37:04 INFO - mkdir: /builds/slave/test/build/tests 13:37:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:37:04 INFO - https://queue.taskcluster.net/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:37:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 13:37:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 13:37:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/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 13:37:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/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 13:37:05 INFO - Downloaded 1361 bytes. 13:37:05 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 13:37:05 INFO - Using the following test package requirements: 13:37:05 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 13:37:05 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:37:05 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 13:37:05 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:37:05 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 13:37:05 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:37:05 INFO - u'jsshell-linux-x86_64.zip'], 13:37:05 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:37:05 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 13:37:05 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 13:37:05 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:37:05 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 13:37:05 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:37:05 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 13:37:05 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:37:05 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 13:37:05 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:37:05 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 13:37:05 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:37:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:37:05 INFO - https://queue.taskcluster.net/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:37:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 13:37:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 13:37:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/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 13:37:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/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 13:37:12 INFO - Downloaded 23820445 bytes. 13:37: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'] 13:37: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 13:37:13 INFO - Return code: 0 13:37:13 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 13:37:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:37:13 INFO - https://queue.taskcluster.net/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:37:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 13:37:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 13:37:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/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 13:37:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/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 13:37:40 INFO - Downloaded 23820445 bytes. 13:37:40 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'] 13:37:40 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 13:37:42 INFO - Return code: 0 13:37:42 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')]} 13:37:42 INFO - https://queue.taskcluster.net/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:37:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 13:37:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 13:37:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/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 13:37:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/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 13:37:44 INFO - Downloaded 10840145 bytes. 13:37:44 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'] 13:37:44 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 13:37:44 INFO - Return code: 0 13:37:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:37:44 INFO - https://queue.taskcluster.net/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:37:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 13:37:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 13:37:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/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 13:37:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiPQa71WSP-SD0XstXuXXg/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 13:37:56 INFO - Downloaded 62689705 bytes. 13:37:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 13:37:56 INFO - mkdir: /builds/slave/test/properties 13:37:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:37:56 INFO - Writing to file /builds/slave/test/properties/build_url 13:37:56 INFO - Contents: 13:37:56 INFO - build_url:https://queue.taskcluster.net/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 13:37:57 INFO - Running post-action listener: _resource_record_post_action 13:37:57 INFO - Running post-action listener: set_extra_try_arguments 13:37:57 INFO - ##### 13:37:57 INFO - ##### Running populate-webroot step. 13:37:57 INFO - ##### 13:37:57 INFO - Running pre-action listener: _resource_record_pre_action 13:37:57 INFO - Running main action method: populate_webroot 13:37:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:37:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:37:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:37:57 INFO - '--tppagecycles', 13:37:57 INFO - '7'], 13:37:57 INFO - 'tests': ['tsvgm']}}, 13:37:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:37:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:37:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:37:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:37:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:37:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:37:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:37:57 INFO - 'talos_options': ['--disable-e10s'], 13:37:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:37:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:37:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:37:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:37:57 INFO - 'talos_options': ['--disable-e10s'], 13:37:57 INFO - 'tests': ['damp', 'tps']}, 13:37:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:37:57 INFO - 'tests': ['damp', 'tps']}, 13:37:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:37:57 INFO - 'tests': ['dromaeo_dom']}, 13:37:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:37:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:37:57 INFO - 'tests': ['a11yr', 13:37:57 INFO - 'ts_paint', 13:37:57 INFO - 'tpaint', 13:37:57 INFO - 'sessionrestore', 13:37:57 INFO - 'sessionrestore_no_auto_restore', 13:37:57 INFO - 'tabpaint']}, 13:37:57 INFO - 'other-e10s': {'tests': ['a11yr', 13:37:57 INFO - 'ts_paint', 13:37:57 INFO - 'tpaint', 13:37:57 INFO - 'sessionrestore', 13:37:57 INFO - 'sessionrestore_no_auto_restore', 13:37:57 INFO - 'tabpaint']}, 13:37:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:37:57 INFO - 'ts_paint', 13:37:57 INFO - 'tpaint', 13:37:57 INFO - 'sessionrestore', 13:37:57 INFO - 'sessionrestore_no_auto_restore', 13:37:57 INFO - 'tabpaint']}, 13:37:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:37:57 INFO - 'ts_paint', 13:37:57 INFO - 'tpaint', 13:37:57 INFO - 'sessionrestore', 13:37:57 INFO - 'sessionrestore_no_auto_restore', 13:37:57 INFO - 'tabpaint']}, 13:37:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:37:57 INFO - 'tests': ['a11yr', 13:37:57 INFO - 'ts_paint', 13:37:57 INFO - 'tpaint', 13:37:57 INFO - 'sessionrestore', 13:37:57 INFO - 'sessionrestore_no_auto_restore', 13:37:57 INFO - 'tabpaint']}, 13:37:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:37:57 INFO - 'tests': ['a11yr', 13:37:57 INFO - 'ts_paint', 13:37:57 INFO - 'tpaint', 13:37:57 INFO - 'sessionrestore', 13:37:57 INFO - 'sessionrestore_no_auto_restore', 13:37:57 INFO - 'tabpaint']}, 13:37:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:37:57 INFO - 'tests': ['tsvgx', 13:37:57 INFO - 'tsvgr_opacity', 13:37:57 INFO - 'tart', 13:37:57 INFO - 'tscrollx', 13:37:57 INFO - 'cart']}, 13:37:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:37:57 INFO - 'tsvgr_opacity', 13:37:57 INFO - 'tart', 13:37:57 INFO - 'tscrollx', 13:37:57 INFO - 'cart']}, 13:37:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:37:57 INFO - 'talos_options': ['--disable-e10s'], 13:37:57 INFO - 'tests': ['tp5o']}, 13:37:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:37:57 INFO - 'tests': ['tp5o']}, 13:37:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:37:57 INFO - 'talos_options': ['--disable-e10s', 13:37:57 INFO - '--xperf_path', 13:37:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:37:57 INFO - 'tests': ['tp5n']}, 13:37:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:37:57 INFO - 'talos_options': ['--xperf_path', 13:37:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:37:57 INFO - 'tests': ['tp5n']}}, 13:37:57 INFO - 'talos.zip': {'path': '', 13:37:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:37:57 INFO - Running post-action listener: _resource_record_post_action 13:37:57 INFO - ##### 13:37:57 INFO - ##### Running create-virtualenv step. 13:37:57 INFO - ##### 13:37:57 INFO - Running pre-action listener: _resource_record_pre_action 13:37:57 INFO - Running main action method: create_virtualenv 13:37:57 INFO - Creating virtualenv /builds/slave/test/build/venv 13:37:57 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 13:37:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:37:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:37:57 INFO - Using real prefix '/usr' 13:37:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:37:58 INFO - Installing distribute.............................................................................................................................................................................................done. 13:38:00 INFO - Installing pip.................done. 13:38:00 INFO - Return code: 0 13:38:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:38: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')]} 13:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:38:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38: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')]} 13:38:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:38:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f49e1d5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224c410>, '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 0x224d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x224d7a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1461703020.690475-831024322', '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 13:38:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:38:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:38:00 INFO - Using env: {'DISPLAY': ':0', 13:38:00 INFO - 'HOME': '/home/cltbld', 13:38:00 INFO - 'LANG': 'en_US.UTF-8', 13:38:00 INFO - 'LANGUAGE': 'en_US:en', 13:38:00 INFO - 'LOGNAME': 'cltbld', 13:38:00 INFO - 'MAIL': '/var/mail/cltbld', 13:38:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:38:00 INFO - 'MOZ_NO_REMOTE': '1', 13:38:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:38:00 INFO - 'NO_EM_RESTART': '1', 13:38:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:38:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:38:00 INFO - 'PWD': '/builds/slave/test', 13:38:00 INFO - 'SHELL': '/bin/bash', 13:38:00 INFO - 'SHLVL': '1', 13:38:00 INFO - 'TERM': 'linux', 13:38:00 INFO - 'TMOUT': '86400', 13:38:00 INFO - 'USER': 'cltbld', 13:38:00 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1461703020.690475-831024322', 13:38:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:38:00 INFO - '_': '/tools/buildbot/bin/python'} 13:38:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:38:00 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 13:38:00 INFO - Cleaning up... 13:38:00 INFO - Return code: 0 13:38:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:38: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')]} 13:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:38:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38: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')]} 13:38:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:38:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f49e1d5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224c410>, '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 0x224d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x224d7a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1461703020.690475-831024322', '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 13:38:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 13:38:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 13:38:00 INFO - Using env: {'DISPLAY': ':0', 13:38:00 INFO - 'HOME': '/home/cltbld', 13:38:00 INFO - 'LANG': 'en_US.UTF-8', 13:38:00 INFO - 'LANGUAGE': 'en_US:en', 13:38:00 INFO - 'LOGNAME': 'cltbld', 13:38:00 INFO - 'MAIL': '/var/mail/cltbld', 13:38:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:38:00 INFO - 'MOZ_NO_REMOTE': '1', 13:38:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:38:00 INFO - 'NO_EM_RESTART': '1', 13:38:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:38:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:38:00 INFO - 'PWD': '/builds/slave/test', 13:38:00 INFO - 'SHELL': '/bin/bash', 13:38:00 INFO - 'SHLVL': '1', 13:38:00 INFO - 'TERM': 'linux', 13:38:00 INFO - 'TMOUT': '86400', 13:38:00 INFO - 'USER': 'cltbld', 13:38:00 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1461703020.690475-831024322', 13:38:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:38:00 INFO - '_': '/tools/buildbot/bin/python'} 13:38:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:38:00 INFO - Downloading/unpacking psutil>=0.7.1 13:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:38:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:38:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:38:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:38:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:38:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:38:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:38:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:38:02 INFO - Installing collected packages: psutil 13:38:02 INFO - Running setup.py install for psutil 13:38:02 INFO - building 'psutil._psutil_linux' extension 13:38:02 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 13:38:02 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 13:38:03 INFO - building 'psutil._psutil_posix' extension 13:38:03 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 13:38:03 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 13:38:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:38:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:38:03 INFO - Successfully installed psutil 13:38:03 INFO - Cleaning up... 13:38:03 INFO - Return code: 0 13:38:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:38:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:38:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:38:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:38:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f49e1d5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224c410>, '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 0x224d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x224d7a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1461703020.690475-831024322', '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 13:38:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 13:38:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 13:38:03 INFO - Using env: {'DISPLAY': ':0', 13:38:03 INFO - 'HOME': '/home/cltbld', 13:38:03 INFO - 'LANG': 'en_US.UTF-8', 13:38:03 INFO - 'LANGUAGE': 'en_US:en', 13:38:03 INFO - 'LOGNAME': 'cltbld', 13:38:03 INFO - 'MAIL': '/var/mail/cltbld', 13:38:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:38:03 INFO - 'MOZ_NO_REMOTE': '1', 13:38:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:38:03 INFO - 'NO_EM_RESTART': '1', 13:38:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:38:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:38:03 INFO - 'PWD': '/builds/slave/test', 13:38:03 INFO - 'SHELL': '/bin/bash', 13:38:03 INFO - 'SHLVL': '1', 13:38:03 INFO - 'TERM': 'linux', 13:38:03 INFO - 'TMOUT': '86400', 13:38:03 INFO - 'USER': 'cltbld', 13:38:03 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1461703020.690475-831024322', 13:38:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:38:03 INFO - '_': '/tools/buildbot/bin/python'} 13:38:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:38:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:38:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:38:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:38:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:38:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:38:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:38:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:38:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:38:05 INFO - Installing collected packages: mozsystemmonitor 13:38:05 INFO - Running setup.py install for mozsystemmonitor 13:38:05 INFO - Successfully installed mozsystemmonitor 13:38:05 INFO - Cleaning up... 13:38:05 INFO - Return code: 0 13:38:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:38:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:38:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:38:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:38:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:05 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 0x7f49e1d5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224c410>, '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 0x224d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x224d7a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1461703020.690475-831024322', '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 13:38:05 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 13:38:05 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 13:38:05 INFO - Using env: {'DISPLAY': ':0', 13:38:05 INFO - 'HOME': '/home/cltbld', 13:38:05 INFO - 'LANG': 'en_US.UTF-8', 13:38:05 INFO - 'LANGUAGE': 'en_US:en', 13:38:05 INFO - 'LOGNAME': 'cltbld', 13:38:05 INFO - 'MAIL': '/var/mail/cltbld', 13:38:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:38:05 INFO - 'MOZ_NO_REMOTE': '1', 13:38:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:38:05 INFO - 'NO_EM_RESTART': '1', 13:38:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:38:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:38:05 INFO - 'PWD': '/builds/slave/test', 13:38:05 INFO - 'SHELL': '/bin/bash', 13:38:05 INFO - 'SHLVL': '1', 13:38:05 INFO - 'TERM': 'linux', 13:38:05 INFO - 'TMOUT': '86400', 13:38:05 INFO - 'USER': 'cltbld', 13:38:05 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1461703020.690475-831024322', 13:38:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:38:05 INFO - '_': '/tools/buildbot/bin/python'} 13:38:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:38:05 INFO - Downloading/unpacking blobuploader==1.2.4 13:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:38:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:38:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:38:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:38:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:38:07 INFO - Downloading blobuploader-1.2.4.tar.gz 13:38:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:38:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:38:07 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 13:38:07 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 13:38:07 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 13:38:07 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 13:38:07 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 13:38:07 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 13:38:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:38:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:38:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:38:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:38:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:38:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:38:08 INFO - Downloading docopt-0.6.1.tar.gz 13:38:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:38:08 INFO - Installing collected packages: blobuploader, requests, docopt 13:38:08 INFO - Running setup.py install for blobuploader 13:38:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:38:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:38:08 INFO - Running setup.py install for requests 13:38:08 INFO - Running setup.py install for docopt 13:38:08 INFO - Successfully installed blobuploader requests docopt 13:38:08 INFO - Cleaning up... 13:38:09 INFO - Return code: 0 13:38:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:38:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:38:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:38:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:38:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:38:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:09 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 0x7f49e1d5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224c410>, '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 0x224d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x224d7a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1461703020.690475-831024322', '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 13:38:09 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 13:38:09 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 13:38:09 INFO - Using env: {'DISPLAY': ':0', 13:38:09 INFO - 'HOME': '/home/cltbld', 13:38:09 INFO - 'LANG': 'en_US.UTF-8', 13:38:09 INFO - 'LANGUAGE': 'en_US:en', 13:38:09 INFO - 'LOGNAME': 'cltbld', 13:38:09 INFO - 'MAIL': '/var/mail/cltbld', 13:38:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:38:09 INFO - 'MOZ_NO_REMOTE': '1', 13:38:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:38:09 INFO - 'NO_EM_RESTART': '1', 13:38:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:38:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:38:09 INFO - 'PWD': '/builds/slave/test', 13:38:09 INFO - 'SHELL': '/bin/bash', 13:38:09 INFO - 'SHLVL': '1', 13:38:09 INFO - 'TERM': 'linux', 13:38:09 INFO - 'TMOUT': '86400', 13:38:09 INFO - 'USER': 'cltbld', 13:38:09 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1461703020.690475-831024322', 13:38:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:38:09 INFO - '_': '/tools/buildbot/bin/python'} 13:38:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:38:09 INFO - Running setup.py (path:/tmp/pip-dtwCMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:38:09 INFO - Running setup.py (path:/tmp/pip-TYX6tS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:38:09 INFO - Running setup.py (path:/tmp/pip-JZxfDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:38:09 INFO - Running setup.py (path:/tmp/pip-tDlosC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:38:09 INFO - Running setup.py (path:/tmp/pip-e3BWCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:38:09 INFO - Running setup.py (path:/tmp/pip-evv2mx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:38:09 INFO - Running setup.py (path:/tmp/pip-mVQTdB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:38:09 INFO - Running setup.py (path:/tmp/pip-FVaNJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:38:09 INFO - Running setup.py (path:/tmp/pip-CfZ37l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:38:09 INFO - Running setup.py (path:/tmp/pip-7ck9ZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:38:09 INFO - Running setup.py (path:/tmp/pip-i39AdR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:38:10 INFO - Running setup.py (path:/tmp/pip-o9azok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:38:10 INFO - Running setup.py (path:/tmp/pip-oaUqof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:38:10 INFO - Running setup.py (path:/tmp/pip-YASfDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:38:10 INFO - Running setup.py (path:/tmp/pip-J9OsB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:38:10 INFO - Running setup.py (path:/tmp/pip-7Lr0MG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:38:10 INFO - Running setup.py (path:/tmp/pip-P6to5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:38:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:38:10 INFO - Running setup.py install for manifestparser 13:38:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:38:10 INFO - Running setup.py install for mozcrash 13:38:10 INFO - Running setup.py install for mozdebug 13:38:10 INFO - Running setup.py install for mozdevice 13:38:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:38:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:38:10 INFO - Running setup.py install for mozfile 13:38:10 INFO - Running setup.py install for mozhttpd 13:38:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:38:11 INFO - Running setup.py install for mozinfo 13:38:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:38:11 INFO - Running setup.py install for mozInstall 13:38:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:38:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:38:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:38:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:38:11 INFO - Running setup.py install for mozleak 13:38:11 INFO - Running setup.py install for mozlog 13:38:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:38:11 INFO - Running setup.py install for moznetwork 13:38:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:38:11 INFO - Running setup.py install for mozprocess 13:38:11 INFO - Running setup.py install for mozprofile 13:38:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:38:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:38:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:38:11 INFO - Running setup.py install for mozrunner 13:38:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:38:11 INFO - Running setup.py install for mozscreenshot 13:38:12 INFO - Running setup.py install for moztest 13:38:12 INFO - Running setup.py install for mozversion 13:38:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:38:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:38:12 INFO - Cleaning up... 13:38:12 INFO - Return code: 0 13:38:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:38:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:38:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:38:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:12 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 0x7f49e1d5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224c410>, '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 0x224d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x224d7a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1461703020.690475-831024322', '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 13:38:12 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 13:38:12 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 13:38:12 INFO - Using env: {'DISPLAY': ':0', 13:38:12 INFO - 'HOME': '/home/cltbld', 13:38:12 INFO - 'LANG': 'en_US.UTF-8', 13:38:12 INFO - 'LANGUAGE': 'en_US:en', 13:38:12 INFO - 'LOGNAME': 'cltbld', 13:38:12 INFO - 'MAIL': '/var/mail/cltbld', 13:38:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:38:12 INFO - 'MOZ_NO_REMOTE': '1', 13:38:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:38:12 INFO - 'NO_EM_RESTART': '1', 13:38:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:38:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:38:12 INFO - 'PWD': '/builds/slave/test', 13:38:12 INFO - 'SHELL': '/bin/bash', 13:38:12 INFO - 'SHLVL': '1', 13:38:12 INFO - 'TERM': 'linux', 13:38:12 INFO - 'TMOUT': '86400', 13:38:12 INFO - 'USER': 'cltbld', 13:38:12 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1461703020.690475-831024322', 13:38:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:38:12 INFO - '_': '/tools/buildbot/bin/python'} 13:38:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:38:12 INFO - Running setup.py (path:/tmp/pip-a4gvDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:38:12 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)) 13:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:38:12 INFO - Running setup.py (path:/tmp/pip-wtVqhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:38:12 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)) 13:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:38:12 INFO - Running setup.py (path:/tmp/pip-WUIFx9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:38:12 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)) 13:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:38:12 INFO - Running setup.py (path:/tmp/pip-x_mHGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:38:12 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)) 13:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:38:12 INFO - Running setup.py (path:/tmp/pip-G71T_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:38:12 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)) 13:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:38:12 INFO - Running setup.py (path:/tmp/pip-g_J6De-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:38:12 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)) 13:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:38:12 INFO - Running setup.py (path:/tmp/pip-7f_b8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:38:12 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)) 13:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:38:12 INFO - Running setup.py (path:/tmp/pip-EHnl_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:38:13 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)) 13:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:38:13 INFO - Running setup.py (path:/tmp/pip-gstpCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:38:13 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)) 13:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:38:13 INFO - Running setup.py (path:/tmp/pip-6LfcOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:38:13 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)) 13:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:38:13 INFO - Running setup.py (path:/tmp/pip-QlGOnS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:38:13 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)) 13:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:38:13 INFO - Running setup.py (path:/tmp/pip-kfLcqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:38:13 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)) 13:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:38:13 INFO - Running setup.py (path:/tmp/pip-F4A0dj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:38:13 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)) 13:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:38:13 INFO - Running setup.py (path:/tmp/pip-iVEpgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:38:13 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)) 13:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:38:13 INFO - Running setup.py (path:/tmp/pip-CrCQ6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:38:13 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)) 13:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:38:13 INFO - Running setup.py (path:/tmp/pip-5yIYAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:38:13 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)) 13:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:38:13 INFO - Running setup.py (path:/tmp/pip-8vOusa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:38:13 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)) 13:38:13 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)) 13:38:13 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)) 13:38:13 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)) 13:38:13 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)) 13:38:13 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)) 13:38:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:38:13 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 13:38:13 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 13:38:13 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 13:38:13 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 13:38:13 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 13:38:13 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 13:38:15 INFO - Downloading blessings-1.6.tar.gz 13:38:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:38:15 INFO - Installing collected packages: blessings 13:38:15 INFO - Running setup.py install for blessings 13:38:15 INFO - Successfully installed blessings 13:38:15 INFO - Cleaning up... 13:38:15 INFO - Return code: 0 13:38:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:38:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:38:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:38:16 INFO - Reading from file tmpfile_stdout 13:38:16 INFO - Current package versions: 13:38:16 INFO - argparse == 1.2.1 13:38:16 INFO - blessings == 1.6 13:38:16 INFO - blobuploader == 1.2.4 13:38:16 INFO - docopt == 0.6.1 13:38:16 INFO - manifestparser == 1.1 13:38:16 INFO - mozInstall == 1.12 13:38:16 INFO - mozcrash == 0.17 13:38:16 INFO - mozdebug == 0.1 13:38:16 INFO - mozdevice == 0.48 13:38:16 INFO - mozfile == 1.2 13:38:16 INFO - mozhttpd == 0.7 13:38:16 INFO - mozinfo == 0.9 13:38:16 INFO - mozleak == 0.1 13:38:16 INFO - mozlog == 3.1 13:38:16 INFO - moznetwork == 0.27 13:38:16 INFO - mozprocess == 0.22 13:38:16 INFO - mozprofile == 0.28 13:38:16 INFO - mozrunner == 6.11 13:38:16 INFO - mozscreenshot == 0.1 13:38:16 INFO - mozsystemmonitor == 0.0 13:38:16 INFO - moztest == 0.7 13:38:16 INFO - mozversion == 1.4 13:38:16 INFO - psutil == 3.1.1 13:38:16 INFO - requests == 1.2.3 13:38:16 INFO - wsgiref == 0.1.2 13:38:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:38: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')]} 13:38:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:38:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38: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')]} 13:38:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:38:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:16 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 0x7f49e1d5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224c410>, '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 0x224d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x224d7a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1461703020.690475-831024322', '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 13:38:16 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 13:38:16 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 13:38:16 INFO - Using env: {'DISPLAY': ':0', 13:38:16 INFO - 'HOME': '/home/cltbld', 13:38:16 INFO - 'LANG': 'en_US.UTF-8', 13:38:16 INFO - 'LANGUAGE': 'en_US:en', 13:38:16 INFO - 'LOGNAME': 'cltbld', 13:38:16 INFO - 'MAIL': '/var/mail/cltbld', 13:38:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:38:16 INFO - 'MOZ_NO_REMOTE': '1', 13:38:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:38:16 INFO - 'NO_EM_RESTART': '1', 13:38:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:38:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:38:16 INFO - 'PWD': '/builds/slave/test', 13:38:16 INFO - 'SHELL': '/bin/bash', 13:38:16 INFO - 'SHLVL': '1', 13:38:16 INFO - 'TERM': 'linux', 13:38:16 INFO - 'TMOUT': '86400', 13:38:16 INFO - 'USER': 'cltbld', 13:38:16 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1461703020.690475-831024322', 13:38:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:38:16 INFO - '_': '/tools/buildbot/bin/python'} 13:38:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:38:16 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)) 13:38:16 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)) 13:38:16 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)) 13:38:16 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)) 13:38:16 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)) 13:38:16 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)) 13:38:16 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)) 13:38:16 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)) 13:38:16 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)) 13:38:16 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)) 13:38:16 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)) 13:38:16 INFO - Cleaning up... 13:38:16 INFO - Return code: 0 13:38:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:38: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')]} 13:38:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:38:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38: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')]} 13:38:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:38:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f49e1d5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224c410>, '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 0x224d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x224d7a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1461703020.690475-831024322', '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 13:38:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:38:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:38:16 INFO - Using env: {'DISPLAY': ':0', 13:38:16 INFO - 'HOME': '/home/cltbld', 13:38:16 INFO - 'LANG': 'en_US.UTF-8', 13:38:16 INFO - 'LANGUAGE': 'en_US:en', 13:38:16 INFO - 'LOGNAME': 'cltbld', 13:38:16 INFO - 'MAIL': '/var/mail/cltbld', 13:38:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:38:16 INFO - 'MOZ_NO_REMOTE': '1', 13:38:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:38:16 INFO - 'NO_EM_RESTART': '1', 13:38:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:38:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:38:16 INFO - 'PWD': '/builds/slave/test', 13:38:16 INFO - 'SHELL': '/bin/bash', 13:38:16 INFO - 'SHLVL': '1', 13:38:16 INFO - 'TERM': 'linux', 13:38:16 INFO - 'TMOUT': '86400', 13:38:16 INFO - 'USER': 'cltbld', 13:38:16 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1461703020.690475-831024322', 13:38:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:38:16 INFO - '_': '/tools/buildbot/bin/python'} 13:38:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:38:16 INFO - Downloading/unpacking jsonschema 13:38:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:38:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:38:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:38:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:38:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:38:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:38:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:38:18 INFO - Downloading/unpacking functools32 (from jsonschema) 13:38:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:38:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:38:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:38:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:38:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:38:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:38:18 INFO - Downloading functools32-3.2.3-2.tar.gz 13:38:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:38:18 INFO - warning: no files found matching '*.txt' 13:38:18 INFO - no previously-included directories found matching 'build' 13:38:18 INFO - no previously-included directories found matching 'dist' 13:38:18 INFO - no previously-included directories found matching '.git*' 13:38:18 INFO - Installing collected packages: jsonschema, functools32 13:38:18 INFO - Running setup.py install for functools32 13:38:18 INFO - warning: no files found matching '*.txt' 13:38:18 INFO - no previously-included directories found matching 'build' 13:38:18 INFO - no previously-included directories found matching 'dist' 13:38:18 INFO - no previously-included directories found matching '.git*' 13:38:18 INFO - Successfully installed jsonschema functools32 13:38:18 INFO - Cleaning up... 13:38:18 INFO - Return code: 0 13:38:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:38: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')]} 13:38:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:38:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38: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')]} 13:38:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:38:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:18 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 0x7f49e1d5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224c410>, '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 0x224d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x224d7a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1461703020.690475-831024322', '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 13:38:18 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 13:38:18 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 13:38:18 INFO - Using env: {'DISPLAY': ':0', 13:38:18 INFO - 'HOME': '/home/cltbld', 13:38:18 INFO - 'LANG': 'en_US.UTF-8', 13:38:18 INFO - 'LANGUAGE': 'en_US:en', 13:38:18 INFO - 'LOGNAME': 'cltbld', 13:38:18 INFO - 'MAIL': '/var/mail/cltbld', 13:38:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:38:18 INFO - 'MOZ_NO_REMOTE': '1', 13:38:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:38:18 INFO - 'NO_EM_RESTART': '1', 13:38:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:38:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:38:18 INFO - 'PWD': '/builds/slave/test', 13:38:18 INFO - 'SHELL': '/bin/bash', 13:38:18 INFO - 'SHLVL': '1', 13:38:18 INFO - 'TERM': 'linux', 13:38:18 INFO - 'TMOUT': '86400', 13:38:18 INFO - 'USER': 'cltbld', 13:38:18 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1461703020.690475-831024322', 13:38:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:38:18 INFO - '_': '/tools/buildbot/bin/python'} 13:38:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:38:19 INFO - Downloading/unpacking flake8 13:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:38:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:38:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:38:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:38:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:38:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:38:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:38:21 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 13:38:21 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 13:38:21 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 13:38:21 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 13:38:21 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 13:38:21 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 13:38:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:38:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:38:21 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 13:38:21 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 13:38:21 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 13:38:21 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 13:38:21 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 13:38:21 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 13:38:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:38:21 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 13:38:21 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 13:38:21 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 13:38:21 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 13:38:21 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 13:38:21 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 13:38:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:38:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:38:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:38:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:38:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:38:21 INFO - no previously-included directories found matching 'docs/_build' 13:38:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:38:21 INFO - Running setup.py install for pep8 13:38:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:38:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:38:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:38:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:38:21 INFO - no previously-included directories found matching 'docs/_build' 13:38:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:38:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:38:21 INFO - Cleaning up... 13:38:22 INFO - Return code: 0 13:38:22 INFO - Running post-action listener: _resource_record_post_action 13:38:22 INFO - Running post-action listener: _start_resource_monitoring 13:38:22 INFO - Starting resource monitoring. 13:38:22 INFO - ##### 13:38:22 INFO - ##### Running install step. 13:38:22 INFO - ##### 13:38:22 INFO - Running pre-action listener: _resource_record_pre_action 13:38:22 INFO - Running main action method: install 13:38:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:38:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:38:22 INFO - Reading from file tmpfile_stdout 13:38:22 INFO - Detecting whether we're running mozinstall >=1.0... 13:38:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:38:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:38:22 INFO - Reading from file tmpfile_stdout 13:38:22 INFO - Output received: 13:38:22 INFO - Usage: mozinstall [options] installer 13:38:22 INFO - Options: 13:38:22 INFO - -h, --help show this help message and exit 13:38:22 INFO - -d DEST, --destination=DEST 13:38:22 INFO - Directory to install application into. [default: 13:38:22 INFO - "/builds/slave/test"] 13:38:22 INFO - --app=APP Application being installed. [default: firefox] 13:38:22 INFO - mkdir: /builds/slave/test/build/application 13:38:22 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'] 13:38:22 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 13:38:37 INFO - Reading from file tmpfile_stdout 13:38:37 INFO - Output received: 13:38:37 INFO - /builds/slave/test/build/application/firefox/firefox 13:38:37 INFO - Running post-action listener: _resource_record_post_action 13:38:37 INFO - ##### 13:38:37 INFO - ##### Running run-tests step. 13:38:37 INFO - ##### 13:38:37 INFO - Running pre-action listener: _resource_record_pre_action 13:38:37 INFO - Running main action method: run_tests 13:38:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:38:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:38:37 INFO - Python 2.7.3 13:38:37 INFO - Return code: 0 13:38:37 INFO - grabbing minidump binary from tooltool 13:38:37 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')]} 13:38:37 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 0x224c410>, '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 0x224d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x224d7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:38:37 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 13:38:37 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 13:38:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:38:37 INFO - Return code: 0 13:38:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:38:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:38:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:38:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:38:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:38:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:38:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:38:38 INFO - Return code: 0 13:38:38 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/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 13:38:38 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/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 13:38:38 INFO - Using env: {'DISPLAY': ':0', 13:38:38 INFO - 'HOME': '/home/cltbld', 13:38:38 INFO - 'LANG': 'en_US.UTF-8', 13:38:38 INFO - 'LANGUAGE': 'en_US:en', 13:38:38 INFO - 'LOGNAME': 'cltbld', 13:38:38 INFO - 'MAIL': '/var/mail/cltbld', 13:38:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:38:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:38:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:38:38 INFO - 'MOZ_NO_REMOTE': '1', 13:38:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:38:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:38:38 INFO - 'NO_EM_RESTART': '1', 13:38:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:38:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:38:38 INFO - 'PWD': '/builds/slave/test', 13:38:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:38:38 INFO - 'SHELL': '/bin/bash', 13:38:38 INFO - 'SHLVL': '1', 13:38:38 INFO - 'TERM': 'linux', 13:38:38 INFO - 'TMOUT': '86400', 13:38:38 INFO - 'USER': 'cltbld', 13:38:38 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1461703020.690475-831024322', 13:38:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:38:38 INFO - '_': '/tools/buildbot/bin/python'} 13:38:38 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/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 13:38:39 INFO - mozversion application_buildid: 20160426062558 13:38:39 INFO - mozversion application_changeset: cbeae0c4410bef3864b3d3f4ad939321c61cb15b 13:38:39 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:38:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:38:39 INFO - mozversion application_name: Firefox 13:38:39 INFO - mozversion application_remotingname: firefox-dev 13:38:39 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:38:39 INFO - mozversion application_vendor: Mozilla 13:38:39 INFO - mozversion application_version: 48.0a2 13:38:39 INFO - mozversion platform_buildid: 20160426062558 13:38:39 INFO - mozversion platform_changeset: cbeae0c4410bef3864b3d3f4ad939321c61cb15b 13:38:39 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:38:39 INFO - mozversion platform_version: 48.0a2 13:38:39 INFO - using testdate: 1461703119 13:38:39 INFO - actual date: 1461703119 13:38:39 INFO - starting webserver on 'localhost:40812' 13:38:39 INFO - SUITE-START | Running 2 tests 13:38:39 INFO - TEST-START | dromaeo_css 13:38:39 INFO - operating with platform_type : linux_ 13:38:39 INFO - Initialising browser for dromaeo_css test... 13:38:39 INFO - TEST-INFO | started process 17936 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT6Zk2n/profile http://localhost:40812/getInfo.html) 13:38:43 INFO - PROCESS | 17936 | __metrics Screen width/height:1600/1200 13:38:43 INFO - PROCESS | 17936 | colorDepth:24 13:38:43 INFO - PROCESS | 17936 | Browser inner width/height: 1024/697 13:38:43 INFO - PROCESS | 17936 | __metrics 13:38:44 ERROR - PROCESS | 17936 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:38:45 INFO - TEST-INFO | 17936: exit 0 13:38:45 INFO - Browser initialized. 13:38:45 INFO - Running cycle 1/1 for dromaeo_css test... 13:38:45 INFO - TEST-INFO | started process 18028 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT6Zk2n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:38:56 INFO - PROCESS | 18028 | RSS: Main: 142045184 13:38:56 INFO - PROCESS | 18028 | 13:39:48 INFO - PROCESS | 18028 | 1461703188576 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] 13:41:55 INFO - PROCESS | 18028 | Cycle 1(1): loaded http://localhost:40812/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40812/tests/dromaeo/cssquery-ext.html) 13:41:56 INFO - PROCESS | 18028 | RSS: Main: 254357504 13:41:56 INFO - PROCESS | 18028 | 13:44:58 INFO - PROCESS | 18028 | Cycle 1(1): loaded http://localhost:40812/tests/dromaeo/cssquery-ext.html (next: http://localhost:40812/tests/dromaeo/cssquery-jquery.html) 13:44:59 INFO - PROCESS | 18028 | RSS: Main: 231342080 13:44:59 INFO - PROCESS | 18028 | 13:48:00 INFO - PROCESS | 18028 | Cycle 1(1): loaded http://localhost:40812/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40812/tests/dromaeo/cssquery-mootools.html) 13:48:01 INFO - PROCESS | 18028 | RSS: Main: 227606528 13:48:01 INFO - PROCESS | 18028 | 13:51:03 INFO - PROCESS | 18028 | Cycle 1(1): loaded http://localhost:40812/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40812/tests/dromaeo/cssquery-prototype.html) 13:51:03 INFO - PROCESS | 18028 | RSS: Main: 221822976 13:51:03 INFO - PROCESS | 18028 | 13:54:06 INFO - PROCESS | 18028 | Cycle 1(1): loaded http://localhost:40812/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40812/tests/dromaeo/cssquery-yui.html) 13:54:07 INFO - PROCESS | 18028 | RSS: Main: 211394560 13:54:07 INFO - PROCESS | 18028 | 13:57:09 INFO - PROCESS | 18028 | Cycle 1(1): loaded http://localhost:40812/tests/dromaeo/cssquery-yui.html (next: http://localhost:40812/tests/dromaeo/cssquery-dojo.html) 13:57:09 INFO - PROCESS | 18028 | RSS: Main: 255451136 13:57:09 INFO - PROCESS | 18028 | 13:57:09 INFO - PROCESS | 18028 | __start_tp_report 13:57:09 INFO - PROCESS | 18028 | _x_x_mozilla_page_load 13:57:09 INFO - PROCESS | 18028 | _x_x_mozilla_page_load_details 13:57:09 INFO - PROCESS | 18028 | |i|pagename|runs| 13:57:09 INFO - PROCESS | 18028 | |0;dojo.html;3282.376348493786;3337.349216902705;3362.831858407079;3362.8318584070807;3400.1499625093725;5574.136008918614;5578.107502799543;5600.971995140024;5620.803271885485;5631.070873305905;5599.664020158793;5645.661260324383;5654.491095801377;5658.688772117532;5660.066089095294;4949.529794669501;5015.423226328964;5074.61940354474;5106.66806657566;5115.309433226523;5051.5453609175165;5098.617603679721;5099.7960081596875;5150.098732721759;5194.091034069042;5110.259012443194;5126.6923984561045;5171.974140129294;5174.146265866128;5187.299714538545;5069.518395752398;5107.540321371057;5179.896402071975;5185.325907632021;5199.896002079956;4936.185529387647;4996.900061998776;5012.022655582163;5031.84904452867;5043.218301163325;5479.369872464677;5511.200875872976;5521.420250873641;5526.917096243559;5533.806316778933;5809.24479817621;5927.199828023205;5976.163337132805;6014.0290914871875;6015.90514604585;6061.545384096166;6077.959912601904;6086.2087928569445;6089.969550152266;6096.420840020191;5656.717164141776;5659.4340565943485;5667.234923285386;5675.1770993205755;5694.658320500783;5963.582549221513;6085.755183265891;6116.694165291718;6174.8147555573405;6193.040078787795;5886.3230728465915;5891.351951285355;5891.3814049525035;5895.852603684943;5911.438413350725;5960.940390596125;5964.463198312173;5965.850853728692;5967.343592204854;5969.283685957713;5805.651660900275;5925.911111333334;5962.25471816023;5996.5202783777195;6047.758089676452;5930.1994230779155;5976.193213916065;5976.551758618034;5980.581359304894;6004.879902401927;4556;4576.427946506687;4584.97707511467;4585.701929374647;4606.641040892945;3988.920221595552;4049.4330793688905;4103.589641035873;4104.343305071234;4135.214309281227;5620.409856965041;5637.49262566371;5642.746076426571;5647;5650.180723795027;6041.818745437556;6044.063170208625;6054.545909056838;6059.697015149225;6061.424164704346;5317.601179911522;5562.888742225133;5586.972065139648;5588.944110558924;5592.133219350926;5144.074066668036;5146.279520867081;5165.1219292720325;5166.095933211673;5172.19830926207;5803.622764520293;6032.105402265063;6056.970315046453;6058.454739073504;6095.146679464879;6040.426159514839;6092.329843717276;6104.816855494342;6114.969425152845;6132.877342453036;6042.456178943916;6048.243969503812;6052.878942421039;6056.848578785565;6057.151998720271;5773.884522309614;5860.794872179454;5893.734781934909;5898.233229680114;5906.763729450774;6027.78902738402;6029.216201893726;6031.7587296507645;6051.969740151271;6065.302490213682;5843.386444423274;5879.706014699163;5884.411558844081;5891.617044892068;5898.292204935436;5658.151277308437;5803.448672376117;5860.120981852756;5860.912086318624;5871.911921321098;5790.768369265351;5794;5796.333421656564;5801.1878337033695;5824.504917082096;5914.704264786829;5917.763289468373;5942.554308426799;5942.7920022799;5949.25634295713;5620.522255608319;5700.828975130753;5770.711464426846;5789.247397838254;5837.416258374129 13:57:09 INFO - PROCESS | 18028 | |1;ext.html;605.3552966091113;664.8105289992352;672.6367761408843;675.5507587454343;743.2344684974478;31974.520382194256;41001.949902504864;41734.58265417341;41775;41823.79088104563;44235;44954.550454495526;44981.55018449815;44982.32526512097;44983.32525012128;8877.64489420424;9097.909020909805;9098.590563424628;9113.0886911309;9116.635334586608;8888.644454221823;9020.458772473672;9037.051109633492;9041.593128309209;9222.30832687551;9228.215601673866;9293.117153870371;9314.76713082175;9320.580573874158;9329.813403731921;9178.54107294636;9212.263018958467;9227.215686666641;9235.492047937361;9236.584353704066;9054.728358149201;9203.539823008823;9203.723888283363;9215.262778977665;9230.261579073658;44856;45480.772596136805;45521.54478455206;45535;45554.08891822145;3846.961530384688;3892.5523564789846;3907.8436862525464;4105.261053010457;4627.606653434462;33259.6674033259;34191.470248110236;34879.825600872085;34955.475667865;35242.47136292957;4354.600216340675;4368.868933931987;4378.452693413324;4379.912401751947;4397.714148580332;351695;354212;356578;357259;358641;61145.38854611397;61309;61703.69148154231;61830.072548911805;61830.69084654638;62601.68699156475;63856.680716597046;64109.679451602446;64200;65129.67435162794;18662.53343666419;18888.622227555374;18906.338278160474;18913.338033168773;18923.391511721657;14361.138331700131;14436.350364233425;14442.061266017676;14448.783268250985;14452.638684032983;20419;20638.071286792132;20664.896675516826;20730.170793168105;20761.480962975744;7710.951750331121;7749.651265692944;7851.175626559243;7901.960490197627;7939.126696063428;1119.7256672115384;1133.5692436873935;1162.575659884153;1179.4161889864401;1253.4610117649315;33843.32313353719;35874.282514349565;35934.46098308527;36002.45996310058;36196.638033619856;1181.1849823621674;1249.2691775311364;1273.6752128207434;1274.6940734223906;1395.4069520453766;18277.451676449728;18851.20913513214;19003.144858481402;19037.14332855025;19056.333028343943;549660;554241;554926;555729;555757;64093.35906640967;65914;65998.3600655978;66026.33973660202;66074.66962665156;1380.6203294094205;1446.7106578684304;1472.9558113256405;1495.8578935001158;1524.9771253431206;32405;34574.48138277877;34806.30387392289;34881.47677784784;35017.64982350144;50845;50941.490585095155;51112.233316499536;51162.488375115776;51175.2323715152;320943;322628;323518;323594;324113;26058.60912086358;28288;29173;29198.56202157012;29205.123846284645;46532.534674654176;47269;48048.51951480441;48642.270365943834;50544;41421.585784142975;41905.37141942934;42231.577684222764;43206.351904720825;43409.78295108631;41275.793621031706;41791.164176716906;42142.789286053376;42848.78575607102;43018;42643.147137057706;43391.56608433875;43618.56381436145;43683;43701;36389;36927.81536092302;37472.437913430775;37596.812015939744;37772.2445551093;29114.126576202747;29389.853050734608;29481.262968425963;29494.557581635865;29587.85206073956 13:57:09 INFO - PROCESS | 18028 | |2;jquery.html;428.81560928800616;433.28940537518463;440.7349526481071;450.5899631335485;455.19061729624747;18330.633387332244;18830.81169188308;19260.711089333672;19292.710609340873;19444.70832937507;17084.82915170848;19092.904535477337;19707.5073123172;19909.701354479657;19936.50158746032;5506.807261745829;5649.971750141243;5677.517411020048;5678.858028549278;5683.147527870832;5555.250041244441;5581.832545023635;5623.100303951348;5628.155776633497;5629.690367029812;5418.133098704208;5547.611667183299;5607.915881261784;5621.943780562204;5626;5554.944450555503;5586.91619625706;5588.133839254901;6065.878682426371;6080.726367313438;5343.545798607123;5435.130379139358;5471.206675032098;5486.177073438977;5510.9448905510835;15129.546113616609;15136.54590362291;15152.621184470367;15153;20162.790232586092;2359.1507057459303;2530.4686015936677;2614.738526147389;2994.1616347422755;3197.1048106530206;10642.787144257149;10665.306755060974;10678.359298442118;10862.131029517619;11344.829827552594;1851.1577232359243;1913.473794706453;1992.14337834731;2010.1356416740796;2073.232903825579;77472;84241.57879210626;85370.57314713387;85482.57258713666;86183;11839.644810655695;11854.407279635983;11859.762804743857;11912.225705329125;12097.818532722016;16865.32538698463;16959.576010599834;16963.74554381685;16972.32110715582;17000.659986800194;9038.683646072355;9046.05016473261;9180.173784359306;9182.403143795766;9282.257419406566;8689.217970382695;8931.374803763803;8953.104689530996;9044.14080662336;9051.547422628842;5237.240600112962;5240.161574148118;5241.790328386898;5247.685138891678;5345.412004679482;2088.7284652995013;2146.8819214943014;2151.698762173297;2165.844984240691;2173.228503881131;1003.9899601003897;1013.5489707080278;1021.4688362051692;1064.685917654294;1081.8457124641416;19130.234790608498;19997.200111995648;20003.399898003085;20115.19539218444;20249.19003239854;1068;1082.8700555933337;1086.4187659602076;1089.2810744908322;1116.179607988128;11037.68208676187;11498.712532186762;11523;11579.942100289445;11585.710357241136;488750;493999;508520;509643;520630;95456.52271738597;98010;101499;101677;102152.48923755334;1025.108155904353;1060.8090543702053;1068.8877667844765;1074.4412905289205;1106.6845948904524;17482.475525734248;17778.91110544439;17805.643887121925;18036.54908627295;18359.90820045891;38370.80814595909;38878.4168237471;39308.80345598254;41212.1757564853;41495.377569335884;59775.701121494116;60897.69551152216;61640.38359616526;61722;62159.6892015537;9238.168564829197;9594.18449431806;9598.760030999281;9645.565949532147;9661.161433122264;10088.445135517324;14266.42934282617;14343.426262949366;14399.42402303896;14499.492517761828;12528.436220369922;12583.87416125827;12697.492100315883;12822.487100515875;13077.280749558486;9235.861462078208;9457.527123643653;12551.560695375618;12563.434645440795;12795.040371972325;11339.603113890975;12089.395530223277;12386.194897331645;12511.749765004832;12890.806637900627;9232.630694772402;9471.952640236756;9497.240220782183;9635.22918166559;9641.662541811003;9648.565814538502;12395.194312369667;12630.179038362478;12632.74734505323;12714.61856144317 13:57:09 INFO - PROCESS | 18028 | |3;mootools.html;1436.1957303909817;1531.410406993308;1585.0252094961597;1770.6458708258351;1905.1522072677665;7862.803429914255;8246;8264.421490495668;8273.627686754095;8278.834423311539;7975.92024079759;8182.79543011425;8187.754367368973;8189.508629482235;8200.38497112716;2105.9894700526474;2368.5973384524586;2428.4171798768302;2434.415740222352;2475.220305603738;2398.112698301622;2404.146527982567;2406.169871394366;2407.109369533275;2410.2287268074224;2347.3896786835376;2395.9880200598973;2398.6521954316613;2398.8200884933613;2399.184277345702;2067.131804642054;2373.8694371809543;2454.5581795276844;2464.9876750616313;2466.5683505386487;2299.252742858561;2313.953720925589;2334.8365614407;2336.556054349668;2355.62310030396;8263.95868020662;8311.127331630152;8362.45644033136;8367.581620918929;8380.916190838074;5072.2391641253735;5230.320058392423;5237.947620523784;5246.8688282792855;5295.126304159809;3451.430513965193;3499.0727457223857;3579.9105022374647;3624.474451204587;3643.67206951373;1145.5589598004744;1174.0431548288118;1186.8694443611196;1218.7806194884918;2195.110980053081;10888.78222435547;11208.27146235492;11249.943750281278;11253.943730281297;11255.774884502345;4486.080353527519;4487;4570.314452832102;4600.079984003146;4620.2607582786595;9082.86375704365;9083.409578377517;9091.27269818413;9092.727218183465;9100.81798364029;4520.615747661485;5124.103281925648;5124.436312005676;5133.486651334837;5143.151380022255;4687.273472611751;4801.831935882227;4817.590504807061;4820.71075735457;4827.879303017382;3706.221693444407;3711.6659500645073;3803.6196380361744;3819.904502387407;3828.349180639242;1127.4813585750646;1169.9415029248503;1177.2877409167502;1178.1105265524475;1181.2971282087144;967.2793768642266;1123.6572845282267;1126.6620013995769;1129.909607231436;1130.66645339625;5970.582059255898;5978.491828194652;6206.379362063757;6222.657753823583;6302.369763023753;496.5655051829649;501.5110267489169;503.80603467665213;513.3634293476138;513.5095983335905;4256.914861702749;4361.694681372337;4406;4412.007298357908;4526.094781043738;10132.24008199388;10484.528196231187;10614.25700200994;10659.626913058006;10663;10365;10416.375017498975;10419.218558608134;10524.579016839394;10548.894511054945;7944.801379965547;8004.239597238253;8151.714689985822;8175.386845986456;8178.345732341399;5942.435468630473;5979.581429300081;5987.6108052976415;6129.509639228941;6134.6625935573975;9229.077092290985;9508.952455237957;9530.47512398013;9552.522373881138;9644.324897257125;9527.952360238154;9640.662576810058;9670.75823104428;9738.659146929824;9762.17021553176;6764.4588432924265;6937.653117344012;7209.819754506179;7385.150707668687;7767.3786097113225;8055;8081.515109093473;8169.877451838108;8186.09952905168;8197.508149511048;7220.277972202738;7332.486725929134;7399.297066778648;7465.9174419709925;7476.25237476248;7245.710171593288;7248.420126389981;7264.782056538313;7397.630118493946;7521.285477879593;6808.421284190899;6872.587644741331;6907.13660792401;6912.274211207952;6915.757948471779;5011.248312753116;5192.818251361185;5315.325672413178;5426.0504411727;5496.862578435571;5326.09456392422;5487.122060470306;5492.368377636623;5534.833954981357;5553.611247212656 13:57:09 INFO - PROCESS | 18028 | |4;prototype.html;352.80419367251176;354.37806649330423;360.9422492401216;360.99278014439705;361.05944015838753;5289.127293996491;5319.468053194679;5329.946700532993;5349.786008559663;5355.384130824957;5236.371635403747;5240.000199771269;5243.711595862226;5244.554212891909;5251.711155886424;3996.600339965995;4030.556638769733;4086.9182616347657;4193.358184343859;4212.957870421287;4202.768847713374;4209.810558524874;4213.504206006869;4216;4218.767967761772;3961.801909904493;4172.874813755592;4175.144095460423;4186.518550366701;4195.979020104895;4036.9798151009204;4101.753894766323;4111.6299533042165;4139.151473947833;4140.441040459529;3647.434647629622;3651.087228192952;3653.4702468142236;3656;3666.358387282215;4991.675541089818;5040.747962601855;5071.923921141186;5085.720285384303;5097.13348730713;4551.271796512575;4674.906501869978;4692.554207350297;4704.858854234379;4705.529447055302;5419.455455195251;5439.809606663748;5481.479259470384;5509.393966663663;5577.832665020056;4021.8391264349393;4028.4762980812307;4059.675225981944;4061.8984525386804;4063.9187216255805;5621.4659607337235;5728.25532680753;5734;5747.741351639144;5750.511206547449;4055.3916912463364;4058.2695114879016;4071.3689378146437;4086.2849001424634;4089.161721847014;4114.177164567099;4141.358089496133;4148.128892932457;4148.43996060534;4154.750714957112;4585.908281834411;4700.576948074621;4704.364910737075;4717.646176536773;4719.631306921023;5480.232767412565;5481.232627432163;5500.944990550043;5515.132131291706;5529.755804943936;1539.6689711712036;1541.244790052866;1541.8226903906195;1549.4499452694356;1563.093405824619;1059.3537941855461;1068.1828401272876;1071.4267866691282;1077.095239998405;1083.8916108389099;5579.903153749627;5612.242347283146;5622.550195984311;5624.71876406178;5635.6618602883955;5978.282606087298;5994.190784244159;6001;6042.371568367774;6044.697765111727;5467.781288748485;5589.496945274945;5611.775528978795;5635.830925072172;5643.858903527444;3201.7278531325096;3203.6956489133495;3213.3573285343023;3213.6020830938614;3219.0342897130768;5930.1994230779155;6026.337102918676;6064.3935606439;6118.571699980958;6141.232345956755;6043.848903777441;6100.69496525172;6124.938750612437;6140.324564297924;6197.442230199304;5949.82150535476;6072.939270607238;6082.1789058477425;6089.1779609753;6102.071005917184;5955.583109182316;5992.191054207626;5998.900384865262;6032.276126864805;6034.336223015553;5874.383189765184;5900.43945825146;5916.230889984275;5969.850753731192;5995.760169593167;5917.6745279010065;6054.637706515999;6058.66709323948;6078.756849726138;6086.665233412028;4388.868333949987;4397.36238245459;4403.8458653946955;4409.691321607456;4430.82276708928;5419.485148910847;5565.693886836263;6002.219711437485;6022.397760223943;6037.547183961133;5497.367802702581;5514.283143191359;5520.66875987442;5551.8889622208135;5556.722163891708;5478.561715062865;5523.972380138073;5561.304836895388;5573.944260557342;5577.860553486195;5249.291345668286;5417.891642167214;5433.510984011458;5482.643628164156;5494.890102197854;5528.226048353154;5567.164925261243;5592.3848376677715;5595.160725891149;5619.297587801525;5197.948020519746;5434.375046869661;5452.5365343946205;5460.754266058117;5469.15228139639 13:57:09 INFO - PROCESS | 18028 | |5;yui.html;827.1521690267472;895.673079326046;915.3729695158814;918.4122161816434;927.3230541704555;13774;13833.170009799407;14053.929730351334;14787.482438114668;15367;14942.850571494282;14987.850121498781;15010.699786004274;15063.698726025474;15091.39634414625;757.0461218864216;891.5497673674785;897.8159477307153;905.4974489158548;905.5427009360263;921.1065266691332;921.9677311294106;923.6582464488149;923.8429466990594;926.0600490502112;967.4243824924159;973.0464145137769;973.1679414100948;973.9415635061919;974.9951250243739;780.8711562592138;920.8848893888264;958.966436174734;959.1415682963708;959.9136077753001;686.4508393285352;688.9069975553286;689.2452764223168;689.3933338661946;689.4518857508293;13349.733005339936;13381.197128172244;13395.06234563581;13417.060805743602;13450.260235687034;13746.862531374658;14279.21464319462;14292.356843941943;14504.202268875208;14769.778453323208;11116.388598627072;11219.439028048564;11398.430078496041;11414.9155830196;11779.234349767237;3833.9424908626393;3834.1373191032076;3906.667933225679;3916.4712763777097;3957.28768821612;56146.15780763292;56152.43847561554;56250.718746406004;56593;56607.150892736645;11643.70560556259;11842.585509507126;11926.1651684383;11965.222260553037;12017.819732704016;21931.780682193294;22093.226737064124;22130.557388852132;22151.44621384478;22294.55410891773;8693.261072808882;8813.955930220436;8824.647014119364;8931.106889311017;9170.312226583033;4740.478547359788;4834.274858771142;4896.216605343128;4966.776495057731;4981.750912454363;3700.500432441586;3754;3759.6052414496085;3762.811859407019;3772.905677358088;679.2901418018183;684.2678334182377;693.5457275484565;694.038756322497;714.0931017607609;683.7401787320787;737.3363972424753;773.2499475508747;795.2723258218665;811.3306522119275;9798.461084640414;10152.644657436955;10267.589296428208;10402.27184097106;10770.676879693621;675.4326365852708;688.8932215506604;730.0910366593519;808.5633757770738;818.1041759273586;4805.543473370024;5037.748112594356;5042.697438153723;5116.079105760999;5148.3564554430695;67352.32647673559;67807.3219267811;68669;70326.64836675784;71412.2858771416;61038.69480652657;61684.38315616876;61982.69008654928;62270.377296227365;63970.6801465999;53869;54130.45869541254;54905.45094549083;55049.1742623861;55137.44862551323;8932.6072022381;8948.5078320693;8983.146601072887;9079.546022698707;9083.45499270046;35167.824160879034;35200.82399587986;35630.821845890605;36273.818630907735;36693.266134676625;46944.53055469538;51237.74381128071;51567;51607.225891612405;51645.48354516407;12235.571754988532;12311.876881231074;12384.504619815107;12495.93752031234;12563.685907852012;13004.869951300367;13376.331183440983;13403.731925361242;13902.791458127935;13923.094998825043;12954.611361659165;13176.407061682055;13251.13867598603;13476.191428514321;13477.932610336886;11960;12146;12359.876401235873;12386.194897331645;12777.36113194318;12499.625011249676;12615.747685046432;12688.23870567769;13127.081104322988;13250.734985300433;10313.535890884777;10439.895601044196;10769.892301076889;10816.67549973502;10992.670219893416;10523.579056837947;10571.101456376295;10608.628697995533;11213.495392707184;11915 13:57:09 INFO - PROCESS | 18028 | __end_tp_report 13:57:09 INFO - PROCESS | 18028 | __start_cc_report 13:57:09 INFO - PROCESS | 18028 | _x_x_mozilla_cycle_collect,880 13:57:09 INFO - PROCESS | 18028 | __end_cc_report 13:57:09 INFO - PROCESS | 18028 | __startTimestamp1461704229691__endTimestamp 13:57:09 INFO - PROCESS | 18028 | 13:57:09 INFO - PROCESS | 18028 | ------- Summary: start ------- 13:57:09 INFO - PROCESS | 18028 | Number of tests: 6 13:57:09 INFO - PROCESS | 18028 | 13:57:09 INFO - PROCESS | 18028 | [#0] dojo.html Cycles:165 Average:5559.09 Median:5794.00 stddev:615.51 (10.6%) stddev-sans-first:590.92 13:57:09 INFO - PROCESS | 18028 | Values: 3282.4 3337.3 3362.8 3362.8 3400.1 5574.1 5578.1 5601.0 5620.8 5631.1 5599.7 5645.7 5654.5 5658.7 5660.1 4949.5 5015.4 5074.6 5106.7 5115.3 5051.5 5098.6 5099.8 5150.1 5194.1 5110.3 5126.7 5172.0 5174.1 5187.3 5069.5 5107.5 5179.9 5185.3 5199.9 4936.2 4996.9 5012.0 5031.8 5043.2 5479.4 5511.2 5521.4 5526.9 5533.8 5809.2 5927.2 5976.2 6014.0 6015.9 6061.5 6078.0 6086.2 6090.0 6096.4 5656.7 5659.4 5667.2 5675.2 5694.7 5963.6 6085.8 6116.7 6174.8 6193.0 5886.3 5891.4 5891.4 5895.9 5911.4 5960.9 5964.5 5965.9 5967.3 5969.3 5805.7 5925.9 5962.3 5996.5 6047.8 5930.2 5976.2 5976.6 5980.6 6004.9 4556.0 4576.4 4585.0 4585.7 4606.6 3988.9 4049.4 4103.6 4104.3 4135.2 5620.4 5637.5 5642.7 5647.0 5650.2 6041.8 6044.1 6054.5 6059.7 6061.4 5317.6 5562.9 5587.0 5588.9 5592.1 5144.1 5146.3 5165.1 5166.1 5172.2 5803.6 6032.1 6057.0 6058.5 6095.1 6040.4 6092.3 6104.8 6115.0 6132.9 6042.5 6048.2 6052.9 6056.8 6057.2 5773.9 5860.8 5893.7 5898.2 5906.8 6027.8 6029.2 6031.8 6052.0 6065.3 5843.4 5879.7 5884.4 5891.6 5898.3 5658.2 5803.4 5860.1 5860.9 5871.9 5790.8 5794.0 5796.3 5801.2 5824.5 5914.7 5917.8 5942.6 5942.8 5949.3 5620.5 5700.8 5770.7 5789.2 5837.4 13:57:09 INFO - PROCESS | 18028 | 13:57:09 INFO - PROCESS | 18028 | [#1] ext.html Cycles:180 Average:58887.10 Median:42745.97 stddev:112088.09 (262.2%) stddev-sans-first:112317.11 13:57:09 INFO - PROCESS | 18028 | Values: 605.4 664.8 672.6 675.6 743.2 31974.5 41001.9 41734.6 41775.0 41823.8 44235.0 44954.6 44981.6 44982.3 44983.3 8877.6 9097.9 9098.6 9113.1 9116.6 8888.6 9020.5 9037.1 9041.6 9222.3 9228.2 9293.1 9314.8 9320.6 9329.8 9178.5 9212.3 9227.2 9235.5 9236.6 9054.7 9203.5 9203.7 9215.3 9230.3 44856.0 45480.8 45521.5 45535.0 45554.1 3847.0 3892.6 3907.8 4105.3 4627.6 33259.7 34191.5 34879.8 34955.5 35242.5 4354.6 4368.9 4378.5 4379.9 4397.7 351695.0 354212.0 356578.0 357259.0 358641.0 61145.4 61309.0 61703.7 61830.1 61830.7 62601.7 63856.7 64109.7 64200.0 65129.7 18662.5 18888.6 18906.3 18913.3 18923.4 14361.1 14436.4 14442.1 14448.8 14452.6 20419.0 20638.1 20664.9 20730.2 20761.5 7711.0 7749.7 7851.2 7902.0 7939.1 1119.7 1133.6 1162.6 1179.4 1253.5 33843.3 35874.3 35934.5 36002.5 36196.6 1181.2 1249.3 1273.7 1274.7 1395.4 18277.5 18851.2 19003.1 19037.1 19056.3 549660.0 554241.0 554926.0 555729.0 555757.0 64093.4 65914.0 65998.4 66026.3 66074.7 1380.6 1446.7 1473.0 1495.9 1525.0 32405.0 34574.5 34806.3 34881.5 35017.6 50845.0 50941.5 51112.2 51162.5 51175.2 320943.0 322628.0 323518.0 323594.0 324113.0 26058.6 28288.0 29173.0 29198.6 29205.1 46532.5 47269.0 48048.5 48642.3 50544.0 41421.6 41905.4 42231.6 43206.4 43409.8 41275.8 41791.2 42142.8 42848.8 43018.0 42643.1 43391.6 43618.6 43683.0 43701.0 36389.0 36927.8 37472.4 37596.8 37772.2 29114.1 29389.9 29481.3 29494.6 29587.9 13:57:09 INFO - PROCESS | 18028 | 13:57:09 INFO - PROCESS | 18028 | [#2] jquery.html Cycles:180 Average:29858.60 Median:2117.81 stddev:83298.08 (3933.2%) stddev-sans-first:83502.44 13:57:09 INFO - PROCESS | 18028 | Values: 428.8 433.3 440.7 450.6 455.2 18330.6 18830.8 19260.7 19292.7 19444.7 17084.8 19092.9 19707.5 19909.7 19936.5 5506.8 5650.0 5677.5 5678.9 5683.1 5555.3 5581.8 5623.1 5628.2 5629.7 5418.1 5547.6 5607.9 5621.9 5626.0 5554.9 5586.9 5588.1 6065.9 6080.7 5343.5 5435.1 5471.2 5486.2 5510.9 15129.5 15136.5 15152.6 15153.0 20162.8 2359.2 2530.5 2614.7 2994.2 3197.1 10642.8 10665.3 10678.4 10862.1 11344.8 1851.2 1913.5 1992.1 2010.1 2073.2 77472.0 84241.6 85370.6 85482.6 86183.0 11839.6 11854.4 11859.8 11912.2 12097.8 16865.3 16959.6 16963.7 16972.3 17000.7 9038.7 9046.1 9180.2 9182.4 9282.3 8689.2 8931.4 8953.1 9044.1 9051.5 5237.2 5240.2 5241.8 5247.7 5345.4 2088.7 2146.9 2151.7 2165.8 2173.2 1004.0 1013.5 1021.5 1064.7 1081.8 19130.2 19997.2 20003.4 20115.2 20249.2 1068.0 1082.9 1086.4 1089.3 1116.2 11037.7 11498.7 11523.0 11579.9 11585.7 488750.0 493999.0 508520.0 509643.0 520630.0 95456.5 98010.0 101499.0 101677.0 102152.5 1025.1 1060.8 1068.9 1074.4 1106.7 17482.5 17778.9 17805.6 18036.5 18359.9 38370.8 38878.4 39308.8 41212.2 41495.4 59775.7 60897.7 61640.4 61722.0 62159.7 9238.2 9594.2 9598.8 9645.6 9661.2 10088.4 14266.4 14343.4 14399.4 14499.5 12528.4 12583.9 12697.5 12822.5 13077.3 9235.9 9457.5 12551.6 12563.4 12795.0 11339.6 12089.4 12386.2 12511.7 12890.8 9232.6 9472.0 9497.2 9635.2 9641.7 9648.6 12395.2 12630.2 12632.7 12714.6 13:57:09 INFO - PROCESS | 18028 | 13:57:09 INFO - PROCESS | 18028 | [#3] mootools.html Cycles:180 Average:5610.51 Median:5124.27 stddev:3037.40 (59.3%) stddev-sans-first:3029.72 13:57:09 INFO - PROCESS | 18028 | Values: 1436.2 1531.4 1585.0 1770.6 1905.2 7862.8 8246.0 8264.4 8273.6 8278.8 7975.9 8182.8 8187.8 8189.5 8200.4 2106.0 2368.6 2428.4 2434.4 2475.2 2398.1 2404.1 2406.2 2407.1 2410.2 2347.4 2396.0 2398.7 2398.8 2399.2 2067.1 2373.9 2454.6 2465.0 2466.6 2299.3 2314.0 2334.8 2336.6 2355.6 8264.0 8311.1 8362.5 8367.6 8380.9 5072.2 5230.3 5237.9 5246.9 5295.1 3451.4 3499.1 3579.9 3624.5 3643.7 1145.6 1174.0 1186.9 1218.8 2195.1 10888.8 11208.3 11249.9 11253.9 11255.8 4486.1 4487.0 4570.3 4600.1 4620.3 9082.9 9083.4 9091.3 9092.7 9100.8 4520.6 5124.1 5124.4 5133.5 5143.2 4687.3 4801.8 4817.6 4820.7 4827.9 3706.2 3711.7 3803.6 3819.9 3828.3 1127.5 1169.9 1177.3 1178.1 1181.3 967.3 1123.7 1126.7 1129.9 1130.7 5970.6 5978.5 6206.4 6222.7 6302.4 496.6 501.5 503.8 513.4 513.5 4256.9 4361.7 4406.0 4412.0 4526.1 10132.2 10484.5 10614.3 10659.6 10663.0 10365.0 10416.4 10419.2 10524.6 10548.9 7944.8 8004.2 8151.7 8175.4 8178.3 5942.4 5979.6 5987.6 6129.5 6134.7 9229.1 9509.0 9530.5 9552.5 9644.3 9528.0 9640.7 9670.8 9738.7 9762.2 6764.5 6937.7 7209.8 7385.2 7767.4 8055.0 8081.5 8169.9 8186.1 8197.5 7220.3 7332.5 7399.3 7465.9 7476.3 7245.7 7248.4 7264.8 7397.6 7521.3 6808.4 6872.6 6907.1 6912.3 6915.8 5011.2 5192.8 5315.3 5426.1 5496.9 5326.1 5487.1 5492.4 5534.8 5553.6 13:57:09 INFO - PROCESS | 18028 | 13:57:09 INFO - PROCESS | 18028 | [#4] prototype.html Cycles:180 Average:4762.80 Median:5352.59 stddev:1391.68 (26.0%) stddev-sans-first:1355.65 13:57:09 INFO - PROCESS | 18028 | Values: 352.8 354.4 360.9 361.0 361.1 5289.1 5319.5 5329.9 5349.8 5355.4 5236.4 5240.0 5243.7 5244.6 5251.7 3996.6 4030.6 4086.9 4193.4 4213.0 4202.8 4209.8 4213.5 4216.0 4218.8 3961.8 4172.9 4175.1 4186.5 4196.0 4037.0 4101.8 4111.6 4139.2 4140.4 3647.4 3651.1 3653.5 3656.0 3666.4 4991.7 5040.7 5071.9 5085.7 5097.1 4551.3 4674.9 4692.6 4704.9 4705.5 5419.5 5439.8 5481.5 5509.4 5577.8 4021.8 4028.5 4059.7 4061.9 4063.9 5621.5 5728.3 5734.0 5747.7 5750.5 4055.4 4058.3 4071.4 4086.3 4089.2 4114.2 4141.4 4148.1 4148.4 4154.8 4585.9 4700.6 4704.4 4717.6 4719.6 5480.2 5481.2 5500.9 5515.1 5529.8 1539.7 1541.2 1541.8 1549.4 1563.1 1059.4 1068.2 1071.4 1077.1 1083.9 5579.9 5612.2 5622.6 5624.7 5635.7 5978.3 5994.2 6001.0 6042.4 6044.7 5467.8 5589.5 5611.8 5635.8 5643.9 3201.7 3203.7 3213.4 3213.6 3219.0 5930.2 6026.3 6064.4 6118.6 6141.2 6043.8 6100.7 6124.9 6140.3 6197.4 5949.8 6072.9 6082.2 6089.2 6102.1 5955.6 5992.2 5998.9 6032.3 6034.3 5874.4 5900.4 5916.2 5969.9 5995.8 5917.7 6054.6 6058.7 6078.8 6086.7 4388.9 4397.4 4403.8 4409.7 4430.8 5419.5 5565.7 6002.2 6022.4 6037.5 5497.4 5514.3 5520.7 5551.9 5556.7 5478.6 5524.0 5561.3 5573.9 5577.9 5249.3 5417.9 5433.5 5482.6 5494.9 5528.2 5567.2 5592.4 5595.2 5619.3 5197.9 5434.4 5452.5 5460.8 5469.2 13:57:09 INFO - PROCESS | 18028 | 13:57:09 INFO - PROCESS | 18028 | [#5] yui.html Cycles:180 Average:15842.29 Median:4773.01 stddev:18766.39 (393.2%) stddev-sans-first:18785.16 13:57:09 INFO - PROCESS | 18028 | Values: 827.2 895.7 915.4 918.4 927.3 13774.0 13833.2 14053.9 14787.5 15367.0 14942.9 14987.9 15010.7 15063.7 15091.4 757.0 891.5 897.8 905.5 905.5 921.1 922.0 923.7 923.8 926.1 967.4 973.0 973.2 973.9 975.0 780.9 920.9 959.0 959.1 959.9 686.5 688.9 689.2 689.4 689.5 13349.7 13381.2 13395.1 13417.1 13450.3 13746.9 14279.2 14292.4 14504.2 14769.8 11116.4 11219.4 11398.4 11414.9 11779.2 3833.9 3834.1 3906.7 3916.5 3957.3 56146.2 56152.4 56250.7 56593.0 56607.2 11643.7 11842.6 11926.2 11965.2 12017.8 21931.8 22093.2 22130.6 22151.4 22294.6 8693.3 8814.0 8824.6 8931.1 9170.3 4740.5 4834.3 4896.2 4966.8 4981.8 3700.5 3754.0 3759.6 3762.8 3772.9 679.3 684.3 693.5 694.0 714.1 683.7 737.3 773.2 795.3 811.3 9798.5 10152.6 10267.6 10402.3 10770.7 675.4 688.9 730.1 808.6 818.1 4805.5 5037.7 5042.7 5116.1 5148.4 67352.3 67807.3 68669.0 70326.6 71412.3 61038.7 61684.4 61982.7 62270.4 63970.7 53869.0 54130.5 54905.5 55049.2 55137.4 8932.6 8948.5 8983.1 9079.5 9083.5 35167.8 35200.8 35630.8 36273.8 36693.3 46944.5 51237.7 51567.0 51607.2 51645.5 12235.6 12311.9 12384.5 12495.9 12563.7 13004.9 13376.3 13403.7 13902.8 13923.1 12954.6 13176.4 13251.1 13476.2 13477.9 11960.0 12146.0 12359.9 12386.2 12777.4 12499.6 12615.7 12688.2 13127.1 13250.7 10313.5 10439.9 10769.9 10816.7 10992.7 10523.6 10571.1 10608.6 11213.5 11915.0 13:57:09 INFO - PROCESS | 18028 | -------- Summary: end -------- 13:57:09 INFO - PROCESS | 18028 | 13:57:10 INFO - TEST-INFO | 18028: exit 0 13:57:10 INFO - TEST-OK | dromaeo_css | took 1111262ms 13:57:10 INFO - TEST-START | kraken 13:57:10 INFO - operating with platform_type : linux_ 13:57:10 INFO - Initialising browser for kraken test... 13:57:10 INFO - TEST-INFO | started process 18219 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJTjvN1/profile http://localhost:40812/getInfo.html) 13:57:14 INFO - PROCESS | 18219 | __metrics Screen width/height:1600/1200 13:57:14 INFO - PROCESS | 18219 | colorDepth:24 13:57:14 INFO - PROCESS | 18219 | Browser inner width/height: 1024/697 13:57:14 INFO - PROCESS | 18219 | __metrics 13:57:15 ERROR - PROCESS | 18219 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:57:16 INFO - TEST-INFO | 18219: exit 0 13:57:16 INFO - Browser initialized. 13:57:16 INFO - Running cycle 1/1 for kraken test... 13:57:16 INFO - TEST-INFO | started process 18308 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJTjvN1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:57:27 INFO - PROCESS | 18308 | RSS: Main: 142934016 13:57:27 INFO - PROCESS | 18308 | 13:57:30 INFO - PROCESS | 18308 | Cycle 1(1): loaded http://localhost:40812/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40812/tests/kraken/driver.html?testName=audio-beat-detection) 13:57:31 INFO - PROCESS | 18308 | RSS: Main: 190939136 13:57:31 INFO - PROCESS | 18308 | 13:57:33 INFO - PROCESS | 18308 | Cycle 1(1): loaded http://localhost:40812/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40812/tests/kraken/driver.html?testName=audio-dft) 13:57:34 INFO - PROCESS | 18308 | RSS: Main: 183840768 13:57:34 INFO - PROCESS | 18308 | 13:57:37 INFO - PROCESS | 18308 | Cycle 1(1): loaded http://localhost:40812/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40812/tests/kraken/driver.html?testName=audio-fft) 13:57:37 INFO - PROCESS | 18308 | RSS: Main: 272908288 13:57:37 INFO - PROCESS | 18308 | 13:57:39 INFO - PROCESS | 18308 | Cycle 1(1): loaded http://localhost:40812/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40812/tests/kraken/driver.html?testName=audio-oscillator) 13:57:40 INFO - PROCESS | 18308 | RSS: Main: 182374400 13:57:40 INFO - PROCESS | 18308 | 13:57:42 INFO - PROCESS | 18308 | Cycle 1(1): loaded http://localhost:40812/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40812/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:57:43 INFO - PROCESS | 18308 | RSS: Main: 180740096 13:57:43 INFO - PROCESS | 18308 | 13:57:46 INFO - PROCESS | 18308 | Cycle 1(1): loaded http://localhost:40812/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40812/tests/kraken/driver.html?testName=imaging-darkroom) 13:57:46 INFO - PROCESS | 18308 | RSS: Main: 215584768 13:57:46 INFO - PROCESS | 18308 | 13:57:50 INFO - PROCESS | 18308 | Cycle 1(1): loaded http://localhost:40812/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40812/tests/kraken/driver.html?testName=imaging-desaturate) 13:57:50 INFO - PROCESS | 18308 | RSS: Main: 215580672 13:57:50 INFO - PROCESS | 18308 | 13:57:53 INFO - PROCESS | 18308 | Cycle 1(1): loaded http://localhost:40812/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40812/tests/kraken/driver.html?testName=json-parse-financial) 13:57:54 INFO - PROCESS | 18308 | RSS: Main: 214855680 13:57:54 INFO - PROCESS | 18308 | 13:57:55 INFO - PROCESS | 18308 | Cycle 1(1): loaded http://localhost:40812/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40812/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:57:56 INFO - PROCESS | 18308 | RSS: Main: 193478656 13:57:56 INFO - PROCESS | 18308 | 13:57:57 INFO - PROCESS | 18308 | Cycle 1(1): loaded http://localhost:40812/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40812/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:57:58 INFO - PROCESS | 18308 | RSS: Main: 194609152 13:57:58 INFO - PROCESS | 18308 | 13:58:00 INFO - PROCESS | 18308 | Cycle 1(1): loaded http://localhost:40812/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40812/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:58:01 INFO - PROCESS | 18308 | RSS: Main: 206618624 13:58:01 INFO - PROCESS | 18308 | 13:58:03 INFO - PROCESS | 18308 | Cycle 1(1): loaded http://localhost:40812/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40812/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:58:04 INFO - PROCESS | 18308 | RSS: Main: 215822336 13:58:04 INFO - PROCESS | 18308 | 13:58:07 INFO - PROCESS | 18308 | Cycle 1(1): loaded http://localhost:40812/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40812/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:58:07 INFO - PROCESS | 18308 | RSS: Main: 212492288 13:58:07 INFO - PROCESS | 18308 | 13:58:09 INFO - PROCESS | 18308 | Cycle 1(1): loaded http://localhost:40812/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40812/tests/kraken/driver.html?testName=ai-astar) 13:58:09 INFO - PROCESS | 18308 | RSS: Main: 275570688 13:58:09 INFO - PROCESS | 18308 | 13:58:09 INFO - PROCESS | 18308 | __start_tp_report 13:58:09 INFO - PROCESS | 18308 | _x_x_mozilla_page_load 13:58:09 INFO - PROCESS | 18308 | _x_x_mozilla_page_load_details 13:58:09 INFO - PROCESS | 18308 | |i|pagename|runs| 13:58:09 INFO - PROCESS | 18308 | |0;ai-astar;111;112;105;109;111;111;100;110;111;111 13:58:09 INFO - PROCESS | 18308 | |1;audio-beat-detection;149;126;152;184;126;156;150;133;190;125 13:58:09 INFO - PROCESS | 18308 | |2;audio-dft;162;161;161;163;162;161;161;163;162;163 13:58:09 INFO - PROCESS | 18308 | |3;audio-fft;78;75;76;190;76;73;76;76;156;76 13:58:09 INFO - PROCESS | 18308 | |4;audio-oscillator;93;93;154;92;93;93;149;93;92;151 13:58:09 INFO - PROCESS | 18308 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;116;117;116 13:58:09 INFO - PROCESS | 18308 | |6;imaging-darkroom;145;145;146;145;146;145;146;146;145;145 13:58:09 INFO - PROCESS | 18308 | |7;imaging-desaturate;94;95;94;95;95;95;94;95;95;95 13:58:09 INFO - PROCESS | 18308 | |8;json-parse-financial;54;55;56;56;54;57;56;74;55;52 13:58:09 INFO - PROCESS | 18308 | |9;json-stringify-tinderbox;57;57;57;56;57;57;57;57;63;57 13:58:09 INFO - PROCESS | 18308 | |10;stanford-crypto-aes;74;74;73;73;75;76;73;75;74;73 13:58:09 INFO - PROCESS | 18308 | |11;stanford-crypto-ccm;119;122;118;121;128;115;120;117;149;118 13:58:09 INFO - PROCESS | 18308 | |12;stanford-crypto-pbkdf2;166;164;161;166;162;174;167;165;170;161 13:58:09 INFO - PROCESS | 18308 | |13;stanford-crypto-sha256-iterative;69;69;67;66;66;65;68;67;67;68 13:58:09 INFO - PROCESS | 18308 | __end_tp_report 13:58:09 INFO - PROCESS | 18308 | __start_cc_report 13:58:09 INFO - PROCESS | 18308 | _x_x_mozilla_cycle_collect,1593 13:58:09 INFO - PROCESS | 18308 | __end_cc_report 13:58:09 INFO - PROCESS | 18308 | __startTimestamp1461704289586__endTimestamp 13:58:09 INFO - PROCESS | 18308 | 13:58:09 INFO - PROCESS | 18308 | ------- Summary: start ------- 13:58:09 INFO - PROCESS | 18308 | Number of tests: 14 13:58:09 INFO - PROCESS | 18308 | 13:58:09 INFO - PROCESS | 18308 | [#0] ai-astar Cycles:10 Average:109.10 Median:111.00 stddev:3.75 (3.4%) stddev-sans-first:3.92 13:58:09 INFO - PROCESS | 18308 | Values: 111.0 112.0 105.0 109.0 111.0 111.0 100.0 110.0 111.0 111.0 13:58:09 INFO - PROCESS | 18308 | 13:58:09 INFO - PROCESS | 18308 | [#1] audio-beat-detection Cycles:10 Average:149.10 Median:151.00 stddev:23.23 (15.4%) stddev-sans-first:24.63 13:58:09 INFO - PROCESS | 18308 | Values: 149.0 126.0 152.0 184.0 126.0 156.0 150.0 133.0 190.0 125.0 13:58:09 INFO - PROCESS | 18308 | 13:58:09 INFO - PROCESS | 18308 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 13:58:09 INFO - PROCESS | 18308 | Values: 162.0 161.0 161.0 163.0 162.0 161.0 161.0 163.0 162.0 163.0 13:58:09 INFO - PROCESS | 18308 | 13:58:09 INFO - PROCESS | 18308 | [#3] audio-fft Cycles:10 Average:95.20 Median:76.00 stddev:41.80 (55.0%) stddev-sans-first:43.87 13:58:09 INFO - PROCESS | 18308 | Values: 78.0 75.0 76.0 190.0 76.0 73.0 76.0 76.0 156.0 76.0 13:58:09 INFO - PROCESS | 18308 | 13:58:09 INFO - PROCESS | 18308 | [#4] audio-oscillator Cycles:10 Average:110.30 Median:93.00 stddev:28.34 (30.5%) stddev-sans-first:29.36 13:58:09 INFO - PROCESS | 18308 | Values: 93.0 93.0 154.0 92.0 93.0 93.0 149.0 93.0 92.0 151.0 13:58:09 INFO - PROCESS | 18308 | 13:58:09 INFO - PROCESS | 18308 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 13:58:09 INFO - PROCESS | 18308 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 13:58:09 INFO - PROCESS | 18308 | 13:58:09 INFO - PROCESS | 18308 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 13:58:09 INFO - PROCESS | 18308 | Values: 145.0 145.0 146.0 145.0 146.0 145.0 146.0 146.0 145.0 145.0 13:58:09 INFO - PROCESS | 18308 | 13:58:09 INFO - PROCESS | 18308 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 13:58:09 INFO - PROCESS | 18308 | Values: 94.0 95.0 94.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 13:58:09 INFO - PROCESS | 18308 | 13:58:09 INFO - PROCESS | 18308 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:56.00 stddev:6.17 (11.0%) stddev-sans-first:6.46 13:58:09 INFO - PROCESS | 18308 | Values: 54.0 55.0 56.0 56.0 54.0 57.0 56.0 74.0 55.0 52.0 13:58:09 INFO - PROCESS | 18308 | 13:58:09 INFO - PROCESS | 18308 | [#9] json-stringify-tinderbox Cycles:10 Average:57.50 Median:57.00 stddev:1.96 (3.4%) stddev-sans-first:2.07 13:58:09 INFO - PROCESS | 18308 | Values: 57.0 57.0 57.0 56.0 57.0 57.0 57.0 57.0 63.0 57.0 13:58:09 INFO - PROCESS | 18308 | 13:58:09 INFO - PROCESS | 18308 | [#10] stanford-crypto-aes Cycles:10 Average:74.00 Median:74.00 stddev:1.05 (1.4%) stddev-sans-first:1.12 13:58:09 INFO - PROCESS | 18308 | Values: 74.0 74.0 73.0 73.0 75.0 76.0 73.0 75.0 74.0 73.0 13:58:09 INFO - PROCESS | 18308 | 13:58:09 INFO - PROCESS | 18308 | [#11] stanford-crypto-ccm Cycles:10 Average:122.70 Median:120.50 stddev:9.89 (8.2%) stddev-sans-first:10.40 13:58:09 INFO - PROCESS | 18308 | Values: 119.0 122.0 118.0 121.0 128.0 115.0 120.0 117.0 149.0 118.0 13:58:09 INFO - PROCESS | 18308 | 13:58:09 INFO - PROCESS | 18308 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.60 Median:166.00 stddev:4.09 (2.5%) stddev-sans-first:4.33 13:58:09 INFO - PROCESS | 18308 | Values: 166.0 164.0 161.0 166.0 162.0 174.0 167.0 165.0 170.0 161.0 13:58:09 INFO - PROCESS | 18308 | 13:58:09 INFO - PROCESS | 18308 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.50 stddev:1.32 (2.0%) stddev-sans-first:1.22 13:58:09 INFO - PROCESS | 18308 | Values: 69.0 69.0 67.0 66.0 66.0 65.0 68.0 67.0 67.0 68.0 13:58:09 INFO - PROCESS | 18308 | -------- Summary: end -------- 13:58:09 INFO - PROCESS | 18308 | 13:58:10 INFO - TEST-INFO | 18308: exit 0 13:58:10 INFO - TEST-OK | kraken | took 60130ms 13:58:10 INFO - SUITE-END | took 1171s 13:58:10 INFO - Completed test suite (00:19:31) 13:58:10 INFO - javascript benchmark 13:58:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3282.376348493786, 3337.349216902705, 3362.831858407079, 3362.8318584070807, 3400.1499625093725, 5574.136008918614, 5578.107502799543, 5600.971995140024, 5620.803271885485, 5631.070873305905, 5599.664020158793, 5645.661260324383, 5654.491095801377, 5658.688772117532, 5660.066089095294, 4949.529794669501, 5015.423226328964, 5074.61940354474, 5106.66806657566, 5115.309433226523, 5051.5453609175165, 5098.617603679721, 5099.7960081596875, 5150.098732721759, 5194.091034069042, 5110.259012443194, 5126.6923984561045, 5171.974140129294, 5174.146265866128, 5187.299714538545, 5069.518395752398, 5107.540321371057, 5179.896402071975, 5185.325907632021, 5199.896002079956, 4936.185529387647, 4996.900061998776, 5012.022655582163, 5031.84904452867, 5043.218301163325, 5479.369872464677, 5511.200875872976, 5521.420250873641, 5526.917096243559, 5533.806316778933, 5809.24479817621, 5927.199828023205, 5976.163337132805, 6014.0290914871875, 6015.90514604585, 6061.545384096166, 6077.959912601904, 6086.2087928569445, 6089.969550152266, 6096.420840020191, 5656.717164141776, 5659.4340565943485, 5667.234923285386, 5675.1770993205755, 5694.658320500783, 5963.582549221513, 6085.755183265891, 6116.694165291718, 6174.8147555573405, 6193.040078787795, 5886.3230728465915, 5891.351951285355, 5891.3814049525035, 5895.852603684943, 5911.438413350725, 5960.940390596125, 5964.463198312173, 5965.850853728692, 5967.343592204854, 5969.283685957713, 5805.651660900275, 5925.911111333334, 5962.25471816023, 5996.5202783777195, 6047.758089676452, 5930.1994230779155, 5976.193213916065, 5976.551758618034, 5980.581359304894, 6004.879902401927, 4556.0, 4576.427946506687, 4584.97707511467, 4585.701929374647, 4606.641040892945, 3988.920221595552, 4049.4330793688905, 4103.589641035873, 4104.343305071234, 4135.214309281227, 5620.409856965041, 5637.49262566371, 5642.746076426571, 5647.0, 5650.180723795027, 6041.818745437556, 6044.063170208625, 6054.545909056838, 6059.697015149225, 6061.424164704346, 5317.601179911522, 5562.888742225133, 5586.972065139648, 5588.944110558924, 5592.133219350926, 5144.074066668036, 5146.279520867081, 5165.1219292720325, 5166.095933211673, 5172.19830926207, 5803.622764520293, 6032.105402265063, 6056.970315046453, 6058.454739073504, 6095.146679464879, 6040.426159514839, 6092.329843717276, 6104.816855494342, 6114.969425152845, 6132.877342453036, 6042.456178943916, 6048.243969503812, 6052.878942421039, 6056.848578785565, 6057.151998720271, 5773.884522309614, 5860.794872179454, 5893.734781934909, 5898.233229680114, 5906.763729450774, 6027.78902738402, 6029.216201893726, 6031.7587296507645, 6051.969740151271, 6065.302490213682, 5843.386444423274, 5879.706014699163, 5884.411558844081, 5891.617044892068, 5898.292204935436, 5658.151277308437, 5803.448672376117, 5860.120981852756, 5860.912086318624, 5871.911921321098, 5790.768369265351, 5794.0, 5796.333421656564, 5801.1878337033695, 5824.504917082096, 5914.704264786829, 5917.763289468373, 5942.554308426799, 5942.7920022799, 5949.25634295713, 5620.522255608319, 5700.828975130753, 5770.711464426846, 5789.247397838254, 5837.416258374129], "value": 5519.01712814012, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.3552966091113, 664.8105289992352, 672.6367761408843, 675.5507587454343, 743.2344684974478, 31974.520382194256, 41001.949902504864, 41734.58265417341, 41775.0, 41823.79088104563, 44235.0, 44954.550454495526, 44981.55018449815, 44982.32526512097, 44983.32525012128, 8877.64489420424, 9097.909020909805, 9098.590563424628, 9113.0886911309, 9116.635334586608, 8888.644454221823, 9020.458772473672, 9037.051109633492, 9041.593128309209, 9222.30832687551, 9228.215601673866, 9293.117153870371, 9314.76713082175, 9320.580573874158, 9329.813403731921, 9178.54107294636, 9212.263018958467, 9227.215686666641, 9235.492047937361, 9236.584353704066, 9054.728358149201, 9203.539823008823, 9203.723888283363, 9215.262778977665, 9230.261579073658, 44856.0, 45480.772596136805, 45521.54478455206, 45535.0, 45554.08891822145, 3846.961530384688, 3892.5523564789846, 3907.8436862525464, 4105.261053010457, 4627.606653434462, 33259.6674033259, 34191.470248110236, 34879.825600872085, 34955.475667865, 35242.47136292957, 4354.600216340675, 4368.868933931987, 4378.452693413324, 4379.912401751947, 4397.714148580332, 351695.0, 354212.0, 356578.0, 357259.0, 358641.0, 61145.38854611397, 61309.0, 61703.69148154231, 61830.072548911805, 61830.69084654638, 62601.68699156475, 63856.680716597046, 64109.679451602446, 64200.0, 65129.67435162794, 18662.53343666419, 18888.622227555374, 18906.338278160474, 18913.338033168773, 18923.391511721657, 14361.138331700131, 14436.350364233425, 14442.061266017676, 14448.783268250985, 14452.638684032983, 20419.0, 20638.071286792132, 20664.896675516826, 20730.170793168105, 20761.480962975744, 7710.951750331121, 7749.651265692944, 7851.175626559243, 7901.960490197627, 7939.126696063428, 1119.7256672115384, 1133.5692436873935, 1162.575659884153, 1179.4161889864401, 1253.4610117649315, 33843.32313353719, 35874.282514349565, 35934.46098308527, 36002.45996310058, 36196.638033619856, 1181.1849823621674, 1249.2691775311364, 1273.6752128207434, 1274.6940734223906, 1395.4069520453766, 18277.451676449728, 18851.20913513214, 19003.144858481402, 19037.14332855025, 19056.333028343943, 549660.0, 554241.0, 554926.0, 555729.0, 555757.0, 64093.35906640967, 65914.0, 65998.3600655978, 66026.33973660202, 66074.66962665156, 1380.6203294094205, 1446.7106578684304, 1472.9558113256405, 1495.8578935001158, 1524.9771253431206, 32405.0, 34574.48138277877, 34806.30387392289, 34881.47677784784, 35017.64982350144, 50845.0, 50941.490585095155, 51112.233316499536, 51162.488375115776, 51175.2323715152, 320943.0, 322628.0, 323518.0, 323594.0, 324113.0, 26058.60912086358, 28288.0, 29173.0, 29198.56202157012, 29205.123846284645, 46532.534674654176, 47269.0, 48048.51951480441, 48642.270365943834, 50544.0, 41421.585784142975, 41905.37141942934, 42231.577684222764, 43206.351904720825, 43409.78295108631, 41275.793621031706, 41791.164176716906, 42142.789286053376, 42848.78575607102, 43018.0, 42643.147137057706, 43391.56608433875, 43618.56381436145, 43683.0, 43701.0, 36389.0, 36927.81536092302, 37472.437913430775, 37596.812015939744, 37772.2445551093, 29114.126576202747, 29389.853050734608, 29481.262968425963, 29494.557581635865, 29587.85206073956], "value": 21094.00566445953, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [428.81560928800616, 433.28940537518463, 440.7349526481071, 450.5899631335485, 455.19061729624747, 18330.633387332244, 18830.81169188308, 19260.711089333672, 19292.710609340873, 19444.70832937507, 17084.82915170848, 19092.904535477337, 19707.5073123172, 19909.701354479657, 19936.50158746032, 5506.807261745829, 5649.971750141243, 5677.517411020048, 5678.858028549278, 5683.147527870832, 5555.250041244441, 5581.832545023635, 5623.100303951348, 5628.155776633497, 5629.690367029812, 5418.133098704208, 5547.611667183299, 5607.915881261784, 5621.943780562204, 5626.0, 5554.944450555503, 5586.91619625706, 5588.133839254901, 6065.878682426371, 6080.726367313438, 5343.545798607123, 5435.130379139358, 5471.206675032098, 5486.177073438977, 5510.9448905510835, 15129.546113616609, 15136.54590362291, 15152.621184470367, 15153.0, 20162.790232586092, 2359.1507057459303, 2530.4686015936677, 2614.738526147389, 2994.1616347422755, 3197.1048106530206, 10642.787144257149, 10665.306755060974, 10678.359298442118, 10862.131029517619, 11344.829827552594, 1851.1577232359243, 1913.473794706453, 1992.14337834731, 2010.1356416740796, 2073.232903825579, 77472.0, 84241.57879210626, 85370.57314713387, 85482.57258713666, 86183.0, 11839.644810655695, 11854.407279635983, 11859.762804743857, 11912.225705329125, 12097.818532722016, 16865.32538698463, 16959.576010599834, 16963.74554381685, 16972.32110715582, 17000.659986800194, 9038.683646072355, 9046.05016473261, 9180.173784359306, 9182.403143795766, 9282.257419406566, 8689.217970382695, 8931.374803763803, 8953.104689530996, 9044.14080662336, 9051.547422628842, 5237.240600112962, 5240.161574148118, 5241.790328386898, 5247.685138891678, 5345.412004679482, 2088.7284652995013, 2146.8819214943014, 2151.698762173297, 2165.844984240691, 2173.228503881131, 1003.9899601003897, 1013.5489707080278, 1021.4688362051692, 1064.685917654294, 1081.8457124641416, 19130.234790608498, 19997.200111995648, 20003.399898003085, 20115.19539218444, 20249.19003239854, 1068.0, 1082.8700555933337, 1086.4187659602076, 1089.2810744908322, 1116.179607988128, 11037.68208676187, 11498.712532186762, 11523.0, 11579.942100289445, 11585.710357241136, 488750.0, 493999.0, 508520.0, 509643.0, 520630.0, 95456.52271738597, 98010.0, 101499.0, 101677.0, 102152.48923755334, 1025.108155904353, 1060.8090543702053, 1068.8877667844765, 1074.4412905289205, 1106.6845948904524, 17482.475525734248, 17778.91110544439, 17805.643887121925, 18036.54908627295, 18359.90820045891, 38370.80814595909, 38878.4168237471, 39308.80345598254, 41212.1757564853, 41495.377569335884, 59775.701121494116, 60897.69551152216, 61640.38359616526, 61722.0, 62159.6892015537, 9238.168564829197, 9594.18449431806, 9598.760030999281, 9645.565949532147, 9661.161433122264, 10088.445135517324, 14266.42934282617, 14343.426262949366, 14399.42402303896, 14499.492517761828, 12528.436220369922, 12583.87416125827, 12697.492100315883, 12822.487100515875, 13077.280749558486, 9235.861462078208, 9457.527123643653, 12551.560695375618, 12563.434645440795, 12795.040371972325, 11339.603113890975, 12089.395530223277, 12386.194897331645, 12511.749765004832, 12890.806637900627, 9232.630694772402, 9471.952640236756, 9497.240220782183, 9635.22918166559, 9641.662541811003, 9648.565814538502, 12395.194312369667, 12630.179038362478, 12632.74734505323, 12714.61856144317], "value": 9571.206603760802, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1436.1957303909817, 1531.410406993308, 1585.0252094961597, 1770.6458708258351, 1905.1522072677665, 7862.803429914255, 8246.0, 8264.421490495668, 8273.627686754095, 8278.834423311539, 7975.92024079759, 8182.79543011425, 8187.754367368973, 8189.508629482235, 8200.38497112716, 2105.9894700526474, 2368.5973384524586, 2428.4171798768302, 2434.415740222352, 2475.220305603738, 2398.112698301622, 2404.146527982567, 2406.169871394366, 2407.109369533275, 2410.2287268074224, 2347.3896786835376, 2395.9880200598973, 2398.6521954316613, 2398.8200884933613, 2399.184277345702, 2067.131804642054, 2373.8694371809543, 2454.5581795276844, 2464.9876750616313, 2466.5683505386487, 2299.252742858561, 2313.953720925589, 2334.8365614407, 2336.556054349668, 2355.62310030396, 8263.95868020662, 8311.127331630152, 8362.45644033136, 8367.581620918929, 8380.916190838074, 5072.2391641253735, 5230.320058392423, 5237.947620523784, 5246.8688282792855, 5295.126304159809, 3451.430513965193, 3499.0727457223857, 3579.9105022374647, 3624.474451204587, 3643.67206951373, 1145.5589598004744, 1174.0431548288118, 1186.8694443611196, 1218.7806194884918, 2195.110980053081, 10888.78222435547, 11208.27146235492, 11249.943750281278, 11253.943730281297, 11255.774884502345, 4486.080353527519, 4487.0, 4570.314452832102, 4600.079984003146, 4620.2607582786595, 9082.86375704365, 9083.409578377517, 9091.27269818413, 9092.727218183465, 9100.81798364029, 4520.615747661485, 5124.103281925648, 5124.436312005676, 5133.486651334837, 5143.151380022255, 4687.273472611751, 4801.831935882227, 4817.590504807061, 4820.71075735457, 4827.879303017382, 3706.221693444407, 3711.6659500645073, 3803.6196380361744, 3819.904502387407, 3828.349180639242, 1127.4813585750646, 1169.9415029248503, 1177.2877409167502, 1178.1105265524475, 1181.2971282087144, 967.2793768642266, 1123.6572845282267, 1126.6620013995769, 1129.909607231436, 1130.66645339625, 5970.582059255898, 5978.491828194652, 6206.379362063757, 6222.657753823583, 6302.369763023753, 496.5655051829649, 501.5110267489169, 503.80603467665213, 513.3634293476138, 513.5095983335905, 4256.914861702749, 4361.694681372337, 4406.0, 4412.007298357908, 4526.094781043738, 10132.24008199388, 10484.528196231187, 10614.25700200994, 10659.626913058006, 10663.0, 10365.0, 10416.375017498975, 10419.218558608134, 10524.579016839394, 10548.894511054945, 7944.801379965547, 8004.239597238253, 8151.714689985822, 8175.386845986456, 8178.345732341399, 5942.435468630473, 5979.581429300081, 5987.6108052976415, 6129.509639228941, 6134.6625935573975, 9229.077092290985, 9508.952455237957, 9530.47512398013, 9552.522373881138, 9644.324897257125, 9527.952360238154, 9640.662576810058, 9670.75823104428, 9738.659146929824, 9762.17021553176, 6764.4588432924265, 6937.653117344012, 7209.819754506179, 7385.150707668687, 7767.3786097113225, 8055.0, 8081.515109093473, 8169.877451838108, 8186.09952905168, 8197.508149511048, 7220.277972202738, 7332.486725929134, 7399.297066778648, 7465.9174419709925, 7476.25237476248, 7245.710171593288, 7248.420126389981, 7264.782056538313, 7397.630118493946, 7521.285477879593, 6808.421284190899, 6872.587644741331, 6907.13660792401, 6912.274211207952, 6915.757948471779, 5011.248312753116, 5192.818251361185, 5315.325672413178, 5426.0504411727, 5496.862578435571, 5326.09456392422, 5487.122060470306, 5492.368377636623, 5534.833954981357, 5553.611247212656], "value": 4525.388848286326, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.80419367251176, 354.37806649330423, 360.9422492401216, 360.99278014439705, 361.05944015838753, 5289.127293996491, 5319.468053194679, 5329.946700532993, 5349.786008559663, 5355.384130824957, 5236.371635403747, 5240.000199771269, 5243.711595862226, 5244.554212891909, 5251.711155886424, 3996.600339965995, 4030.556638769733, 4086.9182616347657, 4193.358184343859, 4212.957870421287, 4202.768847713374, 4209.810558524874, 4213.504206006869, 4216.0, 4218.767967761772, 3961.801909904493, 4172.874813755592, 4175.144095460423, 4186.518550366701, 4195.979020104895, 4036.9798151009204, 4101.753894766323, 4111.6299533042165, 4139.151473947833, 4140.441040459529, 3647.434647629622, 3651.087228192952, 3653.4702468142236, 3656.0, 3666.358387282215, 4991.675541089818, 5040.747962601855, 5071.923921141186, 5085.720285384303, 5097.13348730713, 4551.271796512575, 4674.906501869978, 4692.554207350297, 4704.858854234379, 4705.529447055302, 5419.455455195251, 5439.809606663748, 5481.479259470384, 5509.393966663663, 5577.832665020056, 4021.8391264349393, 4028.4762980812307, 4059.675225981944, 4061.8984525386804, 4063.9187216255805, 5621.4659607337235, 5728.25532680753, 5734.0, 5747.741351639144, 5750.511206547449, 4055.3916912463364, 4058.2695114879016, 4071.3689378146437, 4086.2849001424634, 4089.161721847014, 4114.177164567099, 4141.358089496133, 4148.128892932457, 4148.43996060534, 4154.750714957112, 4585.908281834411, 4700.576948074621, 4704.364910737075, 4717.646176536773, 4719.631306921023, 5480.232767412565, 5481.232627432163, 5500.944990550043, 5515.132131291706, 5529.755804943936, 1539.6689711712036, 1541.244790052866, 1541.8226903906195, 1549.4499452694356, 1563.093405824619, 1059.3537941855461, 1068.1828401272876, 1071.4267866691282, 1077.095239998405, 1083.8916108389099, 5579.903153749627, 5612.242347283146, 5622.550195984311, 5624.71876406178, 5635.6618602883955, 5978.282606087298, 5994.190784244159, 6001.0, 6042.371568367774, 6044.697765111727, 5467.781288748485, 5589.496945274945, 5611.775528978795, 5635.830925072172, 5643.858903527444, 3201.7278531325096, 3203.6956489133495, 3213.3573285343023, 3213.6020830938614, 3219.0342897130768, 5930.1994230779155, 6026.337102918676, 6064.3935606439, 6118.571699980958, 6141.232345956755, 6043.848903777441, 6100.69496525172, 6124.938750612437, 6140.324564297924, 6197.442230199304, 5949.82150535476, 6072.939270607238, 6082.1789058477425, 6089.1779609753, 6102.071005917184, 5955.583109182316, 5992.191054207626, 5998.900384865262, 6032.276126864805, 6034.336223015553, 5874.383189765184, 5900.43945825146, 5916.230889984275, 5969.850753731192, 5995.760169593167, 5917.6745279010065, 6054.637706515999, 6058.66709323948, 6078.756849726138, 6086.665233412028, 4388.868333949987, 4397.36238245459, 4403.8458653946955, 4409.691321607456, 4430.82276708928, 5419.485148910847, 5565.693886836263, 6002.219711437485, 6022.397760223943, 6037.547183961133, 5497.367802702581, 5514.283143191359, 5520.66875987442, 5551.8889622208135, 5556.722163891708, 5478.561715062865, 5523.972380138073, 5561.304836895388, 5573.944260557342, 5577.860553486195, 5249.291345668286, 5417.891642167214, 5433.510984011458, 5482.643628164156, 5494.890102197854, 5528.226048353154, 5567.164925261243, 5592.3848376677715, 5595.160725891149, 5619.297587801525, 5197.948020519746, 5434.375046869661, 5452.5365343946205, 5460.754266058117, 5469.15228139639], "value": 4337.380241292325, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [827.1521690267472, 895.673079326046, 915.3729695158814, 918.4122161816434, 927.3230541704555, 13774.0, 13833.170009799407, 14053.929730351334, 14787.482438114668, 15367.0, 14942.850571494282, 14987.850121498781, 15010.699786004274, 15063.698726025474, 15091.39634414625, 757.0461218864216, 891.5497673674785, 897.8159477307153, 905.4974489158548, 905.5427009360263, 921.1065266691332, 921.9677311294106, 923.6582464488149, 923.8429466990594, 926.0600490502112, 967.4243824924159, 973.0464145137769, 973.1679414100948, 973.9415635061919, 974.9951250243739, 780.8711562592138, 920.8848893888264, 958.966436174734, 959.1415682963708, 959.9136077753001, 686.4508393285352, 688.9069975553286, 689.2452764223168, 689.3933338661946, 689.4518857508293, 13349.733005339936, 13381.197128172244, 13395.06234563581, 13417.060805743602, 13450.260235687034, 13746.862531374658, 14279.21464319462, 14292.356843941943, 14504.202268875208, 14769.778453323208, 11116.388598627072, 11219.439028048564, 11398.430078496041, 11414.9155830196, 11779.234349767237, 3833.9424908626393, 3834.1373191032076, 3906.667933225679, 3916.4712763777097, 3957.28768821612, 56146.15780763292, 56152.43847561554, 56250.718746406004, 56593.0, 56607.150892736645, 11643.70560556259, 11842.585509507126, 11926.1651684383, 11965.222260553037, 12017.819732704016, 21931.780682193294, 22093.226737064124, 22130.557388852132, 22151.44621384478, 22294.55410891773, 8693.261072808882, 8813.955930220436, 8824.647014119364, 8931.106889311017, 9170.312226583033, 4740.478547359788, 4834.274858771142, 4896.216605343128, 4966.776495057731, 4981.750912454363, 3700.500432441586, 3754.0, 3759.6052414496085, 3762.811859407019, 3772.905677358088, 679.2901418018183, 684.2678334182377, 693.5457275484565, 694.038756322497, 714.0931017607609, 683.7401787320787, 737.3363972424753, 773.2499475508747, 795.2723258218665, 811.3306522119275, 9798.461084640414, 10152.644657436955, 10267.589296428208, 10402.27184097106, 10770.676879693621, 675.4326365852708, 688.8932215506604, 730.0910366593519, 808.5633757770738, 818.1041759273586, 4805.543473370024, 5037.748112594356, 5042.697438153723, 5116.079105760999, 5148.3564554430695, 67352.32647673559, 67807.3219267811, 68669.0, 70326.64836675784, 71412.2858771416, 61038.69480652657, 61684.38315616876, 61982.69008654928, 62270.377296227365, 63970.6801465999, 53869.0, 54130.45869541254, 54905.45094549083, 55049.1742623861, 55137.44862551323, 8932.6072022381, 8948.5078320693, 8983.146601072887, 9079.546022698707, 9083.45499270046, 35167.824160879034, 35200.82399587986, 35630.821845890605, 36273.818630907735, 36693.266134676625, 46944.53055469538, 51237.74381128071, 51567.0, 51607.225891612405, 51645.48354516407, 12235.571754988532, 12311.876881231074, 12384.504619815107, 12495.93752031234, 12563.685907852012, 13004.869951300367, 13376.331183440983, 13403.731925361242, 13902.791458127935, 13923.094998825043, 12954.611361659165, 13176.407061682055, 13251.13867598603, 13476.191428514321, 13477.932610336886, 11960.0, 12146.0, 12359.876401235873, 12386.194897331645, 12777.36113194318, 12499.625011249676, 12615.747685046432, 12688.23870567769, 13127.081104322988, 13250.734985300433, 10313.535890884777, 10439.895601044196, 10769.892301076889, 10816.67549973502, 10992.670219893416, 10523.579056837947, 10571.101456376295, 10608.628697995533, 11213.495392707184, 11915.0], "value": 7170.3191691391785, "unit": "score"}], "name": "dromaeo_css", "value": 7343.604991361603, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 105.0, 109.0, 111.0, 111.0, 100.0, 110.0, 111.0, 111.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 126.0, 152.0, 184.0, 126.0, 156.0, 150.0, 133.0, 190.0, 125.0], "value": 149.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 163.0, 162.0, 161.0, 161.0, 163.0, 162.0, 163.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 76.0, 190.0, 76.0, 73.0, 76.0, 76.0, 156.0, 76.0], "value": 95.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 154.0, 92.0, 93.0, 93.0, 149.0, 93.0, 92.0, 151.0], "value": 110.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 56.0, 56.0, 54.0, 57.0, 56.0, 74.0, 55.0, 52.0], "value": 56.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 56.0, 57.0, 57.0, 57.0, 57.0, 63.0, 57.0], "value": 57.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 73.0, 73.0, 75.0, 76.0, 73.0, 75.0, 74.0, 73.0], "value": 74.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 122.0, 118.0, 121.0, 128.0, 115.0, 120.0, 117.0, 149.0, 118.0], "value": 122.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 161.0, 166.0, 162.0, 174.0, 167.0, 165.0, 170.0, 161.0], "value": 165.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 67.0, 66.0, 66.0, 65.0, 68.0, 67.0, 67.0, 68.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1526.3000000000002, "alertThreshold": 2.0}]} 13:58:10 INFO - Return code: 0 13:58:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:58:10 ERROR - # TBPL SUCCESS # 13:58:10 INFO - Running post-action listener: _resource_record_post_action 13:58:10 INFO - Running post-run listener: _resource_record_post_run 13:58:11 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 262144; Write bytes: 261918720; Read time: 12; Write time: 128992 13:58:11 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 13119488; Read time: 0; Write time: 7344 13:58:11 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 262144; Write bytes: 248799232; Read time: 12; Write time: 121648 13:58:11 INFO - Running post-run listener: _upload_blobber_files 13:58:11 INFO - Blob upload gear active. 13:58:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:58:11 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 13:58:11 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'] 13:58:11 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 13:58:12 INFO - (blobuploader) - INFO - Open directory for files ... 13:58:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:58:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:58:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:58:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:58:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:58:13 INFO - (blobuploader) - INFO - Done attempting. 13:58:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:58:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:58:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:58:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:58:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:58:14 INFO - (blobuploader) - INFO - Done attempting. 13:58:14 INFO - (blobuploader) - INFO - Iteration through files over. 13:58:14 INFO - Return code: 0 13:58:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:58:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:58:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1e7a21bde7c6f6ae1e98666fc77f54ae289bf415a2e768e0ae96eca90974b3bcb1be94bf60ed4ed0b4d98790baee272cf04cdbbe4a810930140471b725ef59cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0f5ae3a06244a233c0617a10d1d6e3946c179e859b4bc0dbf48d95ba609cb279a502a20ec2c692cee31644f0ce89bad23b8cf9ddc67fedafe4fbd91b8c329821"} 13:58:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:58:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:58:14 INFO - Contents: 13:58:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1e7a21bde7c6f6ae1e98666fc77f54ae289bf415a2e768e0ae96eca90974b3bcb1be94bf60ed4ed0b4d98790baee272cf04cdbbe4a810930140471b725ef59cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0f5ae3a06244a233c0617a10d1d6e3946c179e859b4bc0dbf48d95ba609cb279a502a20ec2c692cee31644f0ce89bad23b8cf9ddc67fedafe4fbd91b8c329821"} 13:58:14 INFO - Running post-run listener: copy_logs_to_upload_dir 13:58:14 INFO - Copying logs to upload dir... 13:58:14 INFO - mkdir: /builds/slave/test/build/upload/logs 13:58:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.004646 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-04-26 13:58:13.635156) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 13:58:13.639125) ========= 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=337fe3f4b1febe37b85fccc40000019e-1461703020.690475-831024322 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/1e7a21bde7c6f6ae1e98666fc77f54ae289bf415a2e768e0ae96eca90974b3bcb1be94bf60ed4ed0b4d98790baee272cf04cdbbe4a810930140471b725ef59cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0f5ae3a06244a233c0617a10d1d6e3946c179e859b4bc0dbf48d95ba609cb279a502a20ec2c692cee31644f0ce89bad23b8cf9ddc67fedafe4fbd91b8c329821"} build_url:https://queue.taskcluster.net/v1/task/ZiPQa71WSP-SD0XstXuXXg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011233 build_url: 'https://queue.taskcluster.net/v1/task/ZiPQa71WSP-SD0XstXuXXg/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/1e7a21bde7c6f6ae1e98666fc77f54ae289bf415a2e768e0ae96eca90974b3bcb1be94bf60ed4ed0b4d98790baee272cf04cdbbe4a810930140471b725ef59cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0f5ae3a06244a233c0617a10d1d6e3946c179e859b4bc0dbf48d95ba609cb279a502a20ec2c692cee31644f0ce89bad23b8cf9ddc67fedafe4fbd91b8c329821"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 13:58:13.664497) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 13:58:13.664853) ========= 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=337fe3f4b1febe37b85fccc40000019e-1461703020.690475-831024322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004449 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 13:58:13.748582) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 13:58:13.748933) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 13:58:13.749238) ========= ========= Total master_lag: 0.18 =========